[57.395276] Initializing watchdogs
[57.395322]   /dev/watchdog0
[57.409539] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.414325] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.416526] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.420125] [001/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[57.542140] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[57.544387] Starting dynamic subtest: pipe-A
[57.569059] Dynamic subtest pipe-A: SKIP (0.021s)
[57.578616] Starting dynamic subtest: pipe-B
[57.601571] Dynamic subtest pipe-B: SKIP (0.034s)
[57.608650] Starting dynamic subtest: pipe-C
[57.633249] Dynamic subtest pipe-C: SKIP (0.032s)
[57.640117] Starting dynamic subtest: pipe-D
[57.664833] Dynamic subtest pipe-D: SKIP (0.033s)
[57.668893] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.121s)
[57.759404] [002/133] (960s left) kms_universal_plane (cursor-fb-leak)
[57.847893] Starting subtest: cursor-fb-leak
[57.850319] Starting dynamic subtest: pipe-A-eDP-1
[58.197139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[58.206756] Starting dynamic subtest: pipe-B-eDP-1
[59.562743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[59.572416] Starting dynamic subtest: pipe-C-eDP-1
[60.946401] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s)
[60.956538] Starting dynamic subtest: pipe-D-eDP-1
[62.257040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[62.259499] Subtest cursor-fb-leak: SUCCESS (4.486s)
[63.401277] [003/133] (954s left) kms_feature_discovery (psr2)
[63.490045] Starting subtest: psr2
[63.492378] Subtest psr2: SUCCESS (0.000s)
[63.559021] [004/133] (954s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[63.648177] Starting subtest: invalidate-primary-flip-overlay
[74.371048] Subtest invalidate-primary-flip-overlay: SUCCESS (10.783s)
[74.472604] [005/133] (943s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[74.575573] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[74.577301] Starting dynamic subtest: pipe-A-eDP-1
[75.420799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[75.429730] Starting dynamic subtest: pipe-B-eDP-1
[76.941723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.519s)
[76.950692] Starting dynamic subtest: pipe-C-eDP-1
[78.445281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[78.454850] Starting dynamic subtest: pipe-D-eDP-1
[79.943112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s)
[79.945410] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.368s)
[81.081887] [006/133] (937s left) gem_mmap_gtt (fault-concurrent-x)
[81.140996] Subtest fault-concurrent-X: SKIP (0.000s)
[81.198226] [007/133] (936s left) gem_userptr_blits (mmap-offset-banned)
[81.265289] Starting subtest: mmap-offset-banned
[81.267646] Starting dynamic subtest: wb
[81.270248] Dynamic subtest wb: SUCCESS (0.000s)
[81.280101] Starting dynamic subtest: wc
[81.282025] Dynamic subtest wc: SUCCESS (0.000s)
[81.289089] Starting dynamic subtest: uc
[81.290953] Dynamic subtest uc: SUCCESS (0.000s)
[81.292875] Subtest mmap-offset-banned: SUCCESS (0.001s)
[81.404271] [008/133] (936s left) gem_exec_flush (basic-batch-kernel-default-wb)
[81.480431] Starting subtest: basic-batch-kernel-default-wb
[88.818516] Subtest basic-batch-kernel-default-wb: SUCCESS (7.342s)
[89.012533] [009/133] (929s left) kms_pm_rpm (modeset-non-lpsp)
[90.572946] Starting subtest: modeset-non-lpsp
[91.726654] Subtest modeset-non-lpsp: SKIP (1.156s)
[92.106571] [010/133] (926s left) gem_create (create-clear)
[92.166912] Starting subtest: create-clear
[92.169764] Starting dynamic subtest: smem0
[125.005578] Dynamic subtest smem0: SUCCESS (32.835s)
[125.008058] Subtest create-clear: SUCCESS (32.836s)
[125.209599] [011/133] (893s left) gem_eio (suspend)
[125.461946] Starting subtest: suspend
[137.801247] Subtest suspend: SUCCESS (12.337s)
[137.933457] [012/133] (880s left) kms_content_protection (content-type-change)
[138.073052] Starting subtest: content-type-change
[138.077673] Subtest content-type-change: SKIP (0.000s)
[138.194965] [013/133] (880s left) perf_pmu (multi-client)
[138.236645] Starting subtest: multi-client
[138.239174] Starting dynamic subtest: rcs0
[139.289618] Dynamic subtest rcs0: SUCCESS (1.054s)
[139.302484] Starting dynamic subtest: bcs0
[140.340836] Dynamic subtest bcs0: SUCCESS (1.050s)
[140.355088] Starting dynamic subtest: vcs0
[141.391072] Dynamic subtest vcs0: SUCCESS (1.049s)
[141.402564] Starting dynamic subtest: vcs1
[143.290988] Dynamic subtest vcs1: SUCCESS (1.899s)
[143.302695] Starting dynamic subtest: vecs0
[145.336974] Dynamic subtest vecs0: SUCCESS (2.045s)
[145.348427] Starting dynamic subtest: ccs0
[147.321392] Dynamic subtest ccs0: SUCCESS (1.984s)
[147.323960] Subtest multi-client: SUCCESS (9.089s)
[147.439904] [014/133] (870s left) sw_sync (alloc_fence)
[147.477447] Starting subtest: alloc_fence
[147.479834] Subtest alloc_fence: SUCCESS (0.000s)
[147.570507] [015/133] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[147.681209] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[147.683312] Starting dynamic subtest: pipe-A-eDP-1
[147.755956] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[147.767610] Starting dynamic subtest: pipe-B-eDP-1
[148.864776] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s)
[148.869207] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.188s)
[150.052390] [016/133] (868s left) api_intel_bb (blit-reloc-keep-cache)
[150.113192] Starting subtest: blit-reloc-keep-cache
[150.117730] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[150.240813] [017/133] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[150.342367] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[150.346524] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[150.449095] [018/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[150.560703] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[157.251799] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.696s)
[157.361588] [019/133] (861s left) kms_fbcon_fbt (psr)
[157.424993] Starting subtest: psr
[164.702749] Subtest psr: SUCCESS (7.274s)
[164.776003] [020/133] (853s left) gem_userptr_blits (unsync-unmap-after-close)
[164.863775] Subtest unsync-unmap-after-close: SKIP (0.000s)
[164.972707] [021/133] (853s left) gem_pwrite (basic-exhaustion)
[165.016955] Subtest basic-exhaustion: SKIP (0.000s)
[165.087858] [022/133] (853s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[165.187226] Starting subtest: coverage-vs-premult-vs-constant
[165.461702] Starting dynamic subtest: pipe-A-eDP-1
[166.039666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[166.048899] Starting dynamic subtest: pipe-D-eDP-1
[167.327934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[167.330780] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.143s)
[168.183936] [023/133] (850s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[168.286928] Starting subtest: y-tiled-64bpp-rotate-0
[168.291218] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[168.394150] [024/133] (850s left) gem_exec_fence (invalid-fence-array)
[168.880354] Starting subtest: invalid-fence-array
[168.882859] Subtest invalid-fence-array: SUCCESS (0.004s)
[170.374630] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[170.378317] [025/133] (848s left) i915_pm_rpm (gem-execbuf)
[172.403661] Starting subtest: gem-execbuf
[172.405813] Starting dynamic subtest: smem0
[174.171649] Dynamic subtest smem0: SUCCESS (1.768s)
[174.173996] Subtest gem-execbuf: SUCCESS (1.770s)
[174.258730] [026/133] (844s left) gem_set_tiling_vs_gtt
[174.390857] [027/133] (844s left) gem_exercise_blt (fast-copy-emit)
[174.446688] Starting subtest: fast-copy-emit
[174.449275] Starting dynamic subtest: linear-smem-smem-emit
[174.469086] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[174.480438] Starting dynamic subtest: xmajor-smem-smem-emit
[174.485462] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[174.494722] Starting dynamic subtest: tile4-smem-smem-emit
[174.501863] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[174.512152] Starting dynamic subtest: tile64-smem-smem-emit
[174.520377] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[174.522703] Subtest fast-copy-emit: SUCCESS (0.075s)
[174.644450] [028/133] (844s left) kms_plane_lowres (tiling-4)
[174.730205] Starting subtest: tiling-4
[174.732501] Starting dynamic subtest: pipe-A-eDP-1
[174.737058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.030087] Starting dynamic subtest: pipe-B-eDP-1
[175.034770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.044443] Starting dynamic subtest: pipe-C-eDP-1
[175.049215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.058640] Starting dynamic subtest: pipe-D-eDP-1
[175.063265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.067698] Subtest tiling-4: SKIP (0.299s)
[175.884343] [029/133] (843s left) gem_spin_batch (engines)
[175.970718] Starting subtest: engines
[175.973195] Starting dynamic subtest: rcs0
[179.212346] Dynamic subtest rcs0: SUCCESS (3.236s)
[179.224950] Starting dynamic subtest: bcs0
[182.450140] Dynamic subtest bcs0: SUCCESS (3.236s)
[182.461922] Starting dynamic subtest: vcs0
[185.688841] Dynamic subtest vcs0: SUCCESS (3.237s)
[185.698205] Starting dynamic subtest: vcs1
[188.922687] Dynamic subtest vcs1: SUCCESS (3.232s)
[188.934358] Starting dynamic subtest: vecs0
[192.159645] Dynamic subtest vecs0: SUCCESS (3.236s)
[192.172043] Starting dynamic subtest: ccs0
[195.397062] Dynamic subtest ccs0: SUCCESS (3.235s)
[195.399703] Subtest engines: SUCCESS (19.423s)
[195.649663] [030/133] (823s left) api_intel_bb (object-reloc-keep-cache)
[195.702309] Starting subtest: object-reloc-keep-cache
[195.707658] Subtest object-reloc-keep-cache: SKIP (0.006s)
[195.812244] [031/133] (823s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[195.908757] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[195.912735] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[195.982324] [032/133] (823s left) gem_linear_blits (interruptible)
[196.407877] Starting subtest: interruptible
[200.631393] Subtest interruptible: SUCCESS (4.227s)
[200.764789] [033/133] (818s left) kms_rotation_crc (sprite-rotation-270)
[200.909640] Starting subtest: sprite-rotation-270
[200.913938] Subtest sprite-rotation-270: SKIP (0.001s)
[200.985531] [034/133] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[201.079431] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[201.083637] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[201.177119] [035/133] (818s left) gem_reg_read (timestamp-monotonic)
[201.232265] Starting subtest: timestamp-monotonic
[205.400334] Subtest timestamp-monotonic: SUCCESS (4.168s)
[205.473452] [036/133] (813s left) kms_feature_discovery (display-4x)
[205.559734] Starting subtest: display-4x
[205.564181] Subtest display-4x: SKIP (0.000s)
[205.633064] [037/133] (813s left) kms_psr (psr2-primary-blt)
[205.724197] Starting subtest: psr2-primary-blt
[205.726490] Starting dynamic subtest: eDP-1
[207.435483] Dynamic subtest eDP-1: SUCCESS (1.711s)
[207.437479] Subtest psr2-primary-blt: SUCCESS (1.712s)
[208.305811] [038/133] (811s left) gem_busy (extended)
[208.493044] Starting subtest: extended
[208.495625] Starting dynamic subtest: rcs0
[208.593673] Dynamic subtest rcs0: SUCCESS (0.101s)
[208.606781] Starting dynamic subtest: bcs0
[208.635114] Dynamic subtest bcs0: SUCCESS (0.040s)
[208.645838] Starting dynamic subtest: vcs0
[210.306094] Dynamic subtest vcs0: SUCCESS (1.668s)
[210.319616] Starting dynamic subtest: vcs1
[212.290464] Dynamic subtest vcs1: SUCCESS (1.982s)
[212.304183] Starting dynamic subtest: vecs0
[214.273784] Dynamic subtest vecs0: SUCCESS (1.979s)
[214.287052] Starting dynamic subtest: ccs0
[214.321226] Dynamic subtest ccs0: SUCCESS (0.046s)
[214.324027] Subtest extended: SUCCESS (5.828s)
[214.551327] [039/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[214.649453] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[214.653641] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[214.731810] [040/133] (804s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[216.483955] Starting subtest: dpms-mode-unset-lpsp
[220.530936] Subtest dpms-mode-unset-lpsp: SUCCESS (4.049s)
[220.910207] [041/133] (798s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[221.003464] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[224.583874] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.584s)
[225.721129] [042/133] (793s left) gem_exec_schedule (submit-late-slice)
[225.809232] Starting subtest: submit-late-slice
[225.811362] Starting dynamic subtest: rcs0
[225.838079] Dynamic subtest rcs0: SUCCESS (0.037s)
[225.848509] Starting dynamic subtest: bcs0
[225.878257] Dynamic subtest bcs0: SUCCESS (0.039s)
[225.888768] Starting dynamic subtest: vcs0
[225.929186] Dynamic subtest vcs0: SUCCESS (0.050s)
[225.941523] Starting dynamic subtest: vcs1
[225.961158] Dynamic subtest vcs1: SUCCESS (0.032s)
[225.970939] Starting dynamic subtest: vecs0
[226.002883] Dynamic subtest vecs0: SUCCESS (0.041s)
[226.014499] Starting dynamic subtest: ccs0
[226.042285] Dynamic subtest ccs0: SUCCESS (0.039s)
[226.044535] Subtest submit-late-slice: SUCCESS (0.241s)
[227.411232] [043/133] (792s left) prime_self_import (basic-llseek-size)
[227.450741] Starting subtest: basic-llseek-size
[227.465492] Subtest basic-llseek-size: SUCCESS (0.014s)
[227.601362] [044/133] (792s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[227.718242] Starting subtest: verify-pxp-key-change-after-suspend-resume
[234.924586] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.209s)
[235.062050] [045/133] (784s left) i915_drm_fdinfo (virtual-busy-idle-all)
[235.107505] Starting subtest: virtual-busy-idle-all
[235.112227] Subtest virtual-busy-idle-all: SKIP (0.000s)
[235.183152] [046/133] (784s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[235.298083] Starting subtest: cursorB-vs-flipB-toggle
[235.302619] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[235.442675] [047/133] (784s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[235.526732] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[235.528994] Starting dynamic subtest: pipe-A-default-mode
[236.654860] Dynamic subtest pipe-A-default-mode: SKIP (1.127s)
[236.659295] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.128s)
[236.796334] [048/133] (783s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[236.896203] Starting subtest: yf-tiled-32bpp-rotate-180
[236.900538] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[237.003345] [049/133] (782s left) syncobj_timeline (invalid-transfer-non-existent-point)
[237.062334] Starting subtest: invalid-transfer-non-existent-point
[237.064723] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[237.188883] [050/133] (782s left) prime_mmap (test_aperture_limit)
[237.248187] Starting subtest: test_aperture_limit
[237.250463] Starting dynamic subtest: test_aperture_limit-smem
[237.257828] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[237.262247] Subtest test_aperture_limit: SKIP (0.009s)
[237.357130] [051/133] (782s left) kms_async_flips (invalid-async-flip)
[237.449487] Starting subtest: invalid-async-flip
[237.832041] Starting dynamic subtest: pipe-A-eDP-1
[238.655199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[239.024537] Starting dynamic subtest: pipe-B-eDP-1
[239.790954] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[240.153770] Starting dynamic subtest: pipe-C-eDP-1
[240.901093] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[241.255361] Starting dynamic subtest: pipe-D-eDP-1
[242.040608] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s)
[242.042931] Subtest invalid-async-flip: SUCCESS (4.592s)
[243.200818] [052/133] (776s left) gem_ctx_persistence (heartbeat-hostile)
[243.258212] Starting subtest: heartbeat-hostile
[243.262658] Subtest heartbeat-hostile: SKIP (0.000s)
[243.360292] [053/133] (776s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[243.459272] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[243.461542] Starting dynamic subtest: pipe-A-eDP-1
[243.487014] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.498207] Starting dynamic subtest: pipe-B-eDP-1
[243.521154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.530548] Starting dynamic subtest: pipe-C-eDP-1
[243.558806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.568615] Starting dynamic subtest: pipe-D-eDP-1
[243.593470] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.597602] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[245.696852] [054/133] (774s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[245.784098] Starting subtest: 4-tiled-addfb-size-offset-overflow
[245.786378] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[245.882391] [055/133] (774s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[245.976957] Starting subtest: fbcpsr-rgb565-draw-pwrite
[252.974859] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.001s)
[253.088233] [056/133] (767s left) kms_plane (pixel-format-4-tiled-modifier)
[253.173278] Starting subtest: pixel-format-4-tiled-modifier
[253.198630] Starting dynamic subtest: pipe-A-plane-0
[253.843675] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[253.856266] Starting dynamic subtest: pipe-A-plane-3
[254.242561] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[254.252883] Starting dynamic subtest: pipe-A-plane-5
[254.256629] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[255.317643] Starting dynamic subtest: pipe-B-plane-0
[255.925565] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[255.942835] Starting dynamic subtest: pipe-B-plane-3
[256.368763] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[256.380887] Starting dynamic subtest: pipe-B-plane-5
[256.384458] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[256.696455] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.525s)
[257.493242] [057/133] (762s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[257.589235] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[261.596984] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.011s)
[262.712721] [058/133] (757s left) kms_setmode (basic)
[262.764181] Starting subtest: basic
[263.096674] Starting dynamic subtest: pipe-A-eDP-1
[265.222689] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[265.569723] Starting dynamic subtest: pipe-B-eDP-1
[267.650741] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[267.955248] Subtest basic: SUCCESS (5.192s)
[268.798646] [059/133] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[268.901930] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[275.969022] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.069s)
[276.108626] [060/133] (744s left) kms_psr (pr-primary-page-flip)
[276.210076] Starting subtest: pr-primary-page-flip
[276.214114] Subtest pr-primary-page-flip: SKIP (0.000s)
[276.282618] [061/133] (744s left) gem_exec_reloc (basic-scanout)
[276.357191] Subtest basic-scanout: SKIP (0.000s)
[276.432844] [062/133] (744s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[276.498175] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[276.571947] [063/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[276.669057] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[276.673147] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[276.764608] [064/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[276.868433] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[276.872642] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.957547] [065/133] (743s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[277.056241] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[277.059728] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[277.147562] [066/133] (743s left) gen9_exec_parse (basic-rejected-ctx-param)
[277.206754] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[277.285621] [067/133] (743s left) sriov_basic (enable-vfs-bind-unbind-each)
[277.337263] Starting subtest: enable-vfs-bind-unbind-each
[277.339326] Starting dynamic subtest: numvfs-1
[277.408057] Dynamic subtest numvfs-1: FAIL (0.027s)
[277.419742] Starting dynamic subtest: numvfs-2
[277.481212] Dynamic subtest numvfs-2: FAIL (0.004s)
[277.493458] Starting dynamic subtest: numvfs-3
[277.553107] Dynamic subtest numvfs-3: FAIL (0.003s)
[277.563804] Starting dynamic subtest: numvfs-4
[277.622163] Dynamic subtest numvfs-4: FAIL (0.004s)
[277.632584] Starting dynamic subtest: numvfs-5
[277.692724] Dynamic subtest numvfs-5: FAIL (0.004s)
[277.702683] Starting dynamic subtest: numvfs-6
[277.761767] Dynamic subtest numvfs-6: FAIL (0.003s)
[277.773034] Starting dynamic subtest: numvfs-7
[277.832180] Dynamic subtest numvfs-7: FAIL (0.003s)
[277.842531] Starting dynamic subtest: numvfs-random
[277.902027] Dynamic subtest numvfs-random: FAIL (0.004s)
[277.903772] Subtest enable-vfs-bind-unbind-each: FAIL (0.057s)
[277.941773] [068/133] (742s left) kms_flip (2x-blocking-absolute-wf_vblank)
[278.027986] Starting subtest: 2x-blocking-absolute-wf_vblank
[278.036903] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[278.113544] [069/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[278.207196] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[278.210720] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[278.302701] [070/133] (742s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[278.688105] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[279.506853] [071/133] (741s left) perf (i915-ref-count)
[279.583168] Starting subtest: i915-ref-count
[279.655273] Subtest i915-ref-count: SUCCESS (0.070s)
[279.711602] [072/133] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[279.817248] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[279.821268] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.919485] [073/133] (741s left) gem_mmap_gtt (zero-extend)
[279.970120] Subtest zero-extend: SKIP (0.000s)
[280.035247] [074/133] (740s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[280.126767] Starting subtest: async-flip-with-page-flip-events-tiled
[280.497453] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[283.294704] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[283.307562] Starting dynamic subtest: pipe-A-eDP-1-4
[285.469497] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[285.482699] Starting dynamic subtest: pipe-A-eDP-1-4
[287.479487] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[287.491416] Starting dynamic subtest: pipe-A-eDP-1-x
[289.658456] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[290.036482] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[292.824057] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[292.836870] Starting dynamic subtest: pipe-B-eDP-1-4
[295.053658] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.229s)
[295.064681] Starting dynamic subtest: pipe-B-eDP-1-4
[297.063954] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[297.074306] Starting dynamic subtest: pipe-B-eDP-1-x
[299.254592] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[299.630265] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[302.352063] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.730s)
[302.362628] Starting dynamic subtest: pipe-C-eDP-1-4
[304.526733] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[304.537214] Starting dynamic subtest: pipe-C-eDP-1-4
[306.567445] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[306.580577] Starting dynamic subtest: pipe-C-eDP-1-x
[308.726584] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[309.095739] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[311.877086] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[311.893421] Starting dynamic subtest: pipe-D-eDP-1-4
[314.051397] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[314.063081] Starting dynamic subtest: pipe-D-eDP-1-4
[316.062301] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[316.075151] Starting dynamic subtest: pipe-D-eDP-1-x
[318.239998] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[318.242451] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.115s)
[319.468465] [075/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[319.562587] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[319.566697] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.658553] [076/133] (701s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[319.746931] Starting subtest: primary-y-tiled-reflect-x-180
[319.806801] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[319.910572] [077/133] (701s left) gem_userptr_blits (map-fixed-invalidate)
[319.968585] Starting subtest: map-fixed-invalidate
[319.972826] Subtest map-fixed-invalidate: SKIP (0.000s)
[320.077077] [078/133] (701s left) syncobj_wait (reset-during-wait-for-submit)
[320.134486] Starting subtest: reset-during-wait-for-submit
[320.236491] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[320.315389] [079/133] (700s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[320.404042] Starting subtest: fbc-psr-cursor-mmap-cpu
[320.406231] Starting dynamic subtest: eDP-1
[320.410293] Dynamic subtest eDP-1: SKIP (0.000s)
[320.414177] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[320.481477] [080/133] (700s left) gem_workarounds (reset-fd)
[320.557666] Starting subtest: reset-fd
[320.734871] Subtest reset-fd: SUCCESS (0.177s)
[320.855728] [081/133] (700s left) sysfs_preempt_timeout (invalid)
[320.928042] Starting subtest: invalid
[320.930334] Starting dynamic subtest: vecs0
[320.932645] Dynamic subtest vecs0: SUCCESS (0.000s)
[320.944376] Starting dynamic subtest: ccs0
[320.946246] Dynamic subtest ccs0: SUCCESS (0.000s)
[320.956137] Starting dynamic subtest: vcs0
[320.958240] Dynamic subtest vcs0: SUCCESS (0.000s)
[320.968256] Starting dynamic subtest: bcs0
[320.970422] Dynamic subtest bcs0: SUCCESS (0.000s)
[320.979836] Starting dynamic subtest: rcs0
[320.981957] Dynamic subtest rcs0: SUCCESS (0.000s)
[320.991370] Starting dynamic subtest: vcs1
[320.993184] Dynamic subtest vcs1: SUCCESS (0.000s)
[320.995009] Subtest invalid: SUCCESS (0.006s)
[321.045154] [082/133] (700s left) kms_flip (flip-vs-wf_vblank-interruptible)
[321.142949] Starting subtest: flip-vs-wf_vblank-interruptible
[321.145156] Starting dynamic subtest: A-eDP1
[323.019977] Dynamic subtest A-eDP1: SUCCESS (1.876s)
[323.032558] Starting dynamic subtest: B-eDP1
[324.949301] Dynamic subtest B-eDP1: SUCCESS (1.927s)
[324.959725] Starting dynamic subtest: C-eDP1
[326.873177] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[326.884481] Starting dynamic subtest: D-eDP1
[328.804973] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[328.810639] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.667s)
[330.060282] [083/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[330.159974] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[330.164123] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[330.248152] [084/133] (691s left) gem_mmap_gtt (basic-small-copy-odd)
[330.303860] Subtest basic-small-copy-odd: SKIP (0.000s)
[330.364497] [085/133] (691s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[330.466097] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[330.470792] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[330.568823] [086/133] (690s left) gem_unfence_active_buffers
[330.733645] [087/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[330.828958] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[338.142644] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.318s)
[338.267723] [088/133] (683s left) kms_cursor_crc (cursor-random-256x85)
[338.538965] Starting subtest: cursor-random-256x85
[338.594960] Subtest cursor-random-256x85: SKIP (0.051s)
[338.786923] [089/133] (682s left) perf (non-zero-reason)
[338.867145] Starting subtest: non-zero-reason
[338.869528] Starting dynamic subtest: 0-rcs0
[344.259504] Dynamic subtest 0-rcs0: SUCCESS (5.390s)
[344.272594] Starting dynamic subtest: 1-vecs0
[348.166668] Dynamic subtest 1-vecs0: SUCCESS (3.906s)
[348.169791] Subtest non-zero-reason: SUCCESS (9.298s)
[348.216167] [090/133] (673s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[348.327106] Starting subtest: plane-lut1d-post-ctm3x4
[348.450469] Starting dynamic subtest: pipe-A-plane-0
[348.594626] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[348.608493] Starting dynamic subtest: pipe-A-plane-1
[348.783385] Dynamic subtest pipe-A-plane-1: SUCCESS (0.187s)
[348.794291] Starting dynamic subtest: pipe-A-plane-2
[348.916234] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[350.061449] Starting dynamic subtest: pipe-B-plane-0
[350.207815] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[350.218173] Starting dynamic subtest: pipe-B-plane-1
[350.341515] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[350.351784] Starting dynamic subtest: pipe-B-plane-2
[350.485764] Dynamic subtest pipe-B-plane-2: SUCCESS (0.143s)
[351.725038] Starting dynamic subtest: pipe-C-plane-0
[351.848958] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[351.859419] Starting dynamic subtest: pipe-C-plane-1
[351.993311] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[352.003163] Starting dynamic subtest: pipe-C-plane-2
[352.126463] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[353.319497] Starting dynamic subtest: pipe-D-plane-0
[353.444348] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[353.454299] Starting dynamic subtest: pipe-D-plane-1
[353.577983] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[353.588196] Starting dynamic subtest: pipe-D-plane-2
[353.711181] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[353.997350] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.671s)
[354.802919] [091/133] (666s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[354.902422] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[355.904307] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.002s)
[356.033178] [092/133] (665s left) gem_mmap_gtt (basic-small-copy)
[356.093097] Subtest basic-small-copy: SKIP (0.000s)
[356.157089] [093/133] (665s left) kms_cursor_legacy (single-move)
[356.278163] Starting subtest: single-move
[356.280065] Starting dynamic subtest: pipe-A
[361.662595] Dynamic subtest pipe-A: SUCCESS (5.379s)
[361.675243] Starting dynamic subtest: pipe-B
[367.044035] Dynamic subtest pipe-B: SUCCESS (5.379s)
[367.056723] Starting dynamic subtest: pipe-C
[372.426081] Dynamic subtest pipe-C: SUCCESS (5.379s)
[372.438082] Starting dynamic subtest: pipe-D
[377.809245] Dynamic subtest pipe-D: SUCCESS (5.380s)
[377.821526] Starting dynamic subtest: all-pipes
[383.201964] Dynamic subtest all-pipes: SUCCESS (5.388s)
[383.204840] Subtest single-move: SUCCESS (26.921s)
[383.352150] [094/133] (638s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[383.458950] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[384.448842] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.989s)
[384.623418] [095/133] (637s left) syncobj_eventfd (invalid-illegal-eventfd)
[384.671427] Starting subtest: invalid-illegal-eventfd
[384.673700] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[384.759915] [096/133] (637s left) gem_exec_whisper (basic-fds)
[384.825687] Starting subtest: basic-fds
[392.521867] Subtest basic-fds: SUCCESS (7.691s)
[392.718266] [097/133] (629s left) kms_flip (blocking-wf_vblank)
[392.808280] Starting subtest: blocking-wf_vblank
[392.810564] Starting dynamic subtest: A-eDP1
[401.735581] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[401.748269] Starting dynamic subtest: B-eDP1
[410.673165] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[410.690506] Starting dynamic subtest: C-eDP1
[419.583246] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[419.600218] Starting dynamic subtest: D-eDP1
[428.518043] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[428.524289] Subtest blocking-wf_vblank: SUCCESS (35.716s)
[429.750689] [098/133] (592s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[429.859376] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[429.864192] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[430.961665] [099/133] (591s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[431.068221] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[431.073637] Starting dynamic subtest: pipe-A-eDP-1
[431.095742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.111815] Starting dynamic subtest: pipe-B-eDP-1
[431.133216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[431.148715] Starting dynamic subtest: pipe-C-eDP-1
[431.170649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[431.181980] Starting dynamic subtest: pipe-D-eDP-1
[431.204561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[431.209172] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[433.327875] [100/133] (588s left) kms_cursor_edge_walk (128x128-left-edge)
[433.429429] Starting subtest: 128x128-left-edge
[433.431791] Starting dynamic subtest: pipe-A-eDP-1
[436.879215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[436.889814] Starting dynamic subtest: pipe-D-eDP-1
[440.012933] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[440.015349] Subtest 128x128-left-edge: SUCCESS (6.585s)
[440.808887] [101/133] (581s left) gem_eio (kms)
[441.086973] Starting subtest: kms
[460.822641] Subtest kms: SUCCESS (19.735s)
[461.995785] [102/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[462.068661] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[462.073332] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[462.273789] [103/133] (559s left) prime_vgem (basic-read)
[462.347688] Starting subtest: basic-read
[462.356618] Subtest basic-read: SKIP (0.007s)
[462.461443] [104/133] (559s left) gem_exec_balancer (persistence)
[462.717765] Starting subtest: persistence
[463.617536] Subtest persistence: SUCCESS (0.899s)
[463.743335] [105/133] (558s left) kms_addfb_basic (unused-handle)
[463.794851] Starting subtest: unused-handle
[463.797259] Subtest unused-handle: SUCCESS (0.000s)
[463.938903] [106/133] (558s left) kms_invalid_mode (bad-hsync-start)
[464.045309] Starting subtest: bad-hsync-start
[464.047563] Starting dynamic subtest: pipe-A-eDP-1
[464.329582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[464.340622] Starting dynamic subtest: pipe-B-eDP-1
[464.342591] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[464.351949] Starting dynamic subtest: pipe-C-eDP-1
[464.354353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[464.364417] Starting dynamic subtest: pipe-D-eDP-1
[464.366783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[464.369089] Subtest bad-hsync-start: SUCCESS (0.291s)
[465.130742] [107/133] (557s left) gem_exec_schedule (preempt)
[465.207311] Starting subtest: preempt
[465.209623] Starting dynamic subtest: rcs0
[465.264552] Dynamic subtest rcs0: SUCCESS (0.059s)
[465.280911] Starting dynamic subtest: bcs0
[465.288872] Dynamic subtest bcs0: SUCCESS (0.021s)
[465.299423] Starting dynamic subtest: vcs0
[465.310427] Dynamic subtest vcs0: SUCCESS (0.021s)
[465.320492] Starting dynamic subtest: vcs1
[465.331069] Dynamic subtest vcs1: SUCCESS (0.020s)
[465.341177] Starting dynamic subtest: vecs0
[465.352748] Dynamic subtest vecs0: SUCCESS (0.021s)
[465.362776] Starting dynamic subtest: ccs0
[465.380301] Dynamic subtest ccs0: SUCCESS (0.027s)
[465.382601] Subtest preempt: SUCCESS (0.176s)
[467.403761] [108/133] (555s left) gem_ctx_persistence (engines-persistence)
[467.479315] Starting subtest: engines-persistence
[467.481582] Starting dynamic subtest: rcs0
[468.291224] Dynamic subtest rcs0: SUCCESS (0.813s)
[468.304734] Starting dynamic subtest: bcs0
[469.032915] Dynamic subtest bcs0: SUCCESS (0.740s)
[469.047048] Starting dynamic subtest: vcs0
[469.820747] Dynamic subtest vcs0: SUCCESS (0.786s)
[469.834037] Starting dynamic subtest: vcs1
[470.590076] Dynamic subtest vcs1: SUCCESS (0.767s)
[470.603512] Starting dynamic subtest: vecs0
[471.356974] Dynamic subtest vecs0: SUCCESS (0.765s)
[471.370143] Starting dynamic subtest: ccs0
[472.102907] Dynamic subtest ccs0: SUCCESS (0.744s)
[472.105648] Subtest engines-persistence: SUCCESS (4.627s)
[472.235970] [109/133] (550s left) kms_properties (crtc-properties-legacy)
[472.326238] Starting subtest: crtc-properties-legacy
[472.328520] Starting dynamic subtest: pipe-A-eDP-1
[472.764105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[472.775880] Starting dynamic subtest: pipe-B-eDP-1
[473.899754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s)
[473.910825] Starting dynamic subtest: pipe-C-eDP-1
[475.028986] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[475.039519] Starting dynamic subtest: pipe-D-eDP-1
[476.152732] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[476.154655] Subtest crtc-properties-legacy: SUCCESS (3.826s)
[476.966894] [110/133] (545s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[477.023085] Starting subtest: multi-wait-for-submit-submitted-signaled
[477.025322] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[477.131814] [111/133] (545s left) kms_vblank (wait-forked-busy)
[477.216201] Starting subtest: wait-forked-busy
[477.218375] Starting dynamic subtest: pipe-A-eDP-1
[479.089671] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[479.108314] Starting dynamic subtest: pipe-D-eDP-1
[481.627697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[481.629638] Subtest wait-forked-busy: SUCCESS (4.412s)
[482.426322] [112/133] (540s left) i915_power (sanity)
[482.490683] Starting subtest: sanity
[482.495235] Subtest sanity: SKIP (0.000s)
[482.602491] [113/133] (540s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[482.668661] Starting subtest: invalid-bsd1-flag-on-vebox
[482.670893] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[482.782452] [114/133] (539s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[482.831598] Starting subtest: etime-single-wait-all-available-unsubmitted
[482.933867] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[483.010810] [115/133] (539s left) kms_chamelium_audio (hdmi-audio-edid)
[483.400394] Subtest hdmi-audio-edid: SKIP (0.000s)
[484.242732] [116/133] (538s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[484.297080] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[484.299488] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[484.410083] [117/133] (538s left) drm_read (empty-block)
[484.551981] Starting subtest: empty-block
[485.552422] Subtest empty-block: SUCCESS (1.000s)
[485.675842] [118/133] (537s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[485.734170] Starting subtest: wait-all-for-submit-delayed-submit
[485.837624] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[485.921898] [119/133] (537s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[486.002324] Starting subtest: fbc-pr-cursor-mmap-gtt
[486.006700] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[486.077839] [120/133] (536s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[486.178194] Starting subtest: fbc-psr2-primary-mmap-gtt
[486.180463] Starting dynamic subtest: eDP-1
[486.184396] Dynamic subtest eDP-1: SKIP (0.000s)
[486.188287] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[486.254407] [121/133] (536s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[486.626487] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[487.473261] [122/133] (535s left) gem_exec_reloc (basic-range-active)
[487.534491] Subtest basic-range-active: SKIP (0.000s)
[487.601139] [123/133] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[487.687474] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[487.691709] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[487.778927] [124/133] (535s left) kms_legacy_colorkey (invalid-plane)
[487.870967] Starting subtest: invalid-plane
[487.873299] Starting dynamic subtest: zero-id
[487.875467] Dynamic subtest zero-id: SUCCESS (0.000s)
[487.885984] Starting dynamic subtest: outrange-id
[487.887904] Dynamic subtest outrange-id: SUCCESS (0.000s)
[487.889821] Subtest invalid-plane: SUCCESS (0.001s)
[487.945782] [125/133] (535s left) dmabuf_sync_file (import-multiple-read-write)
[487.988729] Starting subtest: import-multiple-read-write
[487.991035] Subtest import-multiple-read-write: SUCCESS (0.003s)
[488.044039] [126/133] (535s left) i915_drm_fdinfo (all-busy-check-all)
[488.082422] Starting subtest: all-busy-check-all
[488.089112] Subtest all-busy-check-all: SKIP (0.004s)
[488.157091] [127/133] (535s left) kms_getfb (getfb-handle-protection)
[488.272206] Starting subtest: getfb-handle-protection
[488.286479] Subtest getfb-handle-protection: SUCCESS (0.016s)
[488.391379] [128/133] (534s left) kms_rmfb (rmfb-ioctl)
[488.474900] Starting subtest: rmfb-ioctl
[488.477051] Starting dynamic subtest: pipe-A-eDP-1
[488.581041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[488.603181] Starting dynamic subtest: pipe-B-eDP-1
[489.759340] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[489.771075] Starting dynamic subtest: pipe-C-eDP-1
[490.885790] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[490.895952] Starting dynamic subtest: pipe-D-eDP-1
[492.024620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[492.027039] Subtest rmfb-ioctl: SUCCESS (3.550s)
[493.244414] [129/133] (530s left) kms_cursor_crc (cursor-offscreen-128x42)
[493.490229] Starting subtest: cursor-offscreen-128x42
[493.534157] Subtest cursor-offscreen-128x42: SKIP (0.040s)
[493.749118] [130/133] (529s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[493.844633] Starting subtest: pr-plane-move-sf-dmg-area
[493.849108] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[493.927667] [131/133] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[494.025345] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[494.029565] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[494.109160] [132/133] (529s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[494.234261] Starting subtest: cursorA-vs-flipB-atomic
[494.237912] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[494.380228] [133/133] (529s left) gem_exec_balancer (busy)
[494.448261] Starting subtest: busy
[496.318957] Subtest busy: SUCCESS (1.872s)
[496.714967] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_universal_plane
results: parsing output: 2/ for test: kms_feature_discovery
results: parsing output: 3/ for test: kms_psr_stress_test
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_create
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_fbcon_fbt
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: gem_pwrite
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: gem_set_tiling_vs_gtt
results: parsing output: 26/ for test: gem_exercise_blt
results: parsing output: 27/ for test: kms_plane_lowres
results: parsing output: 28/ for test: gem_spin_batch
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_reg_read
results: parsing output: 35/ for test: kms_feature_discovery
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_busy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: prime_mmap
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_setmode
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: sriov_basic
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_async_flips
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_workarounds
results: parsing output: 80/ for test: sysfs_preempt_timeout
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_unfence_active_buffers
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_color_pipeline
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_edge_walk
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: prime_vgem
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: kms_properties
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: i915_power
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_chamelium_audio
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_legacy_colorkey
results: parsing output: 124/ for test: dmabuf_sync_file
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: kms_rmfb
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_balancer
Done.