[70.627888] Initializing watchdogs
[70.627952]   /dev/watchdog0
[70.647320] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[70.658216] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.661865] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.664268] [001/134] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[70.850796] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[70.852423] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[71.042411] [002/134] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[71.225558] Starting subtest: flip-vs-cursor-atomic
[80.881395] Subtest flip-vs-cursor-atomic: SUCCESS (9.650s)
[81.172755] [003/134] (950s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[81.361072] Starting subtest: 4-tiled-8bpp-rotate-270
[81.426595] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.065s)
[81.635398] [004/134] (949s left) kms_pm_rpm (modeset-non-lpsp-stress)
[84.027585] Starting subtest: modeset-non-lpsp-stress
[89.460148] Subtest modeset-non-lpsp-stress: SUCCESS (5.428s)
[89.764357] [005/134] (941s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[89.947534] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[89.949206] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[90.146866] [006/134] (941s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[90.333247] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[90.335162] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[90.516086] [007/134] (941s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[90.694776] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[90.756797] [008/134] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[90.945897] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[90.947421] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[91.139815] [009/134] (940s left) kms_addfb_basic (addfb25-bad-modifier)
[91.317963] Starting subtest: addfb25-bad-modifier
[91.318849] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[91.531618] [010/134] (940s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[91.714548] Starting subtest: fbc-rgb101010-draw-render
[94.554672] Subtest fbc-rgb101010-draw-render: SUCCESS (2.840s)
[94.713888] [011/134] (937s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[94.893152] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[94.893938] Starting dynamic subtest: pipe-A
[94.986840] Dynamic subtest pipe-A: SUCCESS (0.093s)
[94.998304] Starting dynamic subtest: pipe-B
[95.199063] Dynamic subtest pipe-B: SUCCESS (0.212s)
[95.212217] Starting dynamic subtest: pipe-C
[95.411800] Dynamic subtest pipe-C: SUCCESS (0.212s)
[95.425059] Starting dynamic subtest: pipe-D
[95.643362] Dynamic subtest pipe-D: SUCCESS (0.231s)
[95.644140] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.750s)
[95.989050] [012/134] (935s left) gem_exec_schedule (u-lateslice)
[96.074394] Starting subtest: u-lateslice
[96.075358] Starting dynamic subtest: rcs0
[96.124173] Dynamic subtest rcs0: SUCCESS (0.050s)
[96.132574] Starting dynamic subtest: bcs0
[96.145274] Dynamic subtest bcs0: SUCCESS (0.021s)
[96.153397] Starting dynamic subtest: vcs0
[96.168313] Dynamic subtest vcs0: SUCCESS (0.023s)
[96.176684] Starting dynamic subtest: vcs1
[96.188479] Dynamic subtest vcs1: SUCCESS (0.020s)
[96.196820] Starting dynamic subtest: vecs0
[96.210081] Dynamic subtest vecs0: SUCCESS (0.021s)
[96.218361] Starting dynamic subtest: vecs1
[96.233130] Dynamic subtest vecs1: SUCCESS (0.023s)
[96.241563] Starting dynamic subtest: ccs0
[96.254406] Dynamic subtest ccs0: SUCCESS (0.021s)
[96.255407] Subtest u-lateslice: SUCCESS (0.180s)
[96.719314] [013/134] (935s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[96.902503] Starting subtest: psr-indfb-scaledprimary
[96.904227] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[97.078071] [014/134] (935s left) perf (gen12-oa-tlb-invalidate)
[97.464372] Starting subtest: gen12-oa-tlb-invalidate
[97.465298] Starting dynamic subtest: 0-rcs0
[107.507069] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[107.508050] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.042s)
[107.551107] [015/134] (924s left) kms_cursor_crc (cursor-sliding-128x128)
[107.913215] Starting subtest: cursor-sliding-128x128
[107.917133] Starting dynamic subtest: pipe-A-DP-3
[112.257018] Dynamic subtest pipe-A-DP-3: SUCCESS (4.339s)
[112.305520] Starting dynamic subtest: pipe-D-DP-3
[116.672381] Dynamic subtest pipe-D-DP-3: SUCCESS (4.373s)
[116.673737] Subtest cursor-sliding-128x128: SUCCESS (8.757s)
[117.152691] [016/134] (915s left) kms_flip (plain-flip-interruptible)
[117.335379] Starting subtest: plain-flip-interruptible
[117.337303] Starting dynamic subtest: A-DP3
[118.157066] Dynamic subtest A-DP3: SUCCESS (0.820s)
[118.170370] Starting dynamic subtest: B-DP3
[118.901523] Dynamic subtest B-DP3: SUCCESS (0.743s)
[118.934411] Starting dynamic subtest: C-DP3
[119.677587] Dynamic subtest C-DP3: SUCCESS (0.773s)
[119.689266] Starting dynamic subtest: D-DP3
[120.436584] Dynamic subtest D-DP3: SUCCESS (0.756s)
[120.443842] Subtest plain-flip-interruptible: SUCCESS (3.111s)
[120.797184] [017/134] (911s left) gem_pread (snoop)
[120.867954] Subtest snoop: SKIP (0.000s)
[120.972198] [018/134] (911s left) gem_exec_whisper (basic-forked)
[121.057407] Starting subtest: basic-forked
[125.417286] Subtest basic-forked: SUCCESS (4.358s)
[125.691869] [019/134] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[125.877460] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[125.879119] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[126.076154] [020/134] (906s left) i915_query (engine-info-invalid)
[126.147106] Starting subtest: engine-info-invalid
[126.148015] Subtest engine-info-invalid: SUCCESS (0.000s)
[126.328036] [021/134] (906s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[126.509398] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[126.510332] Starting dynamic subtest: pipe-A-DP-3
[126.518892] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[126.527400] Starting dynamic subtest: pipe-B-DP-3
[126.535726] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[126.544149] Starting dynamic subtest: pipe-C-DP-3
[126.552422] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[126.560691] Starting dynamic subtest: pipe-D-DP-3
[126.569375] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[126.571520] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[126.997524] [022/134] (905s left) syncobj_timeline (single-wait-all-available-signaled)
[127.064189] Starting subtest: single-wait-all-available-signaled
[127.065071] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[127.244250] [023/134] (905s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[127.430463] Starting subtest: y-tiled-32bpp-rotate-90
[127.432071] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[127.630058] [024/134] (905s left) gen9_exec_parse (bb-start-far)
[127.709498] Subtest bb-start-far: SKIP (0.000s)
[127.794316] [025/134] (905s left) i915_drm_fdinfo (virtual-idle)
[127.857142] Starting subtest: virtual-idle
[131.474055] Subtest virtual-idle: SUCCESS (3.615s)
[131.594550] [026/134] (901s left) kms_lease (lease-revoke)
[131.774093] Starting subtest: lease-revoke
[131.775022] Starting dynamic subtest: pipe-A-DP-3
[131.879173] Dynamic subtest pipe-A-DP-3: SUCCESS (0.105s)
[131.889676] Starting dynamic subtest: pipe-B-DP-3
[131.952412] Dynamic subtest pipe-B-DP-3: SUCCESS (0.072s)
[131.962114] Starting dynamic subtest: pipe-C-DP-3
[132.026127] Dynamic subtest pipe-C-DP-3: SUCCESS (0.072s)
[132.034799] Starting dynamic subtest: pipe-D-DP-3
[132.100760] Dynamic subtest pipe-D-DP-3: SUCCESS (0.071s)
[132.101594] Subtest lease-revoke: SUCCESS (0.325s)
[132.296845] [027/134] (900s left) kms_content_protection (uevent)
[132.537889] Starting subtest: uevent
[132.568188] Starting dynamic subtest: pipe-A-DP-3
[166.681841] Dynamic subtest pipe-A-DP-3: FAIL (34.065s)
[166.742870] Subtest uevent: FAIL (34.205s)
[167.035615] [028/134] (866s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[167.111741] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[167.200592] [029/134] (866s left) kms_atomic_transition (plane-toggle-modeset-transition)
[167.379052] Starting subtest: plane-toggle-modeset-transition
[167.379963] Starting dynamic subtest: pipe-A-DP-3
[169.150346] Dynamic subtest pipe-A-DP-3: SUCCESS (1.770s)
[169.171065] Starting dynamic subtest: pipe-B-DP-3
[170.660235] Dynamic subtest pipe-B-DP-3: SUCCESS (1.500s)
[170.665103] Subtest plane-toggle-modeset-transition: SUCCESS (3.285s)
[170.957078] [030/134] (862s left) api_intel_allocator (simple-allocator)
[171.032061] Starting subtest: simple-allocator
[171.032994] Starting dynamic subtest: basic
[171.064845] Dynamic subtest basic: SUCCESS (0.033s)
[171.073520] Starting dynamic subtest: parallel-one
[171.251281] Dynamic subtest parallel-one: SUCCESS (0.177s)
[171.260274] Starting dynamic subtest: print
[171.261201] Dynamic subtest print: SUCCESS (0.000s)
[171.270005] Starting dynamic subtest: reuse
[171.271228] Dynamic subtest reuse: SUCCESS (0.000s)
[171.279777] Starting dynamic subtest: reserve
[171.280787] Dynamic subtest reserve: SUCCESS (0.000s)
[171.289431] Starting dynamic subtest: fork-reopen-allocator
[171.290630] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[171.291674] Subtest simple-allocator: SUCCESS (0.226s)
[171.449159] [031/134] (861s left) syncobj_wait (wait-for-submit-delayed-submit)
[171.518221] Starting subtest: wait-for-submit-delayed-submit
[171.621897] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[171.761347] [032/134] (861s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[171.958857] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[172.014827] [033/134] (861s left) kms_sequence (queue-busy)
[172.191556] Starting subtest: queue-busy
[172.192451] Starting dynamic subtest: pipe-A-DP-3
[174.783281] Dynamic subtest pipe-A-DP-3: SUCCESS (2.590s)
[174.794039] Starting dynamic subtest: pipe-B-DP-3
[177.266685] Dynamic subtest pipe-B-DP-3: SUCCESS (2.481s)
[177.278064] Starting dynamic subtest: pipe-C-DP-3
[179.739581] Dynamic subtest pipe-C-DP-3: SUCCESS (2.471s)
[179.750708] Starting dynamic subtest: pipe-D-DP-3
[182.217007] Dynamic subtest pipe-D-DP-3: SUCCESS (2.476s)
[182.218007] Subtest queue-busy: SUCCESS (10.025s)
[182.488054] [034/134] (851s left) kms_psr (pr-primary-mmap-gtt)
[182.668966] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[182.731533] [035/134] (850s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[182.907603] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[182.909544] Starting dynamic subtest: pipe-A-valid-mode
[184.743399] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.834s)
[184.744266] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.836s)
[185.073788] [036/134] (848s left) kms_psr (pr-cursor-blt)
[185.251274] Subtest pr-cursor-blt: SKIP (0.000s)
[185.314046] [037/134] (848s left) perf (polling-small-buf)
[185.535468] Starting subtest: polling-small-buf
[185.631172] Subtest polling-small-buf: SUCCESS (0.096s)
[185.682143] [038/134] (848s left) prime_mmap_coherency (read)
[185.759494] Starting subtest: read
[191.175831] Subtest read: SUCCESS (5.416s)
[191.386816] [039/134] (842s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[191.573059] Starting subtest: x-tiled-32bpp-rotate-180
[193.443151] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.869s)
[193.638879] [040/134] (840s left) kms_plane_alpha_blend (constant-alpha-mid)
[193.818578] Starting subtest: constant-alpha-mid
[194.070536] Starting dynamic subtest: pipe-A-DP-3
[194.782578] Dynamic subtest pipe-A-DP-3: SUCCESS (0.712s)
[194.794373] Starting dynamic subtest: pipe-D-DP-3
[195.579249] Dynamic subtest pipe-D-DP-3: SUCCESS (0.794s)
[195.580157] Subtest constant-alpha-mid: SUCCESS (1.760s)
[195.886241] [041/134] (838s left) gem_exec_schedule (implicit-write-read)
[195.980995] Starting subtest: implicit-write-read
[195.981969] Starting dynamic subtest: rcs0
[196.272988] Dynamic subtest rcs0: SUCCESS (0.291s)
[196.282132] Starting dynamic subtest: bcs0
[196.476107] Dynamic subtest bcs0: SUCCESS (0.202s)
[196.485120] Starting dynamic subtest: vcs0
[196.686840] Dynamic subtest vcs0: SUCCESS (0.210s)
[196.695682] Starting dynamic subtest: vcs1
[196.896348] Dynamic subtest vcs1: SUCCESS (0.209s)
[196.905262] Starting dynamic subtest: vecs0
[197.110898] Dynamic subtest vecs0: SUCCESS (0.214s)
[197.120036] Starting dynamic subtest: vecs1
[197.332988] Dynamic subtest vecs1: SUCCESS (0.208s)
[197.341986] Starting dynamic subtest: ccs0
[197.539302] Dynamic subtest ccs0: SUCCESS (0.209s)
[197.540569] Subtest implicit-write-read: SUCCESS (1.549s)
[198.066732] [042/134] (835s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[198.242909] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[198.247230] Starting dynamic subtest: A-DP3
[199.259334] Dynamic subtest A-DP3: SUCCESS (1.010s)
[199.281283] Starting dynamic subtest: B-DP3
[200.034048] Dynamic subtest B-DP3: SUCCESS (0.772s)
[200.052409] Starting dynamic subtest: C-DP3
[200.809914] Dynamic subtest C-DP3: SUCCESS (0.774s)
[200.827586] Starting dynamic subtest: D-DP3
[201.599484] Dynamic subtest D-DP3: SUCCESS (0.787s)
[201.602383] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.358s)
[201.922269] [043/134] (832s left) gem_spin_batch (resubmit-new)
[202.003261] Starting subtest: resubmit-new
[202.004203] Starting dynamic subtest: rcs0
[202.039773] Dynamic subtest rcs0: SUCCESS (0.036s)
[202.049359] Starting dynamic subtest: bcs0
[202.050247] Dynamic subtest bcs0: SUCCESS (0.007s)
[202.059632] Starting dynamic subtest: vcs0
[202.060556] Dynamic subtest vcs0: SUCCESS (0.005s)
[202.069775] Starting dynamic subtest: vcs1
[202.070593] Dynamic subtest vcs1: SUCCESS (0.005s)
[202.079814] Starting dynamic subtest: vecs0
[202.080707] Dynamic subtest vecs0: SUCCESS (0.005s)
[202.089554] Starting dynamic subtest: vecs1
[202.090578] Dynamic subtest vecs1: SUCCESS (0.005s)
[202.099464] Starting dynamic subtest: ccs0
[202.100572] Dynamic subtest ccs0: SUCCESS (0.006s)
[202.101645] Subtest resubmit-new: SUCCESS (0.075s)
[202.407833] [044/134] (831s left) gem_ctx_persistence (smoketest)
[202.494669] Starting subtest: smoketest
[241.158417] Subtest smoketest: SUCCESS (38.662s)
[241.324720] [045/134] (792s left) kms_vblank (wait-forked)
[241.500334] Starting subtest: wait-forked
[241.501234] Starting dynamic subtest: pipe-A-DP-3
[243.901666] Dynamic subtest pipe-A-DP-3: SUCCESS (2.398s)
[243.928673] Starting dynamic subtest: pipe-D-DP-3
[246.230634] Dynamic subtest pipe-D-DP-3: SUCCESS (2.317s)
[246.231683] Subtest wait-forked: SUCCESS (4.730s)
[246.512533] [046/134] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[246.693985] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[246.695668] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[246.875800] [047/134] (787s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[247.053550] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[247.055724] Starting dynamic subtest: pipe-A-DP-3
[247.064216] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[247.073191] Starting dynamic subtest: pipe-B-DP-3
[247.089142] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[247.097944] Starting dynamic subtest: pipe-C-DP-3
[247.106371] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[247.115145] Starting dynamic subtest: pipe-D-DP-3
[247.123891] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[247.126048] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[247.521844] [048/134] (787s left) vgem_basic (setversion)
[247.624366] Starting subtest: setversion
[247.626143] Subtest setversion: SUCCESS (0.000s)
[247.739961] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[247.742011] [049/134] (786s left) gem_exec_params (mmapped)
[247.827646] Starting subtest: mmapped
[247.829981] Subtest mmapped: SUCCESS (0.002s)
[248.043314] [050/134] (786s left) kms_chamelium_color (ctm-0-50)
[248.233423] Subtest ctm-0-50: SKIP (0.000s)
[248.299828] [051/134] (786s left) api_intel_bb (purge-bb)
[248.382446] Starting subtest: purge-bb
[248.412076] Subtest purge-bb: SUCCESS (0.031s)
[248.591081] [052/134] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[248.781840] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[248.783446] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[248.937856] [053/134] (785s left) kms_flip (2x-blocking-wf_vblank)
[249.122217] Starting subtest: 2x-blocking-wf_vblank
[249.137380] Subtest 2x-blocking-wf_vblank: SKIP (0.014s)
[249.310431] [054/134] (785s left) perf_pmu (idle)
[249.381246] Starting subtest: idle
[249.382268] Starting dynamic subtest: rcs0
[249.948556] Dynamic subtest rcs0: SUCCESS (0.566s)
[249.961314] Starting dynamic subtest: bcs0
[250.467539] Dynamic subtest bcs0: SUCCESS (0.515s)
[250.480239] Starting dynamic subtest: vcs0
[250.988601] Dynamic subtest vcs0: SUCCESS (0.517s)
[251.000801] Starting dynamic subtest: vcs1
[251.511550] Dynamic subtest vcs1: SUCCESS (0.519s)
[251.523948] Starting dynamic subtest: vecs0
[252.030872] Dynamic subtest vecs0: SUCCESS (0.513s)
[252.040670] Starting dynamic subtest: vecs1
[252.545568] Dynamic subtest vecs1: SUCCESS (0.513s)
[252.557370] Starting dynamic subtest: ccs0
[253.073585] Dynamic subtest ccs0: SUCCESS (0.525s)
[253.077265] Subtest idle: SUCCESS (3.693s)
[253.274950] [055/134] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[253.471876] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[253.473542] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[253.656473] [056/134] (781s left) gem_exec_fence (syncobj-timeline-export)
[254.327412] Starting subtest: syncobj-timeline-export
[254.359918] Subtest syncobj-timeline-export: SUCCESS (0.033s)
[254.692289] [057/134] (780s left) gem_exec_whisper (basic-queues-forked-all)
[254.782886] Starting subtest: basic-queues-forked-all
[276.801541] Subtest basic-queues-forked-all: SUCCESS (22.016s)
[277.048339] [058/134] (758s left) gem_create (hog-create)
[277.142228] Starting subtest: hog-create
[277.143169] Starting dynamic subtest: lmem0
[309.462485] Dynamic subtest lmem0: SUCCESS (32.320s)
[309.476578] Starting dynamic subtest: smem0
[341.715265] Dynamic subtest smem0: SUCCESS (32.251s)
[341.716265] Subtest hog-create: SUCCESS (64.573s)
[342.002371] [059/134] (693s left) kms_3d (basic)
[342.089509] Starting subtest: basic
[344.084779] Subtest basic: SUCCESS (1.996s)
[344.502679] [060/134] (690s left) perf (whitelisted-registers-userspace-config)
[344.743272] Starting subtest: whitelisted-registers-userspace-config
[344.744247] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[344.800413] [061/134] (690s left) dumb_buffer (map-uaf)
[344.877289] Starting subtest: map-uaf
[344.897536] Subtest map-uaf: SUCCESS (0.020s)
[345.071318] [062/134] (690s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[345.254313] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[345.255024] Starting dynamic subtest: pipe-A
[345.354060] Dynamic subtest pipe-A: SUCCESS (0.100s)
[345.372940] Starting dynamic subtest: pipe-B
[345.566881] Dynamic subtest pipe-B: SUCCESS (0.211s)
[345.588234] Starting dynamic subtest: pipe-C
[345.780060] Dynamic subtest pipe-C: SUCCESS (0.211s)
[345.799062] Starting dynamic subtest: pipe-D
[345.994601] Dynamic subtest pipe-D: SUCCESS (0.213s)
[345.995706] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.743s)
[346.324852] [063/134] (689s left) perf (per-context-mode-unprivileged)
[346.562387] Starting subtest: per-context-mode-unprivileged
[346.564521] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[346.620756] [064/134] (688s left) gem_exec_suspend (basic-s3)
[346.709539] Starting subtest: basic-S3
[346.710432] Starting dynamic subtest: smem
[368.688889] Dynamic subtest smem: SUCCESS (7.245s)
[368.701840] Starting dynamic subtest: lmem0
[390.590414] Dynamic subtest lmem0: SUCCESS (7.230s)
[390.591466] Subtest basic-S3: SUCCESS (14.477s)
[390.893909] [065/134] (644s left) kms_cursor_crc (cursor-offscreen-max-size)
[391.390834] Starting subtest: cursor-offscreen-max-size
[391.393458] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[391.577573] [066/134] (644s left) gem_mmap_gtt (zero-extend)
[391.658467] Subtest zero-extend: SKIP (0.000s)
[391.758371] [067/134] (644s left) gem_mmap_wc (bad-object)
[391.835435] Subtest bad-object: SKIP (0.000s)
[391.920175] [068/134] (643s left) gem_mmap (bad-size)
[391.996463] Subtest bad-size: SKIP (0.000s)
[392.063590] [069/134] (643s left) i915_pm_rc6_residency (rc6-fence)
[392.146544] Starting subtest: rc6-fence
[392.170890] Starting dynamic subtest: gt0
[416.697564] Dynamic subtest gt0: SUCCESS (24.525s)
[416.702607] Subtest rc6-fence: SUCCESS (24.552s)
[416.922573] [070/134] (619s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[417.114206] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[417.115864] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[417.306152] [071/134] (618s left) prime_vgem (basic-fence-read)
[417.405602] Starting subtest: basic-fence-read
[417.431388] Subtest basic-fence-read: SKIP (0.025s)
[417.650833] [072/134] (618s left) gem_exec_nop (basic-parallel)
[417.744657] Starting subtest: basic-parallel
[422.129013] Subtest basic-parallel: SUCCESS (4.385s)
[422.461927] [073/134] (613s left) kms_setmode (invalid-clone-exclusive-crtc)
[422.546851] Starting subtest: invalid-clone-exclusive-crtc
[422.549674] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[422.735014] [074/134] (613s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[422.923035] Starting subtest: bad-pixel-format-y-tiled-ccs
[422.925531] Starting dynamic subtest: pipe-A-DP-3
[422.933937] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[422.946534] Starting dynamic subtest: pipe-B-DP-3
[422.955004] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[422.967338] Starting dynamic subtest: pipe-C-DP-3
[422.975632] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[422.987917] Starting dynamic subtest: pipe-D-DP-3
[422.997957] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[422.999956] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[423.397212] [075/134] (613s left) gem_ctx_sseu (engines)
[423.480221] Subtest engines: SKIP (0.000s)
[423.558658] [076/134] (612s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[423.744590] Starting subtest: drrs-dirtyfb-ioctl
[423.749416] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[423.930276] [077/134] (612s left) syncobj_wait (invalid-wait-bad-flags)
[424.035595] Starting subtest: invalid-wait-bad-flags
[424.036510] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[424.229012] [078/134] (612s left) kms_psr (psr2-primary-render)
[424.415645] Subtest psr2-primary-render: SKIP (0.000s)
[424.474826] [079/134] (612s left) kms_lease (atomic-implicit-crtc)
[424.657658] Starting subtest: atomic-implicit-crtc
[424.658585] Starting dynamic subtest: pipe-A-DP-3
[424.662860] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[424.675199] Starting dynamic subtest: pipe-B-DP-3
[424.679384] Dynamic subtest pipe-B-DP-3: SUCCESS (0.010s)
[424.691715] Starting dynamic subtest: pipe-C-DP-3
[424.695981] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[424.708443] Starting dynamic subtest: pipe-D-DP-3
[424.713792] Dynamic subtest pipe-D-DP-3: SUCCESS (0.010s)
[424.714799] Subtest atomic-implicit-crtc: SUCCESS (0.040s)
[424.895346] [080/134] (611s left) gem_pxp (reject-modify-context-protection-off-1)
[427.500451] Starting subtest: reject-modify-context-protection-off-1
[427.502530] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[427.644456] [081/134] (609s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[427.837460] Starting subtest: fbcpsr-rgb101010-draw-render
[427.839541] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[428.006118] [082/134] (608s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-pwrite)
[428.196343] Starting subtest: psr-abgr161616f-draw-pwrite
[428.198017] Subtest psr-abgr161616f-draw-pwrite: SKIP (0.000s)
[428.375368] [083/134] (608s left) kms_cursor_edge_walk (128x128-left-edge)
[428.577689] Starting subtest: 128x128-left-edge
[428.578642] Starting dynamic subtest: pipe-A-DP-3
[432.046310] Dynamic subtest pipe-A-DP-3: SUCCESS (3.467s)
[432.066189] Starting dynamic subtest: pipe-D-DP-3
[435.373819] Dynamic subtest pipe-D-DP-3: SUCCESS (3.326s)
[435.374735] Subtest 128x128-left-edge: SUCCESS (6.799s)
[435.695783] [084/134] (601s left) kms_psr (fbc-pr-dpms)
[435.889733] Subtest fbc-pr-dpms: SKIP (0.000s)
[435.948196] [085/134] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[436.141496] Starting subtest: fbcpsr-2p-rte
[436.143226] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[436.316816] [086/134] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[436.516142] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[436.517747] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[436.722456] [087/134] (600s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[436.914637] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[436.916521] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[437.034517] [088/134] (600s left) kms_psr (psr-sprite-mmap-cpu)
[437.221075] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[437.282729] [089/134] (600s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[437.486562] Starting subtest: flip-vs-dpms-on-nop-interruptible
[437.491319] Starting dynamic subtest: A-DP3
[438.591765] Dynamic subtest A-DP3: SUCCESS (1.100s)
[438.633814] Starting dynamic subtest: B-DP3
[439.647770] Dynamic subtest B-DP3: SUCCESS (1.050s)
[439.690562] Starting dynamic subtest: C-DP3
[440.713610] Dynamic subtest C-DP3: SUCCESS (1.061s)
[440.730728] Starting dynamic subtest: D-DP3
[441.774568] Dynamic subtest D-DP3: SUCCESS (1.060s)
[441.776841] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.290s)
[442.172939] [090/134] (595s left) kms_big_fb (linear-16bpp-rotate-0)
[442.365362] Starting subtest: linear-16bpp-rotate-0
[444.271382] Subtest linear-16bpp-rotate-0: SUCCESS (1.905s)
[444.521801] [091/134] (593s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[444.714412] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[445.753906] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.039s)
[446.039987] [092/134] (591s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[446.227526] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[446.253406] Starting dynamic subtest: pipe-A-plane-0
[446.255236] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[446.267869] Starting dynamic subtest: pipe-A-plane-3
[446.269678] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[446.281768] Starting dynamic subtest: pipe-A-plane-5
[446.283526] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[446.491840] Starting dynamic subtest: pipe-B-plane-0
[446.494047] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[446.516354] Starting dynamic subtest: pipe-B-plane-3
[446.518297] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[446.531932] Starting dynamic subtest: pipe-B-plane-5
[446.533706] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[446.575151] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.347s)
[446.850747] [093/134] (591s left) gem_vm_create (invalid-destroy)
[446.934060] Starting subtest: invalid-destroy
[446.938755] Subtest invalid-destroy: SUCCESS (0.005s)
[447.132292] [094/134] (590s left) kms_busy (extended-pageflip-hang-oldfb)
[447.323575] Starting subtest: extended-pageflip-hang-oldfb
[447.324498] Starting dynamic subtest: pipe-A
[447.567831] Dynamic subtest pipe-A: SUCCESS (0.241s)
[447.601091] Starting dynamic subtest: pipe-D
[447.830473] Dynamic subtest pipe-D: SUCCESS (0.252s)
[447.831406] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.509s)
[448.162999] [095/134] (589s left) gem_exec_balancer (full-late-pulse)
[448.249610] Starting subtest: full-late-pulse
[450.344803] Subtest full-late-pulse: SUCCESS (2.095s)
[450.794703] [096/134] (587s left) kms_chamelium_frames (vga-frame-dump)
[451.052638] Subtest vga-frame-dump: SKIP (0.000s)
[451.204781] [097/134] (586s left) sysfs_heartbeat_interval (precise)
[451.289205] Starting subtest: precise
[451.290314] Starting dynamic subtest: vecs0
[452.880574] Dynamic subtest vecs0: SUCCESS (1.590s)
[452.893851] Starting dynamic subtest: ccs0
[455.589530] Dynamic subtest ccs0: SUCCESS (2.708s)
[455.602684] Starting dynamic subtest: vcs0
[457.054866] Dynamic subtest vcs0: SUCCESS (1.464s)
[457.069099] Starting dynamic subtest: bcs0
[459.477476] Dynamic subtest bcs0: SUCCESS (2.421s)
[459.494861] Starting dynamic subtest: vecs1
[462.224532] Dynamic subtest vecs1: SUCCESS (2.746s)
[462.239797] Starting dynamic subtest: rcs0
[463.615601] Dynamic subtest rcs0: SUCCESS (1.390s)
[463.629741] Starting dynamic subtest: vcs1
[465.089504] Dynamic subtest vcs1: SUCCESS (1.472s)
[465.090440] Subtest precise: SUCCESS (13.801s)
[465.260474] [098/134] (572s left) syncobj_wait (wait-any-complex)
[465.340606] Starting subtest: wait-any-complex
[465.403595] Subtest wait-any-complex: SUCCESS (0.063s)
[465.562653] [099/134] (572s left) gem_pipe_control_store_loop (fresh-buffer)
[465.649021] Starting subtest: fresh-buffer
[467.823446] Subtest fresh-buffer: SUCCESS (2.174s)
[467.979402] [100/134] (570s left) kms_chamelium_frames (dp-crc-fast)
[468.256654] Subtest dp-crc-fast: SKIP (0.000s)
[468.402711] [101/134] (570s left) kms_plane_lowres (tiling-x)
[468.584703] Starting subtest: tiling-x
[468.585652] Starting dynamic subtest: pipe-A-DP-3
[478.850952] Dynamic subtest pipe-A-DP-3: SUCCESS (10.265s)
[478.953692] Starting dynamic subtest: pipe-B-DP-3
[488.880134] Dynamic subtest pipe-B-DP-3: SUCCESS (9.937s)
[488.984204] Starting dynamic subtest: pipe-C-DP-3
[499.033301] Dynamic subtest pipe-C-DP-3: SUCCESS (10.063s)
[499.152538] Starting dynamic subtest: pipe-D-DP-3
[509.139187] Dynamic subtest pipe-D-DP-3: SUCCESS (9.998s)
[509.245223] Subtest tiling-x: SUCCESS (40.660s)
[509.572925] [102/134] (528s left) syncobj_timeline (invalid-signal-illegal-handle)
[509.652516] Starting subtest: invalid-signal-illegal-handle
[509.653476] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[509.839941] [103/134] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[510.029404] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[510.031093] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[510.244923] [104/134] (528s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[510.320465] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[510.405787] [105/134] (528s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[510.594572] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[510.649812] [106/134] (528s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[510.728708] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[510.834779] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[511.031789] [107/134] (527s left) syncobj_wait (invalid-reset-one-illegal-handle)
[511.110660] Starting subtest: invalid-reset-one-illegal-handle
[511.111565] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[511.267624] [108/134] (527s left) gem_exec_parallel (fds)
[511.360676] Starting subtest: fds
[511.361580] Starting dynamic subtest: rcs0
[516.239439] Dynamic subtest rcs0: SUCCESS (4.879s)
[516.253852] Starting dynamic subtest: bcs0
[519.384563] Dynamic subtest bcs0: SUCCESS (3.144s)
[519.397680] Starting dynamic subtest: vcs0
[524.546832] Dynamic subtest vcs0: SUCCESS (5.161s)
[524.559969] Starting dynamic subtest: vcs1
[528.948823] Dynamic subtest vcs1: SUCCESS (4.401s)
[528.961778] Starting dynamic subtest: vecs0
[533.518491] Dynamic subtest vecs0: SUCCESS (4.568s)
[533.531505] Starting dynamic subtest: vecs1
[538.591780] Dynamic subtest vecs1: SUCCESS (5.072s)
[538.605148] Starting dynamic subtest: ccs0
[543.257789] Dynamic subtest ccs0: SUCCESS (4.665s)
[543.258816] Subtest fds: SUCCESS (31.898s)
[543.592780] [109/134] (495s left) gem_userptr_blits (process-exit)
[543.683175] Starting subtest: process-exit
[543.691664] Subtest process-exit: SUCCESS (0.009s)
[543.916263] [110/134] (495s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[543.995396] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[544.095810] [111/134] (495s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[544.283126] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[547.106439] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.823s)
[547.303570] [112/134] (491s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[547.495526] Starting subtest: plane-ctm3x4-lut1d
[547.521882] Starting dynamic subtest: pipe-A-DP-3
[547.904784] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s)
[548.106057] Starting dynamic subtest: pipe-B-DP-3
[548.440814] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[548.617450] Starting dynamic subtest: pipe-C-DP-3
[548.936568] Dynamic subtest pipe-C-DP-3: SUCCESS (0.332s)
[549.123770] Starting dynamic subtest: pipe-D-DP-3
[549.440589] Dynamic subtest pipe-D-DP-3: SUCCESS (0.331s)
[549.545690] Subtest plane-ctm3x4-lut1d: SUCCESS (2.051s)
[549.832825] [113/134] (489s left) gem_ctx_exec (basic-invalid-context)
[549.921422] Starting subtest: basic-invalid-context
[549.925695] Subtest basic-invalid-context: SUCCESS (0.004s)
[550.127581] [114/134] (489s left) kms_pm_rpm (cursor)
[552.448886] Starting subtest: cursor
[552.451133] Subtest cursor: SKIP (0.000s)
[552.891937] [115/134] (486s left) syncobj_wait (invalid-reset-illegal-handle)
[552.969501] Starting subtest: invalid-reset-illegal-handle
[552.970430] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[553.160598] [116/134] (486s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[553.350472] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[553.351373] Starting dynamic subtest: pipe-A-DP-3
[553.360017] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[553.372489] Starting dynamic subtest: pipe-B-DP-3
[553.380704] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[553.392979] Starting dynamic subtest: pipe-C-DP-3
[553.401162] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[553.413682] Starting dynamic subtest: pipe-D-DP-3
[553.423627] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[553.425575] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[553.825532] [117/134] (485s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[553.914132] Starting subtest: stress-mm-invalidate-close-overlap
[556.062703] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[556.239930] [118/134] (483s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[556.429214] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[556.430969] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[556.639200] [119/134] (483s left) device_reset (unbind-reset-rebind)
[556.720153] Starting subtest: unbind-reset-rebind
[559.300712] Subtest unbind-reset-rebind: SUCCESS (2.580s)
[559.358538] [120/134] (480s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[559.455612] Starting subtest: map-fixed-invalidate-overlap-busy
[559.457486] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[559.679504] [121/134] (480s left) kms_vblank (crtc-id)
[559.862152] Starting subtest: crtc-id
[559.864545] Starting dynamic subtest: pipe-A-DP-3
[560.253108] Dynamic subtest pipe-A-DP-3: SUCCESS (0.389s)
[560.276175] Starting dynamic subtest: pipe-D-DP-3
[560.567472] Dynamic subtest pipe-D-DP-3: SUCCESS (0.310s)
[560.568419] Subtest crtc-id: SUCCESS (0.706s)
[560.838818] [122/134] (479s left) i915_query (query-topology-matches-eu-total)
[560.919072] Starting subtest: query-topology-matches-eu-total
[560.919945] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[561.106726] [123/134] (479s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[561.446608] Starting subtest: parallel-dmabuf-import-out-fence
[563.669720] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.223s)
[563.847830] [124/134] (476s left) syncobj_timeline (wait-any-interrupted)
[563.926468] Starting subtest: wait-any-interrupted
[564.027421] Subtest wait-any-interrupted: SUCCESS (0.101s)
[564.159756] [125/134] (476s left) kms_flip (busy-flip)
[564.347278] Starting subtest: busy-flip
[564.351830] Starting dynamic subtest: A-DP3
[565.176731] Dynamic subtest A-DP3: SUCCESS (0.825s)
[565.193507] Starting dynamic subtest: B-DP3
[565.927647] Dynamic subtest B-DP3: SUCCESS (0.749s)
[565.968204] Starting dynamic subtest: C-DP3
[566.708347] Dynamic subtest C-DP3: SUCCESS (0.776s)
[566.725861] Starting dynamic subtest: D-DP3
[567.480447] Dynamic subtest D-DP3: SUCCESS (0.771s)
[567.482792] Subtest busy-flip: SUCCESS (3.135s)
[567.851280] [126/134] (472s left) kms_atomic (plane-cursor-legacy)
[568.050536] Starting subtest: plane-cursor-legacy
[568.051436] Starting dynamic subtest: pipe-A-DP-3
[568.586646] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s)
[568.587560] Subtest plane-cursor-legacy: SUCCESS (0.537s)
[568.903117] [127/134] (471s left) i915_drm_fdinfo (basics)
[568.972055] Starting subtest: basics
[568.972976] Subtest basics: SUCCESS (0.000s)
[569.096527] [128/134] (471s left) kms_flip_tiling (flip-change-tiling)
[569.281527] Starting subtest: flip-change-tiling
[569.282404] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[569.534915] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.252s)
[569.582834] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[569.751639] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.212s)
[569.799570] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[569.967276] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.212s)
[569.990569] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[570.168419] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.199s)
[570.217072] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[570.351593] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.178s)
[570.401069] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[570.568543] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.212s)
[570.618081] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[570.785103] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.212s)
[570.832773] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[571.002218] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.211s)
[571.024042] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[571.151531] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.145s)
[571.245827] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[571.564447] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.357s)
[571.586437] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[571.713788] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.145s)
[571.753289] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[571.880312] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.164s)
[571.899837] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[572.013566] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.131s)
[572.044236] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[572.163643] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.148s)
[572.198723] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[572.313626] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.148s)
[572.340801] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[572.463653] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.148s)
[572.482798] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[572.596951] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.131s)
[572.631121] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[572.746957] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.148s)
[572.795420] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[573.110587] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.328s)
[573.159635] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[573.276187] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.161s)
[573.303112] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[573.426291] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.148s)
[573.466583] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[573.593009] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.164s)
[573.632749] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[573.759802] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.164s)
[573.799999] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[573.926499] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.164s)
[573.972057] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[574.092882] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.164s)
[574.128271] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[574.259820] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.165s)
[574.279883] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[574.392915] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.130s)
[574.441277] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[574.756647] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.328s)
[574.804776] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[574.938975] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.178s)
[574.984200] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[575.105571] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.164s)
[575.140452] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[575.272426] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.164s)
[575.311828] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[575.439113] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.164s)
[575.477900] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[575.605692] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.164s)
[575.644303] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[575.772354] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.164s)
[575.811468] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[575.938925] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.164s)
[575.958623] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[576.089188] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.148s)
[576.121955] Subtest flip-change-tiling: SUCCESS (6.841s)
[576.504509] [129/134] (464s left) kms_feature_discovery (psr2)
[576.696733] Starting subtest: psr2
[576.698474] Subtest psr2: SKIP (0.000s)
[576.857348] [130/134] (463s left) syncobj_wait (single-wait-all-for-submit-submitted)
[576.940661] Starting subtest: single-wait-all-for-submit-submitted
[577.042508] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[577.222405] [131/134] (463s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[577.297703] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[577.402530] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[577.587803] [132/134] (463s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[577.780314] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[577.782039] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[577.986955] [133/134] (463s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[578.074061] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[578.076416] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[578.351407] [134/134] (462s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[578.428677] Starting subtest: multi-wait-for-submit-unsubmitted
[578.530527] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[578.656095] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_pread
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_query
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: api_intel_allocator
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_sequence
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: prime_mmap_coherency
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_plane_alpha_blend
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: gem_create
results: parsing output: 58/ for test: kms_3d
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: dumb_buffer
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gem_exec_suspend
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: gem_mmap
results: parsing output: 68/ for test: i915_pm_rc6_residency
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: gem_exec_nop
results: parsing output: 72/ for test: kms_setmode
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_ctx_sseu
results: parsing output: 75/ for test: kms_dirtyfb
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_vm_create
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_pipe_control_store_loop
results: parsing output: 99/ for test: kms_chamelium_frames
results: parsing output: 100/ for test: kms_plane_lowres
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_exec_parallel
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_pipe_b_c_ivb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: gem_ctx_exec
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: device_reset
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: i915_query
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_atomic
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: kms_flip_tiling
results: parsing output: 128/ for test: kms_feature_discovery
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_render_copy
results: parsing output: 133/ for test: syncobj_wait
Done.