[57.983593] Initializing watchdogs
[57.983637]   /dev/watchdog0
[57.998396] [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]
[58.002879] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.005112] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.006960] [001/133] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[58.110222] Starting subtest: primary-y-tiled-reflect-x-90
[58.112766] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[58.183719] [002/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[58.281890] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[58.282752] Starting dynamic subtest: pipe-A-eDP-1
[58.405584] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[58.412228] Starting dynamic subtest: pipe-B-eDP-1
[59.545351] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[59.546828] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.282s)
[60.699827] [003/133] (957s left) syncobj_timeline (invalid-signal-illegal-handle)
[60.761742] Starting subtest: invalid-signal-illegal-handle
[60.762703] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[60.870175] [004/133] (957s left) gem_mmap_gtt (big-bo-tiledy)
[60.919049] Subtest big-bo-tiledY: SKIP (0.000s)
[60.971043] [005/133] (957s left) kms_plane (pixel-format-y-tiled-modifier)
[61.052910] Starting subtest: pixel-format-y-tiled-modifier
[61.054586] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[61.117908] [006/133] (957s left) gen9_exec_parse (batch-invalid-length)
[61.175060] Subtest batch-invalid-length: SKIP (0.000s)
[61.227512] [007/133] (957s left) kms_psr (fbc-psr2-cursor-plane-move)
[61.312257] Starting subtest: fbc-psr2-cursor-plane-move
[61.313182] Starting dynamic subtest: eDP-1
[61.314813] Dynamic subtest eDP-1: SKIP (0.000s)
[61.316400] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[61.388806] [008/133] (957s left) i915_query (query-topology-garbage-items)
[61.457181] Starting subtest: query-topology-garbage-items
[61.458173] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[61.563893] [009/133] (957s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[61.620589] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[61.678588] [010/133] (957s left) i915_drm_fdinfo (busy)
[61.712865] Starting subtest: busy
[61.713736] Starting dynamic subtest: rcs0
[61.735966] Dynamic subtest rcs0: SKIP (0.023s)
[61.743879] Starting dynamic subtest: bcs0
[61.745481] Dynamic subtest bcs0: SKIP (0.000s)
[61.758069] Starting dynamic subtest: vcs0
[61.760413] Dynamic subtest vcs0: SKIP (0.000s)
[61.766240] Starting dynamic subtest: vcs1
[61.767997] Dynamic subtest vcs1: SKIP (0.000s)
[61.773620] Starting dynamic subtest: vecs0
[61.775248] Dynamic subtest vecs0: SKIP (0.000s)
[61.780738] Starting dynamic subtest: ccs0
[61.782330] Dynamic subtest ccs0: SKIP (0.000s)
[61.784036] Subtest busy: SKIP (0.026s)
[61.811111] [011/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[61.896910] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[61.898596] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[62.004583] [012/133] (956s left) kms_flip (dpms-off-confusion)
[62.086870] Starting subtest: dpms-off-confusion
[62.089047] Starting dynamic subtest: A-eDP1
[70.828052] Dynamic subtest A-eDP1: SUCCESS (8.762s)
[70.835666] Starting dynamic subtest: B-eDP1
[79.531092] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[79.538857] Starting dynamic subtest: C-eDP1
[88.241956] Dynamic subtest C-eDP1: SUCCESS (8.699s)
[88.250667] Starting dynamic subtest: D-eDP1
[96.872675] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[96.873720] Subtest dpms-off-confusion: SUCCESS (34.814s)
[98.011017] [013/133] (920s left) kms_big_fb (linear-32bpp-rotate-0)
[98.106882] Starting subtest: linear-32bpp-rotate-0
[99.641976] Subtest linear-32bpp-rotate-0: SUCCESS (1.535s)
[99.756113] [014/133] (919s left) kms_async_flips (crc)
[99.842314] Starting subtest: crc
[100.214760] Starting dynamic subtest: pipe-A-eDP-1
[103.130357] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[103.510312] Starting dynamic subtest: pipe-B-eDP-1
[106.440161] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.938s)
[106.812569] Starting dynamic subtest: pipe-C-eDP-1
[109.658828] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.853s)
[110.018109] Starting dynamic subtest: pipe-D-eDP-1
[112.918859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.907s)
[112.919669] Subtest crc: SUCCESS (13.077s)
[114.067405] [015/133] (904s left) kms_setmode (clone-exclusive-crtc)
[114.136414] Starting subtest: clone-exclusive-crtc
[114.139287] Subtest clone-exclusive-crtc: SKIP (0.000s)
[114.234231] [016/133] (904s left) kms_psr (psr2-sprite-plane-onoff)
[114.318220] Starting subtest: psr2-sprite-plane-onoff
[114.319127] Starting dynamic subtest: eDP-1
[116.089353] Dynamic subtest eDP-1: SUCCESS (1.771s)
[116.090356] Subtest psr2-sprite-plane-onoff: SUCCESS (1.772s)
[116.911734] [017/133] (902s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[117.009654] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[117.011507] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[117.086882] [018/133] (901s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[117.174537] Starting subtest: plane-all-modeset-transition-internal-panels
[117.176623] Starting dynamic subtest: pipe-A-eDP-1
[118.475406] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.295s)
[118.741964] Starting dynamic subtest: pipe-B-eDP-1
[119.790932] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[120.058164] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.887s)
[120.915760] [019/133] (898s left) kms_psr2_su (page_flip-xrgb8888)
[120.971027] Subtest page_flip-XRGB8888: SKIP (0.000s)
[121.028207] [020/133] (898s left) kms_chamelium_audio (dp-audio-edid)
[121.415352] Subtest dp-audio-edid: SKIP (0.000s)
[122.219447] [021/133] (896s left) kms_addfb_basic (bad-pitch-32)
[122.264926] Starting subtest: bad-pitch-32
[122.265814] Subtest bad-pitch-32: SUCCESS (0.000s)
[122.386944] [022/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[122.467838] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[122.469870] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[122.543067] [023/133] (896s left) kms_hdr (brightness-with-hdr)
[122.624211] Starting subtest: brightness-with-hdr
[122.626925] Subtest brightness-with-hdr: SKIP (0.000s)
[122.705817] [024/133] (896s left) syncobj_wait (invalid-reset-zero-handles)
[122.750281] Starting subtest: invalid-reset-zero-handles
[122.751203] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[122.838752] [025/133] (896s left) kms_psr (fbc-psr-sprite-render)
[122.914021] Starting subtest: fbc-psr-sprite-render
[122.914795] Starting dynamic subtest: eDP-1
[122.916268] Dynamic subtest eDP-1: SKIP (0.000s)
[122.917801] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[122.977873] [026/133] (896s left) gem_exec_reloc (basic-write-gtt-noreloc)
[123.031263] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[123.087642] [027/133] (896s left) gem_exec_fence (basic-wait)
[123.263675] Starting subtest: basic-wait
[123.265741] Starting dynamic subtest: rcs0
[123.334719] Dynamic subtest rcs0: SUCCESS (0.073s)
[123.344532] Starting dynamic subtest: bcs0
[123.386219] Dynamic subtest bcs0: SUCCESS (0.051s)
[123.394303] Starting dynamic subtest: vcs0
[123.434166] Dynamic subtest vcs0: SUCCESS (0.047s)
[123.442556] Starting dynamic subtest: vcs1
[123.486781] Dynamic subtest vcs1: SUCCESS (0.052s)
[123.494701] Starting dynamic subtest: vecs0
[123.538473] Dynamic subtest vecs0: SUCCESS (0.050s)
[123.547166] Starting dynamic subtest: ccs0
[123.588526] Dynamic subtest ccs0: SUCCESS (0.049s)
[123.589899] Subtest basic-wait: SUCCESS (0.328s)
[125.362639] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[125.364808] [028/133] (894s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[125.465490] Starting subtest: fbc-rgb565-draw-mmap-cpu
[129.586693] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.121s)
[130.737994] [029/133] (888s left) kms_plane_cursor (primary)
[130.844054] Starting subtest: primary
[130.846070] Starting dynamic subtest: pipe-A-eDP-1-size-64
[133.385738] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[133.410801] Starting dynamic subtest: pipe-A-eDP-1-size-128
[135.976103] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[136.001052] Starting dynamic subtest: pipe-A-eDP-1-size-256
[138.565944] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[138.886289] Starting dynamic subtest: pipe-B-eDP-1-size-64
[142.117480] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.239s)
[142.144846] Starting dynamic subtest: pipe-B-eDP-1-size-128
[144.663112] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.528s)
[144.687124] Starting dynamic subtest: pipe-B-eDP-1-size-256
[147.253041] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s)
[147.573431] Starting dynamic subtest: pipe-C-eDP-1-size-64
[150.557184] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.999s)
[150.582185] Starting dynamic subtest: pipe-C-eDP-1-size-128
[152.768463] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[152.794780] Starting dynamic subtest: pipe-C-eDP-1-size-256
[155.001669] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.213s)
[155.314770] Starting dynamic subtest: pipe-D-eDP-1-size-64
[158.228037] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.920s)
[158.255373] Starting dynamic subtest: pipe-D-eDP-1-size-128
[160.428089] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[160.453697] Starting dynamic subtest: pipe-D-eDP-1-size-256
[162.683528] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[162.994210] Subtest primary: SUCCESS (32.148s)
[163.786251] [030/133] (855s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[163.895145] Starting subtest: y-tiled-8bpp-rotate-90
[163.896959] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[163.990585] [031/133] (855s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[164.094882] Starting subtest: fbcpsr-slowdraw
[189.347388] Subtest fbcpsr-slowdraw: SUCCESS (25.253s)
[189.468504] [032/133] (830s left) gem_exec_reloc (basic-wc-read-active)
[189.523849] Subtest basic-wc-read-active: SKIP (0.000s)
[189.585079] [033/133] (829s left) kms_plane_alpha_blend (alpha-7efc)
[189.677721] Starting subtest: alpha-7efc
[189.970191] Starting dynamic subtest: pipe-A-eDP-1
[190.573705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[190.598564] Starting dynamic subtest: pipe-D-eDP-1
[191.848175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[191.849095] Subtest alpha-7efc: SUCCESS (2.171s)
[192.705385] [034/133] (826s left) perf (gen12-unprivileged-single-ctx-counters)
[192.833857] Starting subtest: gen12-unprivileged-single-ctx-counters
[192.834660] Starting dynamic subtest: rcs0
[192.876963] Dynamic subtest rcs0: SUCCESS (0.043s)
[192.879423] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.045s)
[192.924792] [035/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[193.047102] Starting subtest: bad-rotation-90-y-tiled-ccs
[193.047866] Starting dynamic subtest: pipe-A-eDP-1
[193.055869] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.062482] Starting dynamic subtest: pipe-B-eDP-1
[193.070511] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.077243] Starting dynamic subtest: pipe-C-eDP-1
[193.084867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.091496] Starting dynamic subtest: pipe-D-eDP-1
[193.099276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.100752] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[195.289563] [036/133] (824s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[195.342295] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[195.344021] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[195.544768] [037/133] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[195.645913] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[195.647759] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[195.746104] [038/133] (823s left) kms_setmode (invalid-clone-exclusive-crtc)
[195.796783] Starting subtest: invalid-clone-exclusive-crtc
[195.799596] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[195.895060] [039/133] (823s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[195.993351] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[197.130033] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.137s)
[197.256860] [040/133] (822s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[197.364832] Starting subtest: yf-tiled-addfb-size-overflow
[197.366933] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[197.445728] [041/133] (822s left) syncobj_basic (bad-create-flags)
[197.500326] Starting subtest: bad-create-flags
[197.501188] Subtest bad-create-flags: SUCCESS (0.000s)
[197.607450] [042/133] (822s left) gem_lmem_swapping (verify-random)
[197.640810] Subtest verify-random: SKIP (0.000s)
[197.679159] [043/133] (822s left) kms_cursor_legacy (torture-bo)
[197.782296] Starting subtest: torture-bo
[197.783283] Starting dynamic subtest: pipe-A
[203.644657] Dynamic subtest pipe-A: SUCCESS (5.816s)
[203.657344] Starting dynamic subtest: pipe-B
[210.520347] Dynamic subtest pipe-B: SUCCESS (6.910s)
[210.529404] Starting dynamic subtest: pipe-C
[218.469331] Dynamic subtest pipe-C: SUCCESS (7.945s)
[218.480847] Starting dynamic subtest: pipe-D
[225.330244] Dynamic subtest pipe-D: SUCCESS (6.867s)
[225.337566] Starting dynamic subtest: all-pipes
[231.743299] Dynamic subtest all-pipes: SUCCESS (6.402s)
[231.744311] Subtest torture-bo: SUCCESS (33.952s)
[231.887837] [044/133] (788s left) sysfs_preempt_timeout (timeout)
[231.949204] Starting subtest: timeout
[231.950040] Starting dynamic subtest: vecs0
[241.313636] Dynamic subtest vecs0: SUCCESS (9.355s)
[241.325925] Starting dynamic subtest: ccs0
[242.688209] Dynamic subtest ccs0: SUCCESS (1.380s)
[242.698740] Starting dynamic subtest: vcs0
[252.331059] Dynamic subtest vcs0: SUCCESS (9.633s)
[252.340273] Starting dynamic subtest: bcs0
[253.586985] Dynamic subtest bcs0: SUCCESS (1.263s)
[253.605964] Starting dynamic subtest: rcs0
[254.870354] Dynamic subtest rcs0: SUCCESS (1.280s)
[254.879760] Starting dynamic subtest: vcs1
[264.289494] Dynamic subtest vcs1: SUCCESS (9.410s)
[264.290469] Subtest timeout: SUCCESS (32.333s)
[264.351794] [045/133] (755s left) gem_userptr_blits (create-destroy-unsync)
[264.410988] Subtest create-destroy-unsync: SKIP (0.000s)
[264.525486] [046/133] (755s left) gem_exec_balancer (full-pulse)
[264.584096] Starting subtest: full-pulse
[269.262381] Subtest full-pulse: SUCCESS (4.678s)
[269.575143] [047/133] (750s left) kms_vblank (query-forked-hang)
[269.658973] Starting subtest: query-forked-hang
[269.659779] Starting dynamic subtest: pipe-A-eDP-1
[296.097448] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.434s)
[296.106437] Starting dynamic subtest: pipe-D-eDP-1
[311.075128] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[311.076102] Subtest query-forked-hang: SUCCESS (41.415s)
[311.926033] [048/133] (708s left) gem_exec_fence (syncobj-unused-fence)
[312.378374] Starting subtest: syncobj-unused-fence
[312.384559] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[314.409096] [049/133] (705s left) kms_cursor_crc (cursor-sliding-32x32)
[314.565217] Starting subtest: cursor-sliding-32x32
[314.609784] Subtest cursor-sliding-32x32: SKIP (0.042s)
[314.900424] [050/133] (705s left) prime_mmap_kms (buffer-sharing)
[314.996568] Starting subtest: buffer-sharing
[315.445936] Subtest buffer-sharing: SUCCESS (0.451s)
[316.287225] [051/133] (703s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[316.380919] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[316.382841] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[316.469853] [052/133] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[316.561172] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[320.143496] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.582s)
[321.273630] [053/133] (698s left) gem_exec_reloc (basic-write-wc-active)
[321.324032] Subtest basic-write-wc-active: SKIP (0.000s)
[321.398394] [054/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[321.486954] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[321.488739] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[321.583657] [055/133] (698s left) syncobj_timeline (multi-wait-signaled)
[321.652808] Starting subtest: multi-wait-signaled
[321.653800] Subtest multi-wait-signaled: SUCCESS (0.001s)
[321.765578] [056/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[321.869293] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[321.870898] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[321.963594] [057/133] (698s left) kms_chamelium_frames (dp-frame-dump)
[322.344459] Subtest dp-frame-dump: SKIP (0.000s)
[323.165549] [058/133] (697s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[323.254881] Starting subtest: psr-rgb565-draw-mmap-wc
[330.155150] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.901s)
[330.251992] [059/133] (690s left) kms_psr (psr-dpms)
[330.344387] Starting subtest: psr-dpms
[330.345274] Starting dynamic subtest: eDP-1
[333.343554] Dynamic subtest eDP-1: SUCCESS (2.998s)
[333.344487] Subtest psr-dpms: SUCCESS (2.999s)
[334.195923] [060/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[334.284180] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[334.285635] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[334.371429] [061/133] (686s left) gem_spin_batch (spin-all-new)
[334.426088] Starting subtest: spin-all-new
[334.443506] Subtest spin-all-new: SUCCESS (0.017s)
[336.386384] [062/133] (684s left) kms_setmode (invalid-clone-single-crtc-stealing)
[336.442507] Starting subtest: invalid-clone-single-crtc-stealing
[336.445183] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[336.533417] [063/133] (684s left) gem_eio (execbuf)
[336.746936] Starting subtest: execbuf
[337.082114] Subtest execbuf: SUCCESS (0.336s)
[337.258666] [064/133] (683s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[337.351036] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[337.353348] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[337.440433] [065/133] (683s left) gem_exec_schedule (out-order)
[337.498295] Starting subtest: out-order
[337.499252] Starting dynamic subtest: rcs0
[337.610071] Dynamic subtest rcs0: SUCCESS (0.111s)
[337.618595] Starting dynamic subtest: vcs0
[337.701356] Dynamic subtest vcs0: SUCCESS (0.090s)
[337.712064] Starting dynamic subtest: vcs1
[337.781926] Dynamic subtest vcs1: SUCCESS (0.079s)
[337.793185] Starting dynamic subtest: vecs0
[337.860929] Dynamic subtest vecs0: SUCCESS (0.078s)
[337.873840] Starting dynamic subtest: ccs0
[337.955444] Dynamic subtest ccs0: SUCCESS (0.093s)
[337.957043] Subtest out-order: SUCCESS (0.457s)
[339.385656] [066/133] (681s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[339.446357] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[339.550258] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[339.635038] [067/133] (681s left) kms_addfb_basic (tile-pitch-mismatch)
[339.693563] Starting subtest: tile-pitch-mismatch
[339.695404] Subtest tile-pitch-mismatch: SKIP (0.000s)
[339.831958] [068/133] (680s left) gem_exercise_blt (fast-copy)
[339.889557] Starting subtest: fast-copy
[339.890529] Starting dynamic subtest: linear-smem-smem
[339.919931] Dynamic subtest linear-smem-smem: SUCCESS (0.030s)
[339.932869] Starting dynamic subtest: xmajor-smem-smem
[339.938261] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[339.946348] Starting dynamic subtest: tile4-smem-smem
[339.955687] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[339.963439] Starting dynamic subtest: tile64-smem-smem
[339.973591] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[339.974584] Subtest fast-copy: SUCCESS (0.084s)
[340.072939] [069/133] (680s left) kms_universal_plane (cursor-fb-leak)
[340.160376] Starting subtest: cursor-fb-leak
[340.161457] Starting dynamic subtest: pipe-A-eDP-1
[340.496674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[340.508240] Starting dynamic subtest: pipe-B-eDP-1
[341.841627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[341.853537] Starting dynamic subtest: pipe-C-eDP-1
[343.161560] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s)
[343.173401] Starting dynamic subtest: pipe-D-eDP-1
[344.511577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[344.512626] Subtest cursor-fb-leak: SUCCESS (4.353s)
[345.652478] [070/133] (675s left) kms_atomic (test-only)
[345.746398] Starting subtest: test-only
[345.795592] Starting dynamic subtest: pipe-A-eDP-1
[348.367953] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[348.368807] Subtest test-only: SUCCESS (2.623s)
[349.184040] [071/133] (671s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[349.284417] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[349.285343] Starting dynamic subtest: pipe-A-eDP-1
[349.743157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[349.751349] Starting dynamic subtest: pipe-B-eDP-1
[351.188123] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[351.196453] Starting dynamic subtest: pipe-C-eDP-1
[352.593375] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[352.602112] Starting dynamic subtest: pipe-D-eDP-1
[353.979959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s)
[353.980815] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.687s)
[355.091848] [072/133] (665s left) kms_cursor_crc (cursor-dpms)
[355.214057] Starting subtest: cursor-dpms
[355.214977] Starting dynamic subtest: pipe-A-eDP-1
[358.302945] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.088s)
[358.311289] Starting dynamic subtest: pipe-D-eDP-1
[361.886547] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.582s)
[361.887464] Subtest cursor-dpms: SUCCESS (6.673s)
[362.715988] [073/133] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[362.802554] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[362.803480] Starting dynamic subtest: pipe-A
[363.851076] Dynamic subtest pipe-A: SUCCESS (1.050s)
[363.859086] Starting dynamic subtest: pipe-B
[365.927791] Dynamic subtest pipe-B: SUCCESS (2.076s)
[365.937149] Starting dynamic subtest: pipe-C
[367.145647] Dynamic subtest pipe-C: SUCCESS (1.216s)
[367.153397] Starting dynamic subtest: pipe-D
[368.364035] Dynamic subtest pipe-D: SUCCESS (1.218s)
[368.364939] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.563s)
[369.550067] [074/133] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[369.643966] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[369.645842] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[369.742588] [075/133] (651s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[369.820632] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[369.822340] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[369.909419] [076/133] (651s left) kms_color (gamma)
[370.005553] Starting subtest: gamma
[370.006480] Starting dynamic subtest: pipe-A-eDP-1
[370.715913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[370.723819] Starting dynamic subtest: pipe-B-eDP-1
[372.146896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[372.154888] Starting dynamic subtest: pipe-C-eDP-1
[373.543833] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[373.552314] Starting dynamic subtest: pipe-D-eDP-1
[374.876978] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[374.878225] Subtest gamma: SUCCESS (4.871s)
[375.674826] [077/133] (645s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[375.779648] Starting subtest: 4-tiled-32bpp-rotate-180
[377.225734] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.446s)
[377.364563] [078/133] (643s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[377.450364] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[377.452090] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[378.612716] [079/133] (642s left) kms_flip (flip-vs-dpms-on-nop)
[378.691625] Starting subtest: flip-vs-dpms-on-nop
[378.694020] Starting dynamic subtest: A-eDP1
[380.606053] Dynamic subtest A-eDP1: SUCCESS (1.912s)
[380.623189] Starting dynamic subtest: B-eDP1
[382.449992] Dynamic subtest B-eDP1: SUCCESS (1.841s)
[382.461187] Starting dynamic subtest: C-eDP1
[384.278092] Dynamic subtest C-eDP1: SUCCESS (1.824s)
[384.288540] Starting dynamic subtest: D-eDP1
[386.126786] Dynamic subtest D-eDP1: SUCCESS (1.845s)
[386.127818] Subtest flip-vs-dpms-on-nop: SUCCESS (7.435s)
[387.293146] [080/133] (633s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[387.376626] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[387.377527] Starting dynamic subtest: pipe-A-default-mode
[388.558251] Dynamic subtest pipe-A-default-mode: SKIP (1.180s)
[388.560076] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.182s)
[388.690094] [081/133] (632s left) gem_eio (hibernate)
[388.921088] Starting subtest: hibernate
[403.929535] Subtest hibernate: SUCCESS (15.007s)
[411.077429] [082/133] (617s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[411.204472] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[411.205377] Starting dynamic subtest: pipe-A-eDP-1
[411.212859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[411.226565] Starting dynamic subtest: pipe-B-eDP-1
[411.234505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[411.245063] Starting dynamic subtest: pipe-C-eDP-1
[411.252474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[411.260985] Starting dynamic subtest: pipe-D-eDP-1
[411.268749] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[411.269613] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[413.484335] [083/133] (614s left) kms_atomic_interruptible (legacy-dpms)
[413.569392] Starting subtest: legacy-dpms
[413.570250] Starting dynamic subtest: pipe-A-eDP-1
[421.015396] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[421.016233] Subtest legacy-dpms: SUCCESS (7.446s)
[421.828802] [084/133] (606s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[423.466298] Starting subtest: dpms-mode-unset-non-lpsp
[424.622497] Subtest dpms-mode-unset-non-lpsp: SKIP (1.158s)
[424.992813] [085/133] (603s left) kms_pm_rpm (system-suspend-idle)
[426.511430] Starting subtest: system-suspend-idle
[449.685967] Subtest system-suspend-idle: SUCCESS (8.236s)
[450.069614] [086/133] (578s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[450.167789] Starting subtest: yf-tiled-32bpp-rotate-180
[450.169697] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[450.267896] [087/133] (578s left) kms_flip (blocking-wf_vblank)
[450.368378] Starting subtest: blocking-wf_vblank
[450.370498] Starting dynamic subtest: A-eDP1
[459.331297] Dynamic subtest A-eDP1: SUCCESS (8.936s)
[459.343590] Starting dynamic subtest: B-eDP1
[468.269711] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[468.281699] Starting dynamic subtest: C-eDP1
[477.207088] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[477.219576] Starting dynamic subtest: D-eDP1
[498.141119] Dynamic subtest D-eDP1: FAIL (21.152s)
[498.141956] Subtest blocking-wf_vblank: FAIL (47.961s)
[499.190083] [088/133] (529s left) template (b)
[499.234361] Starting subtest: B
[499.235195] Subtest B: SUCCESS (0.000s)
[499.303124] [089/133] (529s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[499.387330] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[499.397763] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[499.448804] [090/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[499.533967] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[506.031208] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.512s)
[506.128221] [091/133] (522s left) prime_vgem (wait)
[506.216702] Starting subtest: wait
[506.217801] Starting dynamic subtest: rcs0
[506.266287] Dynamic subtest rcs0: SUCCESS (0.049s)
[506.277411] Starting dynamic subtest: bcs0
[506.333263] Dynamic subtest bcs0: SUCCESS (0.066s)
[506.342721] Starting dynamic subtest: vcs0
[506.379323] Dynamic subtest vcs0: SUCCESS (0.045s)
[506.389139] Starting dynamic subtest: vcs1
[506.421928] Dynamic subtest vcs1: SUCCESS (0.042s)
[506.431751] Starting dynamic subtest: vecs0
[506.468029] Dynamic subtest vecs0: SUCCESS (0.045s)
[506.478165] Starting dynamic subtest: ccs0
[506.515621] Dynamic subtest ccs0: SUCCESS (0.046s)
[506.517621] Subtest wait: SUCCESS (0.300s)
[506.615362] [092/133] (522s left) kms_rotation_crc (primary-rotation-180)
[506.712430] Starting subtest: primary-rotation-180
[513.606099] Subtest primary-rotation-180: SUCCESS (6.901s)
[514.759056] [093/133] (513s left) syncobj_basic (bad-destroy)
[514.809261] Starting subtest: bad-destroy
[514.810192] Subtest bad-destroy: SUCCESS (0.000s)
[514.888085] [094/133] (513s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[514.979506] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[514.981487] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[515.046379] [095/133] (513s left) kms_dsc (dsc-with-output-formats)
[515.125564] Starting subtest: dsc-with-output-formats
[515.133953] Subtest dsc-with-output-formats: SKIP (0.001s)
[515.171007] [096/133] (513s left) syncobj_wait (single-wait-all-submitted)
[515.227121] Starting subtest: single-wait-all-submitted
[515.329639] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[515.379589] [097/133] (513s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[515.470013] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[515.472056] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[515.516011] [098/133] (513s left) kms_lease (invalid-create-leases)
[515.606750] Starting subtest: invalid-create-leases
[515.611779] Subtest invalid-create-leases: SUCCESS (0.005s)
[515.684812] [099/133] (513s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[515.732482] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[515.833813] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[515.883875] [100/133] (513s left) gem_exec_schedule (thriceslice)
[515.938548] Starting subtest: thriceslice
[515.939413] Starting dynamic subtest: rcs0
[515.968258] Dynamic subtest rcs0: SUCCESS (0.030s)
[515.980735] Starting dynamic subtest: bcs0
[515.996861] Dynamic subtest bcs0: SUCCESS (0.028s)
[516.006502] Starting dynamic subtest: vcs0
[516.025390] Dynamic subtest vcs0: SUCCESS (0.027s)
[516.035104] Starting dynamic subtest: vcs1
[516.055386] Dynamic subtest vcs1: SUCCESS (0.029s)
[516.066031] Starting dynamic subtest: vecs0
[516.084309] Dynamic subtest vecs0: SUCCESS (0.028s)
[516.094025] Starting dynamic subtest: ccs0
[516.113950] Dynamic subtest ccs0: SUCCESS (0.029s)
[516.114858] Subtest thriceslice: SUCCESS (0.177s)
[516.389722] [101/133] (512s left) i915_pm_rpm (gem-pread)
[518.426280] Starting subtest: gem-pread
[520.167839] Subtest gem-pread: SUCCESS (1.745s)
[520.242096] [102/133] (508s left) gem_ctx_shared (disjoint-timelines)
[520.300654] Starting subtest: disjoint-timelines
[520.324749] Subtest disjoint-timelines: SUCCESS (0.024s)
[520.517819] [103/133] (508s left) gem_exec_whisper (basic-contexts-priority)
[520.577061] Starting subtest: basic-contexts-priority
[543.952309] Subtest basic-contexts-priority: SUCCESS (23.364s)
[544.107454] [104/133] (484s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[544.405637] Starting subtest: cursor-rapid-movement-max-size
[544.409317] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[544.501836] [105/133] (484s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[545.119307] Starting subtest: syncobj-timeline-invalid-wait
[545.120337] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[546.375408] [106/133] (482s left) gem_ctx_engines (execute-one)
[546.446155] Starting subtest: execute-one
[549.871668] Subtest execute-one: SUCCESS (3.426s)
[550.031566] [107/133] (479s left) kms_invalid_mode (zero-vdisplay)
[550.121108] Starting subtest: zero-vdisplay
[550.121941] Starting dynamic subtest: pipe-A-eDP-1
[550.413463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[550.423505] Starting dynamic subtest: pipe-B-eDP-1
[550.424411] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[550.433952] Starting dynamic subtest: pipe-C-eDP-1
[550.434872] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[550.444408] Starting dynamic subtest: pipe-D-eDP-1
[550.445287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[550.446112] Subtest zero-vdisplay: SUCCESS (0.298s)
[551.220676] [108/133] (477s left) gem_userptr_blits (coherency-sync)
[551.283465] Starting subtest: coherency-sync
[551.796076] Subtest coherency-sync: SKIP (0.496s)
[551.886973] [109/133] (477s left) core_auth (getclient-master-drop)
[551.960525] Starting subtest: getclient-master-drop
[551.974900] Subtest getclient-master-drop: SUCCESS (0.015s)
[552.057458] [110/133] (477s left) gem_mmap_gtt (zero-extend)
[552.112768] Subtest zero-extend: SKIP (0.000s)
[552.166887] [111/133] (477s left) syncobj_timeline (signal)
[552.220181] Starting subtest: signal
[552.221111] Subtest signal: SUCCESS (0.000s)
[552.302815] [112/133] (477s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[552.393419] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[552.395088] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[552.466341] [113/133] (476s left) gem_pxp (create-regular-context-1)
[552.579859] Starting subtest: create-regular-context-1
[552.581227] Subtest create-regular-context-1: SUCCESS (0.002s)
[552.661316] [114/133] (476s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[552.710322] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[552.712098] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[552.868254] [115/133] (476s left) gem_ctx_persistence (heartbeat-many)
[552.913304] Starting subtest: heartbeat-many
[552.914990] Subtest heartbeat-many: SKIP (0.000s)
[553.002107] [116/133] (476s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[553.084147] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[553.117335] Starting dynamic subtest: pipe-A-plane-0
[553.405194] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[553.417161] Starting dynamic subtest: pipe-A-plane-3
[553.638516] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[553.649231] Starting dynamic subtest: pipe-A-plane-5
[553.650730] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[554.733055] Starting dynamic subtest: pipe-B-plane-0
[555.022564] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[555.033422] Starting dynamic subtest: pipe-B-plane-3
[555.266944] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[555.279947] Starting dynamic subtest: pipe-B-plane-5
[555.281607] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[555.574485] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.491s)
[556.383924] [117/133] (473s left) api_intel_allocator (reloc-allocator)
[556.443935] Starting subtest: reloc-allocator
[556.444933] Starting dynamic subtest: basic
[556.445911] Dynamic subtest basic: SUCCESS (0.003s)
[556.457962] Starting dynamic subtest: parallel-one
[556.459227] Dynamic subtest parallel-one: SUCCESS (0.007s)
[556.469527] Starting dynamic subtest: print
[556.470535] Dynamic subtest print: SUCCESS (0.000s)
[556.480505] Starting dynamic subtest: reuse
[556.482258] Dynamic subtest reuse: SUCCESS (0.000s)
[556.492226] Starting dynamic subtest: fork-reopen-allocator
[556.493075] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[556.493883] Subtest reloc-allocator: SUCCESS (0.026s)
[556.562826] [118/133] (473s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[556.666745] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[565.607830] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.945s)
[565.712562] [119/133] (463s left) gem_exec_reloc (basic-gtt-cpu)
[565.768779] Subtest basic-gtt-cpu: SKIP (0.000s)
[565.836296] [120/133] (463s left) kms_chamelium_hpd (dp-hpd-fast)
[566.228920] Subtest dp-hpd-fast: SKIP (0.000s)
[567.037191] [121/133] (462s left) kms_content_protection (legacy)
[567.175594] Starting subtest: legacy
[567.177602] Subtest legacy: SKIP (0.000s)
[567.261827] [122/133] (462s left) kms_atomic_transition (plane-all-transition-fencing)
[567.349513] Starting subtest: plane-all-transition-fencing
[567.350418] Starting dynamic subtest: pipe-A-eDP-1
[569.845890] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[570.152941] Starting dynamic subtest: pipe-B-eDP-1
[573.391473] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s)
[573.698724] Subtest plane-all-transition-fencing: SUCCESS (6.351s)
[574.515805] [123/133] (455s left) kms_properties (connector-properties-legacy)
[574.610706] Starting subtest: connector-properties-legacy
[574.611677] Starting dynamic subtest: pipe-A-eDP-1
[582.506482] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.892s)
[582.517006] Starting dynamic subtest: pipe-None-DP-1
[582.518827] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[582.528550] Starting dynamic subtest: pipe-None-HDMI-A-1
[582.530232] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[582.540066] Starting dynamic subtest: pipe-None-DP-2
[582.541771] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[582.552032] Starting dynamic subtest: pipe-None-HDMI-A-2
[582.553773] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[582.563816] Starting dynamic subtest: pipe-None-DP-3
[582.565651] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[582.575725] Starting dynamic subtest: pipe-None-DP-4
[582.578089] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[582.579131] Subtest connector-properties-legacy: SUCCESS (7.904s)
[583.369106] [124/133] (446s left) drm_mm (drm_mm)
[583.408401] Starting subtest: drm_mm
[583.426394] Starting dynamic subtest: drm_test_mm_init
[583.521555] Dynamic subtest drm_test_mm_init: SUCCESS (0.095s)
[583.532789] Starting dynamic subtest: drm_test_mm_debug
[583.605512] Dynamic subtest drm_test_mm_debug: SUCCESS (0.082s)
[583.617305] Starting dynamic subtest: drm_test_mm_align32
[583.695564] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[583.707767] Starting dynamic subtest: drm_test_mm_align64
[583.791640] Dynamic subtest drm_test_mm_align64: SUCCESS (0.095s)
[583.802958] Starting dynamic subtest: drm_test_mm_lowest
[583.885698] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.092s)
[583.895936] Starting dynamic subtest: drm_test_mm_highest
[583.980593] Dynamic subtest drm_test_mm_highest: SUCCESS (0.094s)
[583.981658] Subtest drm_mm: SUCCESS (0.571s)
[584.112374] [125/133] (445s left) gem_ctx_persistence (engines-persistence)
[584.173202] Starting subtest: engines-persistence
[584.174166] Starting dynamic subtest: rcs0
[584.962825] Dynamic subtest rcs0: SUCCESS (0.788s)
[584.978391] Starting dynamic subtest: bcs0
[585.715868] Dynamic subtest bcs0: SUCCESS (0.750s)
[585.732579] Starting dynamic subtest: vcs0
[586.490444] Dynamic subtest vcs0: SUCCESS (0.772s)
[586.504719] Starting dynamic subtest: vcs1
[587.265442] Dynamic subtest vcs1: SUCCESS (0.772s)
[587.279478] Starting dynamic subtest: vecs0
[588.006823] Dynamic subtest vecs0: SUCCESS (0.737s)
[588.019113] Starting dynamic subtest: ccs0
[588.774491] Dynamic subtest ccs0: SUCCESS (0.766s)
[588.775598] Subtest engines-persistence: SUCCESS (4.599s)
[588.877736] [126/133] (441s left) perf_pmu (pmu-read)
[588.919883] Starting subtest: pmu-read
[588.922495] Subtest pmu-read: SUCCESS (0.003s)
[588.985159] [127/133] (440s left) kms_psr (fbc-psr-primary-page-flip)
[589.073110] Starting subtest: fbc-psr-primary-page-flip
[589.073960] Starting dynamic subtest: eDP-1
[589.075651] Dynamic subtest eDP-1: SKIP (0.000s)
[589.077312] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[589.121454] [128/133] (440s left) i915_drm_fdinfo (virtual-busy-hang-all)
[589.164842] Starting subtest: virtual-busy-hang-all
[589.166850] Subtest virtual-busy-hang-all: SKIP (0.000s)
[589.209468] [129/133] (440s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[589.325456] Starting subtest: cursorA-vs-flipA-legacy
[600.454505] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s)
[601.313289] [130/133] (428s left) gem_userptr_blits (huge-split)
[601.376435] Starting subtest: huge-split
[601.382809] Subtest huge-split: SUCCESS (0.006s)
[601.485343] [131/133] (428s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[601.537364] Starting subtest: etime-single-wait-for-submit-unsubmitted
[601.641946] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[601.694205] [132/133] (428s left) gem_busy (parallel)
[601.881968] Starting subtest: parallel
[601.883050] Starting dynamic subtest: rcs0
[603.270565] Dynamic subtest rcs0: SUCCESS (1.386s)
[603.283549] Starting dynamic subtest: bcs0
[605.255111] Dynamic subtest bcs0: SUCCESS (1.981s)
[605.268386] Starting dynamic subtest: vcs0
[607.301912] Dynamic subtest vcs0: SUCCESS (2.044s)
[607.314384] Starting dynamic subtest: vcs1
[609.286141] Dynamic subtest vcs1: SUCCESS (1.981s)
[609.300242] Starting dynamic subtest: vecs0
[611.270662] Dynamic subtest vecs0: SUCCESS (1.981s)
[611.283784] Starting dynamic subtest: ccs0
[613.318307] Dynamic subtest ccs0: SUCCESS (2.045s)
[613.319673] Subtest parallel: SUCCESS (11.435s)
[613.525630] [133/133] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[613.629286] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[613.630911] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[613.695559] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_setmode
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: kms_psr2_su
results: parsing output: 19/ for test: kms_chamelium_audio
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_hdr
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_cursor
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_setmode
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: sysfs_preempt_timeout
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: prime_mmap_kms
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_spin_batch
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: gem_exercise_blt
results: parsing output: 68/ for test: kms_universal_plane
results: parsing output: 69/ for test: kms_atomic
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_atomic_interruptible
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: template
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_dsc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: gem_ctx_shared
results: parsing output: 102/ for test: gem_exec_whisper
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: core_auth
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_chamelium_hpd
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_properties
results: parsing output: 123/ for test: drm_mm
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_busy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.