[61.603808] Initializing watchdogs
[61.604076]   /dev/watchdog0
[61.620148] [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]
[61.624580] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.627055] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.629190] [001/133] (960s left) gen9_exec_parse (cmd-crossing-page)
[61.695715] Subtest cmd-crossing-page: SKIP (0.000s)
[61.754347] [002/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[61.877396] Starting subtest: basic-flip-after-cursor-atomic
[62.853630] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.976s)
[63.729040] [003/133] (958s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[63.837389] Starting subtest: extended-modeset-hang-newfb-with-reset
[63.838364] Starting dynamic subtest: pipe-A
[79.389457] Dynamic subtest pipe-A: SUCCESS (15.552s)
[79.401492] Starting dynamic subtest: pipe-D
[94.898267] Dynamic subtest pipe-D: SUCCESS (15.507s)
[94.899148] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.062s)
[95.706585] [004/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[95.797054] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[102.771051] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.963s)
[102.902582] [005/133] (919s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[103.004265] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[109.867605] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.864s)
[110.008180] [006/133] (912s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[110.091371] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[110.118440] Starting dynamic subtest: pipe-A-plane-0
[110.418400] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[110.424618] Starting dynamic subtest: pipe-A-plane-3
[110.651765] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[111.730193] Starting dynamic subtest: pipe-B-plane-0
[112.022678] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[112.029961] Starting dynamic subtest: pipe-B-plane-3
[112.267136] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[112.590386] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.499s)
[113.400829] [007/133] (908s left) perf_pmu (pmu-read)
[113.437408] Starting subtest: pmu-read
[113.439865] Subtest pmu-read: SUCCESS (0.002s)
[113.541391] [008/133] (908s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[113.610297] Starting subtest: invalid-bsd1-flag-on-vebox
[113.611404] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[113.707245] [009/133] (908s left) gem_mmap_offset (bad-flags)
[113.762273] Starting subtest: bad-flags
[113.763176] Subtest bad-flags: SUCCESS (0.000s)
[113.854181] [010/133] (908s left) syncobj_wait (invalid-signal-illegal-handle)
[113.900494] Starting subtest: invalid-signal-illegal-handle
[113.901552] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[114.007563] [011/133] (908s left) kms_psr (fbc-psr2-primary-render)
[114.094927] Starting subtest: fbc-psr2-primary-render
[114.096057] Starting dynamic subtest: eDP-1
[114.098152] Dynamic subtest eDP-1: SKIP (0.000s)
[114.099970] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[114.163610] [012/133] (908s left) syncobj_wait (wait-any-snapshot)
[114.216046] Starting subtest: wait-any-snapshot
[114.297505] Subtest wait-any-snapshot: SUCCESS (0.081s)
[114.366412] [013/133] (908s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[114.424224] Starting subtest: yf-tiled-ccs-to-x-tiled
[114.426115] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[114.609384] [014/133] (907s left) gem_ctx_exec (basic-nohangcheck)
[114.659052] Starting subtest: basic-nohangcheck
[114.909563] Subtest basic-nohangcheck: SUCCESS (0.250s)
[115.030638] [015/133] (907s left) gem_exec_reloc (basic-write-read)
[115.082466] Subtest basic-write-read: SKIP (0.000s)
[115.144603] [016/133] (907s left) core_debugfs (read-all-entries)
[115.199991] Starting subtest: read-all-entries
[115.296145] Subtest read-all-entries: SUCCESS (0.097s)
[115.359816] [017/133] (907s left) kms_psr (psr-cursor-plane-onoff)
[115.453042] Starting subtest: psr-cursor-plane-onoff
[115.453877] Starting dynamic subtest: eDP-1
[117.210200] Dynamic subtest eDP-1: SUCCESS (1.757s)
[117.210965] Subtest psr-cursor-plane-onoff: SUCCESS (1.757s)
[118.078737] [018/133] (904s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[118.135035] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[118.240954] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[118.317778] [019/133] (904s left) gem_ctx_param (invalid-ctx-get)
[118.378551] Starting subtest: invalid-ctx-get
[118.379623] Subtest invalid-ctx-get: SUCCESS (0.000s)
[118.458608] [020/133] (904s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[118.545455] Starting subtest: random-ccs-data-yf-tiled-ccs
[118.546403] Starting dynamic subtest: pipe-A-eDP-1
[118.556331] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.564109] Starting dynamic subtest: pipe-B-eDP-1
[118.573049] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.578991] Starting dynamic subtest: pipe-C-eDP-1
[118.587719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.593699] Starting dynamic subtest: pipe-D-eDP-1
[118.602974] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.604616] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[120.818846] [021/133] (901s left) gem_ppgtt (blt-vs-render-ctx0)
[120.878610] Starting subtest: blt-vs-render-ctx0
[153.934806] Subtest blt-vs-render-ctx0: SUCCESS (33.046s)
[154.062768] [022/133] (868s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[154.214611] Starting subtest: fbc-pr-cursor-plane-update-sf
[154.216352] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[154.293750] [023/133] (868s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[154.377361] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[154.379037] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[154.441382] [024/133] (868s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[154.524994] Starting subtest: primary-4-tiled-reflect-x-0
[161.534947] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.009s)
[162.698214] [025/133] (860s left) api_intel_allocator (reserve-simple)
[162.749276] Starting subtest: reserve-simple
[162.752395] Subtest reserve-simple: SUCCESS (0.004s)
[162.851618] [026/133] (860s left) kms_big_fb (linear-32bpp-rotate-0)
[162.946148] Starting subtest: linear-32bpp-rotate-0
[164.514056] Subtest linear-32bpp-rotate-0: SUCCESS (1.568s)
[164.653983] [027/133] (858s left) kms_setmode (invalid-clone-exclusive-crtc)
[164.700467] Starting subtest: invalid-clone-exclusive-crtc
[164.703208] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[164.835284] [028/133] (858s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[164.889202] Starting subtest: yf-tiled-ccs-to-y-tiled
[164.890821] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[165.063887] [029/133] (857s left) gem_exec_params (no-vebox)
[165.125209] Starting subtest: no-vebox
[165.126267] Subtest no-vebox: SUCCESS (0.002s)
[166.994195] [030/133] (856s left) kms_dsc (dsc-with-bpc-formats)
[167.076916] Starting subtest: dsc-with-bpc-formats
[167.125189] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[167.154199] [031/133] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[167.249267] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[167.250907] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[167.342221] [032/133] (855s left) gem_exec_fence (syncobj-signal)
[167.883052] Starting subtest: syncobj-signal
[167.888689] Subtest syncobj-signal: SUCCESS (0.006s)
[168.967154] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[168.968773] [033/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[169.067285] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[169.068982] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[169.165709] [034/133] (854s left) i915_pm_rpm (debugfs-read)
[171.095640] Starting subtest: debugfs-read
[172.252435] Subtest debugfs-read: SUCCESS (1.158s)
[172.633733] [035/133] (850s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[172.723988] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[172.735605] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[172.824233] [036/133] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[172.914961] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[177.277439] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.363s)
[178.421525] [037/133] (844s left) kms_invalid_mode (uint-max-clock)
[178.517082] Starting subtest: uint-max-clock
[178.517900] Starting dynamic subtest: pipe-A-eDP-1
[178.805933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[178.814678] Starting dynamic subtest: pipe-B-eDP-1
[178.815419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[178.822180] Starting dynamic subtest: pipe-C-eDP-1
[178.822931] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[178.829423] Starting dynamic subtest: pipe-D-eDP-1
[178.830170] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[178.830898] Subtest uint-max-clock: SUCCESS (0.303s)
[179.630638] [038/133] (843s left) i915_query (query-regions-garbage-items)
[179.685584] Starting subtest: query-regions-garbage-items
[179.686636] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[179.799173] [039/133] (843s left) kms_pm_dc (dc5-dpms)
[180.894988] Starting subtest: dc5-dpms
[182.946814] Subtest dc5-dpms: SUCCESS (2.042s)
[183.021898] [040/133] (840s left) gem_eio (wait-wedge-immediate)
[183.258370] Starting subtest: wait-wedge-immediate
[185.003296] Subtest wait-wedge-immediate: SUCCESS (1.745s)
[185.114746] [041/133] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[185.201621] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[189.777534] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.577s)
[190.899835] [042/133] (832s left) gem_exec_schedule (fifo)
[190.961344] Starting subtest: fifo
[190.962353] Starting dynamic subtest: rcs0
[191.063559] Dynamic subtest rcs0: SUCCESS (0.102s)
[191.074021] Starting dynamic subtest: vcs0
[191.148261] Dynamic subtest vcs0: SUCCESS (0.085s)
[191.158554] Starting dynamic subtest: vcs1
[191.229024] Dynamic subtest vcs1: SUCCESS (0.080s)
[191.238837] Starting dynamic subtest: vecs0
[191.336384] Dynamic subtest vecs0: SUCCESS (0.107s)
[191.346999] Starting dynamic subtest: ccs0
[191.430037] Dynamic subtest ccs0: SUCCESS (0.092s)
[191.431770] Subtest fifo: SUCCESS (0.469s)
[193.014516] [043/133] (830s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[193.401433] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[194.202717] [044/133] (829s left) kms_cursor_legacy (single-bo)
[194.311702] Starting subtest: single-bo
[194.312675] Starting dynamic subtest: pipe-A
[199.739442] Dynamic subtest pipe-A: SUCCESS (5.380s)
[199.748843] Starting dynamic subtest: pipe-B
[205.121468] Dynamic subtest pipe-B: SUCCESS (5.380s)
[205.131202] Starting dynamic subtest: pipe-C
[210.502708] Dynamic subtest pipe-C: SUCCESS (5.379s)
[210.512329] Starting dynamic subtest: pipe-D
[215.884865] Dynamic subtest pipe-D: SUCCESS (5.380s)
[215.894508] Starting dynamic subtest: all-pipes
[221.274578] Dynamic subtest all-pipes: SUCCESS (5.387s)
[221.275732] Subtest single-bo: SUCCESS (26.916s)
[221.382755] [045/133] (802s left) kms_color (gamma)
[221.464455] Starting subtest: gamma
[221.465420] Starting dynamic subtest: pipe-A-eDP-1
[222.211210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[222.220329] Starting dynamic subtest: pipe-B-eDP-1
[223.666995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[223.674781] Starting dynamic subtest: pipe-C-eDP-1
[225.031203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[225.043967] Starting dynamic subtest: pipe-D-eDP-1
[226.357736] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[226.358575] Subtest gamma: SUCCESS (4.895s)
[227.142694] [046/133] (796s left) kms_rotation_crc (primary-rotation-180)
[227.228592] Starting subtest: primary-rotation-180
[234.170424] Subtest primary-rotation-180: SUCCESS (6.942s)
[235.424841] [047/133] (788s left) kms_legacy_colorkey (invalid-plane)
[235.510401] Starting subtest: invalid-plane
[235.511285] Starting dynamic subtest: zero-id
[235.512131] Dynamic subtest zero-id: SUCCESS (0.000s)
[235.519310] Starting dynamic subtest: outrange-id
[235.520208] Dynamic subtest outrange-id: SUCCESS (0.000s)
[235.521065] Subtest invalid-plane: SUCCESS (0.001s)
[235.578399] [048/133] (788s left) kms_psr (fbc-psr-sprite-blt)
[235.679454] Starting subtest: fbc-psr-sprite-blt
[235.680364] Starting dynamic subtest: eDP-1
[235.682296] Dynamic subtest eDP-1: SKIP (0.000s)
[235.684107] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[235.754551] [049/133] (787s left) gem_exec_balancer (waits)
[235.812855] Starting subtest: waits
[242.523646] Subtest waits: SUCCESS (6.665s)
[242.793353] [050/133] (780s left) i915_drm_fdinfo (all-busy-check-all)
[242.831426] Starting subtest: all-busy-check-all
[242.839170] Subtest all-busy-check-all: SKIP (0.006s)
[242.906195] [051/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[243.039232] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[250.227180] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.189s)
[250.341186] [052/133] (773s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[250.429568] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[250.431380] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.516552] [053/133] (773s left) gem_userptr_blits (nohangcheck)
[250.582595] Starting subtest: nohangcheck
[250.796827] Subtest nohangcheck: SUCCESS (0.215s)
[250.917101] [054/133] (772s left) vgem_basic (bad-pad)
[250.963336] Starting subtest: bad-pad
[250.964237] Subtest bad-pad: SUCCESS (0.000s)
[251.030295] [055/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[251.112080] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[251.113965] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[251.205244] [056/133] (772s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[251.318253] Starting subtest: cursorB-vs-flipB-toggle
[251.320101] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[251.459975] [057/133] (772s left) sw_sync (sync_random_merge)
[251.489220] Starting subtest: sync_random_merge
[251.539607] Subtest sync_random_merge: SUCCESS (0.050s)
[251.596520] [058/133] (772s left) kms_cursor_crc (cursor-onscreen-max-size)
[251.907161] Starting subtest: cursor-onscreen-max-size
[251.909862] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[252.020040] [059/133] (772s left) gem_exec_params (secure-non-master)
[252.079175] Starting subtest: secure-non-master
[252.081071] Subtest secure-non-master: SKIP (0.000s)
[252.173658] [060/133] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[252.282210] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[275.568019] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.286s)
[275.699975] [061/133] (748s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[275.797800] Starting subtest: x-tiled-32bpp-rotate-180
[277.277041] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[277.431792] [062/133] (746s left) dmabuf_sync_file (export-multiwait)
[277.473584] Starting subtest: export-multiwait
[277.474483] Subtest export-multiwait: SUCCESS (0.000s)
[277.539758] [063/133] (746s left) gem_eio (execbuf)
[277.769105] Starting subtest: execbuf
[278.130814] Subtest execbuf: SUCCESS (0.360s)
[278.242708] [064/133] (746s left) perf (global-sseu-config-invalid)
[278.380916] Starting subtest: global-sseu-config-invalid
[278.382515] Subtest global-sseu-config-invalid: SKIP (0.000s)
[278.412714] [065/133] (745s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[278.501557] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[278.503403] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[279.597727] [066/133] (744s left) gem_lmem_swapping (parallel-random-engines)
[279.632564] Subtest parallel-random-engines: SKIP (0.000s)
[279.677539] [067/133] (744s left) kms_atomic_interruptible (legacy-cursor)
[279.769081] Starting subtest: legacy-cursor
[279.769917] Starting dynamic subtest: pipe-A-eDP-1
[287.220555] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s)
[287.221454] Subtest legacy-cursor: SUCCESS (7.451s)
[288.062430] [068/133] (736s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[288.110726] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[288.111717] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[288.199501] [069/133] (736s left) gem_mmap_wc (bad-object)
[288.241047] Subtest bad-object: SKIP (0.000s)
[288.300863] [070/133] (736s left) gem_lmem_swapping (verify-random)
[288.336112] Subtest verify-random: SKIP (0.000s)
[288.380887] [071/133] (736s left) kms_frontbuffer_tracking (psr-1p-rte)
[288.466673] Starting subtest: psr-1p-rte
[293.870779] Subtest psr-1p-rte: SUCCESS (5.405s)
[294.000769] [072/133] (730s left) gem_exec_balancer (bonded-chain)
[294.059311] Starting subtest: bonded-chain
[301.162756] Subtest bonded-chain: SUCCESS (7.093s)
[301.946952] [073/133] (722s left) perf (missing-sample-flags)
[302.030378] Starting subtest: missing-sample-flags
[302.031460] Subtest missing-sample-flags: SUCCESS (0.000s)
[302.065586] [074/133] (722s left) gem_ctx_shared (exec-shared-gtt)
[302.125743] Starting subtest: exec-shared-gtt
[302.126649] Starting dynamic subtest: rcs0
[302.139931] Dynamic subtest rcs0: SUCCESS (0.014s)
[302.148959] Starting dynamic subtest: bcs0
[302.149870] Dynamic subtest bcs0: SUCCESS (0.008s)
[302.156622] Starting dynamic subtest: vcs0
[302.158656] Dynamic subtest vcs0: SUCCESS (0.009s)
[302.165364] Starting dynamic subtest: vcs1
[302.169502] Dynamic subtest vcs1: SUCCESS (0.011s)
[302.176693] Starting dynamic subtest: vecs0
[302.178855] Dynamic subtest vecs0: SUCCESS (0.009s)
[302.189317] Starting dynamic subtest: ccs0
[302.194036] Dynamic subtest ccs0: SUCCESS (0.014s)
[302.194929] Subtest exec-shared-gtt: SUCCESS (0.069s)
[302.393808] [075/133] (722s left) kms_cursor_crc (cursor-random-128x128)
[302.598901] Starting subtest: cursor-random-128x128
[302.600881] Starting dynamic subtest: pipe-A-eDP-1
[305.964866] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.363s)
[306.001969] Starting dynamic subtest: pipe-D-eDP-1
[309.985371] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[309.986238] Subtest cursor-random-128x128: SUCCESS (7.386s)
[310.832774] [076/133] (713s left) kms_atomic (plane-invalid-params-fence)
[310.935265] Starting subtest: plane-invalid-params-fence
[310.936157] Starting dynamic subtest: pipe-A-eDP-1
[311.289957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[311.290888] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[312.165993] [077/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[312.264964] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[312.266899] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[312.370868] [078/133] (712s left) kms_pm_rpm (system-suspend-modeset)
[314.101802] Starting subtest: system-suspend-modeset
[333.472339] Subtest system-suspend-modeset: SUCCESS (4.777s)
[337.895192] [079/133] (690s left) gem_exec_schedule (u-submit-golden-slice)
[337.972917] Starting subtest: u-submit-golden-slice
[337.973831] Starting dynamic subtest: rcs0
[338.039824] Dynamic subtest rcs0: SUCCESS (0.067s)
[338.049958] Starting dynamic subtest: bcs0
[338.092979] Dynamic subtest bcs0: SUCCESS (0.051s)
[338.102380] Starting dynamic subtest: vcs0
[338.141828] Dynamic subtest vcs0: SUCCESS (0.049s)
[338.152065] Starting dynamic subtest: vcs1
[338.188705] Dynamic subtest vcs1: SUCCESS (0.046s)
[338.198258] Starting dynamic subtest: vecs0
[338.230898] Dynamic subtest vecs0: SUCCESS (0.041s)
[338.241767] Starting dynamic subtest: ccs0
[338.270362] Dynamic subtest ccs0: SUCCESS (0.039s)
[338.272294] Subtest u-submit-golden-slice: SUCCESS (0.298s)
[339.568655] [080/133] (689s left) sriov_basic (enable-vfs-autoprobe-on)
[339.622726] Starting subtest: enable-vfs-autoprobe-on
[339.623582] Starting dynamic subtest: numvfs-1
[339.656502] Dynamic subtest numvfs-1: FAIL (0.015s)
[339.664546] Starting dynamic subtest: numvfs-2
[339.693109] Dynamic subtest numvfs-2: FAIL (0.004s)
[339.701135] Starting dynamic subtest: numvfs-3
[339.729014] Dynamic subtest numvfs-3: FAIL (0.004s)
[339.736914] Starting dynamic subtest: numvfs-4
[339.762436] Dynamic subtest numvfs-4: FAIL (0.004s)
[339.770020] Starting dynamic subtest: numvfs-5
[339.796458] Dynamic subtest numvfs-5: FAIL (0.005s)
[339.803975] Starting dynamic subtest: numvfs-6
[339.829435] Dynamic subtest numvfs-6: FAIL (0.005s)
[339.836843] Starting dynamic subtest: numvfs-7
[339.862292] Dynamic subtest numvfs-7: FAIL (0.005s)
[339.869534] Starting dynamic subtest: numvfs-random
[339.894555] Dynamic subtest numvfs-random: FAIL (0.005s)
[339.901840] Starting dynamic subtest: numvfs-all
[339.927446] Dynamic subtest numvfs-all: FAIL (0.004s)
[339.928237] Subtest enable-vfs-autoprobe-on: FAIL (0.056s)
[339.959443] [081/133] (688s left) gem_partial_pwrite_pread (write-display)
[340.018043] Subtest write-display: SKIP (0.000s)
[340.088728] [082/133] (688s left) gem_exec_schedule (preempt-engines)
[340.154394] Starting subtest: preempt-engines
[340.155500] Starting dynamic subtest: rcs0
[342.545312] Dynamic subtest rcs0: SUCCESS (2.341s)
[342.555867] Starting dynamic subtest: bcs0
[344.864411] Dynamic subtest bcs0: SUCCESS (2.315s)
[344.876339] Starting dynamic subtest: vcs0
[347.142578] Dynamic subtest vcs0: SUCCESS (2.275s)
[347.152324] Starting dynamic subtest: vcs1
[349.445815] Dynamic subtest vcs1: SUCCESS (2.299s)
[349.456963] Starting dynamic subtest: vecs0
[351.789889] Dynamic subtest vecs0: SUCCESS (2.340s)
[351.800713] Starting dynamic subtest: ccs0
[354.099289] Dynamic subtest ccs0: SUCCESS (2.305s)
[354.101166] Subtest preempt-engines: SUCCESS (13.889s)
[354.369358] [083/133] (674s left) i915_getparams_basic (basic-subslice-total)
[354.430382] Starting subtest: basic-subslice-total
[354.431819] Subtest basic-subslice-total: SUCCESS (0.000s)
[354.536759] [084/133] (674s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[354.597804] Starting subtest: etime-multi-wait-all-available-unsubmitted
[354.700143] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[354.773743] [085/133] (674s left) gem_exec_reloc (basic-write-gtt)
[354.819081] Subtest basic-write-gtt: SKIP (0.000s)
[354.884196] [086/133] (674s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[354.973493] Starting subtest: plane-upscale-20x20-with-pixel-format
[354.974530] Starting dynamic subtest: pipe-A
[356.023407] Dynamic subtest pipe-A: SUCCESS (1.050s)
[356.036814] Starting dynamic subtest: pipe-B
[358.145260] Dynamic subtest pipe-B: SUCCESS (2.119s)
[358.153342] Starting dynamic subtest: pipe-C
[359.342561] Dynamic subtest pipe-C: SUCCESS (1.196s)
[359.352112] Starting dynamic subtest: pipe-D
[360.493392] Dynamic subtest pipe-D: SUCCESS (1.149s)
[360.494454] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.520s)
[361.683243] [087/133] (667s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[361.774052] Starting subtest: psr-shrfb-scaledprimary
[367.572265] Subtest psr-shrfb-scaledprimary: SUCCESS (5.798s)
[367.658084] [088/133] (661s left) kms_selftest (drm_cmdline_parser)
[367.701413] Starting subtest: drm_cmdline_parser
[367.744301] Starting dynamic subtest: drm_test_cmdline_force_d_only
[367.834039] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.089s)
[367.843512] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[367.931992] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.097s)
[367.941078] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[368.033858] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.101s)
[368.042993] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[368.141012] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.106s)
[368.150059] Starting dynamic subtest: drm_test_cmdline_force_e_only
[368.251883] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.111s)
[368.260581] Starting dynamic subtest: drm_test_cmdline_res
[368.339646] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.087s)
[368.349267] Starting dynamic subtest: drm_test_cmdline_res_vesa
[368.455015] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.113s)
[368.463523] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[368.549978] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.094s)
[368.558923] Starting dynamic subtest: drm_test_cmdline_res_rblank
[368.632715] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.082s)
[368.642403] Starting dynamic subtest: drm_test_cmdline_res_bpp
[368.733027] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.099s)
[368.741945] Starting dynamic subtest: drm_test_cmdline_res_refresh
[368.819578] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.086s)
[368.828230] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[368.915892] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.093s)
[368.934039] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[369.010079] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.093s)
[369.025788] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[369.101068] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.091s)
[369.110367] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[369.185981] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.085s)
[369.194953] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[369.284108] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.096s)
[369.291685] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[369.371900] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.087s)
[369.379507] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[369.460906] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.088s)
[369.469976] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[369.551059] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.090s)
[369.560182] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[369.639845] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.088s)
[369.647384] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[369.718553] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.078s)
[369.728047] Starting dynamic subtest: drm_test_cmdline_name
[369.807073] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.087s)
[369.816764] Starting dynamic subtest: drm_test_cmdline_name_bpp
[369.888055] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.079s)
[369.898417] Starting dynamic subtest: drm_test_cmdline_name_option
[369.968251] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.077s)
[369.977644] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[370.061964] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.092s)
[370.070976] Starting dynamic subtest: drm_test_cmdline_rotate_0
[370.151985] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.090s)
[370.160401] Starting dynamic subtest: drm_test_cmdline_rotate_90
[370.241180] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.088s)
[370.255633] Starting dynamic subtest: drm_test_cmdline_rotate_180
[370.320061] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.078s)
[370.329366] Starting dynamic subtest: drm_test_cmdline_rotate_270
[370.406833] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.087s)
[370.415964] Starting dynamic subtest: drm_test_cmdline_hmirror
[370.487410] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.080s)
[370.496028] Starting dynamic subtest: drm_test_cmdline_vmirror
[370.584199] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.096s)
[370.593402] Starting dynamic subtest: drm_test_cmdline_margin_options
[370.667647] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.082s)
[370.677955] Starting dynamic subtest: drm_test_cmdline_multiple_options
[370.746526] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.079s)
[370.755375] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[370.842867] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.095s)
[370.853247] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[370.939940] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.095s)
[370.948314] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[371.045980] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.105s)
[371.053629] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[371.142213] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.096s)
[371.151706] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[371.232369] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.090s)
[371.241239] Starting dynamic subtest: drm_test_cmdline_invalid
[371.323580] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.091s)
[371.332339] Starting dynamic subtest: drm_test_cmdline_tv_options
[371.429819] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.104s)
[371.430674] Subtest drm_cmdline_parser: SUCCESS (3.729s)
[371.574574] [089/133] (657s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[371.673163] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[371.674064] Starting dynamic subtest: pipe-A-eDP-1
[377.592359] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.920s)
[377.601752] Starting dynamic subtest: pipe-B-eDP-1
[384.654524] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.060s)
[384.655944] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.983s)
[385.536808] [090/133] (643s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[385.636801] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[385.637637] Starting dynamic subtest: pipe-A-default-mode
[388.346887] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[388.347853] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.711s)
[389.208415] [091/133] (640s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[389.308553] Starting subtest: cursor-tearing-framebuffer-change
[389.309366] Starting dynamic subtest: pipe-A-eDP-1
[389.866245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[389.874994] Starting dynamic subtest: pipe-D-eDP-1
[391.135653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[391.136564] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.828s)
[391.970742] [092/133] (637s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[392.083332] Starting subtest: flip-vs-cursor-toggle
[401.010997] Subtest flip-vs-cursor-toggle: SUCCESS (8.926s)
[401.817165] [093/133] (627s left) kms_chamelium_edid (vga-edid-read)
[402.189638] Subtest vga-edid-read: SKIP (0.000s)
[403.018666] [094/133] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[403.121971] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[403.123793] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[403.203484] [095/133] (626s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[403.291850] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[403.292734] Starting dynamic subtest: pipe-A
[404.419359] Dynamic subtest pipe-A: SUCCESS (1.128s)
[404.428161] Starting dynamic subtest: pipe-B
[406.669607] Dynamic subtest pipe-B: SUCCESS (2.249s)
[406.679514] Starting dynamic subtest: pipe-C
[407.845442] Dynamic subtest pipe-C: SUCCESS (1.174s)
[407.860153] Starting dynamic subtest: pipe-D
[409.081202] Dynamic subtest pipe-D: SUCCESS (1.234s)
[409.083560] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.791s)
[410.264162] [096/133] (619s left) kms_plane_multiple (2x-tiling-x)
[410.360504] Starting subtest: 2x-tiling-x
[410.362199] Subtest 2x-tiling-x: SKIP (0.000s)
[410.427786] [097/133] (619s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[410.483103] Starting subtest: single-wait-for-submit-available-signaled
[410.483996] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[410.592137] [098/133] (618s left) kms_plane_alpha_blend (constant-alpha-mid)
[410.680817] Starting subtest: constant-alpha-mid
[410.982523] Starting dynamic subtest: pipe-A-eDP-1
[411.842931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[411.852154] Starting dynamic subtest: pipe-D-eDP-1
[413.396695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.552s)
[413.397733] Subtest constant-alpha-mid: SUCCESS (2.717s)
[414.227369] [099/133] (615s left) gem_ctx_engines (invalid-engines)
[414.291167] Starting subtest: invalid-engines
[414.299422] Subtest invalid-engines: SUCCESS (0.008s)
[414.520690] [100/133] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[414.614196] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[414.615898] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[414.737505] [101/133] (614s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[414.833041] Starting subtest: 4-tiled-64bpp-rotate-0
[416.379330] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.546s)
[416.548247] [102/133] (613s left) intel_hwmon (hwmon-write)
[416.603134] Subtest hwmon-write: SKIP (0.000s)
[416.662070] [103/133] (613s left) kms_hdr (invalid-hdr)
[416.745788] Starting subtest: invalid-hdr
[418.841759] Starting dynamic subtest: pipe-A-eDP-1
[421.870397] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.028s)
[421.871373] Subtest invalid-hdr: SUCCESS (5.126s)
[421.993501] [104/133] (607s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[422.080355] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[422.082040] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[422.149982] [105/133] (607s left) gem_userptr_blits (process-exit)
[422.208988] Starting subtest: process-exit
[422.217638] Subtest process-exit: SUCCESS (0.009s)
[422.338561] [106/133] (607s left) gem_exec_params (invalid-fence-in)
[422.402742] Starting subtest: invalid-fence-in
[422.404004] Subtest invalid-fence-in: SUCCESS (0.000s)
[422.510611] [107/133] (607s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[422.622158] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[422.623831] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[422.774396] [108/133] (607s left) gem_spin_batch (legacy-resubmit)
[422.827827] Starting subtest: legacy-resubmit
[422.828749] Starting dynamic subtest: default
[422.833844] Dynamic subtest default: SUCCESS (0.005s)
[422.843675] Starting dynamic subtest: render
[422.844934] Dynamic subtest render: SUCCESS (0.002s)
[422.855740] Starting dynamic subtest: bsd
[422.856614] Dynamic subtest bsd: SUCCESS (0.002s)
[422.864209] Starting dynamic subtest: bsd1
[422.864993] Dynamic subtest bsd1: SUCCESS (0.001s)
[422.872612] Starting dynamic subtest: bsd2
[422.873447] Dynamic subtest bsd2: SUCCESS (0.003s)
[422.881053] Starting dynamic subtest: blt
[422.881884] Dynamic subtest blt: SUCCESS (0.003s)
[422.889438] Starting dynamic subtest: vebox
[422.890329] Dynamic subtest vebox: SUCCESS (0.003s)
[422.891180] Subtest legacy-resubmit: SUCCESS (0.025s)
[423.085110] [109/133] (606s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[423.184069] Starting subtest: x-tiled-addfb-size-offset-overflow
[423.184962] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[423.274848] [110/133] (606s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[423.361826] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[423.362828] Starting dynamic subtest: pipe-A-eDP-1
[425.294267] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[425.302645] Starting dynamic subtest: pipe-B-eDP-1
[426.899016] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.603s)
[426.907205] Starting dynamic subtest: pipe-C-eDP-1
[428.427506] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.528s)
[428.435494] Starting dynamic subtest: pipe-D-eDP-1
[430.000264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.571s)
[430.001149] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.636s)
[431.135418] [111/133] (598s left) gem_ctx_bad_destroy (invalid-ctx)
[431.194893] Starting subtest: invalid-ctx
[431.195757] Subtest invalid-ctx: SUCCESS (0.000s)
[431.294598] [112/133] (598s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[431.410719] Starting subtest: cursor-vs-flip-atomic-transitions
[461.474819] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.064s)
[462.282719] [113/133] (567s left) gem_ctx_persistence (legacy-engines-mixed)
[462.330338] Starting subtest: legacy-engines-mixed
[462.331282] Starting dynamic subtest: render
[462.407330] Dynamic subtest render: SUCCESS (0.076s)
[462.424121] Starting dynamic subtest: bsd1
[462.463234] Dynamic subtest bsd1: SUCCESS (0.052s)
[462.474528] Starting dynamic subtest: bsd2
[462.508713] Dynamic subtest bsd2: SUCCESS (0.043s)
[462.519232] Starting dynamic subtest: blt
[462.557239] Dynamic subtest blt: SUCCESS (0.045s)
[462.568814] Starting dynamic subtest: vebox
[462.579451] Dynamic subtest vebox: SUCCESS (0.020s)
[462.580358] Subtest legacy-engines-mixed: SUCCESS (0.250s)
[462.680724] [114/133] (567s left) gem_exec_flush (basic-batch-kernel-default-uc)
[462.736250] Starting subtest: basic-batch-kernel-default-uc
[470.348069] Subtest basic-batch-kernel-default-uc: SUCCESS (7.611s)
[470.546362] [115/133] (559s left) gem_exec_schedule (u-semaphore-noskip)
[470.621663] Starting subtest: u-semaphore-noskip
[471.066214] Subtest u-semaphore-noskip: SUCCESS (0.436s)
[471.386889] [116/133] (558s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[471.504500] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[471.506341] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[471.599581] [117/133] (558s left) kms_psr (pr-primary-page-flip)
[471.680079] Starting subtest: pr-primary-page-flip
[471.681906] Subtest pr-primary-page-flip: SKIP (0.000s)
[471.748901] [118/133] (558s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[471.832768] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[471.833758] Starting dynamic subtest: pipe-A-eDP-1
[472.314444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[472.322749] Starting dynamic subtest: pipe-B-eDP-1
[473.843028] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.527s)
[473.851748] Starting dynamic subtest: pipe-C-eDP-1
[475.287652] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.443s)
[475.298046] Starting dynamic subtest: pipe-D-eDP-1
[476.713117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.424s)
[476.713980] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.871s)
[477.887354] [119/133] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[477.986671] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[477.988500] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[478.091407] [120/133] (552s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[478.180882] Starting subtest: y-tiled-8bpp-rotate-180
[478.182823] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[478.336394] [121/133] (552s left) kms_pwrite_crc
[479.922516] [122/133] (550s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[480.012775] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[480.014423] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[480.081150] [123/133] (550s left) syncobj_timeline (reset-unsignaled)
[480.128513] Starting subtest: reset-unsignaled
[480.129414] Subtest reset-unsignaled: SUCCESS (0.000s)
[480.226616] [124/133] (550s left) gem_ccs (block-copy-uncompressed)
[480.281296] Starting subtest: block-copy-uncompressed
[480.282314] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[480.303959] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[480.313799] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[480.322439] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[480.330540] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[480.339370] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[480.347541] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[480.356993] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[480.357850] Subtest block-copy-uncompressed: SUCCESS (0.076s)
[480.494544] [125/133] (550s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[480.628521] Starting subtest: dp-mst-type-0-suspend-resume
[480.630384] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[480.751688] [126/133] (549s left) gem_exec_params (dr1-dirt)
[480.808234] Starting subtest: DR1-dirt
[480.809247] Subtest DR1-dirt: SUCCESS (0.000s)
[480.899394] [127/133] (549s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[480.986327] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[480.987921] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[481.089733] [128/133] (549s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[481.135395] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[481.214052] [129/133] (549s left) gem_workarounds (reset-fd)
[481.285638] Starting subtest: reset-fd
[481.468665] Subtest reset-fd: SUCCESS (0.183s)
[481.603557] [130/133] (549s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[481.685796] Starting subtest: bad-aux-stride-y-tiled-ccs
[481.686606] Starting dynamic subtest: pipe-A-eDP-1
[481.694786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.703675] Starting dynamic subtest: pipe-B-eDP-1
[481.712459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.722131] Starting dynamic subtest: pipe-C-eDP-1
[481.730362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.738386] Starting dynamic subtest: pipe-D-eDP-1
[481.746569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.748306] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[483.890600] [131/133] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[483.992705] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[483.994369] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[484.078832] [132/133] (546s left) kms_vblank (ts-continuation-modeset-hang)
[484.169619] Starting subtest: ts-continuation-modeset-hang
[484.171795] Starting dynamic subtest: pipe-A-eDP-1
[510.233657] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.059s)
[510.243496] Starting dynamic subtest: pipe-D-eDP-1
[535.322793] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.084s)
[535.324766] Subtest ts-continuation-modeset-hang: SUCCESS (51.150s)
[536.139341] [133/133] (494s left) kms_flip (flip-vs-panning-interruptible)
[536.231716] Starting subtest: flip-vs-panning-interruptible
[536.233975] Starting dynamic subtest: A-eDP1
[544.948857] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[544.959142] Starting dynamic subtest: B-eDP1
[553.681047] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[553.691818] Starting dynamic subtest: C-eDP1
[562.398541] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[562.409179] Starting dynamic subtest: D-eDP1
[571.138031] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[571.143403] Subtest flip-vs-panning-interruptible: SUCCESS (34.911s)
[572.277649] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_ctx_exec
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: core_debugfs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_ppgtt
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_setmode
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_invalid_mode
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_pm_dc
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_legacy_colorkey
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: i915_drm_fdinfo
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_userptr_blits
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: dmabuf_sync_file
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: sriov_basic
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: i915_getparams_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: intel_hwmon
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_pwrite_crc
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_flip
Done.