[103.898516] Initializing watchdogs
[103.898565]   /dev/watchdog0
[103.913350] [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]
[103.918147] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[103.920527] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[103.927351] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[104.076098] Starting subtest: x-tiled-8bpp-rotate-180
[105.357392] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.281s)
[105.493218] [002/133] (958s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[105.590168] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[105.593867] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[105.657904] [003/133] (958s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[105.754326] Starting subtest: pr-cursor-plane-update-sf
[105.757858] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[105.828263] [004/133] (958s left) kms_frontbuffer_tracking (psr-slowdraw)
[105.934833] Starting subtest: psr-slowdraw
[131.152840] Subtest psr-slowdraw: SUCCESS (25.219s)
[131.288074] [005/133] (933s left) kms_flip (plain-flip-fb-recreate)
[131.384543] Starting subtest: plain-flip-fb-recreate
[131.386839] Starting dynamic subtest: A-eDP1
[140.202751] Dynamic subtest A-eDP1: SUCCESS (8.819s)
[140.210386] Starting dynamic subtest: B-eDP1
[149.024111] Dynamic subtest B-eDP1: SUCCESS (8.819s)
[149.032492] Starting dynamic subtest: C-eDP1
[157.848545] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[157.859045] Starting dynamic subtest: D-eDP1
[166.679835] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[166.683825] Subtest plain-flip-fb-recreate: SUCCESS (35.302s)
[167.853808] [006/133] (896s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[167.929063] Starting subtest: invalid-signal-one-illegal-handle
[167.931499] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[168.036184] [007/133] (896s left) api_intel_allocator (open-vm)
[168.104712] Starting subtest: open-vm
[168.106994] Subtest open-vm: SUCCESS (0.003s)
[168.229693] [008/133] (896s left) gem_exec_params (cliprects_ptr-dirt)
[168.300713] Starting subtest: cliprects_ptr-dirt
[168.302607] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[168.394887] [009/133] (896s left) gem_ctx_persistence (engines-hang)
[168.457676] Starting subtest: engines-hang
[168.459889] Starting dynamic subtest: rcs0
[168.525838] Dynamic subtest rcs0: SUCCESS (0.070s)
[168.536618] Starting dynamic subtest: bcs0
[168.614769] Dynamic subtest bcs0: SUCCESS (0.088s)
[168.625086] Starting dynamic subtest: vcs0
[168.707617] Dynamic subtest vcs0: SUCCESS (0.092s)
[168.721068] Starting dynamic subtest: vcs1
[168.798571] Dynamic subtest vcs1: SUCCESS (0.090s)
[168.807891] Starting dynamic subtest: vecs0
[168.886613] Dynamic subtest vecs0: SUCCESS (0.087s)
[168.896889] Starting dynamic subtest: ccs0
[168.985244] Dynamic subtest ccs0: SUCCESS (0.098s)
[168.987235] Subtest engines-hang: SUCCESS (0.531s)
[169.058530] [010/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[169.152072] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[173.460873] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.312s)
[174.665244] [011/133] (890s left) kms_psr (fbc-psr2-primary-page-flip)
[174.749057] Starting subtest: fbc-psr2-primary-page-flip
[174.751362] Starting dynamic subtest: eDP-1
[174.755636] Dynamic subtest eDP-1: SKIP (0.000s)
[174.759891] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[174.821815] [012/133] (890s left) i915_drm_fdinfo (busy)
[174.864263] Starting subtest: busy
[174.866121] Starting dynamic subtest: rcs0
[174.892769] Dynamic subtest rcs0: SKIP (0.027s)
[174.904492] Starting dynamic subtest: bcs0
[174.908621] Dynamic subtest bcs0: SKIP (0.001s)
[174.916452] Starting dynamic subtest: vcs0
[174.920643] Dynamic subtest vcs0: SKIP (0.000s)
[174.927605] Starting dynamic subtest: vcs1
[174.931569] Dynamic subtest vcs1: SKIP (0.000s)
[174.938637] Starting dynamic subtest: vecs0
[174.942605] Dynamic subtest vecs0: SKIP (0.000s)
[174.949643] Starting dynamic subtest: ccs0
[174.953576] Dynamic subtest ccs0: SKIP (0.000s)
[174.957589] Subtest busy: SKIP (0.031s)
[174.991875] [013/133] (889s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[175.098072] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[175.102440] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[175.161551] [014/133] (889s left) kms_cursor_crc (cursor-offscreen-64x64)
[175.331831] Starting subtest: cursor-offscreen-64x64
[175.334162] Starting dynamic subtest: pipe-A-eDP-1
[177.252767] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s)
[177.282062] Starting dynamic subtest: pipe-D-eDP-1
[179.891502] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.615s)
[179.893681] Subtest cursor-offscreen-64x64: SUCCESS (4.561s)
[180.725957] [015/133] (884s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[180.836403] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[180.838583] Starting dynamic subtest: pipe-A-eDP-1
[180.857953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[180.866038] Starting dynamic subtest: pipe-B-eDP-1
[180.884711] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[180.891932] Starting dynamic subtest: pipe-C-eDP-1
[180.910134] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[180.918043] Starting dynamic subtest: pipe-D-eDP-1
[180.936582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[180.938673] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[183.091437] [016/133] (881s left) syncobj_timeline (single-wait-available-signaled)
[183.148875] Starting subtest: single-wait-available-signaled
[183.151235] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[183.227014] [017/133] (881s left) gem_tiled_fence_blits (normal)
[183.296315] Subtest normal: SKIP (0.000s)
[183.353024] [018/133] (881s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[183.452682] Starting subtest: 2x-flip-vs-modeset-vs-hang
[183.462087] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[183.550813] [019/133] (881s left) syncobj_timeline (multi-wait-available-signaled)
[183.617121] Starting subtest: multi-wait-available-signaled
[183.619545] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[183.712896] [020/133] (881s left) kms_content_protection (uevent-hdcp14)
[183.873039] Starting subtest: uevent-hdcp14
[183.877281] Subtest uevent-hdcp14: SKIP (0.000s)
[183.996824] [021/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[184.109248] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[184.112701] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[184.219542] [022/133] (881s left) perf_pmu (semaphore-wait-idle)
[184.264544] Starting subtest: semaphore-wait-idle
[184.266479] Starting dynamic subtest: rcs0
[184.778781] Dynamic subtest rcs0: SUCCESS (0.512s)
[184.788032] Starting dynamic subtest: bcs0
[185.291412] Dynamic subtest bcs0: SUCCESS (0.511s)
[185.302384] Starting dynamic subtest: vcs0
[185.804475] Dynamic subtest vcs0: SUCCESS (0.511s)
[185.815976] Starting dynamic subtest: vcs1
[186.317412] Dynamic subtest vcs1: SUCCESS (0.512s)
[186.329054] Starting dynamic subtest: vecs0
[186.830755] Dynamic subtest vecs0: SUCCESS (0.511s)
[186.845710] Starting dynamic subtest: ccs0
[187.344743] Dynamic subtest ccs0: SUCCESS (0.513s)
[187.347350] Subtest semaphore-wait-idle: SUCCESS (3.080s)
[187.458355] [023/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[187.558961] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[194.949731] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.393s)
[195.094260] [024/133] (870s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[195.204612] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[195.209053] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[195.288239] [025/133] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[195.385181] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[195.389627] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[195.470725] [026/133] (869s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[195.535716] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[195.605432] [027/133] (869s left) kms_psr (pr-sprite-blt)
[195.697840] Starting subtest: pr-sprite-blt
[195.701900] Subtest pr-sprite-blt: SKIP (0.000s)
[195.767331] [028/133] (869s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[195.896997] Starting subtest: flip-vs-cursor-busy-crc-atomic
[196.762919] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.863s)
[197.620058] [029/133] (867s left) kms_psr (psr2-dpms)
[197.718562] Starting subtest: psr2-dpms
[197.720672] Starting dynamic subtest: eDP-1
[200.546798] Dynamic subtest eDP-1: SUCCESS (2.827s)
[200.549127] Subtest psr2-dpms: SUCCESS (2.828s)
[201.439589] [030/133] (864s left) syncobj_wait (single-wait-all-signaled)
[201.490413] Starting subtest: single-wait-all-signaled
[201.492451] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[201.587603] [031/133] (863s left) gem_render_copy_redux (interruptible)
[201.642870] Starting subtest: interruptible
[201.904604] Subtest interruptible: SUCCESS (0.264s)
[202.029885] [032/133] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[202.136727] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[202.141185] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[202.233255] [033/133] (863s left) i915_pm_freq_api (freq-basic-api)
[202.289510] Starting subtest: freq-basic-api
[202.291694] Starting dynamic subtest: gt0
[202.293865] Dynamic subtest gt0: SUCCESS (0.003s)
[202.301914] Starting dynamic subtest: gt1
[202.304121] Dynamic subtest gt1: SUCCESS (0.002s)
[202.306183] Subtest freq-basic-api: SUCCESS (0.006s)
[202.403965] [034/133] (863s left) gem_exercise_blt (fast-copy)
[202.467981] Starting subtest: fast-copy
[202.470141] Starting dynamic subtest: linear-smem-smem
[202.491720] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[202.503741] Starting dynamic subtest: xmajor-smem-smem
[202.508481] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[202.516190] Starting dynamic subtest: tile4-smem-smem
[202.525707] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[202.533456] Starting dynamic subtest: tile64-smem-smem
[202.543412] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[202.545351] Subtest fast-copy: SUCCESS (0.076s)
[202.645776] [035/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[202.734207] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[202.737724] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[202.823681] [036/133] (862s left) gem_partial_pwrite_pread (reads-display)
[202.886160] Subtest reads-display: SKIP (0.000s)
[202.958566] [037/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[203.042160] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[203.045696] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[203.151420] [038/133] (862s left) gem_ctx_param (basic-default)
[203.203436] Starting subtest: basic-default
[203.205679] Subtest basic-default: SUCCESS (0.000s)
[203.271857] [039/133] (862s left) gem_exec_balancer (parallel)
[203.538640] Starting subtest: parallel
[204.497397] Subtest parallel: SUCCESS (0.959s)
[204.925187] [040/133] (860s left) gem_create (create-ext-set-pat)
[205.089969] Starting subtest: create-ext-set-pat
[205.092980] Subtest create-ext-set-pat: SUCCESS (0.001s)
[205.182523] [041/133] (860s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[205.278733] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[205.281707] Starting dynamic subtest: pipe-A-default-mode
[206.405708] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[206.410717] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.131s)
[206.566373] [042/133] (859s left) gem_exec_reloc (basic-gtt-cpu-active)
[206.630733] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[206.691611] [043/133] (859s left) perf (rc6-disable)
[206.815360] Starting subtest: rc6-disable
[206.987416] Subtest rc6-disable: SUCCESS (0.173s)
[207.029264] [044/133] (859s left) gem_mmap_offset (clear-via-pagefault)
[207.077314] Starting subtest: clear-via-pagefault
[207.079644] Starting dynamic subtest: smem0
[240.893845] Dynamic subtest smem0: SUCCESS (33.810s)
[240.896392] Subtest clear-via-pagefault: SUCCESS (33.811s)
[240.998179] [045/133] (825s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[241.102175] Starting subtest: psr-dirtyfb-ioctl
[241.104122] Starting dynamic subtest: A-eDP-1
[244.980637] Dynamic subtest A-eDP-1: SUCCESS (3.879s)
[244.983054] Subtest psr-dirtyfb-ioctl: SUCCESS (3.880s)
[245.777850] [046/133] (820s left) kms_lease (lease-unleased-crtc)
[245.878784] Starting subtest: lease-unleased-crtc
[245.881173] Starting dynamic subtest: pipe-A-eDP-1
[246.174165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[246.183811] Starting dynamic subtest: pipe-B-eDP-1
[246.935868] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[246.945664] Starting dynamic subtest: pipe-C-eDP-1
[246.948039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[246.956657] Starting dynamic subtest: pipe-D-eDP-1
[246.958636] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[246.960544] Subtest lease-unleased-crtc: SUCCESS (1.074s)
[247.307154] [047/133] (818s left) gem_render_copy (yf-tiled)
[247.364483] Starting subtest: yf-tiled
[247.369512] Subtest yf-tiled: SKIP (0.000s)
[247.560933] [048/133] (818s left) i915_suspend (sysfs-reader)
[247.616816] Starting subtest: sysfs-reader
[266.044246] Subtest sysfs-reader: SUCCESS (3.215s)
[266.122339] [049/133] (800s left) gem_render_linear_blits (basic)
[266.201971] Starting subtest: basic
[266.224345] Subtest basic: SUCCESS (0.022s)
[266.308487] [050/133] (800s left) gem_ctx_bad_destroy (invalid-pad)
[266.358214] Starting subtest: invalid-pad
[266.360085] Subtest invalid-pad: SUCCESS (0.000s)
[266.421270] [051/133] (799s left) gem_render_copy (y-tiled-ccs-to-linear)
[266.469485] Starting subtest: y-tiled-ccs-to-linear
[266.472973] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[266.655087] [052/133] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[266.766102] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[273.742768] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.895s)
[273.879048] [053/133] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[273.971075] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[280.531260] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.532s)
[280.653321] [054/133] (785s left) kms_cursor_edge_walk (128x128-right-edge)
[280.743066] Starting subtest: 128x128-right-edge
[280.745347] Starting dynamic subtest: pipe-A-eDP-1
[284.173714] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[284.184471] Starting dynamic subtest: pipe-D-eDP-1
[287.295087] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[287.297413] Subtest 128x128-right-edge: SUCCESS (6.536s)
[288.102370] [055/133] (778s left) kms_plane (plane-position-hole-dpms)
[288.200427] Starting subtest: plane-position-hole-dpms
[288.734706] Starting dynamic subtest: pipe-A-plane-1
[291.112091] Dynamic subtest pipe-A-plane-1: SUCCESS (2.376s)
[291.122474] Starting dynamic subtest: pipe-A-plane-2
[293.573488] Dynamic subtest pipe-A-plane-2: SUCCESS (2.456s)
[293.583569] Starting dynamic subtest: pipe-A-plane-3
[295.963457] Dynamic subtest pipe-A-plane-3: SUCCESS (2.388s)
[295.973824] Starting dynamic subtest: pipe-A-plane-4
[298.429971] Dynamic subtest pipe-A-plane-4: SUCCESS (2.467s)
[298.440755] Starting dynamic subtest: pipe-A-plane-5
[298.460697] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[299.683072] Starting dynamic subtest: pipe-B-plane-1
[302.126909] Dynamic subtest pipe-B-plane-1: SUCCESS (2.451s)
[302.146752] Starting dynamic subtest: pipe-B-plane-2
[304.537772] Dynamic subtest pipe-B-plane-2: SUCCESS (2.411s)
[304.548071] Starting dynamic subtest: pipe-B-plane-3
[306.909022] Dynamic subtest pipe-B-plane-3: SUCCESS (2.373s)
[306.919898] Starting dynamic subtest: pipe-B-plane-4
[309.270325] Dynamic subtest pipe-B-plane-4: SUCCESS (2.359s)
[309.280697] Starting dynamic subtest: pipe-B-plane-5
[309.293317] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[309.295540] Subtest plane-position-hole-dpms: SUCCESS (21.087s)
[310.073304] [056/133] (756s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[310.193873] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[317.544951] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.352s)
[317.677357] [057/133] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[317.768915] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[317.772992] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[317.861671] [058/133] (748s left) gem_softpin (full)
[317.929931] Starting subtest: full
[317.934748] Subtest full: SUCCESS (0.008s)
[318.059774] [059/133] (748s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[318.450005] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[319.231675] [060/133] (747s left) kms_dsc (dsc-fractional-bpp)
[319.331613] Starting subtest: dsc-fractional-bpp
[319.344271] Subtest dsc-fractional-bpp: SKIP (0.000s)
[319.415040] [061/133] (747s left) gem_exec_parallel (userptr)
[319.469904] Starting subtest: userptr
[319.472272] Starting dynamic subtest: rcs0
[320.904257] Dynamic subtest rcs0: SUCCESS (1.434s)
[320.913750] Starting dynamic subtest: bcs0
[322.391257] Dynamic subtest bcs0: SUCCESS (1.485s)
[322.401114] Starting dynamic subtest: vcs0
[324.088530] Dynamic subtest vcs0: SUCCESS (1.694s)
[324.097976] Starting dynamic subtest: vcs1
[326.073858] Dynamic subtest vcs1: SUCCESS (1.981s)
[326.085323] Starting dynamic subtest: vecs0
[328.120885] Dynamic subtest vecs0: SUCCESS (2.043s)
[328.132635] Starting dynamic subtest: ccs0
[329.614474] Dynamic subtest ccs0: SUCCESS (1.492s)
[329.616829] Subtest userptr: SUCCESS (10.143s)
[329.805305] [062/133] (736s left) gem_ctx_exec (basic)
[329.861487] Starting subtest: basic
[329.870594] Subtest basic: SUCCESS (0.010s)
[329.982305] [063/133] (736s left) gem_exec_schedule (submit-late-slice)
[330.045639] Starting subtest: submit-late-slice
[330.047806] Starting dynamic subtest: rcs0
[330.094108] Dynamic subtest rcs0: SUCCESS (0.054s)
[330.106335] Starting dynamic subtest: bcs0
[330.147659] Dynamic subtest bcs0: SUCCESS (0.052s)
[330.158130] Starting dynamic subtest: vcs0
[330.202265] Dynamic subtest vcs0: SUCCESS (0.055s)
[330.213628] Starting dynamic subtest: vcs1
[330.245307] Dynamic subtest vcs1: SUCCESS (0.041s)
[330.255155] Starting dynamic subtest: vecs0
[330.295699] Dynamic subtest vecs0: SUCCESS (0.049s)
[330.307403] Starting dynamic subtest: ccs0
[330.348624] Dynamic subtest ccs0: SUCCESS (0.052s)
[330.350984] Subtest submit-late-slice: SUCCESS (0.309s)
[332.174059] [064/133] (734s left) gem_exec_schedule (preempt-contexts)
[332.250776] Starting subtest: preempt-contexts
[332.252999] Starting dynamic subtest: rcs0
[332.337436] Dynamic subtest rcs0: SUCCESS (0.098s)
[332.348345] Starting dynamic subtest: bcs0
[332.428902] Dynamic subtest bcs0: SUCCESS (0.090s)
[332.439789] Starting dynamic subtest: vcs0
[332.497859] Dynamic subtest vcs0: SUCCESS (0.068s)
[332.507901] Starting dynamic subtest: vcs1
[332.558966] Dynamic subtest vcs1: SUCCESS (0.059s)
[332.569406] Starting dynamic subtest: vecs0
[332.621526] Dynamic subtest vecs0: SUCCESS (0.063s)
[332.631895] Starting dynamic subtest: ccs0
[332.712578] Dynamic subtest ccs0: SUCCESS (0.090s)
[332.714747] Subtest preempt-contexts: SUCCESS (0.474s)
[334.164310] [065/133] (732s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[334.214714] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[334.273815] [066/133] (732s left) gem_exec_reloc (basic-write-read-noreloc)
[334.331840] Subtest basic-write-read-noreloc: SKIP (0.000s)
[334.395901] [067/133] (732s left) kms_addfb_basic (master-rmfb)
[334.451448] Starting subtest: master-rmfb
[334.453330] Subtest master-rmfb: SUCCESS (0.001s)
[334.594821] [068/133] (732s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[334.691734] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[335.516368] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[335.712431] [069/133] (731s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[335.801169] Starting subtest: nonblocking-crc-frame-sequence
[335.803600] Starting dynamic subtest: pipe-A-eDP-1
[336.574764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[336.588159] Starting dynamic subtest: pipe-B-eDP-1
[337.973837] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[337.985075] Starting dynamic subtest: pipe-C-eDP-1
[339.349818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[339.360154] Starting dynamic subtest: pipe-D-eDP-1
[340.714856] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[340.717242] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.912s)
[341.515661] [070/133] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[341.613036] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[341.617070] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[341.722080] [071/133] (725s left) kms_color (ctm-signed)
[341.807513] Starting subtest: ctm-signed
[341.809696] Starting dynamic subtest: pipe-A-eDP-1
[343.904819] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s)
[343.914904] Starting dynamic subtest: pipe-B-eDP-1
[346.798995] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.892s)
[346.809106] Starting dynamic subtest: pipe-C-eDP-1
[349.489349] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.691s)
[349.504236] Starting dynamic subtest: pipe-D-eDP-1
[352.141947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s)
[352.144218] Subtest ctm-signed: SUCCESS (10.333s)
[352.966696] [072/133] (714s left) gem_exec_alignment (forked)
[353.037209] Starting subtest: forked
[393.442578] Subtest forked: SUCCESS (40.406s)
[394.422814] [073/133] (672s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[394.570153] Starting subtest: 4-tiled-32bpp-rotate-90
[394.591518] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[394.692310] [074/133] (672s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[394.792125] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[394.796593] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[394.888377] [075/133] (672s left) syncobj_wait (invalid-wait-bad-flags)
[394.959374] Starting subtest: invalid-wait-bad-flags
[394.962011] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[395.049896] [076/133] (672s left) sw_sync (sync_multi_timeline_wait)
[395.094603] Starting subtest: sync_multi_timeline_wait
[395.096940] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[395.146556] [077/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[395.238301] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[395.242287] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[395.340561] [078/133] (672s left) gem_exec_fence (basic-busy)
[395.521444] Starting subtest: basic-busy
[395.523889] Starting dynamic subtest: rcs0
[395.603606] Dynamic subtest rcs0: SUCCESS (0.082s)
[395.615565] Starting dynamic subtest: bcs0
[395.668934] Dynamic subtest bcs0: SUCCESS (0.063s)
[395.681079] Starting dynamic subtest: vcs0
[395.733460] Dynamic subtest vcs0: SUCCESS (0.062s)
[395.746058] Starting dynamic subtest: vcs1
[395.791785] Dynamic subtest vcs1: SUCCESS (0.056s)
[395.803834] Starting dynamic subtest: vecs0
[395.849737] Dynamic subtest vecs0: SUCCESS (0.056s)
[395.861247] Starting dynamic subtest: ccs0
[395.902224] Dynamic subtest ccs0: SUCCESS (0.050s)
[395.904865] Subtest basic-busy: SUCCESS (0.382s)
[398.228245] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[398.231935] [079/133] (669s left) kms_async_flips (invalid-async-flip)
[398.327862] Starting subtest: invalid-async-flip
[398.720360] Starting dynamic subtest: pipe-A-eDP-1
[399.511786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s)
[399.875463] Starting dynamic subtest: pipe-B-eDP-1
[400.654352] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[401.015331] Starting dynamic subtest: pipe-C-eDP-1
[401.776510] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[402.134596] Starting dynamic subtest: pipe-D-eDP-1
[402.903834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[402.906145] Subtest invalid-async-flip: SUCCESS (4.579s)
[404.060313] [080/133] (663s left) kms_psr2_su (frontbuffer-xrgb8888)
[404.120094] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[404.187139] [081/133] (663s left) syncobj_timeline (etime-single-wait-submitted)
[404.244474] Starting subtest: etime-single-wait-submitted
[404.349681] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[404.439986] [082/133] (663s left) gem_exec_reloc (basic-cpu-wc-active)
[404.502903] Subtest basic-cpu-wc-active: SKIP (0.000s)
[404.575459] [083/133] (663s left) kms_flip (2x-flip-vs-panning-interruptible)
[404.669771] Starting subtest: 2x-flip-vs-panning-interruptible
[404.681934] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[404.762293] [084/133] (662s left) i915_pm_freq_mult (media-freq)
[404.824279] Starting subtest: media-freq
[404.826418] Starting dynamic subtest: gt0
[404.830748] Dynamic subtest gt0: SKIP (0.000s)
[404.841185] Starting dynamic subtest: gt1
[404.845442] Dynamic subtest gt1: SKIP (0.000s)
[404.849587] Subtest media-freq: SKIP (0.002s)
[404.939556] [085/133] (662s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[405.067817] Starting subtest: cursorA-vs-flipB-varying-size
[405.072600] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[405.268158] [086/133] (662s left) kms_pm_rpm (modeset-lpsp)
[407.222439] Starting subtest: modeset-lpsp
[408.700246] Subtest modeset-lpsp: SUCCESS (1.479s)
[408.802191] [087/133] (659s left) gem_exec_whisper (basic-fds-all)
[408.881126] Starting subtest: basic-fds-all
[420.156495] Subtest basic-fds-all: SUCCESS (11.270s)
[420.345474] [088/133] (647s left) fbdev (nullptr)
[420.391861] Starting subtest: nullptr
[420.394118] Subtest nullptr: SUCCESS (0.000s)
[420.453744] [089/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[420.555914] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[427.713002] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.157s)
[427.850664] [090/133] (640s left) gem_userptr_blits (nohangcheck)
[427.930825] Starting subtest: nohangcheck
[428.189363] Subtest nohangcheck: SUCCESS (0.255s)
[428.298544] [091/133] (639s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[428.393125] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[428.395448] Starting dynamic subtest: pipe-A-eDP-1
[428.417595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.428152] Starting dynamic subtest: pipe-B-eDP-1
[428.449642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.459480] Starting dynamic subtest: pipe-C-eDP-1
[428.481027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.490971] Starting dynamic subtest: pipe-D-eDP-1
[428.512770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.516772] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[430.660920] [092/133] (637s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[431.067552] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[431.878897] [093/133] (636s left) perf (blocking)
[431.975030] Starting subtest: blocking
[431.977492] Starting dynamic subtest: 0-rcs0
[441.990468] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[442.002589] Starting dynamic subtest: 1-vecs0
[452.014365] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[452.017026] Subtest blocking: SUCCESS (20.033s)
[452.065332] [094/133] (616s left) kms_psr (psr-primary-mmap-gtt)
[452.168971] Starting subtest: psr-primary-mmap-gtt
[452.171508] Starting dynamic subtest: eDP-1
[453.606561] Dynamic subtest eDP-1: SKIP (1.436s)
[453.611208] Subtest psr-primary-mmap-gtt: SKIP (1.438s)
[453.790192] [095/133] (614s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[453.885094] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[453.887292] Starting dynamic subtest: pipe-A-eDP-1
[454.752431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s)
[454.764144] Starting dynamic subtest: pipe-B-eDP-1
[456.342157] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.585s)
[456.354131] Starting dynamic subtest: pipe-C-eDP-1
[457.886050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s)
[457.902441] Starting dynamic subtest: pipe-D-eDP-1
[459.466093] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.578s)
[459.467954] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.572s)
[460.671379] [096/133] (607s left) gem_exec_params (no-vebox)
[460.726900] Starting subtest: no-vebox
[460.729193] Subtest no-vebox: SUCCESS (0.002s)
[462.186225] [097/133] (606s left) kms_pm_dc (dc5-psr)
[463.291136] Starting subtest: dc5-psr
[466.281321] Subtest dc5-psr: SUCCESS (2.989s)
[467.119784] [098/133] (601s left) gem_pread (self)
[467.180663] Subtest self: SKIP (0.000s)
[467.240317] [099/133] (601s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[467.343290] Starting subtest: yf-tiled-32bpp-rotate-90
[467.347752] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[467.441013] [100/133] (601s left) syncobj_eventfd (binary-wait)
[467.490859] Starting subtest: binary-wait
[467.500223] Subtest binary-wait: SUCCESS (0.011s)
[467.593499] [101/133] (600s left) kms_cursor_crc (cursor-size-hints)
[467.721176] Starting subtest: cursor-size-hints
[467.723468] Starting dynamic subtest: pipe-A-eDP-1
[468.353495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s)
[468.364161] Starting dynamic subtest: pipe-D-eDP-1
[469.570700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[469.572882] Subtest cursor-size-hints: SUCCESS (1.848s)
[470.377716] [102/133] (598s left) kms_atomic_interruptible (legacy-cursor)
[470.465194] Starting subtest: legacy-cursor
[470.467445] Starting dynamic subtest: pipe-A-eDP-1
[477.902112] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[477.904564] Subtest legacy-cursor: SUCCESS (7.436s)
[478.742211] [103/133] (589s left) gem_render_copy (x-tiled)
[478.813226] Starting subtest: x-tiled
[478.815706] Starting dynamic subtest: smem
[478.864697] Dynamic subtest smem: SUCCESS (0.051s)
[478.867423] Subtest x-tiled: SUCCESS (0.051s)
[479.109522] [104/133] (589s left) gen9_exec_parse (basic-rejected)
[479.173875] Subtest basic-rejected: SKIP (0.000s)
[479.245329] [105/133] (589s left) core_sysfs (read-all-entries)
[479.293822] Starting subtest: read-all-entries
[479.299320] Subtest read-all-entries: SUCCESS (0.008s)
[479.405594] [106/133] (589s left) perf (gen12-unprivileged-single-ctx-counters)
[479.501645] Starting subtest: gen12-unprivileged-single-ctx-counters
[479.504105] Starting dynamic subtest: rcs0
[479.680969] Dynamic subtest rcs0: SUCCESS (0.179s)
[479.683320] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.181s)
[479.724399] [107/133] (589s left) kms_big_fb (linear-32bpp-rotate-90)
[479.849553] Starting subtest: linear-32bpp-rotate-90
[479.869009] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[479.995736] [108/133] (588s left) gem_ctx_persistence (legacy-engines-hostile)
[480.071689] Starting subtest: legacy-engines-hostile
[480.073301] Starting dynamic subtest: render
[480.202034] Dynamic subtest render: SUCCESS (0.132s)
[480.217210] Starting dynamic subtest: bsd1
[480.299688] Dynamic subtest bsd1: SUCCESS (0.095s)
[480.312861] Starting dynamic subtest: bsd2
[480.391691] Dynamic subtest bsd2: SUCCESS (0.089s)
[480.406263] Starting dynamic subtest: blt
[480.484879] Dynamic subtest blt: SUCCESS (0.090s)
[480.500361] Starting dynamic subtest: vebox
[480.561745] Dynamic subtest vebox: SUCCESS (0.073s)
[480.563840] Subtest legacy-engines-hostile: SUCCESS (0.493s)
[480.687662] [109/133] (588s left) perf_pmu (enable-race)
[480.725197] Starting subtest: enable-race
[480.727156] Starting dynamic subtest: rcs0
[493.493782] Dynamic subtest rcs0: SUCCESS (12.768s)
[493.508453] Starting dynamic subtest: bcs0
[506.240296] Dynamic subtest bcs0: SUCCESS (12.748s)
[506.251772] Starting dynamic subtest: vcs0
[522.104783] Dynamic subtest vcs0: SUCCESS (15.863s)
[522.116320] Starting dynamic subtest: vcs1
[538.104288] Dynamic subtest vcs1: SUCCESS (15.998s)
[538.115711] Starting dynamic subtest: vecs0
[554.105226] Dynamic subtest vecs0: SUCCESS (15.998s)
[554.116225] Starting dynamic subtest: ccs0
[566.851427] Dynamic subtest ccs0: SUCCESS (12.744s)
[566.853768] Subtest enable-race: SUCCESS (86.132s)
[566.951860] [110/133] (501s left) gem_softpin (32b-excludes-last-page)
[567.018448] Starting subtest: 32b-excludes-last-page
[567.023432] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[567.162010] [111/133] (501s left) api_intel_bb (purge-bb)
[567.214003] Starting subtest: purge-bb
[567.220233] Subtest purge-bb: SUCCESS (0.007s)
[567.345228] [112/133] (501s left) kms_sequence (queue-idle)
[567.442369] Starting subtest: queue-idle
[567.444539] Starting dynamic subtest: pipe-A-eDP-1
[569.256928] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[569.268437] Starting dynamic subtest: pipe-B-eDP-1
[571.711845] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.452s)
[571.723228] Starting dynamic subtest: pipe-C-eDP-1
[574.131200] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.416s)
[574.142209] Starting dynamic subtest: pipe-D-eDP-1
[576.571658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s)
[576.574047] Subtest queue-idle: SUCCESS (9.130s)
[577.384668] [113/133] (491s left) gem_exec_flush (basic-wb-rw-before-default)
[577.448866] Starting subtest: basic-wb-rw-before-default
[582.924097] Subtest basic-wb-rw-before-default: SUCCESS (5.475s)
[583.127449] [114/133] (485s left) syncobj_timeline (wait-for-submit-delayed-submit)
[583.187734] Starting subtest: wait-for-submit-delayed-submit
[583.291866] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[583.394590] [115/133] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[583.494863] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[583.499269] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[583.590860] [116/133] (485s left) kms_flip (flip-vs-panning-interruptible)
[583.678653] Starting subtest: flip-vs-panning-interruptible
[583.681022] Starting dynamic subtest: A-eDP1
[592.399455] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[592.412419] Starting dynamic subtest: B-eDP1
[601.130528] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[601.144299] Starting dynamic subtest: C-eDP1
[609.849110] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[609.861294] Starting dynamic subtest: D-eDP1
[618.573089] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[618.577634] Subtest flip-vs-panning-interruptible: SUCCESS (34.896s)
[619.749819] [117/133] (449s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[619.868445] Starting subtest: y-tiled-16bpp-rotate-90
[619.873008] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[619.976169] [118/133] (449s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[620.078718] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[620.082671] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[620.170847] [119/133] (449s left) kms_plane_multiple (2x-tiling-4)
[620.265893] Starting subtest: 2x-tiling-4
[620.270002] Subtest 2x-tiling-4: SKIP (0.000s)
[620.340361] [120/133] (448s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[620.436463] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[620.438795] Starting dynamic subtest: pipe-A-eDP-1
[620.496195] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[620.508244] Starting dynamic subtest: pipe-B-eDP-1
[620.565261] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[620.576623] Starting dynamic subtest: pipe-C-eDP-1
[620.633583] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[620.644602] Starting dynamic subtest: pipe-D-eDP-1
[620.696047] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[620.699638] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[622.701618] [121/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[622.801364] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[622.805584] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[622.924619] [122/133] (446s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[623.028432] Starting subtest: fbcpsr-slowdraw
[648.456893] Subtest fbcpsr-slowdraw: SUCCESS (25.426s)
[648.624291] [123/133] (420s left) kms_invalid_mode (clock-too-high)
[648.719944] Starting subtest: clock-too-high
[648.722306] Starting dynamic subtest: pipe-A-eDP-1
[648.726806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.737560] Starting dynamic subtest: pipe-B-eDP-1
[648.741888] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.752415] Starting dynamic subtest: pipe-C-eDP-1
[648.756508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.766354] Starting dynamic subtest: pipe-D-eDP-1
[648.770450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.774516] Subtest clock-too-high: SKIP (0.004s)
[648.815555] [124/133] (420s left) gem_exec_fence (submit)
[648.993057] Starting subtest: submit
[648.997658] Subtest submit: SKIP (0.000s)
[651.212630] [125/133] (418s left) kms_vblank (query-forked-busy-hang)
[651.333464] Starting subtest: query-forked-busy-hang
[651.335640] Starting dynamic subtest: pipe-A-eDP-1
[677.890242] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.551s)
[677.908176] Starting dynamic subtest: pipe-D-eDP-1
[702.852841] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[702.855255] Subtest query-forked-busy-hang: SUCCESS (51.511s)
[703.726277] [126/133] (365s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[703.828573] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[703.832761] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[703.932327] [127/133] (365s left) gem_userptr_blits (dmabuf-unsync)
[703.993857] Subtest dmabuf-unsync: SKIP (0.000s)
[704.124536] [128/133] (365s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[704.216161] Starting subtest: plane-upscale-20x20-with-pixel-format
[704.218453] Starting dynamic subtest: pipe-A
[705.263843] Dynamic subtest pipe-A: SUCCESS (1.050s)
[705.273708] Starting dynamic subtest: pipe-B
[707.421448] Dynamic subtest pipe-B: SUCCESS (2.156s)
[707.432192] Starting dynamic subtest: pipe-C
[708.624813] Dynamic subtest pipe-C: SUCCESS (1.202s)
[708.637290] Starting dynamic subtest: pipe-D
[709.846456] Dynamic subtest pipe-D: SUCCESS (1.219s)
[709.849017] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.632s)
[711.030565] [129/133] (358s left) kms_chamelium_color (ctm-max)
[711.125797] Subtest ctm-max: SKIP (0.000s)
[711.180463] [130/133] (358s left) gem_render_copy (y-tiled)
[711.238566] Starting subtest: y-tiled
[711.242524] Subtest y-tiled: SKIP (0.000s)
[711.428184] [131/133] (358s left) kms_psr (fbc-psr-primary-mmap-gtt)
[711.530360] Starting subtest: fbc-psr-primary-mmap-gtt
[711.532713] Starting dynamic subtest: eDP-1
[711.536900] Dynamic subtest eDP-1: SKIP (0.000s)
[711.541168] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[711.605653] [132/133] (358s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[711.716802] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[711.721260] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[711.826004] [133/133] (358s left) gem_exec_params (secure-non-master)
[711.883408] Starting subtest: secure-non-master
[711.887629] Subtest secure-non-master: SKIP (0.000s)
[711.993834] 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.