[57.745266] Initializing watchdogs
[57.745394]   /dev/watchdog0
[57.760377] [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]
[57.764755] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.767057] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.770511] [001/130] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[57.872517] Starting subtest: stress-mm-invalidate-close-overlap
[60.014953] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[60.188426] [002/130] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[60.298610] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[60.302924] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.423748] [003/130] (957s left) kms_lease (lease-again)
[60.529266] Starting subtest: lease-again
[60.531611] Starting dynamic subtest: pipe-A-eDP-1
[60.533884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[60.543213] Starting dynamic subtest: pipe-B-eDP-1
[60.545449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[60.552992] Starting dynamic subtest: pipe-C-eDP-1
[60.555171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[60.562514] Starting dynamic subtest: pipe-D-eDP-1
[60.564648] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[60.566740] Subtest lease-again: SUCCESS (0.012s)
[60.673743] [004/130] (957s left) gem_exec_create (legacy)
[60.730781] Starting subtest: legacy
[60.732677] Starting dynamic subtest: smem
[63.894843] Dynamic subtest smem: SUCCESS (3.168s)
[63.897870] Subtest legacy: SUCCESS (3.169s)
[64.098112] [005/130] (954s left) i915_query (query-regions-garbage-items)
[64.160371] Starting subtest: query-regions-garbage-items
[64.162350] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[64.281392] [006/130] (954s left) gem_ctx_create (basic)
[64.348726] Starting subtest: basic
[64.351084] Subtest basic: SUCCESS (0.000s)
[64.556836] [007/130] (953s left) gem_exec_reloc (basic-gtt-active)
[64.623377] Subtest basic-gtt-active: SKIP (0.000s)
[64.692336] [008/130] (953s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[64.752394] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[64.756876] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[64.959861] [009/130] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[65.064135] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[65.068370] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[65.192314] [010/130] (953s left) kms_psr (pr-cursor-mmap-cpu)
[65.271859] Starting subtest: pr-cursor-mmap-cpu
[65.276052] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[65.364191] [011/130] (953s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[65.459968] Starting subtest: async-flip-with-page-flip-events-tiled
[65.846587] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[68.600654] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[68.610095] Starting dynamic subtest: pipe-A-eDP-1-4
[70.785640] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.186s)
[70.795505] Starting dynamic subtest: pipe-A-eDP-1-4
[72.794251] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[72.802455] Starting dynamic subtest: pipe-A-eDP-1-x
[74.983369] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[75.354890] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[78.126061] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.777s)
[78.133848] Starting dynamic subtest: pipe-B-eDP-1-4
[80.323054] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.197s)
[80.333591] Starting dynamic subtest: pipe-B-eDP-1-4
[82.331965] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[82.339726] Starting dynamic subtest: pipe-B-eDP-1-x
[84.533223] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[84.905913] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[87.654234] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[87.662239] Starting dynamic subtest: pipe-C-eDP-1-4
[89.818586] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[89.826650] Starting dynamic subtest: pipe-C-eDP-1-4
[91.828652] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[91.837666] Starting dynamic subtest: pipe-C-eDP-1-x
[94.007213] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[94.374795] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[97.191143] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.823s)
[97.201670] Starting dynamic subtest: pipe-D-eDP-1-4
[99.387794] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.197s)
[99.395716] Starting dynamic subtest: pipe-D-eDP-1-4
[101.398447] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[101.411235] Starting dynamic subtest: pipe-D-eDP-1-x
[103.565420] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[103.567839] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.113s)
[104.796411] [012/130] (913s left) syncobj_wait (invalid-reset-zero-handles)
[104.880745] Starting subtest: invalid-reset-zero-handles
[104.882713] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[105.011853] [013/130] (913s left) gem_exec_fence (syncobj-invalid-flags)
[105.499062] Starting subtest: syncobj-invalid-flags
[105.501543] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[107.033580] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[107.036876] [014/130] (911s left) gem_exec_params (dr1-dirt)
[107.100535] Starting subtest: DR1-dirt
[107.102972] Subtest DR1-dirt: SUCCESS (0.000s)
[107.236687] [015/130] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[107.367065] Starting subtest: basic-flip-before-cursor-varying-size
[108.315456] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[109.128382] [016/130] (909s left) gem_lmem_swapping (parallel-random-verify)
[109.176284] Subtest parallel-random-verify: SKIP (0.000s)
[109.214834] [017/130] (909s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[109.603606] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[110.416849] [018/130] (908s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[110.518272] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[110.522426] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[110.642123] [019/130] (908s left) kms_tiled_display (basic-test-pattern)
[110.757829] Subtest basic-test-pattern: SKIP (0.000s)
[110.800475] [020/130] (908s left) i915_pciid
[110.975134] [021/130] (908s left) sw_sync (sync_expired_merge)
[111.005496] Starting subtest: sync_expired_merge
[112.079779] Subtest sync_expired_merge: SUCCESS (1.074s)
[112.160189] [022/130] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[112.263069] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[119.518886] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.258s)
[119.675902] [023/130] (899s left) gem_mmap_offset (bad-object)
[119.737927] Starting subtest: bad-object
[119.739936] Subtest bad-object: SUCCESS (0.001s)
[119.870843] [024/130] (899s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[119.958853] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[119.961167] Starting dynamic subtest: pipe-A-eDP-1
[119.984379] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.994937] Starting dynamic subtest: pipe-B-eDP-1
[120.016134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.023951] Starting dynamic subtest: pipe-C-eDP-1
[120.045303] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.052726] Starting dynamic subtest: pipe-D-eDP-1
[120.074522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.078552] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[122.243094] [025/130] (896s left) kms_atomic_interruptible (legacy-pageflip)
[122.336150] Starting subtest: legacy-pageflip
[122.338553] Starting dynamic subtest: pipe-A-eDP-1
[129.729217] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.392s)
[129.731570] Subtest legacy-pageflip: SUCCESS (7.393s)
[130.595782] [026/130] (888s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[130.714303] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[130.718627] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[130.856057] [027/130] (888s left) api_intel_bb (intel-bb-blit-x)
[130.914128] Starting subtest: intel-bb-blit-x
[134.493165] Subtest intel-bb-blit-x: SUCCESS (3.579s)
[134.665203] [028/130] (884s left) gem_exec_schedule (preemptive-hang)
[134.858030] Starting subtest: preemptive-hang
[134.860906] Starting dynamic subtest: rcs0
[144.004099] Dynamic subtest rcs0: SUCCESS (9.146s)
[144.014639] Starting dynamic subtest: bcs0
[153.024847] Dynamic subtest bcs0: SUCCESS (9.017s)
[153.036529] Starting dynamic subtest: vcs0
[162.047572] Dynamic subtest vcs0: SUCCESS (9.023s)
[162.056627] Starting dynamic subtest: vcs1
[171.007310] Dynamic subtest vcs1: SUCCESS (8.954s)
[171.015875] Starting dynamic subtest: vecs0
[180.025926] Dynamic subtest vecs0: SUCCESS (9.019s)
[180.034119] Starting dynamic subtest: ccs0
[189.056406] Dynamic subtest ccs0: SUCCESS (9.029s)
[189.059359] Subtest preemptive-hang: SUCCESS (54.193s)
[189.340263] [029/130] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[189.442670] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[189.447026] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.563062] [030/130] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[189.667533] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[189.671684] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[189.790405] [031/130] (829s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[189.886708] Starting subtest: 4-tiled-64bpp-rotate-270
[189.906923] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[190.064427] [032/130] (829s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[190.165134] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[190.167398] Starting dynamic subtest: pipe-A-default-mode
[190.462263] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[190.466863] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.297s)
[191.319887] [033/130] (828s left) kms_plane (pixel-format)
[191.423285] Starting subtest: pixel-format
[191.448808] Starting dynamic subtest: pipe-A-plane-0
[196.181910] Dynamic subtest pipe-A-plane-0: SUCCESS (4.733s)
[196.191333] Starting dynamic subtest: pipe-A-plane-3
[198.381960] Dynamic subtest pipe-A-plane-3: SUCCESS (2.200s)
[198.390742] Starting dynamic subtest: pipe-A-plane-5
[198.593056] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[199.685943] Starting dynamic subtest: pipe-B-plane-0
[204.412694] Dynamic subtest pipe-B-plane-0: SUCCESS (4.733s)
[204.420785] Starting dynamic subtest: pipe-B-plane-3
[206.734974] Dynamic subtest pipe-B-plane-3: SUCCESS (2.322s)
[206.744394] Starting dynamic subtest: pipe-B-plane-5
[206.957153] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s)
[207.267074] Subtest pixel-format: SUCCESS (15.842s)
[208.077602] [034/130] (811s left) gem_mmap_wc (copy)
[208.150027] Subtest copy: SKIP (0.000s)
[208.217308] [035/130] (811s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[208.269703] Starting subtest: etime-multi-wait-available-unsubmitted
[208.377488] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[208.475959] [036/130] (811s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[213.452898] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[213.457467] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[214.318634] [037/130] (805s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[214.380779] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[214.383078] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[214.499389] [038/130] (805s left) kms_big_fb (linear-16bpp-rotate-270)
[214.614331] Starting subtest: linear-16bpp-rotate-270
[214.633904] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[214.769333] [039/130] (804s left) kms_psr (psr-sprite-mmap-cpu)
[214.867925] Starting subtest: psr-sprite-mmap-cpu
[214.870215] Starting dynamic subtest: eDP-1
[216.599261] Dynamic subtest eDP-1: SUCCESS (1.733s)
[216.601600] Subtest psr-sprite-mmap-cpu: SUCCESS (1.734s)
[217.473555] [040/130] (802s left) gem_softpin (evict-prime)
[217.543870] Starting subtest: evict-prime
[217.546517] Starting dynamic subtest: rcs0
[218.745911] Dynamic subtest rcs0: SUCCESS (1.202s)
[218.758420] Starting dynamic subtest: bcs0
[219.904051] Dynamic subtest bcs0: SUCCESS (1.156s)
[219.914288] Starting dynamic subtest: vcs0
[221.871875] Dynamic subtest vcs0: SUCCESS (1.964s)
[221.882982] Starting dynamic subtest: vcs1
[223.912402] Dynamic subtest vcs1: SUCCESS (2.038s)
[223.931520] Starting dynamic subtest: vecs0
[225.902471] Dynamic subtest vecs0: SUCCESS (1.989s)
[225.912738] Starting dynamic subtest: ccs0
[227.034765] Dynamic subtest ccs0: SUCCESS (1.132s)
[227.043642] Starting dynamic subtest: all
[228.904861] Dynamic subtest all: SUCCESS (1.867s)
[228.907762] Subtest evict-prime: SUCCESS (11.360s)
[229.007646] [041/130] (790s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[229.112366] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[229.122380] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.012s)
[229.223167] [042/130] (790s left) prime_vgem (busy)
[229.321442] Starting subtest: busy
[229.323796] Starting dynamic subtest: rcs0
[229.417674] Dynamic subtest rcs0: SUCCESS (0.095s)
[229.426476] Starting dynamic subtest: bcs0
[229.469311] Dynamic subtest bcs0: SUCCESS (0.052s)
[229.477477] Starting dynamic subtest: vcs0
[229.517270] Dynamic subtest vcs0: SUCCESS (0.047s)
[229.527607] Starting dynamic subtest: vcs1
[229.563239] Dynamic subtest vcs1: SUCCESS (0.043s)
[229.571220] Starting dynamic subtest: vecs0
[229.607753] Dynamic subtest vecs0: SUCCESS (0.044s)
[229.615812] Starting dynamic subtest: ccs0
[229.655513] Dynamic subtest ccs0: SUCCESS (0.047s)
[229.657632] Subtest busy: SUCCESS (0.334s)
[229.813206] [043/130] (790s left) kms_cursor_crc (cursor-onscreen-32x10)
[229.964332] Starting subtest: cursor-onscreen-32x10
[230.010876] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[230.278513] [044/130] (789s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[230.385172] Starting subtest: modeset-atomic-cursor-hotspot
[230.388962] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[230.550987] [045/130] (789s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[230.644026] Starting subtest: primary-yf-tiled-reflect-x-90
[230.647763] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[230.736984] [046/130] (789s left) kms_content_protection (legacy)
[230.874721] Starting subtest: legacy
[230.878380] Subtest legacy: SKIP (0.000s)
[231.033173] [047/130] (789s left) syncobj_wait (invalid-signal-illegal-handle)
[231.105681] Starting subtest: invalid-signal-illegal-handle
[231.107770] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[231.240037] [048/130] (788s left) gem_ppgtt (shrink-vs-evict-any)
[231.301520] Starting subtest: shrink-vs-evict-any
[236.915212] Subtest shrink-vs-evict-any: SUCCESS (5.611s)
[237.018453] [049/130] (783s left) perf (gen12-unprivileged-single-ctx-counters)
[237.153860] Starting subtest: gen12-unprivileged-single-ctx-counters
[237.156101] Starting dynamic subtest: rcs0
[237.707067] Dynamic subtest rcs0: SUCCESS (0.555s)
[237.709293] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.556s)
[237.751147] [050/130] (782s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[237.887785] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[237.890096] Starting dynamic subtest: pipe-A
[239.037533] Dynamic subtest pipe-A: SUCCESS (1.152s)
[239.047388] Starting dynamic subtest: pipe-B
[241.319781] Dynamic subtest pipe-B: SUCCESS (2.280s)
[241.329710] Starting dynamic subtest: pipe-C
[242.470217] Dynamic subtest pipe-C: SUCCESS (1.150s)
[242.479128] Starting dynamic subtest: pipe-D
[243.701038] Dynamic subtest pipe-D: SUCCESS (1.230s)
[243.703374] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.815s)
[244.917991] [051/130] (775s left) i915_pm_rpm (system-suspend-devices)
[247.064801] Starting subtest: system-suspend-devices
[258.488382] Subtest system-suspend-devices: SUCCESS (11.425s)
[258.891211] [052/130] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[259.008593] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[259.012838] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[259.127564] [053/130] (761s left) perf_pmu (rc6-suspend)
[259.171486] Starting subtest: rc6-suspend
[282.203632] Subtest rc6-suspend: SUCCESS (7.510s)
[283.105212] [054/130] (737s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[283.229357] Starting subtest: fbc-rgb101010-draw-render
[287.820846] Subtest fbc-rgb101010-draw-render: SUCCESS (4.615s)
[289.026614] [055/130] (731s left) gem_caching (read-writes)
[289.089669] Subtest read-writes: SKIP (0.000s)
[289.165604] [056/130] (731s left) gem_ctx_isolation (preservation-s3)
[289.233179] Starting subtest: preservation-S3
[289.235565] Starting dynamic subtest: rcs0
[305.101624] Dynamic subtest rcs0: SUCCESS (1.364s)
[305.112620] Starting dynamic subtest: bcs0
[321.081859] Dynamic subtest bcs0: SUCCESS (1.316s)
[321.092668] Starting dynamic subtest: vcs0
[337.080596] Dynamic subtest vcs0: SUCCESS (2.644s)
[337.092659] Starting dynamic subtest: vcs1
[355.093699] Dynamic subtest vcs1: SUCCESS (5.029s)
[355.104900] Starting dynamic subtest: vecs0
[373.094504] Dynamic subtest vecs0: SUCCESS (5.084s)
[373.105859] Starting dynamic subtest: ccs0
[391.088048] Dynamic subtest ccs0: SUCCESS (3.123s)
[391.091512] Subtest preservation-S3: SUCCESS (18.564s)
[391.411284] [057/130] (629s left) gem_exec_reloc (basic-concurrent0)
[391.483712] Subtest basic-concurrent0: SKIP (0.000s)
[391.573469] [058/130] (628s left) kms_plane_scaling (planes-upscale-factor-0-25)
[391.661291] Starting subtest: planes-upscale-factor-0-25
[391.663765] Starting dynamic subtest: pipe-A
[391.721176] Dynamic subtest pipe-A: SUCCESS (0.062s)
[391.732022] Starting dynamic subtest: pipe-B
[392.815036] Dynamic subtest pipe-B: SUCCESS (1.102s)
[392.827498] Starting dynamic subtest: pipe-C
[393.919880] Dynamic subtest pipe-C: SUCCESS (1.111s)
[393.931890] Starting dynamic subtest: pipe-D
[395.043573] Dynamic subtest pipe-D: SUCCESS (1.131s)
[395.046186] Subtest planes-upscale-factor-0-25: SUCCESS (3.412s)
[396.220272] [059/130] (624s left) kms_flip (dpms-vs-vblank-race)
[396.324604] Starting subtest: dpms-vs-vblank-race
[396.326936] Starting dynamic subtest: A-eDP1
[401.266496] Dynamic subtest A-eDP1: SUCCESS (4.957s)
[401.277618] Starting dynamic subtest: B-eDP1
[405.890421] Dynamic subtest B-eDP1: SUCCESS (4.638s)
[405.901435] Starting dynamic subtest: C-eDP1
[410.479833] Dynamic subtest C-eDP1: SUCCESS (4.594s)
[410.495299] Starting dynamic subtest: D-eDP1
[415.109917] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[415.112665] Subtest dpms-vs-vblank-race: SUCCESS (18.829s)
[416.024407] [060/130] (604s left) kms_feature_discovery (display)
[416.124385] Starting subtest: display
[416.126769] Subtest display: SUCCESS (0.000s)
[416.224063] [061/130] (604s left) kms_psr (psr2-sprite-plane-onoff)
[416.315110] Starting subtest: psr2-sprite-plane-onoff
[416.317460] Starting dynamic subtest: eDP-1
[418.125065] Dynamic subtest eDP-1: SUCCESS (1.811s)
[418.127799] Subtest psr2-sprite-plane-onoff: SUCCESS (1.813s)
[418.986121] [062/130] (601s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[419.099923] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[419.104813] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[419.217090] [063/130] (601s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[419.317888] Starting subtest: x-tiled-16bpp-rotate-270
[419.337873] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[419.487181] [064/130] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[419.587924] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[419.593447] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[419.729287] [065/130] (601s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[419.828455] Starting subtest: y-tiled-8bpp-rotate-270
[419.833039] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[419.953271] [066/130] (600s left) kms_vblank (crtc-id)
[420.042795] Starting subtest: crtc-id
[420.045132] Starting dynamic subtest: pipe-A-eDP-1
[420.498390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[420.512904] Starting dynamic subtest: pipe-D-eDP-1
[421.595650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[421.598682] Subtest crtc-id: SUCCESS (1.556s)
[422.451217] [067/130] (598s left) perf (rc6-disable)
[422.561228] Starting subtest: rc6-disable
[422.765562] Subtest rc6-disable: SUCCESS (0.203s)
[422.809757] [068/130] (598s left) kms_cursor_crc (cursor-random-max-size)
[423.108892] Starting subtest: cursor-random-max-size
[423.116462] Subtest cursor-random-max-size: SKIP (0.000s)
[423.250343] [069/130] (597s left) kms_fence_pin_leak
[423.424404] [070/130] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[423.520234] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[432.058902] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.537s)
[432.222547] [071/130] (588s left) kms_psr2_su (page_flip-p010)
[432.286699] Subtest page_flip-P010: SKIP (0.000s)
[432.353587] [072/130] (588s left) gem_exec_schedule (semaphore-power)
[432.541777] Subtest semaphore-power: SKIP (0.000s)
[432.746303] [073/130] (588s left) gem_exec_balancer (full-late-pulse)
[432.815709] Starting subtest: full-late-pulse
[437.769877] Subtest full-late-pulse: SUCCESS (4.957s)
[438.094648] [074/130] (583s left) syncobj_wait (invalid-reset-one-illegal-handle)
[438.158467] Starting subtest: invalid-reset-one-illegal-handle
[438.161122] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[438.311680] [075/130] (583s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[438.417432] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[438.419681] Starting dynamic subtest: pipe-A-eDP-1
[438.560428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s)
[438.571891] Starting dynamic subtest: pipe-B-eDP-1
[438.594838] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[438.604896] Starting dynamic subtest: pipe-C-eDP-1
[438.627696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[438.637024] Starting dynamic subtest: pipe-D-eDP-1
[438.659488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[438.661887] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s)
[440.845291] [076/130] (580s left) gem_ctx_persistence (legacy-engines-mixed-process)
[440.909692] Starting subtest: legacy-engines-mixed-process
[440.912405] Starting dynamic subtest: render
[442.890205] Dynamic subtest render: SUCCESS (1.980s)
[442.902933] Starting dynamic subtest: bsd1
[444.907669] Dynamic subtest bsd1: SUCCESS (2.016s)
[444.918940] Starting dynamic subtest: bsd2
[446.842194] Dynamic subtest bsd2: SUCCESS (1.934s)
[446.854935] Starting dynamic subtest: blt
[448.896748] Dynamic subtest blt: SUCCESS (2.053s)
[448.908941] Starting dynamic subtest: vebox
[450.888461] Dynamic subtest vebox: SUCCESS (1.991s)
[450.891438] Subtest legacy-engines-mixed-process: SUCCESS (9.981s)
[450.996657] [077/130] (570s left) gem_exec_reloc (basic-write-cpu-noreloc)
[451.062233] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[451.141860] [078/130] (570s left) syncobj_timeline (single-wait-all-signaled)
[451.210695] Starting subtest: single-wait-all-signaled
[451.213599] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[451.353291] [079/130] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[451.453829] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[451.459264] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[451.593418] [080/130] (569s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[451.684636] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[451.687183] Starting dynamic subtest: pipe-A-eDP-1
[451.712234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.722817] Starting dynamic subtest: pipe-B-eDP-1
[451.748331] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.757908] Starting dynamic subtest: pipe-C-eDP-1
[451.782721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.793665] Starting dynamic subtest: pipe-D-eDP-1
[451.820667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.825795] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[453.924567] [081/130] (567s left) gem_ctx_shared (q-smoketest)
[453.995537] Starting subtest: Q-smoketest
[453.998322] Starting dynamic subtest: rcs0
[459.585291] Dynamic subtest rcs0: SUCCESS (5.535s)
[459.596311] Starting dynamic subtest: bcs0
[465.090715] Dynamic subtest bcs0: SUCCESS (5.501s)
[465.105466] Starting dynamic subtest: vcs0
[470.577903] Dynamic subtest vcs0: SUCCESS (5.491s)
[470.594865] Starting dynamic subtest: vcs1
[476.061502] Dynamic subtest vcs1: SUCCESS (5.481s)
[476.077004] Starting dynamic subtest: vecs0
[481.543454] Dynamic subtest vecs0: SUCCESS (5.485s)
[481.558646] Starting dynamic subtest: ccs0
[487.045598] Dynamic subtest ccs0: SUCCESS (5.500s)
[487.047831] Subtest Q-smoketest: SUCCESS (33.002s)
[487.204676] [082/130] (534s left) prime_mmap_coherency (read)
[487.282538] Starting subtest: read
[492.664829] Subtest read: SUCCESS (5.377s)
[492.809260] [083/130] (528s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[492.912895] Starting subtest: disable-crc-after-crtc
[492.915513] Starting dynamic subtest: pipe-A-eDP-1
[494.535871] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.624s)
[494.547695] Starting dynamic subtest: pipe-B-eDP-1
[496.800513] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.262s)
[496.812217] Starting dynamic subtest: pipe-C-eDP-1
[499.037175] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[499.048447] Starting dynamic subtest: pipe-D-eDP-1
[501.307382] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s)
[501.310150] Subtest disable-crc-after-crtc: SUCCESS (8.395s)
[502.183265] [084/130] (519s left) gen9_exec_parse (unaligned-access)
[502.257698] Subtest unaligned-access: SKIP (0.000s)
[502.333345] [085/130] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[502.435026] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[502.439616] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.581699] [086/130] (519s left) gem_exec_reloc (basic-cpu-wc)
[502.642897] Subtest basic-cpu-wc: SKIP (0.000s)
[502.709238] [087/130] (519s left) core_sysfs (read-all-entries)
[502.764880] Starting subtest: read-all-entries
[502.770571] Subtest read-all-entries: SUCCESS (0.008s)
[502.900910] [088/130] (519s left) kms_getfb (getfb2-handle-not-fb)
[502.995752] Starting subtest: getfb2-handle-not-fb
[502.998524] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[503.115192] [089/130] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[503.220787] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[503.224924] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[503.366430] [090/130] (518s left) gen9_exec_parse (batch-zero-length)
[503.434513] Subtest batch-zero-length: SKIP (0.000s)
[503.527655] [091/130] (518s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[503.630726] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[503.635524] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[503.768300] [092/130] (518s left) kms_chamelium_frames (hdmi-frame-dump)
[504.160505] Subtest hdmi-frame-dump: SKIP (0.000s)
[504.981307] [093/130] (517s left) kms_prop_blob (invalid-get-prop)
[505.050940] Starting subtest: invalid-get-prop
[505.053931] Subtest invalid-get-prop: SUCCESS (0.000s)
[505.190428] [094/130] (517s left) kms_addfb_basic (bad-pitch-32)
[505.255619] Starting subtest: bad-pitch-32
[505.258319] Subtest bad-pitch-32: SUCCESS (0.000s)
[505.423817] [095/130] (516s left) api_intel_allocator (execbuf-with-allocator)
[505.486631] Starting subtest: execbuf-with-allocator
[505.490896] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[505.654670] [096/130] (516s left) gem_ctx_bad_destroy (invalid-default-ctx)
[505.724208] Starting subtest: invalid-default-ctx
[505.726747] Subtest invalid-default-ctx: SUCCESS (0.000s)
[505.819487] [097/130] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[505.915121] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[505.919789] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[506.037955] [098/130] (516s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[506.135429] Starting subtest: yf-tiled-16bpp-rotate-180
[506.139696] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[506.271079] [099/130] (516s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[506.366094] Starting subtest: fbc-psr2-sprite-mmap-gtt
[506.368432] Starting dynamic subtest: eDP-1
[506.372633] Dynamic subtest eDP-1: SKIP (0.000s)
[506.376625] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[506.467283] [100/130] (515s left) gem_exec_flush (basic-uc-set-default)
[506.528153] Starting subtest: basic-uc-set-default
[511.985293] Subtest basic-uc-set-default: SUCCESS (5.454s)
[512.196156] [101/130] (510s left) template (a)
[512.260364] Starting subtest: A
[512.263192] Subtest A: SUCCESS (0.000s)
[512.386376] [102/130] (510s left) kms_flip (2x-flip-vs-expired-vblank)
[512.484842] Starting subtest: 2x-flip-vs-expired-vblank
[512.492915] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[512.599062] [103/130] (509s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[517.693682] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[517.696445] Starting dynamic subtest: pipe-A-eDP-1
[518.495623] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[518.511216] Starting dynamic subtest: pipe-B-eDP-1
[519.627669] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[519.632890] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.931s)
[520.834770] [104/130] (501s left) gem_exec_reloc (basic-write-cpu)
[520.898695] Subtest basic-write-cpu: SKIP (0.000s)
[520.976649] [105/130] (501s left) kms_vblank (wait-idle)
[521.060705] Starting subtest: wait-idle
[521.063746] Starting dynamic subtest: pipe-A-eDP-1
[522.819750] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.761s)
[522.836169] Starting dynamic subtest: pipe-D-eDP-1
[525.246166] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[525.248922] Subtest wait-idle: SUCCESS (4.187s)
[526.085454] [106/130] (496s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[526.183250] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[526.185529] Starting dynamic subtest: pipe-A-eDP-1
[526.210314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.221456] Starting dynamic subtest: pipe-B-eDP-1
[526.249019] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.258911] Starting dynamic subtest: pipe-C-eDP-1
[526.285835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.295718] Starting dynamic subtest: pipe-D-eDP-1
[526.323737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.328576] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[528.441396] [107/130] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[528.547555] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[535.103822] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.559s)
[535.241681] [108/130] (487s left) kms_cursor_crc (cursor-sliding-256x256)
[535.535246] Starting subtest: cursor-sliding-256x256
[535.544907] Starting dynamic subtest: pipe-A-eDP-1
[538.811278] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.268s)
[538.844660] Starting dynamic subtest: pipe-D-eDP-1
[542.742315] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.908s)
[542.744776] Subtest cursor-sliding-256x256: SUCCESS (7.206s)
[543.623730] [109/130] (479s left) gem_mmap_wc (write)
[543.689158] Subtest write: SKIP (0.000s)
[543.754695] [110/130] (479s left) kms_psr (psr2-cursor-plane-move)
[543.856199] Starting subtest: psr2-cursor-plane-move
[543.858584] Starting dynamic subtest: eDP-1
[545.579580] Dynamic subtest eDP-1: SUCCESS (1.723s)
[545.582284] Subtest psr2-cursor-plane-move: SUCCESS (1.724s)
[546.412161] [111/130] (476s left) gem_exec_parallel (basic)
[546.471788] Starting subtest: basic
[546.474660] Starting dynamic subtest: rcs0
[548.097211] Dynamic subtest rcs0: SUCCESS (1.625s)
[548.109491] Starting dynamic subtest: bcs0
[549.809802] Dynamic subtest bcs0: SUCCESS (1.712s)
[549.820843] Starting dynamic subtest: vcs0
[551.859430] Dynamic subtest vcs0: SUCCESS (2.047s)
[551.872877] Starting dynamic subtest: vcs1
[553.843061] Dynamic subtest vcs1: SUCCESS (1.982s)
[553.858604] Starting dynamic subtest: vecs0
[555.908291] Dynamic subtest vecs0: SUCCESS (2.062s)
[555.921955] Starting dynamic subtest: ccs0
[557.712892] Dynamic subtest ccs0: SUCCESS (1.804s)
[557.715706] Subtest basic: SUCCESS (11.244s)
[557.927714] [112/130] (465s left) syncobj_wait (wait-for-submit-complex)
[557.992899] Starting subtest: wait-for-submit-complex
[558.052344] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[558.157346] [113/130] (464s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[558.287511] Starting subtest: extended-pageflip-modeset-hang-oldfb
[558.290249] Starting dynamic subtest: pipe-A
[566.198773] Dynamic subtest pipe-A: SUCCESS (7.908s)
[566.209548] Starting dynamic subtest: pipe-D
[574.808240] Dynamic subtest pipe-D: SUCCESS (8.610s)
[574.810878] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.522s)
[575.666569] [114/130] (447s left) gem_lmem_swapping (massive-random)
[575.715696] Subtest massive-random: SKIP (0.000s)
[575.762245] [115/130] (447s left) gem_exec_params (no-bsd)
[575.826733] Starting subtest: no-bsd
[575.833797] Subtest no-bsd: SUCCESS (0.003s)
[577.959007] [116/130] (445s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[578.049687] Starting subtest: fbcpsr-tiling-y
[578.053752] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[578.157931] [117/130] (445s left) kms_hdr (static-toggle-suspend)
[578.251896] Starting subtest: static-toggle-suspend
[578.259522] Subtest static-toggle-suspend: SKIP (0.000s)
[578.348410] [118/130] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[578.436573] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[585.768740] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.335s)
[585.908471] [119/130] (437s left) kms_feature_discovery (display-4x)
[586.009620] Starting subtest: display-4x
[586.014547] Subtest display-4x: SKIP (0.000s)
[586.110599] [120/130] (437s left) gem_busy (extended)
[586.298700] Starting subtest: extended
[586.301599] Starting dynamic subtest: rcs0
[586.409076] Dynamic subtest rcs0: SUCCESS (0.110s)
[586.422548] Starting dynamic subtest: bcs0
[586.451120] Dynamic subtest bcs0: SUCCESS (0.040s)
[586.462190] Starting dynamic subtest: vcs0
[587.891077] Dynamic subtest vcs0: SUCCESS (1.437s)
[587.904895] Starting dynamic subtest: vcs1
[589.875545] Dynamic subtest vcs1: SUCCESS (1.982s)
[589.889603] Starting dynamic subtest: vecs0
[591.859135] Dynamic subtest vecs0: SUCCESS (1.981s)
[591.875527] Starting dynamic subtest: ccs0
[591.907461] Dynamic subtest ccs0: SUCCESS (0.047s)
[591.910502] Subtest extended: SUCCESS (5.612s)
[592.194406] [121/130] (431s left) kms_chamelium_color (ctm-max)
[592.295876] Subtest ctm-max: SKIP (0.000s)
[592.342896] [122/130] (431s left) syncobj_timeline (invalid-signal-illegal-handle)
[592.409586] Starting subtest: invalid-signal-illegal-handle
[592.412132] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[592.536734] [123/130] (430s left) gem_compute (compute-square)
[592.595744] Starting subtest: compute-square
[592.598544] Subtest compute-square: SUCCESS (0.006s)
[592.763828] [124/130] (430s left) kms_atomic (atomic-invalid-params)
[592.870707] Starting subtest: atomic-invalid-params
[592.873387] Starting dynamic subtest: pipe-A-eDP-1
[593.257775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[593.260745] Subtest atomic-invalid-params: SUCCESS (0.390s)
[594.087114] [125/130] (429s left) kms_pm_dc (dc9-dpms)
[595.193209] Starting subtest: dc9-dpms
[596.614924] Subtest dc9-dpms: SUCCESS (1.422s)
[596.704123] [126/130] (426s left) gen7_exec_parse (basic-allocation)
[596.771735] Subtest basic-allocation: SKIP (0.000s)
[596.849213] [127/130] (426s left) gem_render_copy (yf-tiled)
[596.897716] Starting subtest: yf-tiled
[596.903128] Subtest yf-tiled: SKIP (0.000s)
[597.103221] [128/130] (426s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[597.160959] Starting subtest: etime-single-wait-all-available-unsubmitted
[597.261870] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[597.368814] [129/130] (426s left) testdisplay
[597.732916] [130/130] (426s left) gem_exec_schedule (u-submit-early-slice)
[597.811574] Starting subtest: u-submit-early-slice
[597.814322] Starting dynamic subtest: rcs0
[597.850175] Dynamic subtest rcs0: SUCCESS (0.050s)
[597.863616] Starting dynamic subtest: bcs0
[597.892891] Dynamic subtest bcs0: SUCCESS (0.043s)
[597.904039] Starting dynamic subtest: vcs0
[597.942288] Dynamic subtest vcs0: SUCCESS (0.049s)
[597.958648] Starting dynamic subtest: vcs1
[597.994932] Dynamic subtest vcs1: SUCCESS (0.051s)
[598.006629] Starting dynamic subtest: vecs0
[598.038332] Dynamic subtest vecs0: SUCCESS (0.043s)
[598.049479] Starting dynamic subtest: ccs0
[598.082679] Dynamic subtest ccs0: SUCCESS (0.044s)
[598.085197] Subtest u-submit-early-slice: SUCCESS (0.284s)
[599.991757] 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.