[60.604473] Initializing watchdogs
[60.604620]   /dev/watchdog0
[60.619572] [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]
[60.623651] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.626028] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.629235] [001/130] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[60.724827] Starting subtest: stress-mm-invalidate-close-overlap
[62.880400] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[63.052538] [002/130] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[63.166954] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[63.171292] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.280197] [003/130] (957s left) kms_lease (lease-again)
[63.369257] Starting subtest: lease-again
[63.371383] Starting dynamic subtest: pipe-A-eDP-1
[63.373614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[63.380694] Starting dynamic subtest: pipe-B-eDP-1
[63.383044] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[63.389917] Starting dynamic subtest: pipe-C-eDP-1
[63.392058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[63.398780] Starting dynamic subtest: pipe-D-eDP-1
[63.400881] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[63.403025] Subtest lease-again: SUCCESS (0.012s)
[63.521965] [004/130] (957s left) gem_exec_create (legacy)
[63.593840] Starting subtest: legacy
[63.596236] Starting dynamic subtest: smem
[66.839113] Dynamic subtest smem: SUCCESS (3.238s)
[66.841743] Subtest legacy: SUCCESS (3.239s)
[67.093850] [005/130] (954s left) i915_query (query-regions-garbage-items)
[67.246956] Starting subtest: query-regions-garbage-items
[67.249333] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[67.446962] [006/130] (953s left) gem_ctx_create (basic)
[67.549946] Starting subtest: basic
[67.552459] Subtest basic: SUCCESS (0.000s)
[67.767527] [007/130] (953s left) gem_exec_reloc (basic-gtt-active)
[67.891838] Subtest basic-gtt-active: SKIP (0.000s)
[67.997571] [008/130] (953s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[68.081858] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[68.086445] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[68.288352] [009/130] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[68.389239] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[68.393275] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[68.517976] [010/130] (953s left) kms_psr (pr-cursor-mmap-cpu)
[68.626641] Starting subtest: pr-cursor-mmap-cpu
[68.631228] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[68.721399] [011/130] (952s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[68.808767] Starting subtest: async-flip-with-page-flip-events-tiled
[69.184117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[71.980331] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[71.988658] Starting dynamic subtest: pipe-A-eDP-1-4
[74.156806] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[74.164868] Starting dynamic subtest: pipe-A-eDP-1-4
[76.168785] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[76.175840] Starting dynamic subtest: pipe-A-eDP-1-x
[78.349412] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s)
[78.726268] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[81.510719] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[81.519655] Starting dynamic subtest: pipe-B-eDP-1-4
[83.697988] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[83.707018] Starting dynamic subtest: pipe-B-eDP-1-4
[85.709044] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[85.721814] Starting dynamic subtest: pipe-B-eDP-1-x
[87.888417] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.179s)
[88.251277] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[91.045968] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[91.054441] Starting dynamic subtest: pipe-C-eDP-1-4
[93.233594] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.186s)
[93.244195] Starting dynamic subtest: pipe-C-eDP-1-4
[95.243956] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[95.251290] Starting dynamic subtest: pipe-C-eDP-1-x
[97.423110] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[97.786359] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[100.575917] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[100.583913] Starting dynamic subtest: pipe-D-eDP-1-4
[102.751297] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[102.761665] Starting dynamic subtest: pipe-D-eDP-1-4
[104.761379] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[104.771883] Starting dynamic subtest: pipe-D-eDP-1-x
[106.929075] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[106.931239] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.104s)
[108.186614] [012/130] (913s left) syncobj_wait (invalid-reset-zero-handles)
[108.261721] Starting subtest: invalid-reset-zero-handles
[108.263591] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[108.390967] [013/130] (913s left) gem_exec_fence (syncobj-invalid-flags)
[108.859052] Starting subtest: syncobj-invalid-flags
[108.861862] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[110.034471] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[110.037360] [014/130] (911s left) gem_exec_params (dr1-dirt)
[110.091851] Starting subtest: DR1-dirt
[110.094148] Subtest DR1-dirt: SUCCESS (0.000s)
[110.225603] [015/130] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[110.341662] Starting subtest: basic-flip-before-cursor-varying-size
[111.315471] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.974s)
[112.211746] [016/130] (909s left) gem_lmem_swapping (parallel-random-verify)
[112.258099] Subtest parallel-random-verify: SKIP (0.000s)
[112.297574] [017/130] (909s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[112.683412] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[113.499305] [018/130] (908s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[113.608564] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[113.612678] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[113.737333] [019/130] (908s left) kms_tiled_display (basic-test-pattern)
[113.850177] Subtest basic-test-pattern: SKIP (0.000s)
[113.891267] [020/130] (908s left) i915_pciid
[114.087985] [021/130] (907s left) sw_sync (sync_expired_merge)
[114.120697] Starting subtest: sync_expired_merge
[115.194892] Subtest sync_expired_merge: SUCCESS (1.074s)
[115.279115] [022/130] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[115.382756] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[122.687063] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.306s)
[122.844193] [023/130] (899s left) gem_mmap_offset (bad-object)
[122.897872] Starting subtest: bad-object
[122.900178] Subtest bad-object: SUCCESS (0.001s)
[123.036108] [024/130] (899s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[123.133278] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[123.135478] Starting dynamic subtest: pipe-A-eDP-1
[123.157831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.167715] Starting dynamic subtest: pipe-B-eDP-1
[123.188085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.195076] Starting dynamic subtest: pipe-C-eDP-1
[123.215456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.222500] Starting dynamic subtest: pipe-D-eDP-1
[123.243142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.247050] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[125.361972] [025/130] (896s left) kms_atomic_interruptible (legacy-pageflip)
[125.464738] Starting subtest: legacy-pageflip
[125.467526] Starting dynamic subtest: pipe-A-eDP-1
[132.861295] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[132.863711] Subtest legacy-pageflip: SUCCESS (7.397s)
[133.734603] [026/130] (888s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[133.842892] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[133.847032] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[133.953043] [027/130] (888s left) api_intel_bb (intel-bb-blit-x)
[134.020118] Starting subtest: intel-bb-blit-x
[137.651847] Subtest intel-bb-blit-x: SUCCESS (3.630s)
[137.805920] [028/130] (884s left) gem_exec_schedule (preemptive-hang)
[137.991091] Starting subtest: preemptive-hang
[137.993200] Starting dynamic subtest: rcs0
[147.009549] Dynamic subtest rcs0: SUCCESS (9.021s)
[147.017150] Starting dynamic subtest: bcs0
[156.097078] Dynamic subtest bcs0: SUCCESS (9.086s)
[156.107348] Starting dynamic subtest: vcs0
[165.052069] Dynamic subtest vcs0: SUCCESS (8.955s)
[165.061147] Starting dynamic subtest: vcs1
[174.010165] Dynamic subtest vcs1: SUCCESS (8.957s)
[174.017950] Starting dynamic subtest: vecs0
[183.032823] Dynamic subtest vecs0: SUCCESS (9.020s)
[183.040555] Starting dynamic subtest: ccs0
[192.066290] Dynamic subtest ccs0: SUCCESS (9.031s)
[192.068304] Subtest preemptive-hang: SUCCESS (54.076s)
[192.333434] [029/130] (829s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[192.448531] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[192.452657] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[192.567595] [030/130] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[192.669819] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[192.674071] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[192.805484] [031/130] (829s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[192.918411] Starting subtest: 4-tiled-64bpp-rotate-270
[192.938701] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[193.077855] [032/130] (829s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[193.171798] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[193.174094] Starting dynamic subtest: pipe-A-default-mode
[193.461220] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[193.466031] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.287s)
[194.359973] [033/130] (828s left) kms_plane (pixel-format)
[194.465236] Starting subtest: pixel-format
[194.493538] Starting dynamic subtest: pipe-A-plane-0
[199.327170] Dynamic subtest pipe-A-plane-0: SUCCESS (4.833s)
[199.338979] Starting dynamic subtest: pipe-A-plane-3
[201.660289] Dynamic subtest pipe-A-plane-3: SUCCESS (2.333s)
[201.672264] Starting dynamic subtest: pipe-A-plane-5
[201.860222] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[202.923395] Starting dynamic subtest: pipe-B-plane-0
[207.738228] Dynamic subtest pipe-B-plane-0: SUCCESS (4.822s)
[207.746654] Starting dynamic subtest: pipe-B-plane-3
[210.027191] Dynamic subtest pipe-B-plane-3: SUCCESS (2.289s)
[210.036182] Starting dynamic subtest: pipe-B-plane-5
[210.238644] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[210.551689] Subtest pixel-format: SUCCESS (16.085s)
[211.414595] [034/130] (811s left) gem_mmap_wc (copy)
[211.491454] Subtest copy: SKIP (0.000s)
[211.593106] [035/130] (810s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[211.666280] Starting subtest: etime-multi-wait-available-unsubmitted
[211.771499] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[211.869171] [036/130] (810s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[216.887367] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[216.891993] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[217.745050] [037/130] (804s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[217.814338] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[217.816657] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[217.948658] [038/130] (804s left) kms_big_fb (linear-16bpp-rotate-270)
[218.049096] Starting subtest: linear-16bpp-rotate-270
[218.068631] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[218.218186] [039/130] (804s left) kms_psr (psr-sprite-mmap-cpu)
[218.312738] Starting subtest: psr-sprite-mmap-cpu
[218.314981] Starting dynamic subtest: eDP-1
[220.030624] Dynamic subtest eDP-1: SUCCESS (1.717s)
[220.032795] Subtest psr-sprite-mmap-cpu: SUCCESS (1.718s)
[220.900238] [040/130] (801s left) gem_softpin (evict-prime)
[220.963775] Starting subtest: evict-prime
[220.966117] Starting dynamic subtest: rcs0
[222.141055] Dynamic subtest rcs0: SUCCESS (1.177s)
[222.151829] Starting dynamic subtest: bcs0
[223.282172] Dynamic subtest bcs0: SUCCESS (1.139s)
[223.292284] Starting dynamic subtest: vcs0
[224.838765] Dynamic subtest vcs0: SUCCESS (1.554s)
[224.849703] Starting dynamic subtest: vcs1
[226.873102] Dynamic subtest vcs1: SUCCESS (2.033s)
[226.884359] Starting dynamic subtest: vecs0
[228.924235] Dynamic subtest vecs0: SUCCESS (2.049s)
[228.935387] Starting dynamic subtest: ccs0
[230.064982] Dynamic subtest ccs0: SUCCESS (1.140s)
[230.076210] Starting dynamic subtest: all
[231.907664] Dynamic subtest all: SUCCESS (1.839s)
[231.910520] Subtest evict-prime: SUCCESS (10.943s)
[232.014105] [041/130] (790s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[232.125098] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[232.136103] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[232.271848] [042/130] (790s left) prime_vgem (busy)
[232.356314] Starting subtest: busy
[232.358288] Starting dynamic subtest: rcs0
[232.446039] Dynamic subtest rcs0: SUCCESS (0.091s)
[232.456100] Starting dynamic subtest: bcs0
[232.503514] Dynamic subtest bcs0: SUCCESS (0.057s)
[232.511382] Starting dynamic subtest: vcs0
[232.555817] Dynamic subtest vcs0: SUCCESS (0.052s)
[232.563768] Starting dynamic subtest: vcs1
[232.602610] Dynamic subtest vcs1: SUCCESS (0.046s)
[232.610588] Starting dynamic subtest: vecs0
[232.649355] Dynamic subtest vecs0: SUCCESS (0.046s)
[232.657231] Starting dynamic subtest: ccs0
[232.698210] Dynamic subtest ccs0: SUCCESS (0.048s)
[232.700413] Subtest busy: SUCCESS (0.345s)
[232.860544] [043/130] (790s left) kms_cursor_crc (cursor-onscreen-32x10)
[233.016737] Starting subtest: cursor-onscreen-32x10
[233.060953] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[233.340384] [044/130] (789s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[233.465158] Starting subtest: modeset-atomic-cursor-hotspot
[233.468885] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[233.632480] [045/130] (789s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[233.731393] Starting subtest: primary-yf-tiled-reflect-x-90
[233.734834] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[233.827116] [046/130] (789s left) kms_content_protection (legacy)
[233.966636] Starting subtest: legacy
[233.970349] Subtest legacy: SKIP (0.000s)
[234.129752] [047/130] (788s left) syncobj_wait (invalid-signal-illegal-handle)
[234.177172] Starting subtest: invalid-signal-illegal-handle
[234.178951] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[234.311643] [048/130] (788s left) gem_ppgtt (shrink-vs-evict-any)
[234.367131] Starting subtest: shrink-vs-evict-any
[239.867404] Subtest shrink-vs-evict-any: SUCCESS (5.498s)
[239.975399] [049/130] (783s left) perf (gen12-unprivileged-single-ctx-counters)
[240.109270] Starting subtest: gen12-unprivileged-single-ctx-counters
[240.111231] Starting dynamic subtest: rcs0
[240.647880] Dynamic subtest rcs0: SUCCESS (0.539s)
[240.650394] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.540s)
[240.697396] [050/130] (782s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[240.799780] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[240.802209] Starting dynamic subtest: pipe-A
[241.952457] Dynamic subtest pipe-A: SUCCESS (1.154s)
[241.960079] Starting dynamic subtest: pipe-B
[244.227149] Dynamic subtest pipe-B: SUCCESS (2.274s)
[244.234985] Starting dynamic subtest: pipe-C
[245.393440] Dynamic subtest pipe-C: SUCCESS (1.165s)
[245.403298] Starting dynamic subtest: pipe-D
[246.615854] Dynamic subtest pipe-D: SUCCESS (1.222s)
[246.618298] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.818s)
[247.876289] [051/130] (775s left) i915_pm_rpm (system-suspend-devices)
[250.032341] Starting subtest: system-suspend-devices
[261.428403] Subtest system-suspend-devices: SUCCESS (11.399s)
[261.834105] [052/130] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[261.952777] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[261.957299] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[262.083048] [053/130] (761s left) perf_pmu (rc6-suspend)
[262.122852] Starting subtest: rc6-suspend
[284.377121] Subtest rc6-suspend: SUCCESS (7.470s)
[285.270596] [054/130] (738s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[285.388803] Starting subtest: fbc-rgb101010-draw-render
[290.093026] Subtest fbc-rgb101010-draw-render: SUCCESS (4.648s)
[291.328589] [055/130] (732s left) gem_caching (read-writes)
[291.393029] Subtest read-writes: SKIP (0.000s)
[291.467492] [056/130] (732s left) gem_ctx_isolation (preservation-s3)
[291.527836] Starting subtest: preservation-S3
[291.530032] Starting dynamic subtest: rcs0
[307.161827] Dynamic subtest rcs0: SUCCESS (1.310s)
[307.172839] Starting dynamic subtest: bcs0
[323.173424] Dynamic subtest bcs0: SUCCESS (1.326s)
[323.185911] Starting dynamic subtest: vcs0
[339.182613] Dynamic subtest vcs0: SUCCESS (2.396s)
[339.193633] Starting dynamic subtest: vcs1
[357.189376] Dynamic subtest vcs1: SUCCESS (4.951s)
[357.202699] Starting dynamic subtest: vecs0
[375.176555] Dynamic subtest vecs0: SUCCESS (4.852s)
[375.188119] Starting dynamic subtest: ccs0
[393.177331] Dynamic subtest ccs0: SUCCESS (3.151s)
[393.180690] Subtest preservation-S3: SUCCESS (17.992s)
[393.445900] [057/130] (630s left) gem_exec_reloc (basic-concurrent0)
[393.535591] Subtest basic-concurrent0: SKIP (0.000s)
[393.624105] [058/130] (629s left) kms_plane_scaling (planes-upscale-factor-0-25)
[393.709905] Starting subtest: planes-upscale-factor-0-25
[393.712593] Starting dynamic subtest: pipe-A
[393.771435] Dynamic subtest pipe-A: SUCCESS (0.062s)
[393.787480] Starting dynamic subtest: pipe-B
[394.994557] Dynamic subtest pipe-B: SUCCESS (1.189s)
[395.004717] Starting dynamic subtest: pipe-C
[396.126558] Dynamic subtest pipe-C: SUCCESS (1.105s)
[396.136817] Starting dynamic subtest: pipe-D
[397.286714] Dynamic subtest pipe-D: SUCCESS (1.135s)
[397.289374] Subtest planes-upscale-factor-0-25: SUCCESS (3.498s)
[398.711824] [059/130] (624s left) kms_flip (dpms-vs-vblank-race)
[398.819959] Starting subtest: dpms-vs-vblank-race
[398.822584] Starting dynamic subtest: A-eDP1
[402.705239] Dynamic subtest A-eDP1: SUCCESS (3.837s)
[402.715254] Starting dynamic subtest: B-eDP1
[407.341030] Dynamic subtest B-eDP1: SUCCESS (4.603s)
[407.354395] Starting dynamic subtest: C-eDP1
[410.849450] Dynamic subtest C-eDP1: SUCCESS (3.491s)
[410.859680] Starting dynamic subtest: D-eDP1
[415.463398] Dynamic subtest D-eDP1: SUCCESS (4.603s)
[415.469332] Subtest dpms-vs-vblank-race: SUCCESS (16.541s)
[416.362105] [060/130] (607s left) kms_feature_discovery (display)
[416.465010] Starting subtest: display
[416.467455] Subtest display: SUCCESS (0.000s)
[416.570827] [061/130] (607s left) kms_psr (psr2-sprite-plane-onoff)
[416.666763] Starting subtest: psr2-sprite-plane-onoff
[416.669351] Starting dynamic subtest: eDP-1
[418.445035] Dynamic subtest eDP-1: SUCCESS (1.777s)
[418.447746] Subtest psr2-sprite-plane-onoff: SUCCESS (1.778s)
[419.329751] [062/130] (604s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[419.436792] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[419.441538] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[419.547066] [063/130] (604s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[419.656187] Starting subtest: x-tiled-16bpp-rotate-270
[419.676539] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[419.828479] [064/130] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[419.933320] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[419.938339] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[420.070423] [065/130] (603s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[420.165401] Starting subtest: y-tiled-8bpp-rotate-270
[420.170583] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[420.299563] [066/130] (603s left) kms_vblank (crtc-id)
[420.399144] Starting subtest: crtc-id
[420.401189] Starting dynamic subtest: pipe-A-eDP-1
[420.843334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[420.860297] Starting dynamic subtest: pipe-D-eDP-1
[421.933911] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s)
[421.936399] Subtest crtc-id: SUCCESS (1.535s)
[422.797235] [067/130] (601s left) perf (rc6-disable)
[422.921362] Starting subtest: rc6-disable
[423.102122] Subtest rc6-disable: SUCCESS (0.180s)
[423.147925] [068/130] (600s left) kms_cursor_crc (cursor-random-max-size)
[423.453289] Starting subtest: cursor-random-max-size
[423.461339] Subtest cursor-random-max-size: SKIP (0.000s)
[423.622985] [069/130] (600s left) kms_fence_pin_leak
[423.788895] [070/130] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[423.882162] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[432.382346] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.504s)
[432.529918] [071/130] (591s left) kms_psr2_su (page_flip-p010)
[432.601360] Subtest page_flip-P010: SKIP (0.000s)
[432.671047] [072/130] (591s left) gem_exec_schedule (semaphore-power)
[432.857199] Subtest semaphore-power: SKIP (0.000s)
[433.056446] [073/130] (591s left) gem_exec_balancer (full-late-pulse)
[433.120424] Starting subtest: full-late-pulse
[437.745811] Subtest full-late-pulse: SUCCESS (4.625s)
[438.072736] [074/130] (586s left) syncobj_wait (invalid-reset-one-illegal-handle)
[438.139625] Starting subtest: invalid-reset-one-illegal-handle
[438.142345] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[438.268232] [075/130] (586s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[438.360724] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[438.363160] Starting dynamic subtest: pipe-A-eDP-1
[438.513379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[438.523817] Starting dynamic subtest: pipe-B-eDP-1
[438.545141] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[438.554351] Starting dynamic subtest: pipe-C-eDP-1
[438.577333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[438.586366] Starting dynamic subtest: pipe-D-eDP-1
[438.609557] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[438.611935] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.152s)
[440.778645] [076/130] (583s left) gem_ctx_persistence (legacy-engines-mixed-process)
[440.839414] Starting subtest: legacy-engines-mixed-process
[440.842584] Starting dynamic subtest: render
[442.874172] Dynamic subtest render: SUCCESS (2.034s)
[442.885532] Starting dynamic subtest: bsd1
[444.855605] Dynamic subtest bsd1: SUCCESS (1.979s)
[444.865843] Starting dynamic subtest: bsd2
[446.878010] Dynamic subtest bsd2: SUCCESS (2.020s)
[446.889434] Starting dynamic subtest: blt
[448.851029] Dynamic subtest blt: SUCCESS (1.970s)
[448.861879] Starting dynamic subtest: vebox
[450.871767] Dynamic subtest vebox: SUCCESS (2.018s)
[450.874474] Subtest legacy-engines-mixed-process: SUCCESS (10.031s)
[450.976579] [077/130] (573s left) gem_exec_reloc (basic-write-cpu-noreloc)
[451.039447] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[451.113763] [078/130] (573s left) syncobj_timeline (single-wait-all-signaled)
[451.161380] Starting subtest: single-wait-all-signaled
[451.164522] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[451.306629] [079/130] (573s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[451.404351] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[451.409441] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[451.536940] [080/130] (572s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[451.631279] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[451.633952] Starting dynamic subtest: pipe-A-eDP-1
[451.659233] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[451.675589] Starting dynamic subtest: pipe-B-eDP-1
[451.701961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.711771] Starting dynamic subtest: pipe-C-eDP-1
[451.737420] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.747241] Starting dynamic subtest: pipe-D-eDP-1
[451.773320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.778166] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[453.867009] [081/130] (570s left) gem_ctx_shared (q-smoketest)
[453.937854] Starting subtest: Q-smoketest
[453.940559] Starting dynamic subtest: rcs0
[459.519895] Dynamic subtest rcs0: SUCCESS (5.527s)
[459.531230] Starting dynamic subtest: bcs0
[465.060676] Dynamic subtest bcs0: SUCCESS (5.532s)
[465.077104] Starting dynamic subtest: vcs0
[470.567299] Dynamic subtest vcs0: SUCCESS (5.500s)
[470.582097] Starting dynamic subtest: vcs1
[476.050379] Dynamic subtest vcs1: SUCCESS (5.486s)
[476.066486] Starting dynamic subtest: vecs0
[481.557175] Dynamic subtest vecs0: SUCCESS (5.497s)
[481.573541] Starting dynamic subtest: ccs0
[487.051129] Dynamic subtest ccs0: SUCCESS (5.489s)
[487.053744] Subtest Q-smoketest: SUCCESS (33.041s)
[487.276863] [082/130] (537s left) prime_mmap_coherency (read)
[487.340717] Starting subtest: read
[492.712985] Subtest read: SUCCESS (5.376s)
[492.894937] [083/130] (531s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[492.999436] Starting subtest: disable-crc-after-crtc
[493.001877] Starting dynamic subtest: pipe-A-eDP-1
[494.676150] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.677s)
[494.687590] Starting dynamic subtest: pipe-B-eDP-1
[496.956947] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.278s)
[496.969570] Starting dynamic subtest: pipe-C-eDP-1
[499.207296] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.248s)
[499.217577] Starting dynamic subtest: pipe-D-eDP-1
[501.480465] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.273s)
[501.483344] Subtest disable-crc-after-crtc: SUCCESS (8.482s)
[502.325647] [084/130] (522s left) gen9_exec_parse (unaligned-access)
[502.399198] Subtest unaligned-access: SKIP (0.000s)
[502.488541] [085/130] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[502.591859] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[502.596800] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.728022] [086/130] (522s left) gem_exec_reloc (basic-cpu-wc)
[502.806978] Subtest basic-cpu-wc: SKIP (0.000s)
[502.891684] [087/130] (521s left) core_sysfs (read-all-entries)
[502.960018] Starting subtest: read-all-entries
[502.965224] Subtest read-all-entries: SUCCESS (0.008s)
[503.100610] [088/130] (521s left) kms_getfb (getfb2-handle-not-fb)
[503.196819] Starting subtest: getfb2-handle-not-fb
[503.199557] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[503.329840] [089/130] (521s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[503.427303] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[503.431810] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[503.546733] [090/130] (521s left) gen9_exec_parse (batch-zero-length)
[503.609569] Subtest batch-zero-length: SKIP (0.000s)
[503.680675] [091/130] (521s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[503.777930] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[503.781240] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[503.897655] [092/130] (521s left) kms_chamelium_frames (hdmi-frame-dump)
[504.294419] Subtest hdmi-frame-dump: SKIP (0.000s)
[505.112597] [093/130] (519s left) kms_prop_blob (invalid-get-prop)
[505.174539] Starting subtest: invalid-get-prop
[505.177398] Subtest invalid-get-prop: SUCCESS (0.000s)
[505.288970] [094/130] (519s left) kms_addfb_basic (bad-pitch-32)
[505.355365] Starting subtest: bad-pitch-32
[505.358219] Subtest bad-pitch-32: SUCCESS (0.000s)
[505.517113] [095/130] (519s left) api_intel_allocator (execbuf-with-allocator)
[505.575454] Starting subtest: execbuf-with-allocator
[505.580349] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[505.704552] [096/130] (519s left) gem_ctx_bad_destroy (invalid-default-ctx)
[505.767972] Starting subtest: invalid-default-ctx
[505.770743] Subtest invalid-default-ctx: SUCCESS (0.000s)
[505.874151] [097/130] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[505.972544] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[505.977148] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[506.122530] [098/130] (519s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[506.227266] Starting subtest: yf-tiled-16bpp-rotate-180
[506.232465] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[506.358641] [099/130] (518s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[506.446916] Starting subtest: fbc-psr2-sprite-mmap-gtt
[506.449224] Starting dynamic subtest: eDP-1
[506.453800] Dynamic subtest eDP-1: SKIP (0.000s)
[506.457781] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[506.567239] [100/130] (518s left) gem_exec_flush (basic-uc-set-default)
[506.624930] Starting subtest: basic-uc-set-default
[512.086551] Subtest basic-uc-set-default: SUCCESS (5.461s)
[512.300877] [101/130] (513s left) template (a)
[512.364690] Starting subtest: A
[512.367528] Subtest A: SUCCESS (0.000s)
[512.507013] [102/130] (512s left) kms_flip (2x-flip-vs-expired-vblank)
[512.613379] Starting subtest: 2x-flip-vs-expired-vblank
[512.624389] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[512.737070] [103/130] (512s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[517.796432] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[517.799350] Starting dynamic subtest: pipe-A-eDP-1
[518.591022] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[518.606271] Starting dynamic subtest: pipe-B-eDP-1
[519.721222] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[519.726429] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.922s)
[520.936814] [104/130] (504s left) gem_exec_reloc (basic-write-cpu)
[521.005086] Subtest basic-write-cpu: SKIP (0.000s)
[521.098166] [105/130] (504s left) kms_vblank (wait-idle)
[521.194365] Starting subtest: wait-idle
[521.196561] Starting dynamic subtest: pipe-A-eDP-1
[522.950558] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[522.967169] Starting dynamic subtest: pipe-D-eDP-1
[525.355813] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[525.358712] Subtest wait-idle: SUCCESS (4.164s)
[526.201166] [106/130] (499s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[526.292325] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[526.294794] Starting dynamic subtest: pipe-A-eDP-1
[526.322207] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.332879] Starting dynamic subtest: pipe-B-eDP-1
[526.360116] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.370123] Starting dynamic subtest: pipe-C-eDP-1
[526.397487] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.407783] Starting dynamic subtest: pipe-D-eDP-1
[526.438078] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.443243] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[528.563865] [107/130] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[528.675306] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[535.180524] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.508s)
[535.357049] [108/130] (490s left) kms_cursor_crc (cursor-sliding-256x256)
[535.610037] Starting subtest: cursor-sliding-256x256
[535.612755] Starting dynamic subtest: pipe-A-eDP-1
[538.853587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.239s)
[538.882156] Starting dynamic subtest: pipe-D-eDP-1
[542.761829] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.884s)
[542.764351] Subtest cursor-sliding-256x256: SUCCESS (7.147s)
[543.643213] [109/130] (482s left) gem_mmap_wc (write)
[543.706934] Subtest write: SKIP (0.000s)
[543.761983] [110/130] (482s left) kms_psr (psr2-cursor-plane-move)
[543.864572] Starting subtest: psr2-cursor-plane-move
[543.867631] Starting dynamic subtest: eDP-1
[545.591999] Dynamic subtest eDP-1: SUCCESS (1.729s)
[545.594189] Subtest psr2-cursor-plane-move: SUCCESS (1.731s)
[546.409690] [111/130] (479s left) gem_exec_parallel (basic)
[546.480809] Starting subtest: basic
[546.483281] Starting dynamic subtest: rcs0
[548.176622] Dynamic subtest rcs0: SUCCESS (1.694s)
[548.186749] Starting dynamic subtest: bcs0
[549.875225] Dynamic subtest bcs0: SUCCESS (1.698s)
[549.886726] Starting dynamic subtest: vcs0
[551.880917] Dynamic subtest vcs0: SUCCESS (2.002s)
[551.893802] Starting dynamic subtest: vcs1
[553.865180] Dynamic subtest vcs1: SUCCESS (1.983s)
[553.876405] Starting dynamic subtest: vecs0
[555.849139] Dynamic subtest vecs0: SUCCESS (1.980s)
[555.862683] Starting dynamic subtest: ccs0
[557.629308] Dynamic subtest ccs0: SUCCESS (1.778s)
[557.632522] Subtest basic: SUCCESS (11.146s)
[557.846848] [112/130] (468s left) syncobj_wait (wait-for-submit-complex)
[557.907333] Starting subtest: wait-for-submit-complex
[557.966977] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[558.077450] [113/130] (467s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[558.179308] Starting subtest: extended-pageflip-modeset-hang-oldfb
[558.182006] Starting dynamic subtest: pipe-A
[566.084568] Dynamic subtest pipe-A: SUCCESS (7.900s)
[566.095534] Starting dynamic subtest: pipe-D
[574.696737] Dynamic subtest pipe-D: SUCCESS (8.607s)
[574.699534] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.512s)
[575.583292] [114/130] (450s left) gem_lmem_swapping (massive-random)
[575.630971] Subtest massive-random: SKIP (0.000s)
[575.679694] [115/130] (450s left) gem_exec_params (no-bsd)
[575.739474] Starting subtest: no-bsd
[575.745519] Subtest no-bsd: SUCCESS (0.004s)
[576.948207] [116/130] (449s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[577.052427] Starting subtest: fbcpsr-tiling-y
[577.058375] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[577.182780] [117/130] (448s left) kms_hdr (static-toggle-suspend)
[577.278790] Starting subtest: static-toggle-suspend
[577.286380] Subtest static-toggle-suspend: SKIP (0.000s)
[577.378355] [118/130] (448s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[577.482557] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[584.903243] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.421s)
[585.078751] [119/130] (441s left) kms_feature_discovery (display-4x)
[585.181408] Starting subtest: display-4x
[585.186850] Subtest display-4x: SKIP (0.000s)
[585.299104] [120/130] (440s left) gem_busy (extended)
[585.472030] Starting subtest: extended
[585.474540] Starting dynamic subtest: rcs0
[585.571184] Dynamic subtest rcs0: SUCCESS (0.099s)
[585.584717] Starting dynamic subtest: bcs0
[585.613692] Dynamic subtest bcs0: SUCCESS (0.041s)
[585.624363] Starting dynamic subtest: vcs0
[586.889265] Dynamic subtest vcs0: SUCCESS (1.272s)
[586.901748] Starting dynamic subtest: vcs1
[588.873309] Dynamic subtest vcs1: SUCCESS (1.981s)
[588.889188] Starting dynamic subtest: vecs0
[590.857920] Dynamic subtest vecs0: SUCCESS (1.980s)
[590.876203] Starting dynamic subtest: ccs0
[590.906145] Dynamic subtest ccs0: SUCCESS (0.047s)
[590.908773] Subtest extended: SUCCESS (5.434s)
[591.182283] [121/130] (435s left) kms_chamelium_color (ctm-max)
[591.279002] Subtest ctm-max: SKIP (0.000s)
[591.327732] [122/130] (435s left) syncobj_timeline (invalid-signal-illegal-handle)
[591.386013] Starting subtest: invalid-signal-illegal-handle
[591.388517] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[591.507817] [123/130] (434s left) gem_compute (compute-square)
[591.566077] Starting subtest: compute-square
[591.570370] Subtest compute-square: SUCCESS (0.007s)
[591.718765] [124/130] (434s left) kms_atomic (atomic-invalid-params)
[591.814476] Starting subtest: atomic-invalid-params
[591.817072] Starting dynamic subtest: pipe-A-eDP-1
[592.208317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[592.210646] Subtest atomic-invalid-params: SUCCESS (0.394s)
[593.032852] [125/130] (433s left) kms_pm_dc (dc9-dpms)
[594.132139] Starting subtest: dc9-dpms
[595.567955] Subtest dc9-dpms: SUCCESS (1.435s)
[595.664440] [126/130] (430s left) gen7_exec_parse (basic-allocation)
[595.740392] Subtest basic-allocation: SKIP (0.000s)
[595.802552] [127/130] (430s left) gem_render_copy (yf-tiled)
[595.870280] Starting subtest: yf-tiled
[595.875262] Subtest yf-tiled: SKIP (0.000s)
[596.075531] [128/130] (430s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[596.138971] Starting subtest: etime-single-wait-all-available-unsubmitted
[596.245458] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[596.346196] [129/130] (430s left) testdisplay
[596.685708] [130/130] (430s left) gem_exec_schedule (u-submit-early-slice)
[596.767284] Starting subtest: u-submit-early-slice
[596.770133] Starting dynamic subtest: rcs0
[596.806251] Dynamic subtest rcs0: SUCCESS (0.049s)
[596.818971] Starting dynamic subtest: bcs0
[596.851059] Dynamic subtest bcs0: SUCCESS (0.044s)
[596.862450] Starting dynamic subtest: vcs0
[596.897560] Dynamic subtest vcs0: SUCCESS (0.046s)
[596.907601] Starting dynamic subtest: vcs1
[596.945132] Dynamic subtest vcs1: SUCCESS (0.047s)
[596.957144] Starting dynamic subtest: vecs0
[596.991400] Dynamic subtest vecs0: SUCCESS (0.046s)
[597.003455] Starting dynamic subtest: ccs0
[597.039234] Dynamic subtest ccs0: SUCCESS (0.047s)
[597.041620] Subtest u-submit-early-slice: SUCCESS (0.283s)
[598.036033] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: gem_exec_create
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: gem_ctx_create
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_tiled_display
results: parsing output: 19/ for test: i915_pciid
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_ppgtt
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: i915_pm_rpm
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_caching
results: parsing output: 55/ for test: gem_ctx_isolation
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_feature_discovery
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_fence_pin_leak
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_su
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: prime_mmap_coherency
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: core_sysfs
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_prop_blob
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: gem_ctx_bad_destroy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: template
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_parallel
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_feature_discovery
results: parsing output: 119/ for test: gem_busy
results: parsing output: 120/ for test: kms_chamelium_color
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_compute
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: kms_pm_dc
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: testdisplay
results: parsing output: 129/ for test: gem_exec_schedule
Done.