[104.847915] Initializing watchdogs
[104.847962]   /dev/watchdog0
[104.862464] [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]
[104.866954] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.869151] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.872893] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[105.010559] Starting subtest: x-tiled-8bpp-rotate-180
[106.290023] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.280s)
[106.464023] [002/133] (958s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[106.568883] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[106.572186] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[106.638988] [003/133] (958s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[106.725780] Starting subtest: pr-cursor-plane-update-sf
[106.729198] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[106.788078] [004/133] (958s left) kms_frontbuffer_tracking (psr-slowdraw)
[106.891317] Starting subtest: psr-slowdraw
[132.181726] Subtest psr-slowdraw: SUCCESS (25.294s)
[132.306477] [005/133] (933s left) kms_flip (plain-flip-fb-recreate)
[132.426506] Starting subtest: plain-flip-fb-recreate
[132.428814] Starting dynamic subtest: A-eDP1
[141.258829] Dynamic subtest A-eDP1: SUCCESS (8.835s)
[141.266270] Starting dynamic subtest: B-eDP1
[150.088247] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[150.095092] Starting dynamic subtest: C-eDP1
[158.908588] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[158.915149] Starting dynamic subtest: D-eDP1
[167.748041] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[167.752124] Subtest plain-flip-fb-recreate: SUCCESS (35.329s)
[168.926677] [006/133] (896s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[168.988121] Starting subtest: invalid-signal-one-illegal-handle
[168.990529] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[169.074613] [007/133] (896s left) api_intel_allocator (open-vm)
[169.133357] Starting subtest: open-vm
[169.135724] Subtest open-vm: SUCCESS (0.002s)
[169.247444] [008/133] (896s left) gem_exec_params (cliprects_ptr-dirt)
[169.301041] Starting subtest: cliprects_ptr-dirt
[169.303302] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[169.391667] [009/133] (896s left) gem_ctx_persistence (engines-hang)
[169.441957] Starting subtest: engines-hang
[169.444241] Starting dynamic subtest: rcs0
[169.512643] Dynamic subtest rcs0: SUCCESS (0.070s)
[169.521370] Starting dynamic subtest: bcs0
[169.606848] Dynamic subtest bcs0: SUCCESS (0.093s)
[169.615959] Starting dynamic subtest: vcs0
[169.691791] Dynamic subtest vcs0: SUCCESS (0.084s)
[169.701873] Starting dynamic subtest: vcs1
[169.783663] Dynamic subtest vcs1: SUCCESS (0.091s)
[169.793590] Starting dynamic subtest: vecs0
[169.852512] Dynamic subtest vecs0: SUCCESS (0.068s)
[169.860994] Starting dynamic subtest: ccs0
[169.971402] Dynamic subtest ccs0: SUCCESS (0.118s)
[169.973594] Subtest engines-hang: SUCCESS (0.530s)
[170.049571] [010/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[170.137158] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[174.429397] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.295s)
[175.654563] [011/133] (890s left) kms_psr (fbc-psr2-primary-page-flip)
[175.752067] Starting subtest: fbc-psr2-primary-page-flip
[175.754373] Starting dynamic subtest: eDP-1
[175.758516] Dynamic subtest eDP-1: SKIP (0.000s)
[175.762790] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[175.822962] [012/133] (889s left) i915_drm_fdinfo (busy)
[175.862672] Starting subtest: busy
[175.864835] Starting dynamic subtest: rcs0
[175.885991] Dynamic subtest rcs0: SKIP (0.023s)
[175.897819] Starting dynamic subtest: bcs0
[175.902231] Dynamic subtest bcs0: SKIP (0.000s)
[175.908667] Starting dynamic subtest: vcs0
[175.913098] Dynamic subtest vcs0: SKIP (0.000s)
[175.919699] Starting dynamic subtest: vcs1
[175.924055] Dynamic subtest vcs1: SKIP (0.000s)
[175.930647] Starting dynamic subtest: vecs0
[175.935040] Dynamic subtest vecs0: SKIP (0.000s)
[175.941900] Starting dynamic subtest: ccs0
[175.946174] Dynamic subtest ccs0: SKIP (0.000s)
[175.950493] Subtest busy: SKIP (0.025s)
[175.986593] [013/133] (889s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[176.077300] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[176.081472] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[176.159680] [014/133] (889s left) kms_cursor_crc (cursor-offscreen-64x64)
[176.338069] Starting subtest: cursor-offscreen-64x64
[176.343225] Starting dynamic subtest: pipe-A-eDP-1
[178.295146] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[178.322430] Starting dynamic subtest: pipe-D-eDP-1
[180.942936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[180.945893] Subtest cursor-offscreen-64x64: SUCCESS (4.602s)
[181.807716] [015/133] (884s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[181.902037] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[181.904381] Starting dynamic subtest: pipe-A-eDP-1
[181.925465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[181.935072] Starting dynamic subtest: pipe-B-eDP-1
[181.953363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[181.960594] Starting dynamic subtest: pipe-C-eDP-1
[181.979160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.986251] Starting dynamic subtest: pipe-D-eDP-1
[182.005159] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[182.007054] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[184.186297] [016/133] (881s left) syncobj_timeline (single-wait-available-signaled)
[184.250213] Starting subtest: single-wait-available-signaled
[184.252645] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[184.342014] [017/133] (881s left) gem_tiled_fence_blits (normal)
[184.416622] Subtest normal: SKIP (0.000s)
[184.474491] [018/133] (881s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[184.576279] Starting subtest: 2x-flip-vs-modeset-vs-hang
[184.585280] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[184.660688] [019/133] (881s left) syncobj_timeline (multi-wait-available-signaled)
[184.729124] Starting subtest: multi-wait-available-signaled
[184.731418] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[184.833702] [020/133] (881s left) kms_content_protection (uevent-hdcp14)
[184.970751] Starting subtest: uevent-hdcp14
[184.975359] Subtest uevent-hdcp14: SKIP (0.000s)
[185.094934] [021/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[185.192767] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[185.196141] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[185.289425] [022/133] (880s left) perf_pmu (semaphore-wait-idle)
[185.326979] Starting subtest: semaphore-wait-idle
[185.328899] Starting dynamic subtest: rcs0
[185.844862] Dynamic subtest rcs0: SUCCESS (0.515s)
[185.855302] Starting dynamic subtest: bcs0
[186.358033] Dynamic subtest bcs0: SUCCESS (0.512s)
[186.368878] Starting dynamic subtest: vcs0
[186.869484] Dynamic subtest vcs0: SUCCESS (0.510s)
[186.879776] Starting dynamic subtest: vcs1
[187.382227] Dynamic subtest vcs1: SUCCESS (0.511s)
[187.392030] Starting dynamic subtest: vecs0
[187.894732] Dynamic subtest vecs0: SUCCESS (0.511s)
[187.905210] Starting dynamic subtest: ccs0
[188.409320] Dynamic subtest ccs0: SUCCESS (0.513s)
[188.411920] Subtest semaphore-wait-idle: SUCCESS (3.081s)
[189.981373] [023/133] (876s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[190.079964] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[197.483081] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.406s)
[197.626668] [024/133] (868s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[197.729056] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[197.733260] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[197.798168] [025/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[197.909542] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[197.913573] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[198.009981] [026/133] (868s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[198.079650] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[198.149384] [027/133] (868s left) kms_psr (pr-sprite-blt)
[198.246106] Starting subtest: pr-sprite-blt
[198.250407] Subtest pr-sprite-blt: SKIP (0.000s)
[198.315290] [028/133] (868s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[198.443707] Starting subtest: flip-vs-cursor-busy-crc-atomic
[199.269308] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.825s)
[200.138303] [029/133] (866s left) kms_psr (psr2-dpms)
[200.244370] Starting subtest: psr2-dpms
[200.246649] Starting dynamic subtest: eDP-1
[203.086756] Dynamic subtest eDP-1: SUCCESS (2.842s)
[203.089013] Subtest psr2-dpms: SUCCESS (2.843s)
[203.985924] [030/133] (862s left) syncobj_wait (single-wait-all-signaled)
[204.042215] Starting subtest: single-wait-all-signaled
[204.044504] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[204.171544] [031/133] (862s left) gem_render_copy_redux (interruptible)
[204.230559] Starting subtest: interruptible
[204.501125] Subtest interruptible: SUCCESS (0.271s)
[204.623542] [032/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[204.721723] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[204.725770] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[204.813436] [033/133] (861s left) i915_pm_freq_api (freq-basic-api)
[204.877279] Starting subtest: freq-basic-api
[204.879612] Starting dynamic subtest: gt0
[204.881841] Dynamic subtest gt0: SUCCESS (0.002s)
[204.888994] Starting dynamic subtest: gt1
[204.890828] Dynamic subtest gt1: SUCCESS (0.002s)
[204.892619] Subtest freq-basic-api: SUCCESS (0.006s)
[204.979049] [034/133] (861s left) gem_exercise_blt (fast-copy)
[205.042372] Starting subtest: fast-copy
[205.044064] Starting dynamic subtest: linear-smem-smem
[205.063082] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[205.072688] Starting dynamic subtest: xmajor-smem-smem
[205.080625] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[205.087662] Starting dynamic subtest: tile4-smem-smem
[205.101769] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s)
[205.108846] Starting dynamic subtest: tile64-smem-smem
[205.119154] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[205.121037] Subtest fast-copy: SUCCESS (0.080s)
[205.242893] [035/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[205.336481] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[205.339909] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[205.431835] [036/133] (861s left) gem_partial_pwrite_pread (reads-display)
[205.494953] Subtest reads-display: SKIP (0.000s)
[205.572788] [037/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[205.671715] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[205.675450] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.767562] [038/133] (861s left) gem_ctx_param (basic-default)
[205.825445] Starting subtest: basic-default
[205.827648] Subtest basic-default: SUCCESS (0.000s)
[205.907857] [039/133] (860s left) gem_exec_balancer (parallel)
[206.167165] Starting subtest: parallel
[207.072857] Subtest parallel: SUCCESS (0.906s)
[207.927435] [040/133] (858s left) gem_create (create-ext-set-pat)
[208.114027] Starting subtest: create-ext-set-pat
[208.116436] Subtest create-ext-set-pat: SUCCESS (0.001s)
[208.231881] [041/133] (858s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[208.334943] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[208.337300] Starting dynamic subtest: pipe-A-default-mode
[209.519794] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[209.524078] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.183s)
[209.688636] [042/133] (857s left) gem_exec_reloc (basic-gtt-cpu-active)
[209.754978] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[209.825061] [043/133] (857s left) perf (rc6-disable)
[209.951721] Starting subtest: rc6-disable
[210.132031] Subtest rc6-disable: SUCCESS (0.180s)
[210.173336] [044/133] (856s left) gem_mmap_offset (clear-via-pagefault)
[210.246611] Starting subtest: clear-via-pagefault
[210.248927] Starting dynamic subtest: smem0
[244.015509] Dynamic subtest smem0: SUCCESS (33.764s)
[244.017665] Subtest clear-via-pagefault: SUCCESS (33.764s)
[244.134747] [045/133] (822s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[244.235703] Starting subtest: psr-dirtyfb-ioctl
[244.237869] Starting dynamic subtest: A-eDP-1
[248.214220] Dynamic subtest A-eDP-1: SUCCESS (3.977s)
[248.216627] Subtest psr-dirtyfb-ioctl: SUCCESS (3.978s)
[249.089152] [046/133] (818s left) kms_lease (lease-unleased-crtc)
[249.182537] Starting subtest: lease-unleased-crtc
[249.184895] Starting dynamic subtest: pipe-A-eDP-1
[249.476672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[249.485462] Starting dynamic subtest: pipe-B-eDP-1
[250.253468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[250.263699] Starting dynamic subtest: pipe-C-eDP-1
[250.266022] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[250.273189] Starting dynamic subtest: pipe-D-eDP-1
[250.275099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[250.276974] Subtest lease-unleased-crtc: SUCCESS (1.084s)
[250.620660] [047/133] (816s left) gem_render_copy (yf-tiled)
[250.692287] Starting subtest: yf-tiled
[250.696705] Subtest yf-tiled: SKIP (0.000s)
[250.883508] [048/133] (816s left) i915_suspend (sysfs-reader)
[250.937944] Starting subtest: sysfs-reader
[269.364100] Subtest sysfs-reader: SUCCESS (4.387s)
[274.494513] [049/133] (797s left) gem_render_linear_blits (basic)
[274.577071] Starting subtest: basic
[274.610132] Subtest basic: SUCCESS (0.034s)
[274.696620] [050/133] (797s left) gem_ctx_bad_destroy (invalid-pad)
[274.755879] Starting subtest: invalid-pad
[274.758258] Subtest invalid-pad: SUCCESS (0.000s)
[274.829573] [051/133] (797s left) gem_render_copy (y-tiled-ccs-to-linear)
[274.890939] Starting subtest: y-tiled-ccs-to-linear
[274.895499] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[275.072362] [052/133] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[275.173781] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[282.075181] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.900s)
[282.224532] [053/133] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[282.322110] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[288.983387] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.663s)
[289.129672] [054/133] (783s left) kms_cursor_edge_walk (128x128-right-edge)
[289.232549] Starting subtest: 128x128-right-edge
[289.234788] Starting dynamic subtest: pipe-A-eDP-1
[292.644833] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[292.659281] Starting dynamic subtest: pipe-D-eDP-1
[295.767732] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[295.769935] Subtest 128x128-right-edge: SUCCESS (6.535s)
[296.594609] [055/133] (775s left) kms_plane (plane-position-hole-dpms)
[296.683540] Starting subtest: plane-position-hole-dpms
[297.208668] Starting dynamic subtest: pipe-A-plane-1
[299.600543] Dynamic subtest pipe-A-plane-1: SUCCESS (2.391s)
[299.610733] Starting dynamic subtest: pipe-A-plane-2
[302.020396] Dynamic subtest pipe-A-plane-2: SUCCESS (2.421s)
[302.028885] Starting dynamic subtest: pipe-A-plane-3
[304.399232] Dynamic subtest pipe-A-plane-3: SUCCESS (2.374s)
[304.408221] Starting dynamic subtest: pipe-A-plane-4
[306.836264] Dynamic subtest pipe-A-plane-4: SUCCESS (2.439s)
[306.846373] Starting dynamic subtest: pipe-A-plane-5
[306.865919] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[308.033137] Starting dynamic subtest: pipe-B-plane-1
[310.471511] Dynamic subtest pipe-B-plane-1: SUCCESS (2.445s)
[310.481970] Starting dynamic subtest: pipe-B-plane-2
[312.943408] Dynamic subtest pipe-B-plane-2: SUCCESS (2.471s)
[312.952421] Starting dynamic subtest: pipe-B-plane-3
[315.383628] Dynamic subtest pipe-B-plane-3: SUCCESS (2.437s)
[315.392858] Starting dynamic subtest: pipe-B-plane-4
[317.778077] Dynamic subtest pipe-B-plane-4: SUCCESS (2.394s)
[317.790361] Starting dynamic subtest: pipe-B-plane-5
[317.804777] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[317.807060] Subtest plane-position-hole-dpms: SUCCESS (21.120s)
[318.651961] [056/133] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[318.754418] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[326.165116] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.412s)
[326.301900] [057/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[326.403954] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[326.408096] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[326.481834] [058/133] (746s left) gem_softpin (full)
[326.545102] Starting subtest: full
[326.552726] Subtest full: SUCCESS (0.007s)
[326.667644] [059/133] (746s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[327.044059] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[327.875080] [060/133] (744s left) kms_dsc (dsc-fractional-bpp)
[327.975625] Starting subtest: dsc-fractional-bpp
[327.988693] Subtest dsc-fractional-bpp: SKIP (0.000s)
[328.061050] [061/133] (744s left) gem_exec_parallel (userptr)
[328.126203] Starting subtest: userptr
[328.128359] Starting dynamic subtest: rcs0
[329.583106] Dynamic subtest rcs0: SUCCESS (1.456s)
[329.592695] Starting dynamic subtest: bcs0
[331.029627] Dynamic subtest bcs0: SUCCESS (1.446s)
[331.039419] Starting dynamic subtest: vcs0
[332.912021] Dynamic subtest vcs0: SUCCESS (1.878s)
[332.923560] Starting dynamic subtest: vcs1
[334.895249] Dynamic subtest vcs1: SUCCESS (1.981s)
[334.907068] Starting dynamic subtest: vecs0
[336.942910] Dynamic subtest vecs0: SUCCESS (2.045s)
[336.954151] Starting dynamic subtest: ccs0
[338.423819] Dynamic subtest ccs0: SUCCESS (1.479s)
[338.429260] Subtest userptr: SUCCESS (10.300s)
[338.615739] [062/133] (734s left) gem_ctx_exec (basic)
[338.676100] Starting subtest: basic
[338.681949] Subtest basic: SUCCESS (0.008s)
[338.792152] [063/133] (734s left) gem_exec_schedule (submit-late-slice)
[338.865854] Starting subtest: submit-late-slice
[338.868198] Starting dynamic subtest: rcs0
[338.912448] Dynamic subtest rcs0: SUCCESS (0.053s)
[338.926266] Starting dynamic subtest: bcs0
[338.960668] Dynamic subtest bcs0: SUCCESS (0.047s)
[338.976134] Starting dynamic subtest: vcs0
[339.016225] Dynamic subtest vcs0: SUCCESS (0.054s)
[339.028238] Starting dynamic subtest: vcs1
[339.065608] Dynamic subtest vcs1: SUCCESS (0.049s)
[339.077594] Starting dynamic subtest: vecs0
[339.114251] Dynamic subtest vecs0: SUCCESS (0.048s)
[339.123091] Starting dynamic subtest: ccs0
[339.169078] Dynamic subtest ccs0: SUCCESS (0.053s)
[339.171858] Subtest submit-late-slice: SUCCESS (0.309s)
[341.077433] [064/133] (731s left) gem_exec_schedule (preempt-contexts)
[341.150761] Starting subtest: preempt-contexts
[341.153348] Starting dynamic subtest: rcs0
[341.244954] Dynamic subtest rcs0: SUCCESS (0.094s)
[341.254778] Starting dynamic subtest: bcs0
[341.326415] Dynamic subtest bcs0: SUCCESS (0.081s)
[341.335867] Starting dynamic subtest: vcs0
[341.398033] Dynamic subtest vcs0: SUCCESS (0.071s)
[341.410723] Starting dynamic subtest: vcs1
[341.459841] Dynamic subtest vcs1: SUCCESS (0.061s)
[341.469433] Starting dynamic subtest: vecs0
[341.516240] Dynamic subtest vecs0: SUCCESS (0.055s)
[341.525462] Starting dynamic subtest: ccs0
[341.593273] Dynamic subtest ccs0: SUCCESS (0.076s)
[341.595519] Subtest preempt-contexts: SUCCESS (0.444s)
[343.067316] [065/133] (729s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[343.134323] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[343.188780] [066/133] (729s left) gem_exec_reloc (basic-write-read-noreloc)
[343.253294] Subtest basic-write-read-noreloc: SKIP (0.000s)
[343.326013] [067/133] (729s left) kms_addfb_basic (master-rmfb)
[343.392237] Starting subtest: master-rmfb
[343.394356] Subtest master-rmfb: SUCCESS (0.001s)
[343.534639] [068/133] (729s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[343.628420] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[344.430576] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[344.618305] [069/133] (728s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[344.716522] Starting subtest: nonblocking-crc-frame-sequence
[344.718808] Starting dynamic subtest: pipe-A-eDP-1
[345.497128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s)
[345.511080] Starting dynamic subtest: pipe-B-eDP-1
[346.913649] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[346.922836] Starting dynamic subtest: pipe-C-eDP-1
[348.279757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[348.289092] Starting dynamic subtest: pipe-D-eDP-1
[349.608214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[349.610659] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.893s)
[350.421345] [070/133] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[350.515645] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[350.519592] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[350.609060] [071/133] (722s left) kms_color (ctm-signed)
[350.709561] Starting subtest: ctm-signed
[350.711668] Starting dynamic subtest: pipe-A-eDP-1
[352.804353] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s)
[352.813783] Starting dynamic subtest: pipe-B-eDP-1
[355.582930] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.779s)
[355.591306] Starting dynamic subtest: pipe-C-eDP-1
[358.285754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.701s)
[358.294500] Starting dynamic subtest: pipe-D-eDP-1
[360.955527] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[360.958055] Subtest ctm-signed: SUCCESS (10.245s)
[361.778000] [072/133] (711s left) gem_exec_alignment (forked)
[361.845744] Starting subtest: forked
[401.454827] Subtest forked: SUCCESS (39.607s)
[401.535329] [073/133] (671s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[401.696618] Starting subtest: 4-tiled-32bpp-rotate-90
[401.717407] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[401.815640] [074/133] (671s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[401.923828] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[401.928204] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[402.012161] [075/133] (671s left) syncobj_wait (invalid-wait-bad-flags)
[402.078380] Starting subtest: invalid-wait-bad-flags
[402.080852] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[402.179478] [076/133] (671s left) sw_sync (sync_multi_timeline_wait)
[402.214134] Starting subtest: sync_multi_timeline_wait
[402.216257] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[402.286526] [077/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[402.386715] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[402.390933] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[402.501833] [078/133] (671s left) gem_exec_fence (basic-busy)
[402.668652] Starting subtest: basic-busy
[402.670935] Starting dynamic subtest: rcs0
[402.781046] Dynamic subtest rcs0: SUCCESS (0.115s)
[402.792789] Starting dynamic subtest: bcs0
[402.836522] Dynamic subtest bcs0: SUCCESS (0.053s)
[402.847750] Starting dynamic subtest: vcs0
[402.891299] Dynamic subtest vcs0: SUCCESS (0.053s)
[402.902381] Starting dynamic subtest: vcs1
[402.946231] Dynamic subtest vcs1: SUCCESS (0.053s)
[402.957479] Starting dynamic subtest: vecs0
[402.997814] Dynamic subtest vecs0: SUCCESS (0.050s)
[403.008490] Starting dynamic subtest: ccs0
[403.058693] Dynamic subtest ccs0: SUCCESS (0.058s)
[403.061372] Subtest basic-busy: SUCCESS (0.393s)
[404.990422] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[404.994928] [079/133] (668s left) kms_async_flips (invalid-async-flip)
[405.092072] Starting subtest: invalid-async-flip
[405.467624] Starting dynamic subtest: pipe-A-eDP-1
[406.319314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[406.678011] Starting dynamic subtest: pipe-B-eDP-1
[407.538272] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.868s)
[407.893554] Starting dynamic subtest: pipe-C-eDP-1
[408.663817] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[409.022194] Starting dynamic subtest: pipe-D-eDP-1
[409.791499] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[409.793845] Subtest invalid-async-flip: SUCCESS (4.701s)
[410.947771] [080/133] (662s left) kms_psr2_su (frontbuffer-xrgb8888)
[411.000539] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[411.067757] [081/133] (662s left) syncobj_timeline (etime-single-wait-submitted)
[411.128477] Starting subtest: etime-single-wait-submitted
[411.235846] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[411.312228] [082/133] (662s left) gem_exec_reloc (basic-cpu-wc-active)
[411.362791] Subtest basic-cpu-wc-active: SKIP (0.000s)
[411.436327] [083/133] (662s left) kms_flip (2x-flip-vs-panning-interruptible)
[411.546083] Starting subtest: 2x-flip-vs-panning-interruptible
[411.557912] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[411.687515] [084/133] (662s left) i915_pm_freq_mult (media-freq)
[411.756511] Starting subtest: media-freq
[411.758741] Starting dynamic subtest: gt0
[411.763257] Dynamic subtest gt0: SKIP (0.000s)
[411.772678] Starting dynamic subtest: gt1
[411.777039] Dynamic subtest gt1: SKIP (0.000s)
[411.781423] Subtest media-freq: SKIP (0.002s)
[411.858532] [085/133] (662s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[411.985795] Starting subtest: cursorA-vs-flipB-varying-size
[411.990179] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[412.132340] [086/133] (661s left) kms_pm_rpm (modeset-lpsp)
[414.081941] Starting subtest: modeset-lpsp
[415.567775] Subtest modeset-lpsp: SUCCESS (1.487s)
[415.658150] [087/133] (658s left) gem_exec_whisper (basic-fds-all)
[415.722798] Starting subtest: basic-fds-all
[426.925710] Subtest basic-fds-all: SUCCESS (11.202s)
[427.115022] [088/133] (646s left) fbdev (nullptr)
[427.172077] Starting subtest: nullptr
[427.174419] Subtest nullptr: SUCCESS (0.000s)
[427.234003] [089/133] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[427.332967] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[434.475291] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.144s)
[434.590175] [090/133] (639s left) gem_userptr_blits (nohangcheck)
[434.671731] Starting subtest: nohangcheck
[434.908550] Subtest nohangcheck: SUCCESS (0.233s)
[435.028541] [091/133] (639s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[435.118583] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[435.120786] Starting dynamic subtest: pipe-A-eDP-1
[435.143940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.155906] Starting dynamic subtest: pipe-B-eDP-1
[435.178078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.189593] Starting dynamic subtest: pipe-C-eDP-1
[435.211132] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.220528] Starting dynamic subtest: pipe-D-eDP-1
[435.243430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.247713] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[437.423114] [092/133] (636s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[437.816124] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[438.631667] [093/133] (635s left) perf (blocking)
[438.733971] Starting subtest: blocking
[438.736279] Starting dynamic subtest: 0-rcs0
[448.766835] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[448.777546] Starting dynamic subtest: 1-vcs1
[458.791734] Dynamic subtest 1-vcs1: SUCCESS (10.024s)
[458.794542] Subtest blocking: SUCCESS (20.056s)
[458.846280] [094/133] (615s left) kms_psr (psr-primary-mmap-gtt)
[458.946341] Starting subtest: psr-primary-mmap-gtt
[458.948512] Starting dynamic subtest: eDP-1
[460.444371] Dynamic subtest eDP-1: SKIP (1.495s)
[460.449167] Subtest psr-primary-mmap-gtt: SKIP (1.497s)
[460.613236] [095/133] (613s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[460.708455] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[460.710786] Starting dynamic subtest: pipe-A-eDP-1
[461.619549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.906s)
[461.628548] Starting dynamic subtest: pipe-B-eDP-1
[463.351779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.728s)
[463.361577] Starting dynamic subtest: pipe-C-eDP-1
[464.982300] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.630s)
[464.993250] Starting dynamic subtest: pipe-D-eDP-1
[466.553884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.570s)
[466.555753] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.839s)
[467.736400] [096/133] (606s left) gem_exec_params (no-vebox)
[467.797975] Starting subtest: no-vebox
[467.800303] Subtest no-vebox: SUCCESS (0.002s)
[469.025446] [097/133] (605s left) kms_pm_dc (dc5-psr)
[470.124195] Starting subtest: dc5-psr
[473.007336] Subtest dc5-psr: SUCCESS (2.883s)
[473.854349] [098/133] (600s left) gem_pread (self)
[473.918762] Subtest self: SKIP (0.000s)
[473.978778] [099/133] (600s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[474.081285] Starting subtest: yf-tiled-32bpp-rotate-90
[474.085528] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[474.180119] [100/133] (600s left) syncobj_eventfd (binary-wait)
[474.246909] Starting subtest: binary-wait
[474.255727] Subtest binary-wait: SUCCESS (0.011s)
[474.332238] [101/133] (600s left) kms_cursor_crc (cursor-size-hints)
[474.460188] Starting subtest: cursor-size-hints
[474.462369] Starting dynamic subtest: pipe-A-eDP-1
[475.066729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[475.082022] Starting dynamic subtest: pipe-D-eDP-1
[476.319629] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[476.321923] Subtest cursor-size-hints: SUCCESS (1.861s)
[477.117682] [102/133] (597s left) kms_atomic_interruptible (legacy-cursor)
[477.227602] Starting subtest: legacy-cursor
[477.230228] Starting dynamic subtest: pipe-A-eDP-1
[484.641534] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.410s)
[484.643713] Subtest legacy-cursor: SUCCESS (7.411s)
[485.495574] [103/133] (589s left) gem_render_copy (x-tiled)
[485.561189] Starting subtest: x-tiled
[485.563566] Starting dynamic subtest: smem
[485.606893] Dynamic subtest smem: SUCCESS (0.045s)
[485.609325] Subtest x-tiled: SUCCESS (0.046s)
[485.792579] [104/133] (588s left) gen9_exec_parse (basic-rejected)
[485.847853] Subtest basic-rejected: SKIP (0.000s)
[485.919704] [105/133] (588s left) core_sysfs (read-all-entries)
[485.969405] Starting subtest: read-all-entries
[485.984329] Subtest read-all-entries: SUCCESS (0.015s)
[486.059868] [106/133] (588s left) perf (gen12-unprivileged-single-ctx-counters)
[486.154104] Starting subtest: gen12-unprivileged-single-ctx-counters
[486.156490] Starting dynamic subtest: rcs0
[486.349834] Dynamic subtest rcs0: SUCCESS (0.195s)
[486.352122] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.198s)
[486.401980] [107/133] (588s left) kms_big_fb (linear-32bpp-rotate-90)
[486.500894] Starting subtest: linear-32bpp-rotate-90
[486.521770] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[486.635086] [108/133] (588s left) gem_ctx_persistence (legacy-engines-hostile)
[486.696011] Starting subtest: legacy-engines-hostile
[486.698380] Starting dynamic subtest: render
[486.804986] Dynamic subtest render: SUCCESS (0.109s)
[486.820393] Starting dynamic subtest: bsd1
[486.894001] Dynamic subtest bsd1: SUCCESS (0.086s)
[486.908522] Starting dynamic subtest: bsd2
[486.999011] Dynamic subtest bsd2: SUCCESS (0.102s)
[487.013638] Starting dynamic subtest: blt
[487.091039] Dynamic subtest blt: SUCCESS (0.089s)
[487.105591] Starting dynamic subtest: vebox
[487.179612] Dynamic subtest vebox: SUCCESS (0.086s)
[487.181627] Subtest legacy-engines-hostile: SUCCESS (0.485s)
[487.262486] [109/133] (587s left) perf_pmu (enable-race)
[487.299907] Starting subtest: enable-race
[487.301835] Starting dynamic subtest: rcs0
[500.056508] Dynamic subtest rcs0: SUCCESS (12.755s)
[500.068535] Starting dynamic subtest: bcs0
[512.794799] Dynamic subtest bcs0: SUCCESS (12.737s)
[512.806426] Starting dynamic subtest: vcs0
[527.918888] Dynamic subtest vcs0: SUCCESS (15.122s)
[527.931413] Starting dynamic subtest: vcs1
[543.919206] Dynamic subtest vcs1: SUCCESS (15.996s)
[543.930551] Starting dynamic subtest: vecs0
[559.982943] Dynamic subtest vecs0: SUCCESS (16.060s)
[559.995297] Starting dynamic subtest: ccs0
[572.725501] Dynamic subtest ccs0: SUCCESS (12.741s)
[572.728007] Subtest enable-race: SUCCESS (85.424s)
[572.846863] [110/133] (502s left) gem_softpin (32b-excludes-last-page)
[572.906939] Starting subtest: 32b-excludes-last-page
[572.912346] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[573.044118] [111/133] (501s left) api_intel_bb (purge-bb)
[573.091569] Starting subtest: purge-bb
[573.097944] Subtest purge-bb: SUCCESS (0.007s)
[573.224693] [112/133] (501s left) kms_sequence (queue-idle)
[573.323716] Starting subtest: queue-idle
[573.325951] Starting dynamic subtest: pipe-A-eDP-1
[575.145001] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[575.154671] Starting dynamic subtest: pipe-B-eDP-1
[577.679820] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.533s)
[577.690138] Starting dynamic subtest: pipe-C-eDP-1
[580.189347] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.508s)
[580.199331] Starting dynamic subtest: pipe-D-eDP-1
[582.611672] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[582.613552] Subtest queue-idle: SUCCESS (9.285s)
[583.415243] [113/133] (491s left) gem_exec_flush (basic-wb-rw-before-default)
[583.482368] Starting subtest: basic-wb-rw-before-default
[588.935464] Subtest basic-wb-rw-before-default: SUCCESS (5.455s)
[589.142836] [114/133] (485s left) syncobj_timeline (wait-for-submit-delayed-submit)
[589.201551] Starting subtest: wait-for-submit-delayed-submit
[589.306475] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[589.386617] [115/133] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[589.482636] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[589.486580] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[589.579923] [116/133] (485s left) kms_flip (flip-vs-panning-interruptible)
[589.672274] Starting subtest: flip-vs-panning-interruptible
[589.674164] Starting dynamic subtest: A-eDP1
[598.337658] Dynamic subtest A-eDP1: SUCCESS (8.663s)
[598.353896] Starting dynamic subtest: B-eDP1
[607.078777] Dynamic subtest B-eDP1: SUCCESS (8.739s)
[607.091406] Starting dynamic subtest: C-eDP1
[615.786673] Dynamic subtest C-eDP1: SUCCESS (8.705s)
[615.801472] Starting dynamic subtest: D-eDP1
[624.425709] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[624.429894] Subtest flip-vs-panning-interruptible: SUCCESS (34.757s)
[625.592331] [117/133] (449s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[625.692889] Starting subtest: y-tiled-16bpp-rotate-90
[625.697502] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[625.790844] [118/133] (449s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[625.887063] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[625.891053] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[625.985563] [119/133] (449s left) kms_plane_multiple (2x-tiling-4)
[626.078701] Starting subtest: 2x-tiling-4
[626.083069] Subtest 2x-tiling-4: SKIP (0.000s)
[626.156829] [120/133] (449s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[626.247494] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[626.249677] Starting dynamic subtest: pipe-A-eDP-1
[626.307042] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[626.319596] Starting dynamic subtest: pipe-B-eDP-1
[626.373192] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[626.383097] Starting dynamic subtest: pipe-C-eDP-1
[626.439027] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[626.449617] Starting dynamic subtest: pipe-D-eDP-1
[626.505783] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[626.510186] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[628.542991] [121/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[628.643116] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[628.647150] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.752614] [122/133] (446s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[628.848517] Starting subtest: fbcpsr-slowdraw
[654.100474] Subtest fbcpsr-slowdraw: SUCCESS (25.253s)
[654.243912] [123/133] (421s left) kms_invalid_mode (clock-too-high)
[654.340632] Starting subtest: clock-too-high
[654.342876] Starting dynamic subtest: pipe-A-eDP-1
[654.347091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[654.357531] Starting dynamic subtest: pipe-B-eDP-1
[654.361806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[654.371624] Starting dynamic subtest: pipe-C-eDP-1
[654.375635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[654.386064] Starting dynamic subtest: pipe-D-eDP-1
[654.390185] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[654.394311] Subtest clock-too-high: SKIP (0.004s)
[654.432756] [124/133] (421s left) gem_exec_fence (submit)
[654.608844] Starting subtest: submit
[654.613036] Subtest submit: SKIP (0.000s)
[656.035517] [125/133] (419s left) kms_vblank (query-forked-busy-hang)
[656.124151] Starting subtest: query-forked-busy-hang
[656.126426] Starting dynamic subtest: pipe-A-eDP-1
[682.733976] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.606s)
[682.748279] Starting dynamic subtest: pipe-D-eDP-1
[707.758961] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.022s)
[707.761317] Subtest query-forked-busy-hang: SUCCESS (51.633s)
[708.642392] [126/133] (367s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[708.749068] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[708.753418] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[708.834707] [127/133] (366s left) gem_userptr_blits (dmabuf-unsync)
[708.915027] Subtest dmabuf-unsync: SKIP (0.000s)
[709.040575] [128/133] (366s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[709.132450] Starting subtest: plane-upscale-20x20-with-pixel-format
[709.134790] Starting dynamic subtest: pipe-A
[710.183732] Dynamic subtest pipe-A: SUCCESS (1.051s)
[710.193712] Starting dynamic subtest: pipe-B
[712.332307] Dynamic subtest pipe-B: SUCCESS (2.147s)
[712.341556] Starting dynamic subtest: pipe-C
[713.527782] Dynamic subtest pipe-C: SUCCESS (1.194s)
[713.537514] Starting dynamic subtest: pipe-D
[714.754433] Dynamic subtest pipe-D: SUCCESS (1.225s)
[714.756805] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.623s)
[715.947785] [129/133] (359s left) kms_chamelium_color (ctm-max)
[716.048853] Subtest ctm-max: SKIP (0.000s)
[716.094948] [130/133] (359s left) gem_render_copy (y-tiled)
[716.146222] Starting subtest: y-tiled
[716.150415] Subtest y-tiled: SKIP (0.000s)
[716.327357] [131/133] (359s left) kms_psr (fbc-psr-primary-mmap-gtt)
[716.425794] Starting subtest: fbc-psr-primary-mmap-gtt
[716.427690] Starting dynamic subtest: eDP-1
[716.431631] Dynamic subtest eDP-1: SKIP (0.000s)
[716.435644] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[716.506094] [132/133] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[716.603876] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[716.608116] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[716.709040] [133/133] (359s left) gem_exec_params (secure-non-master)
[716.767169] Starting subtest: secure-non-master
[716.771232] Subtest secure-non-master: SKIP (0.000s)
[716.886746] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_tiled_fence_blits
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fenced_exec_thrash
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_render_copy_redux
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_freq_api
results: parsing output: 33/ for test: gem_exercise_blt
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_dirtyfb
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: i915_suspend
results: parsing output: 48/ for test: gem_render_linear_blits
results: parsing output: 49/ for test: gem_ctx_bad_destroy
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: gem_ctx_exec
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pipe_crc_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: gem_exec_alignment
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_psr2_su
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: i915_pm_freq_mult
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: gem_pread
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_atomic_interruptible
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: core_sysfs
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_sequence
results: parsing output: 112/ for test: gem_exec_flush
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_multiple
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_params
Done.