[58.771824] Initializing watchdogs
[58.771870]   /dev/watchdog0
[58.785549] [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.789830] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.792379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.795709] [001/133] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[58.911769] Starting subtest: primary-y-tiled-reflect-x-90
[58.916193] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[58.990683] [002/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[59.091022] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[59.093305] Starting dynamic subtest: pipe-A-eDP-1
[59.211768] Dynamic subtest pipe-A-eDP-1: SKIP (0.126s)
[59.219414] Starting dynamic subtest: pipe-B-eDP-1
[60.387853] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[60.392514] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.321s)
[61.553297] [003/133] (957s left) syncobj_timeline (invalid-signal-illegal-handle)
[61.607638] Starting subtest: invalid-signal-illegal-handle
[61.610023] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[61.691732] [004/133] (957s left) gem_mmap_gtt (big-bo-tiledy)
[61.744845] Subtest big-bo-tiledY: SKIP (0.000s)
[61.803639] [005/133] (957s left) kms_plane (pixel-format-y-tiled-modifier)
[61.884936] Starting subtest: pixel-format-y-tiled-modifier
[61.889135] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[61.969028] [006/133] (957s left) gen9_exec_parse (batch-invalid-length)
[62.027759] Subtest batch-invalid-length: SKIP (0.000s)
[62.092122] [007/133] (957s left) kms_psr (fbc-psr2-cursor-plane-move)
[62.183892] Starting subtest: fbc-psr2-cursor-plane-move
[62.186299] Starting dynamic subtest: eDP-1
[62.190499] Dynamic subtest eDP-1: SKIP (0.000s)
[62.194746] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[62.260737] [008/133] (957s left) i915_query (query-topology-garbage-items)
[62.315179] Starting subtest: query-topology-garbage-items
[62.317413] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[62.418174] [009/133] (957s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[62.476376] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[62.539129] [010/133] (957s left) i915_drm_fdinfo (busy)
[62.575420] Starting subtest: busy
[62.577246] Starting dynamic subtest: rcs0
[62.607060] Dynamic subtest rcs0: SKIP (0.030s)
[62.615824] Starting dynamic subtest: bcs0
[62.619220] Dynamic subtest bcs0: SKIP (0.000s)
[62.628566] Starting dynamic subtest: vcs0
[62.632319] Dynamic subtest vcs0: SKIP (0.000s)
[62.640862] Starting dynamic subtest: vcs1
[62.644133] Dynamic subtest vcs1: SKIP (0.000s)
[62.650432] Starting dynamic subtest: vecs0
[62.653797] Dynamic subtest vecs0: SKIP (0.000s)
[62.660167] Starting dynamic subtest: ccs0
[62.663462] Dynamic subtest ccs0: SKIP (0.000s)
[62.666802] Subtest busy: SKIP (0.033s)
[62.699335] [011/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[62.795372] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[62.798716] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[62.904975] [012/133] (956s left) kms_flip (dpms-off-confusion)
[62.983055] Starting subtest: dpms-off-confusion
[62.984870] Starting dynamic subtest: A-eDP1
[71.660688] Dynamic subtest A-eDP1: SUCCESS (8.696s)
[71.671532] Starting dynamic subtest: B-eDP1
[80.346769] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[80.356294] Starting dynamic subtest: C-eDP1
[89.053205] Dynamic subtest C-eDP1: SUCCESS (8.695s)
[89.062938] Starting dynamic subtest: D-eDP1
[97.682559] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[97.685067] Subtest dpms-off-confusion: SUCCESS (34.727s)
[98.801895] [013/133] (920s left) kms_big_fb (linear-32bpp-rotate-0)
[98.911494] Starting subtest: linear-32bpp-rotate-0
[100.446582] Subtest linear-32bpp-rotate-0: SUCCESS (1.536s)
[100.574191] [014/133] (919s left) kms_async_flips (crc)
[100.669711] Starting subtest: crc
[101.079988] Starting dynamic subtest: pipe-A-eDP-1
[104.019798] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.940s)
[104.396323] Starting dynamic subtest: pipe-B-eDP-1
[107.258473] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s)
[107.634555] Starting dynamic subtest: pipe-C-eDP-1
[110.561635] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s)
[110.934487] Starting dynamic subtest: pipe-D-eDP-1
[113.796929] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[113.799300] Subtest crc: SUCCESS (13.126s)
[114.961041] [015/133] (904s left) kms_setmode (clone-exclusive-crtc)
[115.025992] Starting subtest: clone-exclusive-crtc
[115.033082] Subtest clone-exclusive-crtc: SKIP (0.000s)
[115.132816] [016/133] (904s left) kms_psr (psr2-sprite-plane-onoff)
[115.224649] Starting subtest: psr2-sprite-plane-onoff
[115.227000] Starting dynamic subtest: eDP-1
[116.973153] Dynamic subtest eDP-1: SUCCESS (1.747s)
[116.975434] Subtest psr2-sprite-plane-onoff: SUCCESS (1.747s)
[117.834242] [017/133] (902s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[117.931058] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[117.935668] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[118.025803] [018/133] (901s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[118.125199] Starting subtest: plane-all-modeset-transition-internal-panels
[118.127159] Starting dynamic subtest: pipe-A-eDP-1
[119.472355] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.347s)
[119.748785] Starting dynamic subtest: pipe-B-eDP-1
[120.793636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[121.061520] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.935s)
[121.926774] [019/133] (898s left) kms_psr2_su (page_flip-xrgb8888)
[121.983178] Subtest page_flip-XRGB8888: SKIP (0.000s)
[122.045667] [020/133] (897s left) kms_chamelium_audio (dp-audio-edid)
[122.431604] Subtest dp-audio-edid: SKIP (0.000s)
[123.208217] [021/133] (896s left) kms_addfb_basic (bad-pitch-32)
[123.273215] Starting subtest: bad-pitch-32
[123.275679] Subtest bad-pitch-32: SUCCESS (0.000s)
[123.413216] [022/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[123.515084] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[123.519321] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[123.611705] [023/133] (896s left) kms_hdr (brightness-with-hdr)
[123.698756] Starting subtest: brightness-with-hdr
[123.704909] Subtest brightness-with-hdr: SKIP (0.000s)
[123.770732] [024/133] (896s left) syncobj_wait (invalid-reset-zero-handles)
[123.818594] Starting subtest: invalid-reset-zero-handles
[123.820688] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[123.978736] [025/133] (896s left) kms_psr (fbc-psr-sprite-render)
[124.077764] Starting subtest: fbc-psr-sprite-render
[124.080099] Starting dynamic subtest: eDP-1
[124.084406] Dynamic subtest eDP-1: SKIP (0.000s)
[124.088756] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[124.149812] [026/133] (896s left) gem_exec_reloc (basic-write-gtt-noreloc)
[124.216724] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[124.274397] [027/133] (896s left) gem_exec_fence (basic-wait)
[124.449541] Starting subtest: basic-wait
[124.452306] Starting dynamic subtest: rcs0
[124.527670] Dynamic subtest rcs0: SUCCESS (0.076s)
[124.537772] Starting dynamic subtest: bcs0
[124.580660] Dynamic subtest bcs0: SUCCESS (0.052s)
[124.590495] Starting dynamic subtest: vcs0
[124.637877] Dynamic subtest vcs0: SUCCESS (0.056s)
[124.649472] Starting dynamic subtest: vcs1
[124.691808] Dynamic subtest vcs1: SUCCESS (0.055s)
[124.703308] Starting dynamic subtest: vecs0
[124.741321] Dynamic subtest vecs0: SUCCESS (0.049s)
[124.750564] Starting dynamic subtest: ccs0
[124.791084] Dynamic subtest ccs0: SUCCESS (0.048s)
[124.793849] Subtest basic-wait: SUCCESS (0.342s)
[126.346909] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[126.350283] [028/133] (894s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[126.438370] Starting subtest: fbc-rgb565-draw-mmap-cpu
[130.483039] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.048s)
[131.638611] [029/133] (888s left) kms_plane_cursor (primary)
[131.735117] Starting subtest: primary
[131.739607] Starting dynamic subtest: pipe-A-eDP-1-size-64
[134.321489] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.587s)
[134.344174] Starting dynamic subtest: pipe-A-eDP-1-size-128
[136.955143] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s)
[136.979825] Starting dynamic subtest: pipe-A-eDP-1-size-256
[139.556060] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[139.879750] Starting dynamic subtest: pipe-B-eDP-1-size-64
[143.125059] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.252s)
[143.147913] Starting dynamic subtest: pipe-B-eDP-1-size-128
[145.737055] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[145.759238] Starting dynamic subtest: pipe-B-eDP-1-size-256
[148.325958] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s)
[148.641905] Starting dynamic subtest: pipe-C-eDP-1-size-64
[151.592262] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.960s)
[151.617750] Starting dynamic subtest: pipe-C-eDP-1-size-128
[153.792340] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[153.816900] Starting dynamic subtest: pipe-C-eDP-1-size-256
[155.992425] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[156.311240] Starting dynamic subtest: pipe-D-eDP-1-size-64
[159.210053] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.909s)
[159.235318] Starting dynamic subtest: pipe-D-eDP-1-size-128
[161.432553] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[161.458192] Starting dynamic subtest: pipe-D-eDP-1-size-256
[163.632617] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[163.941357] Subtest primary: SUCCESS (32.204s)
[164.778884] [030/133] (855s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[164.905924] Starting subtest: y-tiled-8bpp-rotate-90
[164.911018] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[165.016462] [031/133] (855s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[165.137538] Starting subtest: fbcpsr-slowdraw
[190.352833] Subtest fbcpsr-slowdraw: SUCCESS (25.216s)
[190.485511] [032/133] (830s left) gem_exec_reloc (basic-wc-read-active)
[190.551259] Subtest basic-wc-read-active: SKIP (0.000s)
[190.616864] [033/133] (829s left) kms_plane_alpha_blend (alpha-7efc)
[190.703753] Starting subtest: alpha-7efc
[191.006687] Starting dynamic subtest: pipe-A-eDP-1
[191.596059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[191.619870] Starting dynamic subtest: pipe-D-eDP-1
[192.908593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[192.910886] Subtest alpha-7efc: SUCCESS (2.207s)
[193.767344] [034/133] (826s left) perf (gen12-unprivileged-single-ctx-counters)
[193.891368] Starting subtest: gen12-unprivileged-single-ctx-counters
[193.893746] Starting dynamic subtest: rcs0
[194.287647] Dynamic subtest rcs0: SUCCESS (0.396s)
[194.290066] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.397s)
[194.331347] [035/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[194.437719] Starting subtest: bad-rotation-90-y-tiled-ccs
[194.439969] Starting dynamic subtest: pipe-A-eDP-1
[194.461620] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.470049] Starting dynamic subtest: pipe-B-eDP-1
[194.490172] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.497436] Starting dynamic subtest: pipe-C-eDP-1
[194.518041] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.525613] Starting dynamic subtest: pipe-D-eDP-1
[194.546416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.550592] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[196.727487] [036/133] (823s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[196.783866] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[196.788131] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[196.967058] [037/133] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[197.067520] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[197.071920] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[197.206145] [038/133] (823s left) kms_setmode (invalid-clone-exclusive-crtc)
[197.254998] Starting subtest: invalid-clone-exclusive-crtc
[197.261414] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[197.348296] [039/133] (823s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[197.437350] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[198.515972] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.079s)
[198.631092] [040/133] (822s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[198.732062] Starting subtest: yf-tiled-addfb-size-overflow
[198.735553] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[198.824686] [041/133] (822s left) syncobj_basic (bad-create-flags)
[198.884466] Starting subtest: bad-create-flags
[198.886070] Subtest bad-create-flags: SUCCESS (0.000s)
[198.981901] [042/133] (821s left) gem_lmem_swapping (verify-random)
[199.020319] Subtest verify-random: SKIP (0.000s)
[199.054943] [043/133] (821s left) kms_cursor_legacy (torture-bo)
[199.186900] Starting subtest: torture-bo
[199.188838] Starting dynamic subtest: pipe-A
[205.282294] Dynamic subtest pipe-A: SUCCESS (6.039s)
[205.291284] Starting dynamic subtest: pipe-B
[212.028722] Dynamic subtest pipe-B: SUCCESS (6.796s)
[212.041226] Starting dynamic subtest: pipe-C
[218.993669] Dynamic subtest pipe-C: SUCCESS (6.964s)
[219.006199] Starting dynamic subtest: pipe-D
[225.358769] Dynamic subtest pipe-D: SUCCESS (6.362s)
[225.370342] Starting dynamic subtest: all-pipes
[232.579052] Dynamic subtest all-pipes: SUCCESS (7.217s)
[232.581659] Subtest torture-bo: SUCCESS (33.389s)
[232.747446] [044/133] (788s left) sysfs_preempt_timeout (timeout)
[232.819612] Starting subtest: timeout
[232.822056] Starting dynamic subtest: vecs0
[242.298571] Dynamic subtest vecs0: SUCCESS (9.474s)
[242.308951] Starting dynamic subtest: ccs0
[243.631909] Dynamic subtest ccs0: SUCCESS (1.334s)
[243.641814] Starting dynamic subtest: vcs0
[253.301605] Dynamic subtest vcs0: SUCCESS (9.666s)
[253.313923] Starting dynamic subtest: bcs0
[254.561576] Dynamic subtest bcs0: SUCCESS (1.259s)
[254.570864] Starting dynamic subtest: rcs0
[255.808650] Dynamic subtest rcs0: SUCCESS (1.245s)
[255.818428] Starting dynamic subtest: vcs1
[265.268887] Dynamic subtest vcs1: SUCCESS (9.456s)
[265.271362] Subtest timeout: SUCCESS (32.446s)
[265.345962] [045/133] (755s left) gem_userptr_blits (create-destroy-unsync)
[265.422724] Subtest create-destroy-unsync: SKIP (0.000s)
[265.554486] [046/133] (755s left) gem_exec_balancer (full-pulse)
[265.607323] Starting subtest: full-pulse
[270.175963] Subtest full-pulse: SUCCESS (4.568s)
[270.491654] [047/133] (750s left) kms_vblank (query-forked-hang)
[270.594033] Starting subtest: query-forked-hang
[270.595937] Starting dynamic subtest: pipe-A-eDP-1
[298.042833] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.448s)
[298.056973] Starting dynamic subtest: pipe-D-eDP-1
[313.012696] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s)
[313.014622] Subtest query-forked-hang: SUCCESS (42.418s)
[313.882570] [048/133] (707s left) gem_exec_fence (syncobj-unused-fence)
[314.326576] Starting subtest: syncobj-unused-fence
[314.328980] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[315.403974] [049/133] (705s left) kms_cursor_crc (cursor-sliding-32x32)
[315.544891] Starting subtest: cursor-sliding-32x32
[315.589830] Subtest cursor-sliding-32x32: SKIP (0.040s)
[315.870975] [050/133] (705s left) prime_mmap_kms (buffer-sharing)
[315.958229] Starting subtest: buffer-sharing
[316.388516] Subtest buffer-sharing: SUCCESS (0.433s)
[317.218697] [051/133] (704s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[317.314370] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[317.318808] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[317.435424] [052/133] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[317.534378] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[321.068403] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.537s)
[322.231601] [053/133] (699s left) gem_exec_reloc (basic-write-wc-active)
[322.316815] Subtest basic-write-wc-active: SKIP (0.000s)
[322.383624] [054/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[322.488739] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[322.493185] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[322.586089] [055/133] (698s left) syncobj_timeline (multi-wait-signaled)
[322.646023] Starting subtest: multi-wait-signaled
[322.648331] Subtest multi-wait-signaled: SUCCESS (0.001s)
[322.753808] [056/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[322.864071] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[322.868279] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[322.963297] [057/133] (698s left) kms_chamelium_frames (dp-frame-dump)
[323.350517] Subtest dp-frame-dump: SKIP (0.000s)
[324.214938] [058/133] (697s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[324.315023] Starting subtest: psr-rgb565-draw-mmap-wc
[331.107331] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.795s)
[331.208173] [059/133] (690s left) kms_psr (psr-dpms)
[331.297747] Starting subtest: psr-dpms
[331.299999] Starting dynamic subtest: eDP-1
[334.303719] Dynamic subtest eDP-1: SUCCESS (3.005s)
[334.306280] Subtest psr-dpms: SUCCESS (3.006s)
[335.161135] [060/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[335.257490] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[335.261629] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[335.359778] [061/133] (686s left) gem_spin_batch (spin-all-new)
[335.423190] Starting subtest: spin-all-new
[335.437731] Subtest spin-all-new: SUCCESS (0.014s)
[337.312870] [062/133] (684s left) kms_setmode (invalid-clone-single-crtc-stealing)
[337.367550] Starting subtest: invalid-clone-single-crtc-stealing
[337.374326] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[337.463012] [063/133] (684s left) gem_eio (execbuf)
[337.679035] Starting subtest: execbuf
[338.010050] Subtest execbuf: SUCCESS (0.332s)
[338.179764] [064/133] (683s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[338.277023] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[338.280455] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[338.377123] [065/133] (683s left) gem_exec_schedule (out-order)
[338.436292] Starting subtest: out-order
[338.438142] Starting dynamic subtest: rcs0
[338.545554] Dynamic subtest rcs0: SUCCESS (0.115s)
[338.557175] Starting dynamic subtest: vcs0
[338.631264] Dynamic subtest vcs0: SUCCESS (0.085s)
[338.642214] Starting dynamic subtest: vcs1
[338.709043] Dynamic subtest vcs1: SUCCESS (0.077s)
[338.720810] Starting dynamic subtest: vecs0
[338.793772] Dynamic subtest vecs0: SUCCESS (0.083s)
[338.805697] Starting dynamic subtest: ccs0
[338.890196] Dynamic subtest ccs0: SUCCESS (0.096s)
[338.892652] Subtest out-order: SUCCESS (0.461s)
[340.373204] [066/133] (681s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[340.443433] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[340.543644] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.100s)
[340.637145] [067/133] (681s left) kms_addfb_basic (tile-pitch-mismatch)
[340.702093] Starting subtest: tile-pitch-mismatch
[340.706320] Subtest tile-pitch-mismatch: SKIP (0.000s)
[340.838627] [068/133] (681s left) gem_exercise_blt (fast-copy)
[340.901636] Starting subtest: fast-copy
[340.903932] Starting dynamic subtest: linear-smem-smem
[340.924093] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[340.934347] Starting dynamic subtest: xmajor-smem-smem
[340.941154] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[340.949565] Starting dynamic subtest: tile4-smem-smem
[340.957577] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[340.965852] Starting dynamic subtest: tile64-smem-smem
[340.974198] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[340.976362] Subtest fast-copy: SUCCESS (0.073s)
[341.090585] [069/133] (681s left) kms_universal_plane (cursor-fb-leak)
[341.176819] Starting subtest: cursor-fb-leak
[341.178977] Starting dynamic subtest: pipe-A-eDP-1
[341.513351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[341.526134] Starting dynamic subtest: pipe-B-eDP-1
[342.877922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[342.889637] Starting dynamic subtest: pipe-C-eDP-1
[344.295985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[344.308775] Starting dynamic subtest: pipe-D-eDP-1
[345.622178] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[345.624543] Subtest cursor-fb-leak: SUCCESS (4.447s)
[346.784833] [070/133] (675s left) kms_atomic (test-only)
[346.880301] Starting subtest: test-only
[346.929394] Starting dynamic subtest: pipe-A-eDP-1
[349.512719] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.585s)
[349.515103] Subtest test-only: SUCCESS (2.635s)
[350.381181] [071/133] (671s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[350.473766] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[350.475648] Starting dynamic subtest: pipe-A-eDP-1
[350.982809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[350.993663] Starting dynamic subtest: pipe-B-eDP-1
[352.415305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[352.428057] Starting dynamic subtest: pipe-C-eDP-1
[353.804093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[353.814634] Starting dynamic subtest: pipe-D-eDP-1
[355.138442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[355.140661] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.640s)
[356.316726] [072/133] (665s left) kms_cursor_crc (cursor-dpms)
[356.450721] Starting subtest: cursor-dpms
[356.453107] Starting dynamic subtest: pipe-A-eDP-1
[359.488934] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.037s)
[359.498550] Starting dynamic subtest: pipe-D-eDP-1
[363.080784] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.589s)
[363.082851] Subtest cursor-dpms: SUCCESS (6.629s)
[363.917249] [073/133] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[364.019775] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[364.021998] Starting dynamic subtest: pipe-A
[365.066965] Dynamic subtest pipe-A: SUCCESS (1.049s)
[365.081323] Starting dynamic subtest: pipe-B
[367.236383] Dynamic subtest pipe-B: SUCCESS (2.169s)
[367.245969] Starting dynamic subtest: pipe-C
[368.424195] Dynamic subtest pipe-C: SUCCESS (1.186s)
[368.437953] Starting dynamic subtest: pipe-D
[369.656668] Dynamic subtest pipe-D: SUCCESS (1.229s)
[369.659089] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.640s)
[370.855688] [074/133] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[370.958743] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[370.963229] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.061363] [075/133] (651s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[371.160472] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[371.164593] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.254449] [076/133] (651s left) kms_color (gamma)
[371.355664] Starting subtest: gamma
[371.357780] Starting dynamic subtest: pipe-A-eDP-1
[372.064518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[372.074595] Starting dynamic subtest: pipe-B-eDP-1
[373.486363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[373.495507] Starting dynamic subtest: pipe-C-eDP-1
[374.819637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.328s)
[374.829067] Starting dynamic subtest: pipe-D-eDP-1
[376.163690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[376.165645] Subtest gamma: SUCCESS (4.808s)
[376.973240] [077/133] (645s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[377.079411] Starting subtest: 4-tiled-32bpp-rotate-180
[378.580826] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.502s)
[378.728193] [078/133] (643s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[378.834333] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[378.837970] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[380.012907] [079/133] (642s left) kms_flip (flip-vs-dpms-on-nop)
[380.094904] Starting subtest: flip-vs-dpms-on-nop
[380.097258] Starting dynamic subtest: A-eDP1
[381.995466] Dynamic subtest A-eDP1: SUCCESS (1.902s)
[382.004327] Starting dynamic subtest: B-eDP1
[383.833112] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[383.846448] Starting dynamic subtest: C-eDP1
[385.683679] Dynamic subtest C-eDP1: SUCCESS (1.835s)
[385.692945] Starting dynamic subtest: D-eDP1
[387.496153] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[387.498531] Subtest flip-vs-dpms-on-nop: SUCCESS (7.406s)
[388.671211] [080/133] (633s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[388.767727] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[388.770139] Starting dynamic subtest: pipe-A-default-mode
[389.929536] Dynamic subtest pipe-A-default-mode: SKIP (1.160s)
[389.933316] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.161s)
[390.076188] [081/133] (632s left) gem_eio (hibernate)
[390.298235] Starting subtest: hibernate
[405.783946] Subtest hibernate: SUCCESS (15.483s)
[412.930558] [082/133] (616s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[413.047731] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[413.049946] Starting dynamic subtest: pipe-A-eDP-1
[413.070304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[413.081114] Starting dynamic subtest: pipe-B-eDP-1
[413.101477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[413.111094] Starting dynamic subtest: pipe-C-eDP-1
[413.131330] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[413.140262] Starting dynamic subtest: pipe-D-eDP-1
[413.159453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[413.161394] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.020s)
[415.406450] [083/133] (614s left) kms_atomic_interruptible (legacy-dpms)
[415.498195] Starting subtest: legacy-dpms
[415.500712] Starting dynamic subtest: pipe-A-eDP-1
[422.945687] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.447s)
[422.948064] Subtest legacy-dpms: SUCCESS (7.449s)
[423.779707] [084/133] (605s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[425.420771] Starting subtest: dpms-mode-unset-non-lpsp
[426.581980] Subtest dpms-mode-unset-non-lpsp: SKIP (1.162s)
[426.948808] [085/133] (602s left) kms_pm_rpm (system-suspend-idle)
[428.475712] Starting subtest: system-suspend-idle
[447.967558] Subtest system-suspend-idle: SUCCESS (4.307s)
[448.350335] [086/133] (581s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[448.499852] Starting subtest: yf-tiled-32bpp-rotate-180
[448.504692] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[448.609348] [087/133] (581s left) kms_flip (blocking-wf_vblank)
[448.705194] Starting subtest: blocking-wf_vblank
[448.707089] Starting dynamic subtest: A-eDP1
[457.598984] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[457.609073] Starting dynamic subtest: B-eDP1
[466.556447] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[466.567860] Starting dynamic subtest: C-eDP1
[475.485423] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[475.497404] Starting dynamic subtest: D-eDP1
[496.214016] Dynamic subtest D-eDP1: SUCCESS (21.065s)
[496.216372] Subtest blocking-wf_vblank: SUCCESS (47.808s)
[497.448808] [088/133] (532s left) template (b)
[497.506759] Starting subtest: B
[497.508915] Subtest B: SUCCESS (0.000s)
[497.609950] [089/133] (532s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[497.716674] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[497.725347] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[497.818383] [090/133] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[497.917306] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[504.432354] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.532s)
[504.551931] [091/133] (525s left) prime_vgem (wait)
[504.627698] Starting subtest: wait
[504.630083] Starting dynamic subtest: rcs0
[504.685912] Dynamic subtest rcs0: SUCCESS (0.058s)
[504.695798] Starting dynamic subtest: bcs0
[504.758016] Dynamic subtest bcs0: SUCCESS (0.071s)
[504.767682] Starting dynamic subtest: vcs0
[504.802932] Dynamic subtest vcs0: SUCCESS (0.044s)
[504.812566] Starting dynamic subtest: vcs1
[504.848834] Dynamic subtest vcs1: SUCCESS (0.045s)
[504.858914] Starting dynamic subtest: vecs0
[504.893300] Dynamic subtest vecs0: SUCCESS (0.044s)
[504.903249] Starting dynamic subtest: ccs0
[504.940824] Dynamic subtest ccs0: SUCCESS (0.047s)
[504.942973] Subtest wait: SUCCESS (0.314s)
[505.056488] [092/133] (525s left) kms_rotation_crc (primary-rotation-180)
[505.149049] Starting subtest: primary-rotation-180
[512.218794] Subtest primary-rotation-180: SUCCESS (7.074s)
[513.412186] [093/133] (516s left) syncobj_basic (bad-destroy)
[513.469142] Starting subtest: bad-destroy
[513.471347] Subtest bad-destroy: SUCCESS (0.000s)
[513.567956] [094/133] (516s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[513.663429] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[513.667924] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[513.755764] [095/133] (516s left) kms_dsc (dsc-with-output-formats)
[513.864768] Starting subtest: dsc-with-output-formats
[513.887289] Subtest dsc-with-output-formats: SKIP (0.001s)
[513.944604] [096/133] (516s left) syncobj_wait (single-wait-all-submitted)
[513.999775] Starting subtest: single-wait-all-submitted
[514.102853] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[514.178925] [097/133] (516s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[514.277018] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[514.281054] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[514.345705] [098/133] (515s left) kms_lease (invalid-create-leases)
[514.451376] Starting subtest: invalid-create-leases
[514.453713] Subtest invalid-create-leases: SUCCESS (0.006s)
[514.564193] [099/133] (515s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[514.623443] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[514.727102] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[514.804949] [100/133] (515s left) gem_exec_schedule (thriceslice)
[514.874303] Starting subtest: thriceslice
[514.876378] Starting dynamic subtest: rcs0
[514.898904] Dynamic subtest rcs0: SUCCESS (0.031s)
[514.912396] Starting dynamic subtest: bcs0
[514.927941] Dynamic subtest bcs0: SUCCESS (0.028s)
[514.937965] Starting dynamic subtest: vcs0
[514.979200] Dynamic subtest vcs0: SUCCESS (0.050s)
[514.992236] Starting dynamic subtest: vcs1
[515.009294] Dynamic subtest vcs1: SUCCESS (0.029s)
[515.019265] Starting dynamic subtest: vecs0
[515.061114] Dynamic subtest vecs0: SUCCESS (0.050s)
[515.074268] Starting dynamic subtest: ccs0
[515.114783] Dynamic subtest ccs0: SUCCESS (0.052s)
[515.117389] Subtest thriceslice: SUCCESS (0.249s)
[516.555568] [101/133] (513s left) i915_pm_rpm (gem-pread)
[518.681226] Starting subtest: gem-pread
[520.428876] Subtest gem-pread: SUCCESS (1.750s)
[520.523350] [102/133] (509s left) gem_ctx_shared (disjoint-timelines)
[520.579514] Starting subtest: disjoint-timelines
[520.603426] Subtest disjoint-timelines: SUCCESS (0.024s)
[520.842210] [103/133] (509s left) gem_exec_whisper (basic-contexts-priority)
[520.907755] Starting subtest: basic-contexts-priority
[544.289092] Subtest basic-contexts-priority: SUCCESS (23.378s)
[544.474582] [104/133] (486s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[544.785439] Starting subtest: cursor-rapid-movement-max-size
[544.791823] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[544.914965] [105/133] (485s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[545.550921] Starting subtest: syncobj-timeline-invalid-wait
[545.553441] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[546.510870] [106/133] (484s left) gem_ctx_engines (execute-one)
[546.578458] Starting subtest: execute-one
[549.862619] Subtest execute-one: SUCCESS (3.285s)
[550.044701] [107/133] (480s left) kms_invalid_mode (zero-vdisplay)
[550.155575] Starting subtest: zero-vdisplay
[550.157858] Starting dynamic subtest: pipe-A-eDP-1
[550.452926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[550.464559] Starting dynamic subtest: pipe-B-eDP-1
[550.466946] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[550.484503] Starting dynamic subtest: pipe-C-eDP-1
[550.487447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[550.501261] Starting dynamic subtest: pipe-D-eDP-1
[550.503807] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[550.506345] Subtest zero-vdisplay: SUCCESS (0.304s)
[551.312093] [108/133] (479s left) gem_userptr_blits (coherency-sync)
[551.377627] Starting subtest: coherency-sync
[551.785510] Subtest coherency-sync: SKIP (0.376s)
[551.900294] [109/133] (478s left) core_auth (getclient-master-drop)
[551.991945] Starting subtest: getclient-master-drop
[552.006893] Subtest getclient-master-drop: SUCCESS (0.014s)
[552.104027] [110/133] (478s left) gem_mmap_gtt (zero-extend)
[552.155380] Subtest zero-extend: SKIP (0.000s)
[552.217698] [111/133] (478s left) syncobj_timeline (signal)
[552.277489] Starting subtest: signal
[552.279778] Subtest signal: SUCCESS (0.000s)
[552.355351] [112/133] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[552.465234] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[552.469530] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[552.563805] [113/133] (478s left) gem_pxp (create-regular-context-1)
[552.686358] Starting subtest: create-regular-context-1
[552.688774] Subtest create-regular-context-1: SUCCESS (0.002s)
[552.788847] [114/133] (478s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[552.841196] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[552.845017] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[553.038919] [115/133] (478s left) gem_ctx_persistence (heartbeat-many)
[553.101574] Starting subtest: heartbeat-many
[553.105471] Subtest heartbeat-many: SKIP (0.000s)
[553.210606] [116/133] (477s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[553.299131] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[553.326058] Starting dynamic subtest: pipe-A-plane-0
[553.625342] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[553.636146] Starting dynamic subtest: pipe-A-plane-3
[553.858865] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[553.870320] Starting dynamic subtest: pipe-A-plane-5
[553.874236] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[554.999920] Starting dynamic subtest: pipe-B-plane-0
[555.290342] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[555.301805] Starting dynamic subtest: pipe-B-plane-3
[555.537028] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[555.548082] Starting dynamic subtest: pipe-B-plane-5
[555.552618] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[555.849785] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.551s)
[556.689260] [117/133] (474s left) api_intel_allocator (reloc-allocator)
[556.752703] Starting subtest: reloc-allocator
[556.755316] Starting dynamic subtest: basic
[556.757810] Dynamic subtest basic: SUCCESS (0.003s)
[556.771911] Starting dynamic subtest: parallel-one
[556.773780] Dynamic subtest parallel-one: SUCCESS (0.007s)
[556.787802] Starting dynamic subtest: print
[556.790045] Dynamic subtest print: SUCCESS (0.000s)
[556.800141] Starting dynamic subtest: reuse
[556.802415] Dynamic subtest reuse: SUCCESS (0.000s)
[556.812782] Starting dynamic subtest: fork-reopen-allocator
[556.814989] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[556.817202] Subtest reloc-allocator: SUCCESS (0.025s)
[556.912171] [118/133] (474s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[557.009318] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[565.660007] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.655s)
[565.760019] [119/133] (465s left) gem_exec_reloc (basic-gtt-cpu)
[565.813791] Subtest basic-gtt-cpu: SKIP (0.000s)
[565.882701] [120/133] (465s left) kms_chamelium_hpd (dp-hpd-fast)
[566.277203] Subtest dp-hpd-fast: SKIP (0.000s)
[567.136968] [121/133] (464s left) kms_content_protection (legacy)
[567.279545] Starting subtest: legacy
[567.283803] Subtest legacy: SKIP (0.000s)
[567.405567] [122/133] (463s left) kms_atomic_transition (plane-all-transition-fencing)
[567.491772] Starting subtest: plane-all-transition-fencing
[567.494030] Starting dynamic subtest: pipe-A-eDP-1
[569.990528] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[570.298168] Starting dynamic subtest: pipe-B-eDP-1
[573.584020] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.298s)
[573.880831] Subtest plane-all-transition-fencing: SUCCESS (6.392s)
[574.704422] [123/133] (456s left) kms_properties (connector-properties-legacy)
[574.809556] Starting subtest: connector-properties-legacy
[574.811854] Starting dynamic subtest: pipe-A-eDP-1
[582.639577] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.827s)
[582.651279] Starting dynamic subtest: pipe-None-DP-1
[582.656188] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[582.666037] Starting dynamic subtest: pipe-None-HDMI-A-1
[582.670716] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[582.680927] Starting dynamic subtest: pipe-None-DP-2
[582.685592] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[582.695889] Starting dynamic subtest: pipe-None-HDMI-A-2
[582.700391] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[582.710427] Starting dynamic subtest: pipe-None-DP-3
[582.714404] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[582.724025] Starting dynamic subtest: pipe-None-DP-4
[582.727935] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[582.729779] Subtest connector-properties-legacy: SUCCESS (7.838s)
[583.515945] [124/133] (447s left) drm_mm (drm_mm)
[583.553828] Starting subtest: drm_mm
[583.573395] Starting dynamic subtest: drm_test_mm_init
[583.661700] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s)
[583.673888] Starting dynamic subtest: drm_test_mm_debug
[583.774655] Dynamic subtest drm_test_mm_debug: SUCCESS (0.113s)
[583.784660] Starting dynamic subtest: drm_test_mm_align32
[583.870215] Dynamic subtest drm_test_mm_align32: SUCCESS (0.095s)
[583.880174] Starting dynamic subtest: drm_test_mm_align64
[583.967972] Dynamic subtest drm_test_mm_align64: SUCCESS (0.096s)
[583.980555] Starting dynamic subtest: drm_test_mm_lowest
[584.067881] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.098s)
[584.084985] Starting dynamic subtest: drm_test_mm_highest
[584.155067] Dynamic subtest drm_test_mm_highest: SUCCESS (0.087s)
[584.157389] Subtest drm_mm: SUCCESS (0.602s)
[584.309072] [125/133] (447s left) gem_ctx_persistence (engines-persistence)
[584.360942] Starting subtest: engines-persistence
[584.363266] Starting dynamic subtest: rcs0
[585.171412] Dynamic subtest rcs0: SUCCESS (0.810s)
[585.185068] Starting dynamic subtest: bcs0
[585.919702] Dynamic subtest bcs0: SUCCESS (0.746s)
[585.932041] Starting dynamic subtest: vcs0
[586.680548] Dynamic subtest vcs0: SUCCESS (0.759s)
[586.692665] Starting dynamic subtest: vcs1
[587.466683] Dynamic subtest vcs1: SUCCESS (0.784s)
[587.480207] Starting dynamic subtest: vecs0
[588.237619] Dynamic subtest vecs0: SUCCESS (0.768s)
[588.251531] Starting dynamic subtest: ccs0
[589.011779] Dynamic subtest ccs0: SUCCESS (0.771s)
[589.014678] Subtest engines-persistence: SUCCESS (4.650s)
[589.098905] [126/133] (442s left) perf_pmu (pmu-read)
[589.140105] Starting subtest: pmu-read
[589.142405] Subtest pmu-read: SUCCESS (0.002s)
[589.247503] [127/133] (442s left) kms_psr (fbc-psr-primary-page-flip)
[589.341429] Starting subtest: fbc-psr-primary-page-flip
[589.343743] Starting dynamic subtest: eDP-1
[589.347821] Dynamic subtest eDP-1: SKIP (0.000s)
[589.352241] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[589.414402] [128/133] (442s left) i915_drm_fdinfo (virtual-busy-hang-all)
[589.456523] Starting subtest: virtual-busy-hang-all
[589.460886] Subtest virtual-busy-hang-all: SKIP (0.000s)
[589.525985] [129/133] (442s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[589.641214] Starting subtest: cursorA-vs-flipA-legacy
[600.761582] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.119s)
[601.555145] [130/133] (430s left) gem_userptr_blits (huge-split)
[601.631347] Starting subtest: huge-split
[601.637853] Subtest huge-split: SUCCESS (0.007s)
[601.770496] [131/133] (429s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[601.826650] Starting subtest: etime-single-wait-for-submit-unsubmitted
[601.934664] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[602.014290] [132/133] (429s left) gem_busy (parallel)
[602.194664] Starting subtest: parallel
[602.197007] Starting dynamic subtest: rcs0
[603.474899] Dynamic subtest rcs0: SUCCESS (1.278s)
[603.490034] Starting dynamic subtest: bcs0
[605.458900] Dynamic subtest bcs0: SUCCESS (1.981s)
[605.472701] Starting dynamic subtest: vcs0
[607.559575] Dynamic subtest vcs0: SUCCESS (2.044s)
[607.571290] Starting dynamic subtest: vcs1
[609.491513] Dynamic subtest vcs1: SUCCESS (1.982s)
[609.509597] Starting dynamic subtest: vecs0
[611.477993] Dynamic subtest vecs0: SUCCESS (1.980s)
[611.489028] Starting dynamic subtest: ccs0
[613.459472] Dynamic subtest ccs0: SUCCESS (1.980s)
[613.462423] Subtest parallel: SUCCESS (11.264s)
[613.716172] [133/133] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[613.819304] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[613.823474] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[613.905812] 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.