[61.046355] Initializing watchdogs
[61.046401]   /dev/watchdog0
[61.061432] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[61.065702] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.067740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.070997] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[61.171512] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[61.175896] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[61.258467] [002/133] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[61.317082] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[61.319443] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[61.419866] [003/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[61.501717] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[61.504058] Starting dynamic subtest: pipe-A-eDP-1
[62.345621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s)
[62.354211] Starting dynamic subtest: pipe-B-eDP-1
[63.882130] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.528s)
[63.890930] Starting dynamic subtest: pipe-C-eDP-1
[65.617052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.730s)
[65.625739] Starting dynamic subtest: pipe-D-eDP-1
[67.151137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[67.153608] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.630s)
[68.629303] [004/133] (953s left) gem_mmap_gtt (cpuset-big-copy)
[68.691710] Subtest cpuset-big-copy: SKIP (0.000s)
[68.753439] [005/133] (953s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[68.832663] Starting subtest: yf-tiled-64bpp-rotate-0
[68.837085] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[68.928783] [006/133] (952s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[69.010271] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[69.012625] Starting dynamic subtest: pipe-A-eDP-1
[69.071541] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[69.080286] Starting dynamic subtest: pipe-B-eDP-1
[69.136720] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[69.146779] Starting dynamic subtest: pipe-C-eDP-1
[69.203487] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[69.213238] Starting dynamic subtest: pipe-D-eDP-1
[69.272460] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[69.277121] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[71.267858] [007/133] (950s left) kms_plane_scaling (intel-max-src-size)
[71.338212] Starting subtest: intel-max-src-size
[71.345242] Subtest intel-max-src-size: SKIP (0.000s)
[71.441835] [008/133] (950s left) prime_self_import (basic-llseek-size)
[71.473487] Starting subtest: basic-llseek-size
[71.491157] Subtest basic-llseek-size: SUCCESS (0.018s)
[71.597551] [009/133] (950s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[71.647980] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[71.709016] [010/133] (950s left) kms_draw_crc (draw-method-mmap-cpu)
[71.778652] Starting subtest: draw-method-mmap-cpu
[71.780582] Starting dynamic subtest: xrgb8888-untiled
[72.021967] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[72.028913] Starting dynamic subtest: rgb565-untiled
[72.233443] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[72.241931] Starting dynamic subtest: xrgb2101010-untiled
[72.443945] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[72.451574] Starting dynamic subtest: xbgr16161616f-untiled
[72.677744] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[72.685475] Starting dynamic subtest: xrgb8888-xtiled
[72.799988] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[72.807585] Starting dynamic subtest: rgb565-xtiled
[72.933459] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[72.941699] Starting dynamic subtest: xrgb2101010-xtiled
[73.055584] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[73.063202] Starting dynamic subtest: xbgr16161616f-xtiled
[73.167074] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[73.175986] Starting dynamic subtest: xrgb8888-4tiled
[73.300167] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[73.307928] Starting dynamic subtest: rgb565-4tiled
[73.444734] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[73.451388] Starting dynamic subtest: xrgb2101010-4tiled
[73.567053] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[73.574110] Starting dynamic subtest: xbgr16161616f-4tiled
[73.711577] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[73.713524] Subtest draw-method-mmap-cpu: SUCCESS (1.933s)
[73.800021] [011/133] (948s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[73.852883] Starting subtest: wait-all-for-submit-delayed-submit
[73.954845] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[74.029801] [012/133] (947s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[74.102593] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[80.968729] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.863s)
[81.077440] [013/133] (940s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[81.136675] Starting subtest: multi-wait-all-for-submit-signaled
[81.139072] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[81.231765] [014/133] (940s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[81.301509] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[81.306053] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[81.370333] [015/133] (940s left) gem_ctx_persistence (userptr)
[81.433637] Starting subtest: userptr
[81.620838] Subtest userptr: SUCCESS (0.187s)
[81.699818] [016/133] (940s left) prime_vgem (coherency-blt)
[81.797792] Starting subtest: coherency-blt
[82.871066] Subtest coherency-blt: SUCCESS (1.073s)
[82.970595] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[82.973699] [017/133] (939s left) gen9_exec_parse (bb-start-far)
[83.035965] Subtest bb-start-far: SKIP (0.000s)
[83.103989] [018/133] (939s left) gem_exec_balancer (nop)
[83.163546] Starting subtest: nop
[129.726270] Subtest nop: SUCCESS (46.557s)
[130.036663] [019/133] (892s left) sw_sync (sync_busy_fork)
[130.082812] Starting subtest: sync_busy_fork
[131.096514] Subtest sync_busy_fork: SUCCESS (1.012s)
[131.169425] [020/133] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[131.254690] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[131.259058] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[131.354005] [021/133] (891s left) kms_busy (extended-modeset-hang-oldfb)
[131.432691] Starting subtest: extended-modeset-hang-oldfb
[131.435059] Starting dynamic subtest: pipe-A
[143.276106] Dynamic subtest pipe-A: SUCCESS (11.841s)
[143.284210] Starting dynamic subtest: pipe-D
[155.558717] Dynamic subtest pipe-D: SUCCESS (12.280s)
[155.561256] Subtest extended-modeset-hang-oldfb: SUCCESS (24.125s)
[156.384409] [022/133] (866s left) kms_flip (blocking-absolute-wf_vblank)
[156.464331] Starting subtest: blocking-absolute-wf_vblank
[156.466716] Starting dynamic subtest: A-eDP1
[165.199230] Dynamic subtest A-eDP1: SUCCESS (8.736s)
[165.209902] Starting dynamic subtest: B-eDP1
[173.940599] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[173.949844] Starting dynamic subtest: C-eDP1
[182.668335] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[182.677992] Starting dynamic subtest: D-eDP1
[191.395683] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[191.400874] Subtest blocking-absolute-wf_vblank: SUCCESS (34.938s)
[192.603222] [023/133] (829s left) gem_mmap_gtt (basic)
[192.674639] Subtest basic: SKIP (0.000s)
[192.738717] [024/133] (829s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[192.823357] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[192.827607] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[192.904567] [025/133] (829s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[192.975802] Starting subtest: fbc-psr2-primary-mmap-gtt
[192.978116] Starting dynamic subtest: eDP-1
[192.983145] Dynamic subtest eDP-1: SKIP (0.000s)
[192.987391] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[193.047150] [026/133] (829s left) kms_cursor_crc (cursor-offscreen-128x128)
[193.238877] Starting subtest: cursor-offscreen-128x128
[193.241248] Starting dynamic subtest: pipe-A-eDP-1
[195.197819] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[195.226812] Starting dynamic subtest: pipe-D-eDP-1
[197.802391] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[197.804769] Subtest cursor-offscreen-128x128: SUCCESS (4.564s)
[198.650394] [027/133] (824s left) kms_rotation_crc (primary-rotation-90)
[198.749043] Starting subtest: primary-rotation-90
[198.753601] Subtest primary-rotation-90: SKIP (0.001s)
[198.820929] [028/133] (823s left) gem_exec_reloc (basic-gtt-cpu)
[198.889525] Subtest basic-gtt-cpu: SKIP (0.000s)
[198.966215] [029/133] (823s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[199.049327] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[199.051498] Starting dynamic subtest: pipe-A-eDP-1
[204.947177] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.903s)
[204.956146] Starting dynamic subtest: pipe-B-eDP-1
[211.571773] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.623s)
[211.574077] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.528s)
[212.472477] [030/133] (810s left) gem_render_copy (yf-tiled-to-vebox-linear)
[212.534226] Starting subtest: yf-tiled-to-vebox-linear
[212.538239] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[212.727256] [031/133] (810s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[212.811959] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[212.816151] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[212.912969] [032/133] (809s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[213.003496] Starting subtest: fbcpsr-stridechange
[219.236105] Subtest fbcpsr-stridechange: SUCCESS (6.237s)
[219.369032] [033/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[219.445455] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[219.449838] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[219.538987] [034/133] (803s left) kms_plane_lowres (tiling-yf)
[219.619217] Starting subtest: tiling-yf
[219.623510] Subtest tiling-yf: SKIP (0.000s)
[219.704384] [035/133] (803s left) kms_universal_plane (disable-primary-vs-flip)
[219.780971] Starting subtest: disable-primary-vs-flip
[219.783252] Starting dynamic subtest: pipe-A-eDP-1
[221.312342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.530s)
[221.321387] Starting dynamic subtest: pipe-B-eDP-1
[223.584988] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.271s)
[223.592454] Starting dynamic subtest: pipe-C-eDP-1
[225.845630] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.261s)
[225.853530] Starting dynamic subtest: pipe-D-eDP-1
[228.004351] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.156s)
[228.006664] Subtest disable-primary-vs-flip: SUCCESS (8.223s)
[228.807184] [036/133] (794s left) syncobj_timeline (multi-wait-signaled)
[228.864418] Starting subtest: multi-wait-signaled
[228.866737] Subtest multi-wait-signaled: SUCCESS (0.001s)
[228.962692] [037/133] (794s left) perf_pmu (invalid-open)
[229.006411] Starting subtest: invalid-open
[229.008596] Subtest invalid-open: SUCCESS (0.000s)
[229.128310] [038/133] (793s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[229.216030] Starting subtest: x-tiled-8bpp-rotate-0
[230.420232] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[230.568303] [039/133] (792s left) kms_vblank (wait-forked-hang)
[230.644074] Starting subtest: wait-forked-hang
[230.645993] Starting dynamic subtest: pipe-A-eDP-1
[256.666508] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.018s)
[256.679832] Starting dynamic subtest: pipe-D-eDP-1
[271.676063] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.007s)
[271.678328] Subtest wait-forked-hang: SUCCESS (41.029s)
[272.469294] [040/133] (750s left) gem_exec_schedule (reorder-wide)
[272.658626] Subtest reorder-wide: SKIP (0.000s)
[272.840573] [041/133] (750s left) gem_ccs (ctrl-surf-copy)
[272.894809] Starting subtest: ctrl-surf-copy
[272.899369] Subtest ctrl-surf-copy: SKIP (0.000s)
[272.991273] [042/133] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[273.074040] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[279.859470] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.787s)
[280.004105] [043/133] (743s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[280.079747] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[280.084382] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.168774] [044/133] (743s left) gem_exec_reloc (basic-gtt)
[280.221633] Subtest basic-gtt: SKIP (0.000s)
[280.291060] [045/133] (743s left) gem_tiling_max_stride
[280.400828] [046/133] (743s left) kms_color (invalid-gamma-lut-sizes)
[280.483699] Starting subtest: invalid-gamma-lut-sizes
[280.485952] Starting dynamic subtest: pipe-A
[280.779055] Dynamic subtest pipe-A: SUCCESS (0.296s)
[280.788994] Starting dynamic subtest: pipe-B
[280.791163] Dynamic subtest pipe-B: SUCCESS (0.000s)
[280.798629] Starting dynamic subtest: pipe-C
[280.800827] Dynamic subtest pipe-C: SUCCESS (0.000s)
[280.808296] Starting dynamic subtest: pipe-D
[280.810568] Dynamic subtest pipe-D: SUCCESS (0.000s)
[280.812940] Subtest invalid-gamma-lut-sizes: SUCCESS (0.300s)
[281.614892] [047/133] (741s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[281.690764] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[281.695031] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[281.784950] [048/133] (741s left) i915_pciid
[281.930152] [049/133] (741s left) kms_psr (fbc-psr2-sprite-plane-move)
[282.002371] Starting subtest: fbc-psr2-sprite-plane-move
[282.004588] Starting dynamic subtest: eDP-1
[282.008603] Dynamic subtest eDP-1: SKIP (0.000s)
[282.012610] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[282.078038] [050/133] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[282.162767] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[289.454265] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.294s)
[289.586442] [051/133] (734s left) vgem_basic (create)
[289.630179] Starting subtest: create
[289.632374] Subtest create: SUCCESS (0.000s)
[289.689778] [052/133] (733s left) core_getversion (basic)
[289.725315] Starting subtest: basic
[289.729598] Subtest basic: SUCCESS (0.000s)
[289.800660] [053/133] (733s left) gem_exec_balancer (parallel-contexts)
[290.062755] Starting subtest: parallel-contexts
[292.492787] Subtest parallel-contexts: SUCCESS (2.430s)
[292.600389] [054/133] (731s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[292.975052] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[293.746423] [055/133] (730s left) gem_spin_batch (resubmit-all)
[293.810373] Starting subtest: resubmit-all
[293.812765] Starting dynamic subtest: rcs0
[293.822144] Dynamic subtest rcs0: SUCCESS (0.011s)
[293.832346] Starting dynamic subtest: bcs0
[293.834630] Dynamic subtest bcs0: SUCCESS (0.002s)
[293.842148] Starting dynamic subtest: vcs0
[293.843975] Dynamic subtest vcs0: SUCCESS (0.002s)
[293.851070] Starting dynamic subtest: vcs1
[293.852860] Dynamic subtest vcs1: SUCCESS (0.002s)
[293.859997] Starting dynamic subtest: vecs0
[293.861813] Dynamic subtest vecs0: SUCCESS (0.002s)
[293.870327] Starting dynamic subtest: ccs0
[293.872247] Dynamic subtest ccs0: SUCCESS (0.003s)
[293.874065] Subtest resubmit-all: SUCCESS (0.026s)
[295.876256] [056/133] (727s left) kms_content_protection (legacy)
[296.002971] Starting subtest: legacy
[296.007516] Subtest legacy: SKIP (0.000s)
[296.124993] [057/133] (727s left) kms_plane_alpha_blend (constant-alpha-min)
[296.196324] Starting subtest: constant-alpha-min
[296.478761] Starting dynamic subtest: pipe-A-eDP-1
[297.167223] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[297.175283] Starting dynamic subtest: pipe-D-eDP-1
[298.645082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[298.647417] Subtest constant-alpha-min: SUCCESS (2.449s)
[299.455192] [058/133] (724s left) gem_userptr_blits (sync-overlap)
[299.529671] Starting subtest: sync-overlap
[299.532098] Subtest sync-overlap: SUCCESS (0.000s)
[299.664899] [059/133] (724s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[299.743487] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[299.747754] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[299.821619] [060/133] (724s left) gem_ctx_engines (execute-oneforall)
[299.885838] Starting subtest: execute-oneforall
[300.364044] Subtest execute-oneforall: SUCCESS (0.477s)
[301.948984] [061/133] (722s left) kms_dp_aux_dev
[302.314827] [062/133] (721s left) sysfs_preempt_timeout (invalid)
[302.375625] Starting subtest: invalid
[302.377953] Starting dynamic subtest: vecs0
[302.380299] Dynamic subtest vecs0: SUCCESS (0.000s)
[302.392288] Starting dynamic subtest: ccs0
[302.394483] Dynamic subtest ccs0: SUCCESS (0.000s)
[302.404309] Starting dynamic subtest: vcs0
[302.406174] Dynamic subtest vcs0: SUCCESS (0.000s)
[302.412913] Starting dynamic subtest: bcs0
[302.414823] Dynamic subtest bcs0: SUCCESS (0.000s)
[302.421651] Starting dynamic subtest: rcs0
[302.424159] Dynamic subtest rcs0: SUCCESS (0.000s)
[302.433399] Starting dynamic subtest: vcs1
[302.435597] Dynamic subtest vcs1: SUCCESS (0.000s)
[302.437468] Subtest invalid: SUCCESS (0.006s)
[302.481144] [063/133] (721s left) perf (gen12-group-concurrent-oa-buffer-read)
[302.611022] Starting subtest: gen12-group-concurrent-oa-buffer-read
[312.649636] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.038s)
[312.698693] [064/133] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[312.785332] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[312.789329] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[312.881219] [065/133] (711s left) perf (oa-formats)
[312.985889] Starting subtest: oa-formats
[312.987940] Starting dynamic subtest: 0-rcs0
[312.996054] Dynamic subtest 0-rcs0: SUCCESS (0.013s)
[313.005156] Starting dynamic subtest: 1-vecs0
[313.018608] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[313.020824] Subtest oa-formats: SUCCESS (0.037s)
[313.066522] [066/133] (711s left) gem_exec_gttfill (multigpu-basic)
[313.247899] Starting subtest: multigpu-basic
[324.937885] Subtest multigpu-basic: SUCCESS (11.689s)
[324.984895] [067/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[325.108710] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[325.113019] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[325.214472] [068/133] (699s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[325.295015] Starting subtest: bad-rotation-90-yf-tiled-ccs
[325.297256] Starting dynamic subtest: pipe-A-eDP-1
[325.319827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[325.328547] Starting dynamic subtest: pipe-B-eDP-1
[325.349675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[325.357310] Starting dynamic subtest: pipe-C-eDP-1
[325.379305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[325.387988] Starting dynamic subtest: pipe-D-eDP-1
[325.409873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[325.413945] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[327.606073] [069/133] (696s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[327.665654] Starting subtest: multi-wait-all-available-submitted-signaled
[327.668064] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[327.776100] [070/133] (696s left) gem_pxp (fail-invalid-protected-context)
[327.913500] Starting subtest: fail-invalid-protected-context
[327.915839] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[328.026602] [071/133] (696s left) gem_lmem_swapping (heavy-multi)
[328.076095] Subtest heavy-multi: SKIP (0.000s)
[328.115775] [072/133] (696s left) kms_invalid_mode (zero-clock)
[328.199301] Starting subtest: zero-clock
[328.201522] Starting dynamic subtest: pipe-A-eDP-1
[328.483564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[328.492811] Starting dynamic subtest: pipe-B-eDP-1
[328.495244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[328.503021] Starting dynamic subtest: pipe-C-eDP-1
[328.505516] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[328.512626] Starting dynamic subtest: pipe-D-eDP-1
[328.514537] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[328.516944] Subtest zero-clock: SUCCESS (0.290s)
[329.329266] [073/133] (695s left) kms_cursor_edge_walk (64x64-top-bottom)
[329.402399] Starting subtest: 64x64-top-bottom
[329.404682] Starting dynamic subtest: pipe-A-eDP-1
[332.890767] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s)
[332.899838] Starting dynamic subtest: pipe-D-eDP-1
[336.027324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[336.029504] Subtest 64x64-top-bottom: SUCCESS (6.625s)
[336.829855] [074/133] (687s left) kms_async_flips (async-flip-dpms)
[336.914598] Starting subtest: async-flip-dpms
[337.297925] Starting dynamic subtest: pipe-A-eDP-1
[341.249391] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.949s)
[341.619056] Starting dynamic subtest: pipe-B-eDP-1
[344.502302] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.888s)
[344.872570] Starting dynamic subtest: pipe-C-eDP-1
[347.654314] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.787s)
[348.017951] Starting dynamic subtest: pipe-D-eDP-1
[350.823147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.812s)
[350.825485] Subtest async-flip-dpms: SUCCESS (13.911s)
[351.992256] [075/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[352.077039] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[352.081321] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[352.179159] [076/133] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[352.256587] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[352.260783] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[352.388052] [077/133] (672s left) kms_psr (pr-sprite-render)
[352.464822] Starting subtest: pr-sprite-render
[352.469270] Subtest pr-sprite-render: SKIP (0.000s)
[352.535232] [078/133] (672s left) kms_lease (lease-unleased-crtc)
[352.611876] Starting subtest: lease-unleased-crtc
[352.614278] Starting dynamic subtest: pipe-A-eDP-1
[352.901815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[352.910600] Starting dynamic subtest: pipe-B-eDP-1
[353.645954] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.741s)
[353.658303] Starting dynamic subtest: pipe-C-eDP-1
[353.660417] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[353.668228] Starting dynamic subtest: pipe-D-eDP-1
[353.670408] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[353.672589] Subtest lease-unleased-crtc: SUCCESS (1.045s)
[354.028379] [079/133] (670s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[354.095309] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[354.099973] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[354.289641] [080/133] (670s left) gen9_exec_parse (shadow-peek)
[354.352082] Subtest shadow-peek: SKIP (0.000s)
[354.428745] [081/133] (670s left) gem_exec_fence (submit3)
[354.598698] Starting subtest: submit3
[354.603533] Subtest submit3: SKIP (0.000s)
[355.948608] [082/133] (668s left) i915_pm_sseu (full-enable)
[356.001888] Subtest full-enable: SKIP (0.000s)
[356.114019] [083/133] (668s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[356.351367] Starting subtest: cursor-rapid-movement-256x256
[356.356354] Starting dynamic subtest: pipe-A-eDP-1
[356.889632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[356.918500] Starting dynamic subtest: pipe-D-eDP-1
[358.137067] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[358.138960] Subtest cursor-rapid-movement-256x256: SUCCESS (1.784s)
[358.971916] [084/133] (665s left) gem_ctx_persistence (engines-hostile)
[359.041313] Starting subtest: engines-hostile
[359.043566] Starting dynamic subtest: rcs0
[359.160702] Dynamic subtest rcs0: SUCCESS (0.119s)
[359.169313] Starting dynamic subtest: bcs0
[359.261658] Dynamic subtest bcs0: SUCCESS (0.099s)
[359.272070] Starting dynamic subtest: vcs0
[359.351344] Dynamic subtest vcs0: SUCCESS (0.087s)
[359.361646] Starting dynamic subtest: vcs1
[359.442991] Dynamic subtest vcs1: SUCCESS (0.090s)
[359.453315] Starting dynamic subtest: vecs0
[359.536575] Dynamic subtest vecs0: SUCCESS (0.091s)
[359.546712] Starting dynamic subtest: ccs0
[359.628791] Dynamic subtest ccs0: SUCCESS (0.090s)
[359.631242] Subtest engines-hostile: SUCCESS (0.589s)
[359.721274] [085/133] (665s left) gem_userptr_blits (set-cache-level)
[359.792584] Starting subtest: set-cache-level
[359.796839] Subtest set-cache-level: SKIP (0.000s)
[359.925320] [086/133] (665s left) syncobj_timeline (host-signal-ordered)
[359.987396] Starting subtest: host-signal-ordered
[359.989454] Subtest host-signal-ordered: SUCCESS (0.000s)
[360.081952] [087/133] (664s left) kms_flip (flip-vs-dpms-on-nop)
[360.157349] Starting subtest: flip-vs-dpms-on-nop
[360.159238] Starting dynamic subtest: A-eDP1
[362.063407] Dynamic subtest A-eDP1: SUCCESS (1.906s)
[362.074924] Starting dynamic subtest: B-eDP1
[363.898726] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[363.909398] Starting dynamic subtest: C-eDP1
[365.719187] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[365.731429] Starting dynamic subtest: D-eDP1
[367.554067] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[367.556462] Subtest flip-vs-dpms-on-nop: SUCCESS (7.401s)
[368.741668] [088/133] (656s left) api_intel_allocator (fork-simple-once)
[368.799066] Starting subtest: fork-simple-once
[368.815141] Subtest fork-simple-once: SUCCESS (0.018s)
[368.934152] [089/133] (656s left) kms_plane_scaling (planes-downscale-factor-0-75)
[369.006751] Starting subtest: planes-downscale-factor-0-75
[369.009058] Starting dynamic subtest: pipe-A
[369.026278] Dynamic subtest pipe-A: SKIP (0.018s)
[369.034755] Starting dynamic subtest: pipe-B
[369.059818] Dynamic subtest pipe-B: SKIP (0.031s)
[369.068192] Starting dynamic subtest: pipe-C
[369.089944] Dynamic subtest pipe-C: SKIP (0.031s)
[369.097924] Starting dynamic subtest: pipe-D
[369.122511] Dynamic subtest pipe-D: SKIP (0.031s)
[369.126598] Subtest planes-downscale-factor-0-75: SKIP (0.113s)
[369.234000] [090/133] (655s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[369.290811] Starting subtest: single-wait-for-submit-available-submitted
[369.293082] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[369.392237] [091/133] (655s left) kms_psr (psr2-cursor-plane-move)
[369.465808] Starting subtest: psr2-cursor-plane-move
[369.468074] Starting dynamic subtest: eDP-1
[371.221850] Dynamic subtest eDP-1: SUCCESS (1.755s)
[371.224214] Subtest psr2-cursor-plane-move: SUCCESS (1.757s)
[372.029875] [092/133] (653s left) kms_cursor_crc (cursor-size-change)
[372.111295] Starting subtest: cursor-size-change
[372.113442] Starting dynamic subtest: pipe-A-eDP-1
[372.887349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[372.896082] Starting dynamic subtest: pipe-D-eDP-1
[374.380656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[374.382810] Subtest cursor-size-change: SUCCESS (2.269s)
[375.178784] [093/133] (650s left) prime_vgem (basic-fence-mmap)
[375.274723] Starting subtest: basic-fence-mmap
[375.279318] Subtest basic-fence-mmap: SKIP (0.000s)
[375.367313] [094/133] (649s left) gem_softpin (noreloc-s3)
[375.430672] Starting subtest: noreloc-S3
[395.186090] Subtest noreloc-S3: SUCCESS (5.378s)
[395.385995] [095/133] (629s left) gem_exec_parallel (basic)
[395.460349] Starting subtest: basic
[395.462857] Starting dynamic subtest: rcs0
[396.981693] Dynamic subtest rcs0: SUCCESS (1.510s)
[396.994286] Starting dynamic subtest: bcs0
[398.494605] Dynamic subtest bcs0: SUCCESS (1.502s)
[398.503639] Starting dynamic subtest: vcs0
[400.221351] Dynamic subtest vcs0: SUCCESS (1.715s)
[400.230241] Starting dynamic subtest: vcs1
[402.140982] Dynamic subtest vcs1: SUCCESS (1.911s)
[402.153212] Starting dynamic subtest: vecs0
[404.125375] Dynamic subtest vecs0: SUCCESS (1.976s)
[404.137312] Starting dynamic subtest: ccs0
[405.612512] Dynamic subtest ccs0: SUCCESS (1.482s)
[405.614877] Subtest basic: SUCCESS (10.109s)
[405.799410] [096/133] (619s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[405.912328] Starting subtest: cursorA-vs-flipA-toggle
[417.055601] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s)
[417.909602] [097/133] (607s left) kms_pm_lpsp (kms-lpsp)
[418.993399] Starting subtest: kms-lpsp
[418.995728] Starting dynamic subtest: pipe-A-eDP-1
[419.141547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[419.443867] Subtest kms-lpsp: SUCCESS (0.453s)
[420.237781] [098/133] (605s left) core_getstats (basic)
[420.292362] Starting subtest: basic
[420.294459] Subtest basic: SUCCESS (0.000s)
[420.405987] [099/133] (605s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[420.495951] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[420.500007] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[420.594398] [100/133] (604s left) kms_force_connector_basic (force-load-detect)
[420.650011] Subtest force-load-detect: SKIP (0.000s)
[420.707387] [101/133] (604s left) i915_pm_rpm (system-suspend-execbuf)
[422.308243] Starting subtest: system-suspend-execbuf
[480.193568] Subtest system-suspend-execbuf: SUCCESS (42.952s)
[480.558803] [102/133] (545s left) gem_exec_whisper (basic-forked-all)
[480.634626] Starting subtest: basic-forked-all
[493.730920] Subtest basic-forked-all: SUCCESS (13.092s)
[493.914959] [103/133] (531s left) kms_async_flips (test-time-stamp)
[493.993760] Starting subtest: test-time-stamp
[494.371649] Starting dynamic subtest: pipe-A-eDP-1
[495.170531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[495.555592] Starting dynamic subtest: pipe-B-eDP-1
[496.305293] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[496.684181] Starting dynamic subtest: pipe-C-eDP-1
[497.444998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[497.813176] Starting dynamic subtest: pipe-D-eDP-1
[498.569952] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[498.572432] Subtest test-time-stamp: SUCCESS (4.575s)
[499.736551] [104/133] (525s left) gem_exec_async (forked-writes)
[499.809384] Starting subtest: forked-writes
[499.811852] Starting dynamic subtest: rcs0
[499.840365] Dynamic subtest rcs0: SUCCESS (0.031s)
[499.851368] Starting dynamic subtest: bcs0
[499.866995] Dynamic subtest bcs0: SUCCESS (0.025s)
[499.877229] Starting dynamic subtest: vcs0
[499.889649] Dynamic subtest vcs0: SUCCESS (0.022s)
[499.900944] Starting dynamic subtest: vcs1
[499.913684] Dynamic subtest vcs1: SUCCESS (0.023s)
[499.924104] Starting dynamic subtest: vecs0
[499.935030] Dynamic subtest vecs0: SUCCESS (0.020s)
[499.945609] Starting dynamic subtest: ccs0
[499.958436] Dynamic subtest ccs0: SUCCESS (0.023s)
[499.960674] Subtest forked-writes: SUCCESS (0.150s)
[500.179176] [105/133] (525s left) kms_frontbuffer_tracking (fbc-stridechange)
[500.266437] Starting subtest: fbc-stridechange
[503.528709] Subtest fbc-stridechange: SUCCESS (3.266s)
[504.643655] [106/133] (521s left) kms_chamelium_color (ctm-blue-to-red)
[504.721853] Subtest ctm-blue-to-red: SKIP (0.000s)
[504.765563] [107/133] (521s left) kms_pm_rpm (fences-dpms)
[506.274422] Starting subtest: fences-dpms
[506.279382] Subtest fences-dpms: SKIP (0.000s)
[506.961059] [108/133] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[507.030830] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[507.034883] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[507.151565] [109/133] (518s left) gem_mmap_offset (blt-coherency)
[507.209600] Starting subtest: blt-coherency
[507.214619] Subtest blt-coherency: SUCCESS (0.007s)
[507.332897] [110/133] (518s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[507.428352] Starting subtest: cursorA-vs-flipA-varying-size
[518.581392] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.149s)
[519.397804] [111/133] (506s left) kms_psr (psr-sprite-blt)
[519.486352] Starting subtest: psr-sprite-blt
[519.488777] Starting dynamic subtest: eDP-1
[521.220637] Dynamic subtest eDP-1: SUCCESS (1.734s)
[521.222965] Subtest psr-sprite-blt: SUCCESS (1.736s)
[522.051935] [112/133] (503s left) vgem_basic (dmabuf-export)
[522.095566] Starting subtest: dmabuf-export
[522.142537] Subtest dmabuf-export: SUCCESS (0.053s)
[522.262328] [113/133] (503s left) gem_exec_schedule (preempt-engines)
[522.327804] Starting subtest: preempt-engines
[522.329720] Starting dynamic subtest: rcs0
[524.629991] Dynamic subtest rcs0: SUCCESS (2.308s)
[524.643100] Starting dynamic subtest: bcs0
[526.926596] Dynamic subtest bcs0: SUCCESS (2.294s)
[526.937935] Starting dynamic subtest: vcs0
[529.244947] Dynamic subtest vcs0: SUCCESS (2.315s)
[529.255376] Starting dynamic subtest: vcs1
[531.522560] Dynamic subtest vcs1: SUCCESS (2.274s)
[531.532701] Starting dynamic subtest: vecs0
[533.783027] Dynamic subtest vecs0: SUCCESS (2.257s)
[533.792509] Starting dynamic subtest: ccs0
[536.060328] Dynamic subtest ccs0: SUCCESS (2.273s)
[536.063043] Subtest preempt-engines: SUCCESS (13.735s)
[536.409914] [114/133] (489s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[536.498039] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[536.502115] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[536.589369] [115/133] (489s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[536.655777] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[536.660237] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[536.759510] [116/133] (489s left) gem_exec_reloc (basic-cpu-noreloc)
[536.815445] Subtest basic-cpu-noreloc: SKIP (0.000s)
[536.886483] [117/133] (489s left) kms_atomic_transition (plane-toggle-modeset-transition)
[536.953044] Starting subtest: plane-toggle-modeset-transition
[536.955190] Starting dynamic subtest: pipe-A-eDP-1
[549.713886] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.762s)
[549.728480] Starting dynamic subtest: pipe-B-eDP-1
[562.150044] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.428s)
[562.152680] Subtest plane-toggle-modeset-transition: SUCCESS (25.196s)
[562.974277] [118/133] (463s left) gem_exec_flush (basic-wb-pro-default)
[563.043912] Starting subtest: basic-wb-pro-default
[568.499174] Subtest basic-wb-pro-default: SUCCESS (5.456s)
[568.683169] [119/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[568.762843] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[568.767432] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[568.865060] [120/133] (457s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[568.936619] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[572.516594] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.583s)
[573.651491] [121/133] (452s left) kms_chamelium_edid (vga-edid-read)
[574.017146] Subtest vga-edid-read: SKIP (0.000s)
[574.854324] [122/133] (451s left) kms_big_fb (linear-32bpp-rotate-90)
[574.939492] Starting subtest: linear-32bpp-rotate-90
[574.959993] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[575.073509] [123/133] (451s left) kms_flip (dpms-off-confusion-interruptible)
[575.148359] Starting subtest: dpms-off-confusion-interruptible
[575.150703] Starting dynamic subtest: A-eDP1
[583.777104] Dynamic subtest A-eDP1: SUCCESS (8.627s)
[583.789371] Starting dynamic subtest: B-eDP1
[592.415762] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[592.429591] Starting dynamic subtest: C-eDP1
[601.049253] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[601.059819] Starting dynamic subtest: D-eDP1
[609.681096] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[609.683516] Subtest dpms-off-confusion-interruptible: SUCCESS (34.529s)
[610.838243] [124/133] (415s left) syncobj_wait (invalid-wait-illegal-handle)
[610.890805] Starting subtest: invalid-wait-illegal-handle
[610.893188] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[610.987612] [125/133] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[611.061255] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[615.438537] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.379s)
[616.653973] [126/133] (409s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[616.724109] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[616.725943] Starting dynamic subtest: pipe-A-eDP-1
[616.745932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[616.762376] Starting dynamic subtest: pipe-B-eDP-1
[616.782219] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[616.795136] Starting dynamic subtest: pipe-C-eDP-1
[616.814552] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[616.823568] Starting dynamic subtest: pipe-D-eDP-1
[616.843092] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[616.845291] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[619.081815] [127/133] (407s left) syncobj_wait (multi-wait-for-submit-submitted)
[619.150310] Starting subtest: multi-wait-for-submit-submitted
[619.256889] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[619.333179] [128/133] (407s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[619.417662] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[620.418334] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.001s)
[620.552897] [129/133] (406s left) syncobj_eventfd (invalid-illegal-handle)
[620.615174] Starting subtest: invalid-illegal-handle
[620.616870] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[620.702706] [130/133] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[620.789726] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[620.793095] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[620.880947] [131/133] (405s left) gem_exec_reloc (basic-write-gtt-noreloc)
[620.950364] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[621.016455] [132/133] (405s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[621.090724] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[621.162716] [133/133] (405s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[621.242505] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[622.045242] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[622.189844] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: prime_self_import
results: parsing output: 8/ for test: kms_pipe_b_c_ivb
results: parsing output: 9/ for test: kms_draw_crc
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_rotation_crc
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_lowres
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_tiling_max_stride
results: parsing output: 45/ for test: kms_color
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_pciid
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: core_getversion
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: gem_spin_batch
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: kms_plane_alpha_blend
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gem_ctx_engines
results: parsing output: 60/ for test: kms_dp_aux_dev
results: parsing output: 61/ for test: sysfs_preempt_timeout
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_exec_gttfill
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_invalid_mode
results: parsing output: 72/ for test: kms_cursor_edge_walk
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_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: i915_pm_sseu
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: api_intel_allocator
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: gem_exec_parallel
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_pm_lpsp
results: parsing output: 97/ for test: core_getstats
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_force_connector_basic
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_async
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_color
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: vgem_basic
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_atomic_transition
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: syncobj_eventfd
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: kms_big_fb
Done.