[105.998239] Initializing watchdogs
[105.998286]   /dev/watchdog0
[106.013659] [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]
[106.018240] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[106.020331] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[106.023596] [001/133] (960s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[106.158699] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[106.163432] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.002s)
[106.285965] [002/133] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[106.343670] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[106.394474] [003/133] (960s left) kms_vrr (negative-basic)
[106.497418] Starting subtest: negative-basic
[106.503967] Starting dynamic subtest: pipe-A-eDP-1
[111.948396] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.442s)
[112.248266] Subtest negative-basic: SUCCESS (5.751s)
[113.080737] [004/133] (953s left) gem_ctx_persistence (idempotent)
[113.144526] Starting subtest: idempotent
[113.146989] Subtest idempotent: SUCCESS (0.000s)
[113.264204] [005/133] (953s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[113.329105] Starting subtest: multi-wait-available-unsubmitted-submitted
[113.331267] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[113.452715] [006/133] (953s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[113.556238] Starting subtest: fbcpsr-tiling-4
[120.692857] Subtest fbcpsr-tiling-4: SUCCESS (7.140s)
[120.872680] [007/133] (945s left) i915_pm_rps (thresholds)
[120.941606] Starting subtest: thresholds
[120.945594] Subtest thresholds: SKIP (0.000s)
[121.051812] [008/133] (945s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[121.097493] Starting subtest: etime-multi-wait-all-for-submit-submitted
[121.202309] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[121.295655] [009/133] (945s left) kms_content_protection (lic-type-1)
[121.447075] Starting subtest: lic-type-1
[121.451855] Subtest lic-type-1: SKIP (0.000s)
[121.608680] [010/133] (945s left) api_intel_bb (object-reloc-purge-cache)
[121.667666] Starting subtest: object-reloc-purge-cache
[121.672066] Subtest object-reloc-purge-cache: SKIP (0.002s)
[121.771972] [011/133] (945s left) gem_linear_blits (basic)
[122.027150] Starting subtest: basic
[122.032802] Subtest basic: SUCCESS (0.006s)
[122.185839] [012/133] (944s left) kms_properties (crtc-properties-atomic)
[122.322501] Starting subtest: crtc-properties-atomic
[122.324876] Starting dynamic subtest: pipe-A-eDP-1
[122.811802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[122.820754] Starting dynamic subtest: pipe-B-eDP-1
[123.965552] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[123.974410] Starting dynamic subtest: pipe-C-eDP-1
[125.092842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[125.102067] Starting dynamic subtest: pipe-D-eDP-1
[126.233939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[126.236289] Subtest crtc-properties-atomic: SUCCESS (3.910s)
[127.055968] [013/133] (939s left) gem_exec_params (invalid-ring)
[127.111679] Starting subtest: invalid-ring
[127.114061] Subtest invalid-ring: SUCCESS (0.000s)
[127.240061] [014/133] (939s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[127.333059] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[127.335377] Starting dynamic subtest: pipe-A
[127.680072] Dynamic subtest pipe-A: SUCCESS (0.349s)
[127.688342] Starting dynamic subtest: pipe-B
[129.046528] Dynamic subtest pipe-B: SUCCESS (1.366s)
[129.054682] Starting dynamic subtest: pipe-C
[130.482527] Dynamic subtest pipe-C: SUCCESS (1.435s)
[130.491591] Starting dynamic subtest: pipe-D
[131.916407] Dynamic subtest pipe-D: SUCCESS (1.433s)
[131.918636] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.586s)
[133.098973] [015/133] (933s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[133.202436] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[133.206650] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[133.325437] [016/133] (933s left) gem_exec_reloc (basic-cpu-gtt)
[133.403040] Subtest basic-cpu-gtt: SKIP (0.000s)
[133.484561] [017/133] (933s left) kms_rotation_crc (primary-rotation-90)
[133.581745] Starting subtest: primary-rotation-90
[133.585668] Subtest primary-rotation-90: SKIP (0.001s)
[133.663551] [018/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[133.777890] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[133.781719] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[133.900041] [019/133] (933s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[133.959749] Starting subtest: framebuffer-vs-set-tiling
[133.963785] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[134.127108] [020/133] (933s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[134.186808] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[134.251409] [021/133] (933s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[134.365300] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[134.368681] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[134.438073] [022/133] (932s left) syncobj_wait (wait-all-snapshot)
[134.493704] Starting subtest: wait-all-snapshot
[134.575043] Subtest wait-all-snapshot: SUCCESS (0.081s)
[134.654868] [023/133] (932s left) gem_mmap_gtt (big-copy-xy)
[134.710089] Subtest big-copy-XY: SKIP (0.000s)
[134.775989] [024/133] (932s left) kms_sequence (get-busy)
[134.881135] Starting subtest: get-busy
[134.883195] Starting dynamic subtest: pipe-A-eDP-1
[136.832309] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[136.846590] Starting dynamic subtest: pipe-B-eDP-1
[139.370675] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.536s)
[139.379508] Starting dynamic subtest: pipe-C-eDP-1
[141.992504] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s)
[142.002105] Starting dynamic subtest: pipe-D-eDP-1
[144.537507] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[144.539604] Subtest get-busy: SUCCESS (9.655s)
[145.356425] [025/133] (922s left) gem_exec_await (wide-all)
[145.569023] Starting subtest: wide-all
[168.572888] Subtest wide-all: SUCCESS (23.003s)
[168.776289] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[168.780113] [026/133] (898s left) gem_exec_suspend (basic-s3)
[168.885076] Starting subtest: basic-S3
[168.887099] Starting dynamic subtest: smem
[189.575252] Dynamic subtest smem: SUCCESS (7.008s)
[189.578401] Subtest basic-S3: SUCCESS (7.010s)
[189.780335] [027/133] (877s left) gem_exec_balancer (parallel)
[190.058645] Starting subtest: parallel
[190.972408] Subtest parallel: SUCCESS (0.912s)
[191.608945] [028/133] (875s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[191.674704] Starting subtest: invalid-signal-one-illegal-handle
[191.677701] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[191.809204] [029/133] (875s left) prime_vgem (fence-wait)
[191.895620] Starting subtest: fence-wait
[191.898268] Starting dynamic subtest: rcs0
[192.948331] Dynamic subtest rcs0: SUCCESS (1.052s)
[192.960619] Starting dynamic subtest: bcs0
[194.034729] Dynamic subtest bcs0: SUCCESS (1.084s)
[194.045839] Starting dynamic subtest: vcs0
[195.079428] Dynamic subtest vcs0: SUCCESS (1.043s)
[195.091149] Starting dynamic subtest: vcs1
[196.120557] Dynamic subtest vcs1: SUCCESS (1.039s)
[196.132718] Starting dynamic subtest: vecs0
[197.163874] Dynamic subtest vecs0: SUCCESS (1.041s)
[197.175520] Starting dynamic subtest: ccs0
[198.205704] Dynamic subtest ccs0: SUCCESS (1.041s)
[198.208370] Subtest fence-wait: SUCCESS (6.306s)
[198.349877] [030/133] (869s left) gem_bad_reloc (negative-reloc)
[198.399341] Subtest negative-reloc: SKIP (0.000s)
[198.481484] [031/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[198.596745] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[198.602189] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[198.715680] [032/133] (868s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[198.814271] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[199.694745] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.881s)
[199.878177] [033/133] (867s left) gem_render_copy (yf-tiled)
[199.947080] Starting subtest: yf-tiled
[199.952718] Subtest yf-tiled: SKIP (0.000s)
[200.157183] [034/133] (867s left) perf_pmu (render-node-busy)
[200.232974] Starting subtest: render-node-busy
[200.235651] Starting dynamic subtest: rcs0
[200.808859] Dynamic subtest rcs0: SUCCESS (0.575s)
[200.820863] Starting dynamic subtest: bcs0
[201.378929] Dynamic subtest bcs0: SUCCESS (0.568s)
[201.391414] Starting dynamic subtest: vcs0
[202.566477] Dynamic subtest vcs0: SUCCESS (1.185s)
[202.578674] Starting dynamic subtest: vcs1
[204.615208] Dynamic subtest vcs1: SUCCESS (2.046s)
[204.626647] Starting dynamic subtest: vecs0
[206.598517] Dynamic subtest vecs0: SUCCESS (1.981s)
[206.610509] Starting dynamic subtest: ccs0
[207.172025] Dynamic subtest ccs0: SUCCESS (0.573s)
[207.175000] Subtest render-node-busy: SUCCESS (6.937s)
[207.261745] [035/133] (860s left) api_intel_allocator (fork-simple-once)
[207.329195] Starting subtest: fork-simple-once
[207.346595] Subtest fork-simple-once: SUCCESS (0.020s)
[207.504056] [036/133] (860s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[207.619530] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[207.624532] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[207.727437] [037/133] (860s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[207.830649] Starting subtest: psr-rgb565-draw-render
[214.915451] Subtest psr-rgb565-draw-render: SUCCESS (7.087s)
[215.063954] [038/133] (852s left) gem_exec_fence (syncobj-timeline-repeat)
[215.603046] Starting subtest: syncobj-timeline-repeat
[215.857045] Subtest syncobj-timeline-repeat: SUCCESS (0.254s)
[216.655718] [039/133] (851s left) gem_exec_reloc (basic-range-active)
[216.726576] Subtest basic-range-active: SKIP (0.000s)
[216.786597] [040/133] (851s left) gem_mmap_gtt (basic-small-copy)
[216.847188] Subtest basic-small-copy: SKIP (0.000s)
[216.915190] [041/133] (851s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[217.304182] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[218.083410] [042/133] (850s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[218.181984] Starting subtest: fbc-rgb101010-draw-blt
[222.844542] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.668s)
[224.018041] [043/133] (844s left) kms_psr (fbc-psr2-no-drrs)
[224.117310] Starting subtest: fbc-psr2-no-drrs
[224.119572] Starting dynamic subtest: eDP-1
[224.124535] Dynamic subtest eDP-1: SKIP (0.000s)
[224.129549] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[224.203592] [044/133] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[224.303228] Starting subtest: psr-2p-primscrn-cur-indfb-move
[224.308276] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[224.418591] [045/133] (843s left) kms_vblank (wait-forked-hang)
[224.517408] Starting subtest: wait-forked-hang
[224.519483] Starting dynamic subtest: pipe-A-eDP-1
[251.342306] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.823s)
[251.358252] Starting dynamic subtest: pipe-D-eDP-1
[276.361268] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s)
[276.363717] Subtest wait-forked-hang: SUCCESS (51.841s)
[277.192069] [046/133] (791s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[277.421146] Starting subtest: cursor-rapid-movement-128x42
[277.465977] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[277.724773] [047/133] (790s left) syncobj_wait (wait-for-submit-delayed-submit)
[277.789155] Starting subtest: wait-for-submit-delayed-submit
[277.891540] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[277.977988] [048/133] (790s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[278.073428] Starting subtest: plane-use-after-nonblocking-unbind
[278.076103] Starting dynamic subtest: pipe-A-eDP-1
[278.133399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[278.426977] Starting dynamic subtest: pipe-B-eDP-1
[279.180338] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[279.479370] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.408s)
[280.343608] [049/133] (788s left) gem_softpin (allocator-evict)
[280.404951] Starting subtest: allocator-evict
[280.407538] Starting dynamic subtest: rcs0
[303.612589] Dynamic subtest rcs0: SUCCESS (23.210s)
[303.624260] Starting dynamic subtest: bcs0
[327.736186] Dynamic subtest bcs0: SUCCESS (24.122s)
[327.748100] Starting dynamic subtest: vcs0
[351.472635] Dynamic subtest vcs0: SUCCESS (23.733s)
[351.484979] Starting dynamic subtest: vcs1
[374.976496] Dynamic subtest vcs1: SUCCESS (23.501s)
[374.989049] Starting dynamic subtest: vecs0
[398.654450] Dynamic subtest vecs0: SUCCESS (23.675s)
[398.664489] Starting dynamic subtest: ccs0
[422.803398] Dynamic subtest ccs0: SUCCESS (24.146s)
[422.806397] Subtest allocator-evict: SUCCESS (142.395s)
[422.903718] [050/133] (645s left) kms_pm_rpm (cursor-dpms)
[424.713822] Starting subtest: cursor-dpms
[424.719505] Subtest cursor-dpms: SKIP (0.000s)
[425.268774] [051/133] (643s left) gem_exec_gttfill (engines)
[425.332521] Starting subtest: engines
[425.335422] Starting dynamic subtest: rcs0
[447.908493] Dynamic subtest rcs0: SUCCESS (22.575s)
[447.920348] Starting dynamic subtest: bcs0
[471.184293] Dynamic subtest bcs0: SUCCESS (23.272s)
[471.194304] Starting dynamic subtest: vcs0
[494.448880] Dynamic subtest vcs0: SUCCESS (23.263s)
[494.464862] Starting dynamic subtest: vcs1
[517.717271] Dynamic subtest vcs1: SUCCESS (23.266s)
[517.729206] Starting dynamic subtest: vecs0
[541.007887] Dynamic subtest vecs0: SUCCESS (23.284s)
[541.020881] Starting dynamic subtest: ccs0
[564.289732] Dynamic subtest ccs0: SUCCESS (23.279s)
[564.292900] Subtest engines: SUCCESS (138.950s)
[564.491357] [052/133] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[564.634477] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[564.639196] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[564.747391] [053/133] (503s left) gem_mmap_gtt (basic-read-write)
[564.819587] Subtest basic-read-write: SKIP (0.000s)
[564.884976] [054/133] (503s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[565.277312] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[566.055286] [055/133] (502s left) kms_rotation_crc (bad-tiling)
[566.153384] Starting subtest: bad-tiling
[566.158847] Subtest bad-tiling: SKIP (0.001s)
[566.242169] [056/133] (502s left) kms_psr (pr-primary-mmap-cpu)
[566.331513] Starting subtest: pr-primary-mmap-cpu
[566.336493] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[566.413501] [057/133] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[566.518986] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[572.893594] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.378s)
[573.007990] [058/133] (495s left) gem_exec_reloc (basic-write-cpu-noreloc)
[573.072605] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[573.158266] [059/133] (495s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[573.257221] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[579.866147] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.612s)
[580.021474] [060/133] (488s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[580.121008] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[580.125559] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[581.208510] [061/133] (487s left) kms_atomic_transition (modeset-transition-fencing)
[581.302476] Starting subtest: modeset-transition-fencing
[581.305448] Starting dynamic subtest: 1x-outputs
[592.141725] Dynamic subtest 1x-outputs: SUCCESS (10.838s)
[592.144701] Subtest modeset-transition-fencing: SUCCESS (10.839s)
[593.035893] [062/133] (475s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[593.145715] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[593.150625] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[593.269034] [063/133] (475s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[593.356915] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[593.359561] Starting dynamic subtest: pipe-A-eDP-1
[593.387083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[593.396680] Starting dynamic subtest: pipe-B-eDP-1
[593.425380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[593.434495] Starting dynamic subtest: pipe-C-eDP-1
[593.463533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[593.472752] Starting dynamic subtest: pipe-D-eDP-1
[593.502521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[593.507766] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[595.696050] [064/133] (473s left) gem_exec_params (invalid-bsd-ring)
[595.772836] Starting subtest: invalid-bsd-ring
[595.775717] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[595.884809] [065/133] (473s left) gem_ctx_param (invalid-ctx-get)
[595.946061] Starting subtest: invalid-ctx-get
[595.948770] Subtest invalid-ctx-get: SUCCESS (0.000s)
[596.033762] [066/133] (473s left) gen9_exec_parse (secure-batches)
[596.102544] Subtest secure-batches: SKIP (0.000s)
[596.187756] [067/133] (472s left) gem_eio (wait-10ms)
[596.413584] Starting subtest: wait-10ms
[596.756531] Subtest wait-10ms: SUCCESS (0.343s)
[596.918915] [068/133] (472s left) i915_drm_fdinfo (memory-info-shared)
[596.955271] Starting subtest: memory-info-shared
[596.957534] Starting dynamic subtest: smem0
[597.039980] Dynamic subtest smem0: SUCCESS (0.085s)
[597.042700] Subtest memory-info-shared: SUCCESS (0.085s)
[597.128011] [069/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[597.245302] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[597.249725] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[597.368111] [070/133] (471s left) gem_ctx_engines (independent)
[597.427391] Starting subtest: independent
[597.429872] Starting dynamic subtest: rcs0
[597.580348] Dynamic subtest rcs0: SUCCESS (0.151s)
[597.593494] Starting dynamic subtest: bcs0
[597.726352] Dynamic subtest bcs0: SUCCESS (0.145s)
[597.737776] Starting dynamic subtest: vcs0
[597.869184] Dynamic subtest vcs0: SUCCESS (0.142s)
[597.879359] Starting dynamic subtest: vcs1
[598.040423] Dynamic subtest vcs1: SUCCESS (0.170s)
[598.051563] Starting dynamic subtest: vecs0
[598.184917] Dynamic subtest vecs0: SUCCESS (0.144s)
[598.194717] Starting dynamic subtest: ccs0
[598.335502] Dynamic subtest ccs0: SUCCESS (0.151s)
[598.349128] Starting dynamic subtest: all-engines
[599.193721] Dynamic subtest all-engines: SUCCESS (0.856s)
[599.196614] Subtest independent: SUCCESS (1.765s)
[599.714260] [071/133] (469s left) kms_invalid_mode (bad-htotal)
[599.817978] Starting subtest: bad-htotal
[599.820510] Starting dynamic subtest: pipe-A-eDP-1
[600.101092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[600.112023] Starting dynamic subtest: pipe-B-eDP-1
[600.114572] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[600.123702] Starting dynamic subtest: pipe-C-eDP-1
[600.126479] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[600.135699] Starting dynamic subtest: pipe-D-eDP-1
[600.138718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[600.141498] Subtest bad-htotal: SUCCESS (0.290s)
[600.927381] [072/133] (468s left) kms_big_fb (linear-addfb)
[601.033912] Starting subtest: linear-addfb
[601.036577] Subtest linear-addfb: SUCCESS (0.000s)
[601.167145] [073/133] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[601.269137] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[601.273701] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[601.398130] [074/133] (468s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[601.461552] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[601.467704] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[601.657475] [075/133] (467s left) kms_color (ctm-signed)
[601.743466] Starting subtest: ctm-signed
[601.745939] Starting dynamic subtest: pipe-A-eDP-1
[603.802625] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[603.812376] Starting dynamic subtest: pipe-B-eDP-1
[606.584731] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.782s)
[606.595836] Starting dynamic subtest: pipe-C-eDP-1
[609.279742] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.694s)
[609.290430] Starting dynamic subtest: pipe-D-eDP-1
[611.947069] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.667s)
[611.949807] Subtest ctm-signed: SUCCESS (10.205s)
[612.793230] [076/133] (456s left) gem_exec_whisper (basic-queues-priority)
[612.868619] Starting subtest: basic-queues-priority
[635.562531] Subtest basic-queues-priority: SUCCESS (22.688s)
[635.758636] [077/133] (433s left) kms_pipe_crc_basic (nonblocking-crc)
[635.863305] Starting subtest: nonblocking-crc
[635.865426] Starting dynamic subtest: pipe-A-eDP-1
[636.589717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[636.600753] Starting dynamic subtest: pipe-B-eDP-1
[638.000011] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[638.010846] Starting dynamic subtest: pipe-C-eDP-1
[639.350464] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[639.360266] Starting dynamic subtest: pipe-D-eDP-1
[640.689616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[640.692158] Subtest nonblocking-crc: SUCCESS (4.826s)
[641.503816] [078/133] (428s left) gem_vm_create (invalid-destroy)
[641.575175] Starting subtest: invalid-destroy
[641.577849] Subtest invalid-destroy: SUCCESS (0.002s)
[641.708485] [079/133] (427s left) kms_feature_discovery (psr2)
[641.808362] Starting subtest: psr2
[641.810986] Subtest psr2: SUCCESS (0.000s)
[641.893161] [080/133] (427s left) syncobj_timeline (wait-all-for-submit-complex)
[641.958535] Starting subtest: wait-all-for-submit-complex
[642.175693] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[642.262943] [081/133] (427s left) gem_exec_balancer (smoke)
[642.320501] Starting subtest: smoke
[664.900805] Subtest smoke: SUCCESS (22.576s)
[666.715231] [082/133] (403s left) gem_mmap_gtt (medium-copy-odd)
[666.770341] Subtest medium-copy-odd: SKIP (0.000s)
[666.837903] [083/133] (403s left) kms_flip (2x-blocking-wf_vblank)
[666.945451] Starting subtest: 2x-blocking-wf_vblank
[666.954006] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[667.080736] [084/133] (402s left) dumb_buffer (map-invalid-size)
[667.137499] Starting subtest: map-invalid-size
[667.140566] Subtest map-invalid-size: SUCCESS (0.000s)
[667.262037] [085/133] (402s left) gem_exec_schedule (u-semaphore-user)
[667.334269] Starting subtest: u-semaphore-user
[667.379700] Subtest u-semaphore-user: SUCCESS (0.058s)
[668.667242] [086/133] (401s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[670.714711] Starting subtest: modeset-non-lpsp-stress-no-wait
[670.773140] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.056s)
[671.127796] [087/133] (398s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[671.248453] Starting subtest: cursorA-vs-flipA-varying-size
[682.380388] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.131s)
[683.249053] [088/133] (386s left) syncobj_wait (wait-zero-handles)
[683.315714] Starting subtest: wait-zero-handles
[683.318524] Subtest wait-zero-handles: SUCCESS (0.000s)
[683.436199] [089/133] (386s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[683.529176] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[683.554613] Starting dynamic subtest: pipe-A-plane-0
[683.843386] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[683.853693] Starting dynamic subtest: pipe-A-plane-3
[684.078512] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[684.087583] Starting dynamic subtest: pipe-A-plane-5
[684.092364] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[685.232768] Starting dynamic subtest: pipe-B-plane-0
[685.525215] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[685.535627] Starting dynamic subtest: pipe-B-plane-3
[685.769421] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[685.778966] Starting dynamic subtest: pipe-B-plane-5
[685.783438] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[686.082536] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.551s)
[686.916835] [090/133] (383s left) kms_psr (psr-no-drrs)
[687.015256] Starting subtest: psr-no-drrs
[687.017633] Starting dynamic subtest: eDP-1
[688.582721] Dynamic subtest eDP-1: SUCCESS (1.568s)
[688.585506] Subtest psr-no-drrs: SUCCESS (1.569s)
[689.478795] [091/133] (380s left) kms_legacy_colorkey (basic)
[689.573526] Starting subtest: basic
[689.576327] Starting dynamic subtest: pipe-A
[689.616182] Dynamic subtest pipe-A: SUCCESS (0.045s)
[689.629123] Starting dynamic subtest: pipe-B
[689.631332] Dynamic subtest pipe-B: SUCCESS (0.000s)
[689.641556] Starting dynamic subtest: pipe-C
[689.644461] Dynamic subtest pipe-C: SUCCESS (0.000s)
[689.655349] Starting dynamic subtest: pipe-D
[689.657731] Dynamic subtest pipe-D: SUCCESS (0.000s)
[689.659967] Subtest basic: SUCCESS (0.049s)
[689.698141] [092/133] (380s left) gem_ctx_shared (q-smoketest)
[689.776526] Starting subtest: Q-smoketest
[689.779364] Starting dynamic subtest: rcs0
[695.348562] Dynamic subtest rcs0: SUCCESS (5.516s)
[695.364733] Starting dynamic subtest: bcs0
[700.830159] Dynamic subtest bcs0: SUCCESS (5.481s)
[700.846408] Starting dynamic subtest: vcs0
[706.327431] Dynamic subtest vcs0: SUCCESS (5.495s)
[706.339082] Starting dynamic subtest: vcs1
[711.825177] Dynamic subtest vcs1: SUCCESS (5.500s)
[711.836972] Starting dynamic subtest: vecs0
[717.311857] Dynamic subtest vecs0: SUCCESS (5.474s)
[717.324408] Starting dynamic subtest: ccs0
[722.821603] Dynamic subtest ccs0: SUCCESS (5.510s)
[722.824742] Subtest Q-smoketest: SUCCESS (32.986s)
[722.972382] [093/133] (347s left) kms_plane_multiple (tiling-4)
[723.068693] Starting subtest: tiling-4
[723.071446] Starting dynamic subtest: pipe-A-eDP-1
[726.778952] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.710s)
[726.790929] Starting dynamic subtest: pipe-B-eDP-1
[731.126457] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.346s)
[731.136473] Starting dynamic subtest: pipe-C-eDP-1
[735.524863] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.398s)
[735.537002] Starting dynamic subtest: pipe-D-eDP-1
[739.853151] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.328s)
[739.855798] Subtest tiling-4: SUCCESS (16.786s)
[740.686806] [094/133] (329s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[740.796549] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[744.885892] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.093s)
[746.083482] [095/133] (324s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[746.200705] Starting subtest: cursorA-vs-flipB-legacy
[746.205533] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[746.360563] [096/133] (324s left) kms_cdclk (plane-scaling)
[746.459704] Starting subtest: plane-scaling
[746.462470] Starting dynamic subtest: pipe-A-eDP-1
[746.762654] Dynamic subtest pipe-A-eDP-1: SKIP (0.300s)
[746.774548] Starting dynamic subtest: pipe-B-eDP-1
[746.780086] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[746.790697] Starting dynamic subtest: pipe-C-eDP-1
[746.796387] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[746.805980] Starting dynamic subtest: pipe-D-eDP-1
[746.811324] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[746.816412] Subtest plane-scaling: SKIP (0.308s)
[747.608780] [097/133] (322s left) kms_psr (fbc-psr-basic)
[747.711451] Starting subtest: fbc-psr-basic
[747.714259] Starting dynamic subtest: eDP-1
[747.719583] Dynamic subtest eDP-1: SKIP (0.000s)
[747.724507] Subtest fbc-psr-basic: SKIP (0.001s)
[747.800953] [098/133] (322s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[747.916095] Starting subtest: modeset-atomic-cursor-hotspot
[747.920750] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[748.076288] [099/133] (322s left) kms_force_connector_basic (prune-stale-modes)
[748.155179] Starting subtest: prune-stale-modes
[748.624294] Subtest prune-stale-modes: SUCCESS (0.469s)
[748.774199] [100/133] (321s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[750.711771] Starting subtest: gem-execbuf-stress-pc8
[750.757184] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[751.102304] [101/133] (319s left) kms_cursor_crc (cursor-offscreen-256x85)
[751.458711] Starting subtest: cursor-offscreen-256x85
[751.506933] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[751.712947] [102/133] (318s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[751.815488] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[751.818232] Starting dynamic subtest: pipe-A-eDP-1
[751.912492] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[751.924486] Starting dynamic subtest: pipe-B-eDP-1
[753.059232] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[753.063731] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.247s)
[754.327017] [103/133] (316s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[754.419494] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[761.367219] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.951s)
[761.529217] [104/133] (309s left) syncobj_basic (bad-pad-fd-to-handle)
[761.599311] Starting subtest: bad-pad-fd-to-handle
[761.602063] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[761.706222] [105/133] (309s left) gem_exec_schedule (pi-distinct-iova)
[761.895701] Starting subtest: pi-distinct-iova
[761.898346] Starting dynamic subtest: rcs0
[761.977836] Dynamic subtest rcs0: SUCCESS (0.083s)
[761.989377] Starting dynamic subtest: vcs0
[762.045332] Dynamic subtest vcs0: SUCCESS (0.067s)
[762.056543] Starting dynamic subtest: vcs1
[762.106477] Dynamic subtest vcs1: SUCCESS (0.060s)
[762.117733] Starting dynamic subtest: vecs0
[762.169894] Dynamic subtest vecs0: SUCCESS (0.063s)
[762.180432] Starting dynamic subtest: ccs0
[762.247698] Dynamic subtest ccs0: SUCCESS (0.076s)
[762.250518] Subtest pi-distinct-iova: SUCCESS (0.354s)
[763.728096] [106/133] (307s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[763.824617] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[763.827494] Starting dynamic subtest: pipe-A
[765.038975] Dynamic subtest pipe-A: SUCCESS (1.217s)
[765.050527] Starting dynamic subtest: pipe-B
[767.284223] Dynamic subtest pipe-B: SUCCESS (2.245s)
[767.293724] Starting dynamic subtest: pipe-C
[768.455530] Dynamic subtest pipe-C: SUCCESS (1.170s)
[768.468400] Starting dynamic subtest: pipe-D
[769.648420] Dynamic subtest pipe-D: SUCCESS (1.192s)
[769.650756] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.827s)
[770.828499] [107/133] (300s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[770.932158] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[770.937337] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[771.053026] [108/133] (299s left) syncobj_wait (single-wait-all-for-submit-signaled)
[771.104704] Starting subtest: single-wait-all-for-submit-signaled
[771.107496] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[771.232036] [109/133] (299s left) gem_ctx_bad_destroy (invalid-default-ctx)
[771.290570] Starting subtest: invalid-default-ctx
[771.293451] Subtest invalid-default-ctx: SUCCESS (0.000s)
[771.381975] [110/133] (299s left) gem_mmap_offset (oob-read)
[771.430064] Starting subtest: oob-read
[771.432477] Subtest oob-read: SUCCESS (0.001s)
[771.567082] [111/133] (299s left) gem_sync (basic-each)
[771.656587] Starting subtest: basic-each
[774.282731] Subtest basic-each: SUCCESS (2.641s)
[774.499049] [112/133] (296s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[774.611259] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[774.616292] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[774.730697] [113/133] (296s left) gem_mmap_gtt (basic-write-gtt)
[774.790520] Subtest basic-write-gtt: SKIP (0.000s)
[774.847330] [114/133] (296s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[774.948161] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[774.953242] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[775.089113] [115/133] (296s left) kms_flip (flip-vs-rmfb)
[775.188480] Starting subtest: flip-vs-rmfb
[775.190738] Starting dynamic subtest: A-eDP1
[783.876966] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[783.887078] Starting dynamic subtest: B-eDP1
[792.576657] Dynamic subtest B-eDP1: SUCCESS (8.698s)
[792.588140] Starting dynamic subtest: C-eDP1
[801.271319] Dynamic subtest C-eDP1: SUCCESS (8.694s)
[801.281391] Starting dynamic subtest: D-eDP1
[809.962945] Dynamic subtest D-eDP1: SUCCESS (8.690s)
[809.968241] Subtest flip-vs-rmfb: SUCCESS (34.780s)
[811.227606] [116/133] (260s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[811.318593] Starting subtest: addfb25-y-tiled-legacy
[811.321514] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[811.431370] [117/133] (259s left) i915_pm_freq_api (freq-reset)
[811.484272] Starting subtest: freq-reset
[811.486793] Starting dynamic subtest: gt0
[811.681795] Dynamic subtest gt0: SUCCESS (0.195s)
[811.691401] Starting dynamic subtest: gt1
[811.860010] Dynamic subtest gt1: SUCCESS (0.177s)
[811.862866] Subtest freq-reset: SUCCESS (0.374s)
[811.951779] [118/133] (259s left) gem_fenced_exec_thrash (no-spare-fences)
[812.018605] Subtest no-spare-fences: SKIP (0.000s)
[812.104440] [119/133] (259s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[812.206848] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[812.209133] Starting dynamic subtest: pipe-A-eDP-1
[813.038769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[813.049491] Starting dynamic subtest: pipe-B-eDP-1
[814.604523] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[814.614698] Starting dynamic subtest: pipe-C-eDP-1
[816.083286] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[816.094646] Starting dynamic subtest: pipe-D-eDP-1
[817.590534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[817.592878] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.374s)
[818.813482] [120/133] (252s left) i915_query (query-topology-kernel-writes)
[818.885814] Starting subtest: query-topology-kernel-writes
[818.888424] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[818.985212] [121/133] (252s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[819.082804] Starting subtest: y-tiled-16bpp-rotate-90
[819.088101] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[819.219378] [122/133] (252s left) gem_mmap_wc (set-cache-level)
[819.288849] Subtest set-cache-level: SKIP (0.000s)
[819.360123] [123/133] (252s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[819.468254] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[820.501971] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.035s)
[820.637061] [124/133] (251s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[820.702339] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[820.705611] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[820.825553] [125/133] (250s left) kms_psr (psr-cursor-plane-onoff)
[820.911025] Starting subtest: psr-cursor-plane-onoff
[820.913117] Starting dynamic subtest: eDP-1
[822.675728] Dynamic subtest eDP-1: SUCCESS (1.763s)
[822.678228] Subtest psr-cursor-plane-onoff: SUCCESS (1.764s)
[823.522761] [126/133] (248s left) gem_eio (in-flight-1us)
[823.773196] Starting subtest: in-flight-1us
[832.796009] Subtest in-flight-1us: SUCCESS (9.023s)
[832.932063] [127/133] (238s left) gem_exec_whisper (basic-fds-priority-all)
[832.994364] Starting subtest: basic-fds-priority-all
[857.652100] Subtest basic-fds-priority-all: SUCCESS (24.653s)
[857.865105] [128/133] (213s left) kms_cursor_edge_walk (64x64-left-edge)
[857.979334] Starting subtest: 64x64-left-edge
[857.981716] Starting dynamic subtest: pipe-A-eDP-1
[861.443037] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[861.459341] Starting dynamic subtest: pipe-D-eDP-1
[864.630162] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.186s)
[864.632703] Subtest 64x64-left-edge: SUCCESS (6.653s)
[865.507045] [129/133] (206s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[865.595687] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[865.598458] Starting dynamic subtest: pipe-A-default-mode
[868.278730] Dynamic subtest pipe-A-default-mode: SUCCESS (2.681s)
[868.281620] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.682s)
[869.121331] [130/133] (202s left) kms_flip (flip-vs-suspend-interruptible)
[869.215304] Starting subtest: flip-vs-suspend-interruptible
[869.217928] Starting dynamic subtest: A-eDP1
[918.778833] Dynamic subtest A-eDP1: SUCCESS (4.554s)
[918.789924] Starting dynamic subtest: B-eDP1
[967.768260] Dynamic subtest B-eDP1: SUCCESS (4.532s)
[967.779578] Starting dynamic subtest: C-eDP1
[1016.769981] Dynamic subtest C-eDP1: SUCCESS (4.584s)
[1016.786260] Starting dynamic subtest: D-eDP1
[1065.763243] Dynamic subtest D-eDP1: SUCCESS (4.510s)
[1065.768045] Subtest flip-vs-suspend-interruptible: SUCCESS (18.192s)
[1066.905645] [131/133] (  5s left) gem_mmap (pf-nonblock)
[1066.961114] Subtest pf-nonblock: SKIP (0.000s)
[1067.015298] [132/133] (  4s left) gem_ctx_persistence (engines-queued)
[1067.084519] Starting subtest: engines-queued
[1067.086835] Starting dynamic subtest: rcs0
[1067.190755] Dynamic subtest rcs0: SUCCESS (0.104s)
[1067.204549] Starting dynamic subtest: bcs0
[1067.214777] Dynamic subtest bcs0: SUCCESS (0.023s)
[1067.224858] Starting dynamic subtest: vcs0
[1068.888303] Dynamic subtest vcs0: SUCCESS (1.663s)
[1068.901758] Starting dynamic subtest: vcs1
[1070.934395] Dynamic subtest vcs1: SUCCESS (2.036s)
[1070.947135] Starting dynamic subtest: vecs0
[1072.918280] Dynamic subtest vecs0: SUCCESS (1.975s)
[1072.932162] Starting dynamic subtest: ccs0
[1073.010092] Dynamic subtest ccs0: SUCCESS (0.091s)
[1073.012573] Subtest engines-queued: SUCCESS (5.903s)
[1073.149903] Overall timeout time exceeded, stopping.
[1073.167353] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr2_su
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_pm_rps
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_linear_blits
results: parsing output: 11/ for test: kms_properties
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_sequence
results: parsing output: 24/ for test: gem_exec_await
results: parsing output: 25/ for test: gem_exec_suspend
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: prime_vgem
results: parsing output: 29/ for test: gem_bad_reloc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_chamelium_frames
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_exec_gttfill
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_ctx_engines
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_pipe_crc_basic
results: parsing output: 77/ for test: gem_vm_create
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: dumb_buffer
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_legacy_colorkey
results: parsing output: 91/ for test: gem_ctx_shared
results: parsing output: 92/ for test: kms_plane_multiple
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_cdclk
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_force_connector_basic
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: gem_sync
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: i915_pm_freq_api
results: parsing output: 117/ for test: gem_fenced_exec_thrash
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_ccs
results: no output, setting notrun
Done.