[55.836365] Initializing watchdogs
[55.836411]   /dev/watchdog0
[55.850503] [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]
[55.854830] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.857123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.860684] [001/133] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[55.981488] Starting subtest: primary-y-tiled-reflect-x-90
[55.986066] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[56.055364] [002/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[56.149578] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[56.151921] Starting dynamic subtest: pipe-A-eDP-1
[56.288163] Dynamic subtest pipe-A-eDP-1: SKIP (0.139s)
[56.297707] Starting dynamic subtest: pipe-B-eDP-1
[57.493505] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[57.497984] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.315s)
[58.699710] [003/133] (957s left) syncobj_timeline (invalid-signal-illegal-handle)
[58.760734] Starting subtest: invalid-signal-illegal-handle
[58.762599] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[58.868597] [004/133] (957s left) gem_mmap_gtt (big-bo-tiledy)
[58.925370] Subtest big-bo-tiledY: SKIP (0.000s)
[58.992075] [005/133] (957s left) kms_plane (pixel-format-y-tiled-modifier)
[59.075903] Starting subtest: pixel-format-y-tiled-modifier
[59.080754] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[59.149620] [006/133] (957s left) gen9_exec_parse (batch-invalid-length)
[59.221639] Subtest batch-invalid-length: SKIP (0.000s)
[59.285498] [007/133] (957s left) kms_psr (fbc-psr2-cursor-plane-move)
[59.373001] Starting subtest: fbc-psr2-cursor-plane-move
[59.376012] Starting dynamic subtest: eDP-1
[59.380549] Dynamic subtest eDP-1: SKIP (0.000s)
[59.385062] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[59.467797] [008/133] (957s left) i915_query (query-topology-garbage-items)
[59.527140] Starting subtest: query-topology-garbage-items
[59.529599] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[59.631554] [009/133] (957s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[59.693782] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[59.752215] [010/133] (956s left) i915_drm_fdinfo (busy)
[59.790803] Starting subtest: busy
[59.792566] Starting dynamic subtest: rcs0
[59.811767] Dynamic subtest rcs0: SKIP (0.021s)
[59.821740] Starting dynamic subtest: bcs0
[59.825326] Dynamic subtest bcs0: SKIP (0.000s)
[59.831966] Starting dynamic subtest: vcs0
[59.835464] Dynamic subtest vcs0: SKIP (0.000s)
[59.842105] Starting dynamic subtest: vcs1
[59.845395] Dynamic subtest vcs1: SKIP (0.000s)
[59.851606] Starting dynamic subtest: vecs0
[59.854870] Dynamic subtest vecs0: SKIP (0.000s)
[59.861076] Starting dynamic subtest: ccs0
[59.864447] Dynamic subtest ccs0: SKIP (0.000s)
[59.867841] Subtest busy: SKIP (0.023s)
[59.899888] [011/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[59.997094] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[60.000668] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.097347] [012/133] (956s left) kms_flip (dpms-off-confusion)
[60.192421] Starting subtest: dpms-off-confusion
[60.194463] Starting dynamic subtest: A-eDP1
[68.957045] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[68.966525] Starting dynamic subtest: B-eDP1
[77.661878] Dynamic subtest B-eDP1: SUCCESS (8.675s)
[77.672043] Starting dynamic subtest: C-eDP1
[86.300891] Dynamic subtest C-eDP1: SUCCESS (8.631s)
[86.310281] Starting dynamic subtest: D-eDP1
[94.939283] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[94.941745] Subtest dpms-off-confusion: SUCCESS (34.629s)
[96.116942] [013/133] (920s left) kms_big_fb (linear-32bpp-rotate-0)
[96.223739] Starting subtest: linear-32bpp-rotate-0
[97.769486] Subtest linear-32bpp-rotate-0: SUCCESS (1.545s)
[97.906885] [014/133] (918s left) kms_async_flips (crc)
[98.002704] Starting subtest: crc
[98.392754] Starting dynamic subtest: pipe-A-eDP-1
[101.315040] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.922s)
[101.691467] Starting dynamic subtest: pipe-B-eDP-1
[104.558565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.875s)
[104.950776] Starting dynamic subtest: pipe-C-eDP-1
[107.854203] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s)
[108.216761] Starting dynamic subtest: pipe-D-eDP-1
[111.103781] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[111.106184] Subtest crc: SUCCESS (13.097s)
[112.258647] [015/133] (904s left) kms_setmode (clone-exclusive-crtc)
[112.312888] Starting subtest: clone-exclusive-crtc
[112.319565] Subtest clone-exclusive-crtc: SKIP (0.000s)
[112.403233] [016/133] (904s left) kms_psr (psr2-sprite-plane-onoff)
[112.494768] Starting subtest: psr2-sprite-plane-onoff
[112.496968] Starting dynamic subtest: eDP-1
[114.281540] Dynamic subtest eDP-1: SUCCESS (1.787s)
[114.283888] Subtest psr2-sprite-plane-onoff: SUCCESS (1.787s)
[115.144736] [017/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[115.239983] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[115.244156] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[115.323335] [018/133] (901s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[115.408612] Starting subtest: plane-all-modeset-transition-internal-panels
[115.410692] Starting dynamic subtest: pipe-A-eDP-1
[116.693876] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.284s)
[116.983639] Starting dynamic subtest: pipe-B-eDP-1
[118.028724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[118.295904] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.885s)
[119.134231] [019/133] (897s left) kms_psr2_su (page_flip-xrgb8888)
[119.197241] Subtest page_flip-XRGB8888: SKIP (0.000s)
[119.252765] [020/133] (897s left) kms_chamelium_audio (dp-audio-edid)
[119.642511] Subtest dp-audio-edid: SKIP (0.000s)
[120.453986] [021/133] (896s left) kms_addfb_basic (bad-pitch-32)
[120.514928] Starting subtest: bad-pitch-32
[120.517348] Subtest bad-pitch-32: SUCCESS (0.000s)
[120.670395] [022/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[120.778653] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[120.783243] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[120.892049] [023/133] (896s left) kms_hdr (brightness-with-hdr)
[120.995680] Starting subtest: brightness-with-hdr
[121.002239] Subtest brightness-with-hdr: SKIP (0.000s)
[121.068981] [024/133] (896s left) syncobj_wait (invalid-reset-zero-handles)
[121.115893] Starting subtest: invalid-reset-zero-handles
[121.118926] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[121.223098] [025/133] (896s left) kms_psr (fbc-psr-sprite-render)
[121.323252] Starting subtest: fbc-psr-sprite-render
[121.325218] Starting dynamic subtest: eDP-1
[121.329331] Dynamic subtest eDP-1: SKIP (0.000s)
[121.333502] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[121.400484] [026/133] (895s left) gem_exec_reloc (basic-write-gtt-noreloc)
[121.462021] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[121.533257] [027/133] (895s left) gem_exec_fence (basic-wait)
[121.699779] Starting subtest: basic-wait
[121.702308] Starting dynamic subtest: rcs0
[121.796294] Dynamic subtest rcs0: SUCCESS (0.097s)
[121.806265] Starting dynamic subtest: bcs0
[121.861663] Dynamic subtest bcs0: SUCCESS (0.064s)
[121.871145] Starting dynamic subtest: vcs0
[121.926637] Dynamic subtest vcs0: SUCCESS (0.064s)
[121.936944] Starting dynamic subtest: vcs1
[121.985421] Dynamic subtest vcs1: SUCCESS (0.058s)
[121.993696] Starting dynamic subtest: vecs0
[122.040218] Dynamic subtest vecs0: SUCCESS (0.054s)
[122.048048] Starting dynamic subtest: ccs0
[122.099481] Dynamic subtest ccs0: SUCCESS (0.058s)
[122.101991] Subtest basic-wait: SUCCESS (0.401s)
[124.346094] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[124.349479] [028/133] (893s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[124.449109] Starting subtest: fbc-rgb565-draw-mmap-cpu
[128.456721] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.010s)
[129.583238] [029/133] (887s left) kms_plane_cursor (primary)
[129.685061] Starting subtest: primary
[129.689554] Starting dynamic subtest: pipe-A-eDP-1-size-64
[132.224446] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[132.249546] Starting dynamic subtest: pipe-A-eDP-1-size-128
[134.795061] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[134.815696] Starting dynamic subtest: pipe-A-eDP-1-size-256
[137.394916] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[137.719213] Starting dynamic subtest: pipe-B-eDP-1-size-64
[140.949874] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.248s)
[140.973059] Starting dynamic subtest: pipe-B-eDP-1-size-128
[143.529162] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[143.552839] Starting dynamic subtest: pipe-B-eDP-1-size-256
[146.075055] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[146.390357] Starting dynamic subtest: pipe-C-eDP-1-size-64
[149.358484] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.977s)
[149.384284] Starting dynamic subtest: pipe-C-eDP-1-size-128
[151.569622] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[151.594935] Starting dynamic subtest: pipe-C-eDP-1-size-256
[153.803155] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[154.120643] Starting dynamic subtest: pipe-D-eDP-1-size-64
[157.066486] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.957s)
[157.092261] Starting dynamic subtest: pipe-D-eDP-1-size-128
[159.266181] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[159.291730] Starting dynamic subtest: pipe-D-eDP-1-size-256
[161.466328] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[161.777743] Subtest primary: SUCCESS (32.090s)
[162.608348] [030/133] (854s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[162.709309] Starting subtest: y-tiled-8bpp-rotate-90
[162.713381] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[162.801909] [031/133] (854s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[162.910403] Starting subtest: fbcpsr-slowdraw
[188.109342] Subtest fbcpsr-slowdraw: SUCCESS (25.202s)
[188.255836] [032/133] (829s left) gem_exec_reloc (basic-wc-read-active)
[188.312804] Subtest basic-wc-read-active: SKIP (0.000s)
[188.376462] [033/133] (829s left) kms_plane_alpha_blend (alpha-7efc)
[188.477964] Starting subtest: alpha-7efc
[188.755512] Starting dynamic subtest: pipe-A-eDP-1
[189.353834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[189.378438] Starting dynamic subtest: pipe-D-eDP-1
[190.627061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[190.629336] Subtest alpha-7efc: SUCCESS (2.151s)
[191.492540] [034/133] (826s left) perf (gen12-unprivileged-single-ctx-counters)
[191.624615] Starting subtest: gen12-unprivileged-single-ctx-counters
[191.626717] Starting dynamic subtest: rcs0
[191.662213] Dynamic subtest rcs0: SUCCESS (0.038s)
[191.664546] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.039s)
[191.711066] [035/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[191.831028] Starting subtest: bad-rotation-90-y-tiled-ccs
[191.833327] Starting dynamic subtest: pipe-A-eDP-1
[191.855887] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.864698] Starting dynamic subtest: pipe-B-eDP-1
[191.886200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.893590] Starting dynamic subtest: pipe-C-eDP-1
[191.914790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.922130] Starting dynamic subtest: pipe-D-eDP-1
[191.943552] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.947886] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[194.147041] [036/133] (823s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[194.209226] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[194.213312] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[194.394829] [037/133] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[194.507278] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[194.511614] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[194.597834] [038/133] (823s left) kms_setmode (invalid-clone-exclusive-crtc)
[194.650056] Starting subtest: invalid-clone-exclusive-crtc
[194.656349] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[194.772856] [039/133] (823s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[194.864091] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[196.023531] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.159s)
[196.145827] [040/133] (821s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[196.234966] Starting subtest: yf-tiled-addfb-size-overflow
[196.239222] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[196.325797] [041/133] (821s left) syncobj_basic (bad-create-flags)
[196.373916] Starting subtest: bad-create-flags
[196.375806] Subtest bad-create-flags: SUCCESS (0.000s)
[196.464015] [042/133] (821s left) gem_lmem_swapping (verify-random)
[196.506943] Subtest verify-random: SKIP (0.000s)
[196.552523] [043/133] (821s left) kms_cursor_legacy (torture-bo)
[196.659499] Starting subtest: torture-bo
[196.661367] Starting dynamic subtest: pipe-A
[202.508771] Dynamic subtest pipe-A: SUCCESS (5.844s)
[202.520039] Starting dynamic subtest: pipe-B
[209.092887] Dynamic subtest pipe-B: SUCCESS (6.582s)
[209.103980] Starting dynamic subtest: pipe-C
[215.983445] Dynamic subtest pipe-C: SUCCESS (6.889s)
[215.993301] Starting dynamic subtest: pipe-D
[222.477978] Dynamic subtest pipe-D: SUCCESS (6.490s)
[222.489391] Starting dynamic subtest: all-pipes
[229.556829] Dynamic subtest all-pipes: SUCCESS (7.076s)
[229.559280] Subtest torture-bo: SUCCESS (32.893s)
[229.731354] [044/133] (788s left) sysfs_preempt_timeout (timeout)
[229.799640] Starting subtest: timeout
[229.802129] Starting dynamic subtest: vecs0
[239.292915] Dynamic subtest vecs0: SUCCESS (9.489s)
[239.302578] Starting dynamic subtest: ccs0
[240.599174] Dynamic subtest ccs0: SUCCESS (1.305s)
[240.607150] Starting dynamic subtest: vcs0
[250.304406] Dynamic subtest vcs0: SUCCESS (9.701s)
[250.314033] Starting dynamic subtest: bcs0
[251.589290] Dynamic subtest bcs0: SUCCESS (1.283s)
[251.602983] Starting dynamic subtest: rcs0
[252.808341] Dynamic subtest rcs0: SUCCESS (1.216s)
[252.819463] Starting dynamic subtest: vcs1
[262.272931] Dynamic subtest vcs1: SUCCESS (9.461s)
[262.275278] Subtest timeout: SUCCESS (32.470s)
[262.360988] [045/133] (755s left) gem_userptr_blits (create-destroy-unsync)
[262.436747] Subtest create-destroy-unsync: SKIP (0.000s)
[262.571145] [046/133] (755s left) gem_exec_balancer (full-pulse)
[262.647800] Starting subtest: full-pulse
[267.139847] Subtest full-pulse: SUCCESS (4.491s)
[267.464672] [047/133] (750s left) kms_vblank (query-forked-hang)
[267.561122] Starting subtest: query-forked-hang
[267.563311] Starting dynamic subtest: pipe-A-eDP-1
[294.090086] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.529s)
[294.104386] Starting dynamic subtest: pipe-D-eDP-1
[309.063239] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s)
[309.065510] Subtest query-forked-hang: SUCCESS (41.504s)
[309.911370] [048/133] (708s left) gem_exec_fence (syncobj-unused-fence)
[310.346888] Starting subtest: syncobj-unused-fence
[310.352463] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[312.337172] [049/133] (705s left) kms_cursor_crc (cursor-sliding-32x32)
[312.476799] Starting subtest: cursor-sliding-32x32
[312.522155] Subtest cursor-sliding-32x32: SKIP (0.040s)
[312.778093] [050/133] (705s left) prime_mmap_kms (buffer-sharing)
[312.867070] Starting subtest: buffer-sharing
[313.303866] Subtest buffer-sharing: SUCCESS (0.437s)
[314.135837] [051/133] (704s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[314.223047] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[314.227317] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[314.308699] [052/133] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[314.402212] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[317.989537] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.591s)
[319.129715] [053/133] (699s left) gem_exec_reloc (basic-write-wc-active)
[319.193345] Subtest basic-write-wc-active: SKIP (0.000s)
[319.260748] [054/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[319.371552] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[319.375645] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[319.481616] [055/133] (699s left) syncobj_timeline (multi-wait-signaled)
[319.544172] Starting subtest: multi-wait-signaled
[319.546367] Subtest multi-wait-signaled: SUCCESS (0.001s)
[319.661349] [056/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[319.754419] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[319.758678] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[319.869554] [057/133] (698s left) kms_chamelium_frames (dp-frame-dump)
[320.247902] Subtest dp-frame-dump: SKIP (0.000s)
[321.037760] [058/133] (697s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[321.131304] Starting subtest: psr-rgb565-draw-mmap-wc
[327.895682] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.766s)
[328.054925] [059/133] (690s left) kms_psr (psr-dpms)
[328.151895] Starting subtest: psr-dpms
[328.154132] Starting dynamic subtest: eDP-1
[331.101365] Dynamic subtest eDP-1: SUCCESS (2.949s)
[331.103502] Subtest psr-dpms: SUCCESS (2.950s)
[331.947445] [060/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[332.051069] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[332.055164] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[332.151182] [061/133] (686s left) gem_spin_batch (spin-all-new)
[332.213107] Starting subtest: spin-all-new
[332.229631] Subtest spin-all-new: SUCCESS (0.014s)
[333.353984] [062/133] (685s left) kms_setmode (invalid-clone-single-crtc-stealing)
[333.399160] Starting subtest: invalid-clone-single-crtc-stealing
[333.405291] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[333.494408] [063/133] (685s left) gem_eio (execbuf)
[333.714728] Starting subtest: execbuf
[334.029405] Subtest execbuf: SUCCESS (0.312s)
[334.176891] [064/133] (684s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[334.263632] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[334.268235] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[334.354863] [065/133] (684s left) gem_exec_schedule (out-order)
[334.431341] Starting subtest: out-order
[334.433217] Starting dynamic subtest: rcs0
[334.530557] Dynamic subtest rcs0: SUCCESS (0.103s)
[334.540866] Starting dynamic subtest: vcs0
[334.615737] Dynamic subtest vcs0: SUCCESS (0.084s)
[334.626818] Starting dynamic subtest: vcs1
[334.696589] Dynamic subtest vcs1: SUCCESS (0.080s)
[334.704847] Starting dynamic subtest: vecs0
[334.782135] Dynamic subtest vecs0: SUCCESS (0.085s)
[334.793951] Starting dynamic subtest: ccs0
[334.886389] Dynamic subtest ccs0: SUCCESS (0.103s)
[334.888675] Subtest out-order: SUCCESS (0.460s)
[336.407303] [066/133] (682s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[336.465165] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[336.568969] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[336.645072] [067/133] (682s left) kms_addfb_basic (tile-pitch-mismatch)
[336.699059] Starting subtest: tile-pitch-mismatch
[336.703302] Subtest tile-pitch-mismatch: SKIP (0.000s)
[336.822500] [068/133] (682s left) gem_exercise_blt (fast-copy)
[336.881578] Starting subtest: fast-copy
[336.883781] Starting dynamic subtest: linear-smem-smem
[336.904283] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[336.914990] Starting dynamic subtest: xmajor-smem-smem
[336.922248] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[336.932730] Starting dynamic subtest: tile4-smem-smem
[336.939681] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[336.948082] Starting dynamic subtest: tile64-smem-smem
[336.956754] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[336.958953] Subtest fast-copy: SUCCESS (0.076s)
[337.063823] [069/133] (682s left) kms_universal_plane (cursor-fb-leak)
[337.155028] Starting subtest: cursor-fb-leak
[337.156873] Starting dynamic subtest: pipe-A-eDP-1
[337.502785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.349s)
[337.517895] Starting dynamic subtest: pipe-B-eDP-1
[338.878457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s)
[338.892506] Starting dynamic subtest: pipe-C-eDP-1
[340.290964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[340.301452] Starting dynamic subtest: pipe-D-eDP-1
[341.627793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[341.630176] Subtest cursor-fb-leak: SUCCESS (4.476s)
[342.781814] [070/133] (676s left) kms_atomic (test-only)
[342.882739] Starting subtest: test-only
[342.930608] Starting dynamic subtest: pipe-A-eDP-1
[345.486541] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.556s)
[345.488498] Subtest test-only: SUCCESS (2.603s)
[346.275293] [071/133] (672s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[346.366182] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[346.368503] Starting dynamic subtest: pipe-A-eDP-1
[346.795757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[346.806878] Starting dynamic subtest: pipe-B-eDP-1
[348.170082] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[348.180116] Starting dynamic subtest: pipe-C-eDP-1
[349.591956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.423s)
[349.603701] Starting dynamic subtest: pipe-D-eDP-1
[350.915714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[350.917720] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.524s)
[352.118706] [072/133] (667s left) kms_cursor_crc (cursor-dpms)
[352.238288] Starting subtest: cursor-dpms
[352.240431] Starting dynamic subtest: pipe-A-eDP-1
[355.288633] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.048s)
[355.298790] Starting dynamic subtest: pipe-D-eDP-1
[358.864287] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.573s)
[358.866133] Subtest cursor-dpms: SUCCESS (6.623s)
[359.711240] [073/133] (659s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[359.810060] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[359.812422] Starting dynamic subtest: pipe-A
[360.870526] Dynamic subtest pipe-A: SUCCESS (1.063s)
[360.878923] Starting dynamic subtest: pipe-B
[363.029331] Dynamic subtest pipe-B: SUCCESS (2.158s)
[363.038565] Starting dynamic subtest: pipe-C
[364.224144] Dynamic subtest pipe-C: SUCCESS (1.193s)
[364.233233] Starting dynamic subtest: pipe-D
[365.436160] Dynamic subtest pipe-D: SUCCESS (1.211s)
[365.438216] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.629s)
[366.628208] [074/133] (652s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[366.735906] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[366.740114] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[366.840907] [075/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[366.942064] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[366.945964] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.036482] [076/133] (652s left) kms_color (gamma)
[367.134829] Starting subtest: gamma
[367.137089] Starting dynamic subtest: pipe-A-eDP-1
[367.834730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[367.848705] Starting dynamic subtest: pipe-B-eDP-1
[369.267475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[369.276727] Starting dynamic subtest: pipe-C-eDP-1
[370.610733] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[370.620585] Starting dynamic subtest: pipe-D-eDP-1
[371.950435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[371.952796] Subtest gamma: SUCCESS (4.818s)
[372.773567] [077/133] (646s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[372.870119] Starting subtest: 4-tiled-32bpp-rotate-180
[374.281355] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.412s)
[374.415220] [078/133] (645s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[374.516290] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[374.520027] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[375.614611] [079/133] (643s left) kms_flip (flip-vs-dpms-on-nop)
[375.709353] Starting subtest: flip-vs-dpms-on-nop
[375.711721] Starting dynamic subtest: A-eDP1
[377.586568] Dynamic subtest A-eDP1: SUCCESS (1.877s)
[377.601129] Starting dynamic subtest: B-eDP1
[379.426774] Dynamic subtest B-eDP1: SUCCESS (1.837s)
[379.439397] Starting dynamic subtest: C-eDP1
[381.250814] Dynamic subtest C-eDP1: SUCCESS (1.821s)
[381.265551] Starting dynamic subtest: D-eDP1
[383.069606] Dynamic subtest D-eDP1: SUCCESS (1.816s)
[383.075483] Subtest flip-vs-dpms-on-nop: SUCCESS (7.368s)
[384.266416] [080/133] (635s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[384.362718] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[384.364981] Starting dynamic subtest: pipe-A-default-mode
[385.522351] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[385.526803] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.159s)
[385.668877] [081/133] (633s left) gem_eio (hibernate)
[385.899676] Starting subtest: hibernate
[400.614976] Subtest hibernate: SUCCESS (14.715s)
[408.796968] [082/133] (618s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[408.907810] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[408.910456] Starting dynamic subtest: pipe-A-eDP-1
[408.931384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[408.942183] Starting dynamic subtest: pipe-B-eDP-1
[408.962310] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[408.971899] Starting dynamic subtest: pipe-C-eDP-1
[408.991384] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[409.000844] Starting dynamic subtest: pipe-D-eDP-1
[409.020367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[409.022610] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.008s)
[411.158942] [083/133] (616s left) kms_atomic_interruptible (legacy-dpms)
[411.259670] Starting subtest: legacy-dpms
[411.261893] Starting dynamic subtest: pipe-A-eDP-1
[418.694360] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.432s)
[418.696592] Subtest legacy-dpms: SUCCESS (7.434s)
[419.528277] [084/133] (608s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[421.471242] Starting subtest: dpms-mode-unset-non-lpsp
[422.625799] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s)
[422.996288] [085/133] (604s left) kms_pm_rpm (system-suspend-idle)
[424.517066] Starting subtest: system-suspend-idle
[444.211917] Subtest system-suspend-idle: SUCCESS (4.607s)
[444.603179] [086/133] (583s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[444.720012] Starting subtest: yf-tiled-32bpp-rotate-180
[444.723977] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[444.817948] [087/133] (583s left) kms_flip (blocking-wf_vblank)
[444.917823] Starting subtest: blocking-wf_vblank
[444.919981] Starting dynamic subtest: A-eDP1
[453.830445] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[453.844627] Starting dynamic subtest: B-eDP1
[462.766261] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[462.784193] Starting dynamic subtest: C-eDP1
[471.677975] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[471.688995] Starting dynamic subtest: D-eDP1
[493.153528] Dynamic subtest D-eDP1: FAIL (20.952s)
[493.155712] Subtest blocking-wf_vblank: FAIL (47.718s)
[494.177595] [088/133] (533s left) template (b)
[494.233153] Starting subtest: B
[494.235401] Subtest B: SUCCESS (0.000s)
[494.317784] [089/133] (533s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[494.409461] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[494.418165] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[494.477810] [090/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[494.580686] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[501.355351] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.763s)
[501.445139] [091/133] (526s left) prime_vgem (wait)
[501.523333] Starting subtest: wait
[501.525684] Starting dynamic subtest: rcs0
[501.580747] Dynamic subtest rcs0: SUCCESS (0.060s)
[501.591266] Starting dynamic subtest: bcs0
[501.640277] Dynamic subtest bcs0: SUCCESS (0.059s)
[501.650325] Starting dynamic subtest: vcs0
[501.686799] Dynamic subtest vcs0: SUCCESS (0.045s)
[501.697481] Starting dynamic subtest: vcs1
[501.732550] Dynamic subtest vcs1: SUCCESS (0.045s)
[501.743465] Starting dynamic subtest: vecs0
[501.776518] Dynamic subtest vecs0: SUCCESS (0.043s)
[501.787343] Starting dynamic subtest: ccs0
[501.824070] Dynamic subtest ccs0: SUCCESS (0.047s)
[501.826373] Subtest wait: SUCCESS (0.304s)
[501.937150] [092/133] (526s left) kms_rotation_crc (primary-rotation-180)
[502.026504] Starting subtest: primary-rotation-180
[508.946692] Subtest primary-rotation-180: SUCCESS (6.917s)
[510.108552] [093/133] (518s left) syncobj_basic (bad-destroy)
[510.156607] Starting subtest: bad-destroy
[510.158455] Subtest bad-destroy: SUCCESS (0.000s)
[510.226624] [094/133] (518s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[510.320727] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[510.324970] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[510.399901] [095/133] (517s left) kms_dsc (dsc-with-output-formats)
[510.489483] Starting subtest: dsc-with-output-formats
[510.510361] Subtest dsc-with-output-formats: SKIP (0.000s)
[510.552088] [096/133] (517s left) syncobj_wait (single-wait-all-submitted)
[510.606651] Starting subtest: single-wait-all-submitted
[510.715449] Subtest single-wait-all-submitted: SUCCESS (0.109s)
[510.770036] [097/133] (517s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[510.883247] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[510.887710] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[510.932945] [098/133] (517s left) kms_lease (invalid-create-leases)
[511.018482] Starting subtest: invalid-create-leases
[511.023517] Subtest invalid-create-leases: SUCCESS (0.005s)
[511.105903] [099/133] (517s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[511.156601] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[511.258360] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[511.319961] [100/133] (517s left) gem_exec_schedule (thriceslice)
[511.394600] Starting subtest: thriceslice
[511.396569] Starting dynamic subtest: rcs0
[511.418217] Dynamic subtest rcs0: SUCCESS (0.032s)
[511.439366] Starting dynamic subtest: bcs0
[511.456321] Dynamic subtest bcs0: SUCCESS (0.036s)
[511.469550] Starting dynamic subtest: vcs0
[511.486486] Dynamic subtest vcs0: SUCCESS (0.029s)
[511.496422] Starting dynamic subtest: vcs1
[511.516099] Dynamic subtest vcs1: SUCCESS (0.029s)
[511.525764] Starting dynamic subtest: vecs0
[511.567700] Dynamic subtest vecs0: SUCCESS (0.050s)
[511.578403] Starting dynamic subtest: ccs0
[511.598841] Dynamic subtest ccs0: SUCCESS (0.030s)
[511.601078] Subtest thriceslice: SUCCESS (0.214s)
[511.875825] [101/133] (516s left) i915_pm_rpm (gem-pread)
[513.502975] Starting subtest: gem-pread
[515.521650] Subtest gem-pread: SUCCESS (2.019s)
[515.588034] [102/133] (512s left) gem_ctx_shared (disjoint-timelines)
[515.649707] Starting subtest: disjoint-timelines
[515.676112] Subtest disjoint-timelines: SUCCESS (0.026s)
[515.888048] [103/133] (512s left) gem_exec_whisper (basic-contexts-priority)
[515.945315] Starting subtest: basic-contexts-priority
[540.865558] Subtest basic-contexts-priority: SUCCESS (24.903s)
[541.025545] [104/133] (487s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[541.352545] Starting subtest: cursor-rapid-movement-max-size
[541.359206] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[541.450629] [105/133] (487s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[542.026962] Starting subtest: syncobj-timeline-invalid-wait
[542.029414] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[543.411922] [106/133] (485s left) gem_ctx_engines (execute-one)
[543.460871] Starting subtest: execute-one
[547.105740] Subtest execute-one: SUCCESS (3.643s)
[547.268480] [107/133] (481s left) kms_invalid_mode (zero-vdisplay)
[547.365648] Starting subtest: zero-vdisplay
[547.367914] Starting dynamic subtest: pipe-A-eDP-1
[547.650107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[547.660737] Starting dynamic subtest: pipe-B-eDP-1
[547.662850] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[547.672382] Starting dynamic subtest: pipe-C-eDP-1
[547.674293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[547.683840] Starting dynamic subtest: pipe-D-eDP-1
[547.685964] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[547.688206] Subtest zero-vdisplay: SUCCESS (0.291s)
[548.494246] [108/133] (480s left) gem_userptr_blits (coherency-sync)
[548.568240] Starting subtest: coherency-sync
[548.939141] Subtest coherency-sync: SKIP (0.332s)
[549.017446] [109/133] (479s left) core_auth (getclient-master-drop)
[549.107938] Starting subtest: getclient-master-drop
[549.122887] Subtest getclient-master-drop: SUCCESS (0.015s)
[549.195771] [110/133] (479s left) gem_mmap_gtt (zero-extend)
[549.254428] Subtest zero-extend: SKIP (0.000s)
[549.316746] [111/133] (479s left) syncobj_timeline (signal)
[549.388610] Starting subtest: signal
[549.391504] Subtest signal: SUCCESS (0.000s)
[549.438773] [112/133] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[549.548428] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[549.552440] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[549.617621] [113/133] (479s left) gem_pxp (create-regular-context-1)
[549.737497] Starting subtest: create-regular-context-1
[549.739928] Subtest create-regular-context-1: SUCCESS (0.002s)
[549.835923] [114/133] (479s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[549.906250] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[549.909991] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[550.069115] [115/133] (479s left) gem_ctx_persistence (heartbeat-many)
[550.130634] Starting subtest: heartbeat-many
[550.134978] Subtest heartbeat-many: SKIP (0.000s)
[550.214193] [116/133] (478s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[550.320987] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[550.348648] Starting dynamic subtest: pipe-A-plane-0
[550.638197] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[550.648983] Starting dynamic subtest: pipe-A-plane-3
[550.871219] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[550.881727] Starting dynamic subtest: pipe-A-plane-5
[550.886137] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[552.001199] Starting dynamic subtest: pipe-B-plane-0
[552.269390] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[552.281220] Starting dynamic subtest: pipe-B-plane-3
[552.514038] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[552.526366] Starting dynamic subtest: pipe-B-plane-5
[552.530768] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[552.829630] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.508s)
[553.652110] [117/133] (475s left) api_intel_allocator (reloc-allocator)
[553.703686] Starting subtest: reloc-allocator
[553.705598] Starting dynamic subtest: basic
[553.707985] Dynamic subtest basic: SUCCESS (0.004s)
[553.718753] Starting dynamic subtest: parallel-one
[553.720711] Dynamic subtest parallel-one: SUCCESS (0.007s)
[553.731807] Starting dynamic subtest: print
[553.734019] Dynamic subtest print: SUCCESS (0.000s)
[553.744148] Starting dynamic subtest: reuse
[553.746350] Dynamic subtest reuse: SUCCESS (0.000s)
[553.756462] Starting dynamic subtest: fork-reopen-allocator
[553.758748] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[553.760914] Subtest reloc-allocator: SUCCESS (0.026s)
[553.818437] [118/133] (475s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[553.913859] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[562.424690] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.510s)
[562.515869] [119/133] (466s left) gem_exec_reloc (basic-gtt-cpu)
[562.575723] Subtest basic-gtt-cpu: SKIP (0.000s)
[562.656697] [120/133] (466s left) kms_chamelium_hpd (dp-hpd-fast)
[563.043514] Subtest dp-hpd-fast: SKIP (0.000s)
[563.839591] [121/133] (465s left) kms_content_protection (legacy)
[563.988734] Starting subtest: legacy
[563.993116] Subtest legacy: SKIP (0.000s)
[564.093369] [122/133] (465s left) kms_atomic_transition (plane-all-transition-fencing)
[564.181609] Starting subtest: plane-all-transition-fencing
[564.183908] Starting dynamic subtest: pipe-A-eDP-1
[566.676613] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[566.984248] Starting dynamic subtest: pipe-B-eDP-1
[570.192637] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[570.508167] Subtest plane-all-transition-fencing: SUCCESS (6.327s)
[571.296992] [123/133] (458s left) kms_properties (connector-properties-legacy)
[571.388772] Starting subtest: connector-properties-legacy
[571.391032] Starting dynamic subtest: pipe-A-eDP-1
[579.118880] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.734s)
[579.130436] Starting dynamic subtest: pipe-None-DP-1
[579.134362] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[579.144337] Starting dynamic subtest: pipe-None-HDMI-A-1
[579.148372] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[579.158253] Starting dynamic subtest: pipe-None-DP-2
[579.162442] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[579.172718] Starting dynamic subtest: pipe-None-HDMI-A-2
[579.176928] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[579.187162] Starting dynamic subtest: pipe-None-DP-3
[579.191680] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[579.202457] Starting dynamic subtest: pipe-None-DP-4
[579.206653] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[579.208552] Subtest connector-properties-legacy: SUCCESS (7.745s)
[579.967472] [124/133] (449s left) drm_mm (drm_mm)
[580.008485] Starting subtest: drm_mm
[580.030021] Starting dynamic subtest: drm_test_mm_init
[580.124965] Dynamic subtest drm_test_mm_init: SUCCESS (0.094s)
[580.137187] Starting dynamic subtest: drm_test_mm_debug
[580.229104] Dynamic subtest drm_test_mm_debug: SUCCESS (0.103s)
[580.241213] Starting dynamic subtest: drm_test_mm_align32
[580.328902] Dynamic subtest drm_test_mm_align32: SUCCESS (0.099s)
[580.340722] Starting dynamic subtest: drm_test_mm_align64
[580.428931] Dynamic subtest drm_test_mm_align64: SUCCESS (0.100s)
[580.440964] Starting dynamic subtest: drm_test_mm_lowest
[580.531928] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.101s)
[580.544193] Starting dynamic subtest: drm_test_mm_highest
[580.628435] Dynamic subtest drm_test_mm_highest: SUCCESS (0.095s)
[580.630378] Subtest drm_mm: SUCCESS (0.619s)
[580.757140] [125/133] (448s left) gem_ctx_persistence (engines-persistence)
[580.810014] Starting subtest: engines-persistence
[580.812430] Starting dynamic subtest: rcs0
[581.621546] Dynamic subtest rcs0: SUCCESS (0.811s)
[581.634429] Starting dynamic subtest: bcs0
[582.387640] Dynamic subtest bcs0: SUCCESS (0.764s)
[582.401373] Starting dynamic subtest: vcs0
[583.134037] Dynamic subtest vcs0: SUCCESS (0.744s)
[583.146612] Starting dynamic subtest: vcs1
[583.920553] Dynamic subtest vcs1: SUCCESS (0.785s)
[583.934001] Starting dynamic subtest: vecs0
[584.691361] Dynamic subtest vecs0: SUCCESS (0.769s)
[584.704850] Starting dynamic subtest: ccs0
[585.455479] Dynamic subtest ccs0: SUCCESS (0.762s)
[585.458064] Subtest engines-persistence: SUCCESS (4.648s)
[585.514747] [126/133] (444s left) perf_pmu (pmu-read)
[585.566325] Starting subtest: pmu-read
[585.568567] Subtest pmu-read: SUCCESS (0.002s)
[585.641667] [127/133] (443s left) kms_psr (fbc-psr-primary-page-flip)
[585.733726] Starting subtest: fbc-psr-primary-page-flip
[585.736002] Starting dynamic subtest: eDP-1
[585.740127] Dynamic subtest eDP-1: SKIP (0.000s)
[585.744292] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[585.784909] [128/133] (443s left) i915_drm_fdinfo (virtual-busy-hang-all)
[585.825681] Starting subtest: virtual-busy-hang-all
[585.830075] Subtest virtual-busy-hang-all: SKIP (0.000s)
[585.877228] [129/133] (443s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[585.986402] Starting subtest: cursorA-vs-flipA-legacy
[597.119841] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.134s)
[597.909614] [130/133] (431s left) gem_userptr_blits (huge-split)
[597.978254] Starting subtest: huge-split
[597.985445] Subtest huge-split: SUCCESS (0.007s)
[598.093330] [131/133] (431s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[598.149302] Starting subtest: etime-single-wait-for-submit-unsubmitted
[598.250348] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[598.308645] [132/133] (431s left) gem_busy (parallel)
[598.489837] Starting subtest: parallel
[598.492125] Starting dynamic subtest: rcs0
[600.376519] Dynamic subtest rcs0: SUCCESS (1.884s)
[600.388928] Starting dynamic subtest: bcs0
[602.363061] Dynamic subtest bcs0: SUCCESS (1.983s)
[602.377410] Starting dynamic subtest: vcs0
[604.345008] Dynamic subtest vcs0: SUCCESS (1.979s)
[604.359347] Starting dynamic subtest: vcs1
[606.329022] Dynamic subtest vcs1: SUCCESS (1.980s)
[606.343381] Starting dynamic subtest: vecs0
[608.312323] Dynamic subtest vecs0: SUCCESS (1.980s)
[608.326425] Starting dynamic subtest: ccs0
[610.359174] Dynamic subtest ccs0: SUCCESS (2.044s)
[610.361961] Subtest parallel: SUCCESS (11.870s)
[610.568093] [133/133] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[610.682145] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[610.686524] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[610.754193] 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.