[57.682445] Initializing watchdogs
[57.682580]   /dev/watchdog0
[57.697739] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.702181] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.704450] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.708123] [001/132] (960s left) gem_ctx_shared (q-in-order)
[57.801017] Starting subtest: Q-in-order
[57.803031] Starting dynamic subtest: rcs0
[57.972596] Dynamic subtest rcs0: SUCCESS (0.172s)
[57.987068] Starting dynamic subtest: vcs0
[58.072306] Dynamic subtest vcs0: SUCCESS (0.101s)
[58.081527] Starting dynamic subtest: vcs1
[58.187463] Dynamic subtest vcs1: SUCCESS (0.114s)
[58.204212] Starting dynamic subtest: vecs0
[58.294624] Dynamic subtest vecs0: SUCCESS (0.108s)
[58.309680] Starting dynamic subtest: ccs0
[58.420087] Dynamic subtest ccs0: SUCCESS (0.124s)
[58.422198] Subtest Q-in-order: SUCCESS (0.620s)
[60.020823] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[60.026143] [002/132] (958s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[60.084186] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[60.086472] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[60.182863] [003/132] (958s left) gem_exec_flush (basic-uc-ro-default)
[60.256987] Starting subtest: basic-uc-ro-default
[65.714889] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[65.898225] [004/132] (952s left) kms_flip (wf_vblank-ts-check-interruptible)
[66.002042] Starting subtest: wf_vblank-ts-check-interruptible
[66.004322] Starting dynamic subtest: A-eDP1
[74.926198] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[74.936239] Starting dynamic subtest: B-eDP1
[83.847395] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[83.854864] Starting dynamic subtest: C-eDP1
[92.755906] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[92.764948] Starting dynamic subtest: D-eDP1
[101.600553] Dynamic subtest D-eDP1: SUCCESS (8.845s)
[101.605620] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.606s)
[102.813433] [005/132] (915s left) perf (blocking)
[102.935954] Starting subtest: blocking
[102.937965] Starting dynamic subtest: 0-rcs0
[112.954631] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[112.961742] Starting dynamic subtest: 1-vcs0
[122.975959] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[122.979039] Subtest blocking: SUCCESS (20.040s)
[123.022360] [006/132] (895s left) kms_flip (flip-vs-expired-vblank)
[123.119503] Starting subtest: flip-vs-expired-vblank
[123.121577] Starting dynamic subtest: A-eDP1
[131.822717] Dynamic subtest A-eDP1: SUCCESS (8.704s)
[131.833174] Starting dynamic subtest: B-eDP1
[140.532128] Dynamic subtest B-eDP1: SUCCESS (8.708s)
[140.543384] Starting dynamic subtest: C-eDP1
[149.158400] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[149.169316] Starting dynamic subtest: D-eDP1
[157.788480] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[157.793237] Subtest flip-vs-expired-vblank: SUCCESS (34.675s)
[158.965786] [007/132] (859s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[159.055063] Starting subtest: disable-crc-after-crtc
[159.057288] Starting dynamic subtest: pipe-A-eDP-1
[160.722922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.664s)
[160.731849] Starting dynamic subtest: pipe-B-eDP-1
[163.058480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.336s)
[163.067705] Starting dynamic subtest: pipe-C-eDP-1
[165.325867] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.267s)
[165.333173] Starting dynamic subtest: pipe-D-eDP-1
[167.584679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[167.586972] Subtest disable-crc-after-crtc: SUCCESS (8.528s)
[168.415818] [008/132] (850s left) kms_chamelium_color (ctm-0-50)
[168.529156] Subtest ctm-0-50: SKIP (0.000s)
[168.574959] [009/132] (849s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[168.673752] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[168.676028] Starting dynamic subtest: pipe-A-eDP-1
[169.473795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[169.482292] Starting dynamic subtest: pipe-B-eDP-1
[171.056840] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[171.065747] Starting dynamic subtest: pipe-C-eDP-1
[172.537876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[172.547257] Starting dynamic subtest: pipe-D-eDP-1
[174.082473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s)
[174.084667] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.402s)
[175.246111] [010/132] (843s left) kms_sequence (get-forked)
[175.337432] Starting subtest: get-forked
[175.339651] Starting dynamic subtest: pipe-A-eDP-1
[177.229558] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[177.238118] Starting dynamic subtest: pipe-B-eDP-1
[179.771506] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.541s)
[179.779923] Starting dynamic subtest: pipe-C-eDP-1
[182.275830] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.502s)
[182.284260] Starting dynamic subtest: pipe-D-eDP-1
[184.792809] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.515s)
[184.795078] Subtest get-forked: SUCCESS (9.455s)
[185.639260] [011/132] (832s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[185.750394] Starting subtest: yf-tiled-8bpp-rotate-0
[185.754399] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[185.841103] [012/132] (832s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[185.904272] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[185.908707] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[186.083252] [013/132] (832s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[186.133844] Starting subtest: y-tiled-ccs-to-y-tiled
[186.138440] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[186.327072] [014/132] (832s left) kms_plane_lowres (tiling-y)
[186.414920] Starting subtest: tiling-y
[186.419287] Subtest tiling-y: SKIP (0.000s)
[186.485251] [015/132] (832s left) kms_lease (lessee-list)
[186.565230] Starting subtest: lessee-list
[186.567566] Starting dynamic subtest: pipe-A-eDP-1
[186.569946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[186.579121] Starting dynamic subtest: pipe-B-eDP-1
[186.581230] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[186.588026] Starting dynamic subtest: pipe-C-eDP-1
[186.590137] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[186.596809] Starting dynamic subtest: pipe-D-eDP-1
[186.598957] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[186.601135] Subtest lessee-list: SUCCESS (0.009s)
[186.669279] [016/132] (832s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[186.761971] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[193.366511] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.607s)
[193.477163] [017/132] (825s left) kms_atomic_transition (plane-all-transition-nonblocking)
[193.564678] Starting subtest: plane-all-transition-nonblocking
[193.566848] Starting dynamic subtest: pipe-A-eDP-1
[196.059667] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[196.364544] Starting dynamic subtest: pipe-B-eDP-1
[199.607278] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.251s)
[199.917043] Subtest plane-all-transition-nonblocking: SUCCESS (6.351s)
[200.740907] [018/132] (818s left) syncobj_timeline (wait-all-interrupted)
[200.803296] Starting subtest: wait-all-interrupted
[200.905483] Subtest wait-all-interrupted: SUCCESS (0.102s)
[200.983556] [019/132] (817s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[201.083162] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[201.085495] Starting dynamic subtest: A-eDP1
[204.665126] Dynamic subtest A-eDP1: SUCCESS (3.581s)
[204.677245] Starting dynamic subtest: B-eDP1
[207.844676] Dynamic subtest B-eDP1: SUCCESS (3.176s)
[207.852093] Starting dynamic subtest: C-eDP1
[210.961756] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[210.969696] Starting dynamic subtest: D-eDP1
[214.047473] Dynamic subtest D-eDP1: SUCCESS (3.084s)
[214.049338] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.965s)
[214.874243] [020/132] (804s left) kms_big_fb (linear-8bpp-rotate-90)
[214.988316] Starting subtest: linear-8bpp-rotate-90
[215.009468] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[215.121786] [021/132] (803s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[215.214159] Starting subtest: pipe-fbc-rte
[215.220703] Starting dynamic subtest: pipe-B-eDP-1
[220.697860] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.489s)
[220.705132] Subtest pipe-fbc-rte: SUCCESS (5.491s)
[222.961583] [022/132] (796s left) i915_selftest (mock)
[226.254981] Starting subtest: mock
[226.257540] Starting dynamic subtest: sanitycheck
[226.916169] Dynamic subtest sanitycheck: SUCCESS (0.661s)
[226.925102] Starting dynamic subtest: shmem
[227.568353] Dynamic subtest shmem: SUCCESS (0.650s)
[227.577993] Starting dynamic subtest: fence
[235.038574] Dynamic subtest fence: SUCCESS (7.467s)
[235.047440] Starting dynamic subtest: scatterlist
[236.678081] Dynamic subtest scatterlist: SUCCESS (1.638s)
[236.687249] Starting dynamic subtest: syncmap
[239.792576] Dynamic subtest syncmap: SUCCESS (3.112s)
[239.801408] Starting dynamic subtest: uncore
[240.438099] Dynamic subtest uncore: SUCCESS (0.644s)
[240.447080] Starting dynamic subtest: ring
[241.098981] Dynamic subtest ring: SUCCESS (0.659s)
[241.107862] Starting dynamic subtest: engine
[241.752633] Dynamic subtest engine: SUCCESS (0.651s)
[241.761330] Starting dynamic subtest: timelines
[245.475116] Dynamic subtest timelines: SUCCESS (3.722s)
[245.482291] Starting dynamic subtest: requests
[249.387502] Dynamic subtest requests: SUCCESS (3.909s)
[249.394037] Starting dynamic subtest: objects
[250.146286] Dynamic subtest objects: SUCCESS (0.758s)
[250.154435] Starting dynamic subtest: phys
[250.910322] Dynamic subtest phys: SUCCESS (0.762s)
[250.918729] Starting dynamic subtest: dmabuf
[251.656500] Dynamic subtest dmabuf: SUCCESS (0.744s)
[251.664656] Starting dynamic subtest: vma
[257.277081] Dynamic subtest vma: SUCCESS (5.618s)
[257.285782] Starting dynamic subtest: evict
[258.660394] Dynamic subtest evict: SUCCESS (1.381s)
[258.667626] Starting dynamic subtest: gtt
[261.903607] Dynamic subtest gtt: SUCCESS (3.242s)
[261.911693] Starting dynamic subtest: hugepages
[262.741394] Dynamic subtest hugepages: SUCCESS (0.837s)
[262.750249] Starting dynamic subtest: memory_region
[265.204357] Dynamic subtest memory_region: SUCCESS (2.461s)
[265.206873] Subtest mock: SUCCESS (38.950s)
[265.233543] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[265.234250] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[265.237449] [023/132] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[266.787463] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[270.408073] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.624s)
[271.621328] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[271.622497] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[271.626357] [024/132] (747s left) gem_exec_balancer (parallel-out-fence)
[271.903458] Starting subtest: parallel-out-fence
[272.944036] Subtest parallel-out-fence: SUCCESS (1.040s)
[273.034199] [025/132] (746s left) kms_color (ctm-green-to-red)
[273.125810] Starting subtest: ctm-green-to-red
[273.127957] Starting dynamic subtest: pipe-A-eDP-1
[273.805950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s)
[273.813730] Starting dynamic subtest: pipe-B-eDP-1
[275.183351] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[275.191821] Starting dynamic subtest: pipe-C-eDP-1
[276.536545] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[276.544279] Starting dynamic subtest: pipe-D-eDP-1
[277.871825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[277.874255] Subtest ctm-green-to-red: SUCCESS (4.747s)
[278.737547] [026/132] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[278.833771] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[283.287737] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.458s)
[284.423377] [027/132] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[284.534809] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[291.850574] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.317s)
[291.987293] [028/132] (727s left) gem_exec_schedule (pi-distinct-iova)
[292.178241] Starting subtest: pi-distinct-iova
[292.180572] Starting dynamic subtest: rcs0
[292.252977] Dynamic subtest rcs0: SUCCESS (0.077s)
[292.264993] Starting dynamic subtest: vcs0
[292.307471] Dynamic subtest vcs0: SUCCESS (0.053s)
[292.320265] Starting dynamic subtest: vcs1
[292.358732] Dynamic subtest vcs1: SUCCESS (0.051s)
[292.372666] Starting dynamic subtest: vecs0
[292.410041] Dynamic subtest vecs0: SUCCESS (0.051s)
[292.420373] Starting dynamic subtest: ccs0
[292.485725] Dynamic subtest ccs0: SUCCESS (0.075s)
[292.488258] Subtest pi-distinct-iova: SUCCESS (0.312s)
[293.995387] [029/132] (725s left) api_intel_allocator (fork-simple-stress-signal)
[294.050100] Starting subtest: fork-simple-stress-signal
[299.452420] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[299.582414] [030/132] (719s left) kms_pm_backlight (fade-with-suspend)
[299.694943] Starting subtest: fade-with-suspend
[316.156175] Starting dynamic subtest: eDP-1
[318.630606] Dynamic subtest eDP-1: SUCCESS (2.477s)
[318.632854] Subtest fade-with-suspend: SUCCESS (12.876s)
[319.472620] [031/132] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[319.579329] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[326.643282] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.065s)
[326.764822] [032/132] (692s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[326.856554] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[326.859058] Starting dynamic subtest: pipe-A-eDP-1
[326.880592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.889582] Starting dynamic subtest: pipe-B-eDP-1
[326.909845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.917420] Starting dynamic subtest: pipe-C-eDP-1
[326.937560] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.944813] Starting dynamic subtest: pipe-D-eDP-1
[326.965318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.969435] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[329.050090] [033/132] (690s left) kms_addfb_basic (size-max)
[329.145659] Starting subtest: size-max
[329.147919] Subtest size-max: SUCCESS (0.000s)
[329.239838] [034/132] (690s left) kms_addfb_basic (unused-modifier)
[329.285718] Starting subtest: unused-modifier
[329.287898] Subtest unused-modifier: SUCCESS (0.000s)
[329.402482] [035/132] (690s left) kms_draw_crc (draw-method-mmap-cpu)
[329.489659] Starting subtest: draw-method-mmap-cpu
[329.491939] Starting dynamic subtest: xrgb8888-untiled
[329.721141] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[329.729484] Starting dynamic subtest: rgb565-untiled
[329.965329] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[329.973991] Starting dynamic subtest: xrgb2101010-untiled
[330.187315] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[330.195013] Starting dynamic subtest: xbgr16161616f-untiled
[330.409714] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[330.418058] Starting dynamic subtest: xrgb8888-xtiled
[330.531732] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[330.539976] Starting dynamic subtest: rgb565-xtiled
[330.655749] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[330.664084] Starting dynamic subtest: xrgb2101010-xtiled
[330.788234] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[330.808614] Starting dynamic subtest: xbgr16161616f-xtiled
[330.921844] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.130s)
[330.929832] Starting dynamic subtest: xrgb8888-4tiled
[331.065403] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[331.073382] Starting dynamic subtest: rgb565-4tiled
[331.209924] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[331.217802] Starting dynamic subtest: xrgb2101010-4tiled
[331.343451] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[331.351852] Starting dynamic subtest: xbgr16161616f-4tiled
[331.487835] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[331.489893] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[331.583646] [036/132] (687s left) gem_mmap_wc (write-prefaulted)
[331.637546] Subtest write-prefaulted: SKIP (0.000s)
[331.695207] [037/132] (687s left) perf_pmu (busy-accuracy-50)
[331.738151] Starting subtest: busy-accuracy-50
[331.739966] Starting dynamic subtest: rcs0
[333.282482] Dynamic subtest rcs0: SUCCESS (1.540s)
[333.294642] Starting dynamic subtest: bcs0
[334.826861] Dynamic subtest bcs0: SUCCESS (1.544s)
[334.839851] Starting dynamic subtest: vcs0
[336.370173] Dynamic subtest vcs0: SUCCESS (1.542s)
[336.381487] Starting dynamic subtest: vcs1
[337.922940] Dynamic subtest vcs1: SUCCESS (1.547s)
[337.933146] Starting dynamic subtest: vecs0
[339.461824] Dynamic subtest vecs0: SUCCESS (1.539s)
[339.471045] Starting dynamic subtest: ccs0
[341.005993] Dynamic subtest ccs0: SUCCESS (1.540s)
[341.008505] Subtest busy-accuracy-50: SUCCESS (9.265s)
[341.119962] [038/132] (678s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[341.215612] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[341.219932] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[341.327080] [039/132] (678s left) kms_content_protection (uevent-hdcp14)
[341.465107] Starting subtest: uevent-hdcp14
[341.469740] Subtest uevent-hdcp14: SKIP (0.000s)
[341.596491] [040/132] (678s left) gem_exec_schedule (timeslicing)
[341.682779] Starting subtest: timeslicing
[341.684840] Starting dynamic subtest: rcs0
[341.694063] Dynamic subtest rcs0: SUCCESS (0.021s)
[341.705412] Starting dynamic subtest: bcs0
[341.714305] Dynamic subtest bcs0: SUCCESS (0.020s)
[341.722744] Starting dynamic subtest: vcs0
[341.736233] Dynamic subtest vcs0: SUCCESS (0.021s)
[341.749186] Starting dynamic subtest: vcs1
[341.759041] Dynamic subtest vcs1: SUCCESS (0.020s)
[341.767944] Starting dynamic subtest: vecs0
[341.779689] Dynamic subtest vecs0: SUCCESS (0.020s)
[341.788149] Starting dynamic subtest: ccs0
[341.800110] Dynamic subtest ccs0: SUCCESS (0.020s)
[341.802179] Subtest timeslicing: SUCCESS (0.128s)
[343.015933] [041/132] (676s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[343.110080] Starting subtest: y-tiled-16bpp-rotate-270
[343.114070] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[343.226122] [042/132] (676s left) kms_flip (flip-vs-expired-vblank-interruptible)
[343.330811] Starting subtest: flip-vs-expired-vblank-interruptible
[343.332977] Starting dynamic subtest: A-eDP1
[351.973636] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[351.985121] Starting dynamic subtest: B-eDP1
[360.608667] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[360.619569] Starting dynamic subtest: C-eDP1
[369.238860] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[369.257963] Starting dynamic subtest: D-eDP1
[377.869638] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[377.874394] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.544s)
[379.042411] [043/132] (640s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[379.140321] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[379.144608] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[379.233291] [044/132] (640s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[379.326566] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[379.330722] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[379.409324] [045/132] (640s left) kms_async_flips (alternate-sync-async-flip-atomic)
[379.505384] Starting subtest: alternate-sync-async-flip-atomic
[379.888584] Starting dynamic subtest: pipe-A-eDP-1
[382.641905] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s)
[383.020613] Starting dynamic subtest: pipe-B-eDP-1
[385.770354] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[386.160683] Starting dynamic subtest: pipe-C-eDP-1
[388.909752] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[389.273865] Starting dynamic subtest: pipe-D-eDP-1
[392.033789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[392.035743] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.532s)
[393.207942] [046/132] (626s left) gem_lmem_swapping (verify)
[393.273756] Subtest verify: SKIP (0.000s)
[393.318027] [047/132] (626s left) perf (invalid-remove-userspace-config)
[393.449047] Starting subtest: invalid-remove-userspace-config
[393.459145] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[393.495235] [048/132] (626s left) syncobj_timeline (multi-wait-available-submitted)
[393.546941] Starting subtest: multi-wait-available-submitted
[393.549163] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[393.653071] [049/132] (626s left) gem_mmap_offset (perf)
[393.719773] Starting subtest: perf
[393.722040] Starting dynamic subtest: smem0
[394.083919] Dynamic subtest smem0: SUCCESS (0.363s)
[394.086252] Subtest perf: SUCCESS (0.364s)
[394.216839] [050/132] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[394.311301] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[394.315673] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[394.425319] [051/132] (625s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[394.529024] Starting subtest: x-tiled-32bpp-rotate-180
[395.995671] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[396.148730] [052/132] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[396.260731] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[396.264414] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[396.368178] [053/132] (623s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[396.462013] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[396.463905] Starting dynamic subtest: pipe-A-eDP-1
[396.482772] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.493528] Starting dynamic subtest: pipe-B-eDP-1
[396.511067] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.522092] Starting dynamic subtest: pipe-C-eDP-1
[396.540121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.547614] Starting dynamic subtest: pipe-D-eDP-1
[396.565637] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.569127] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[398.755050] [054/132] (621s left) gem_render_linear_blits (basic)
[398.807508] Starting subtest: basic
[398.828157] Subtest basic: SUCCESS (0.021s)
[398.943677] [055/132] (621s left) kms_plane (plane-position-covered)
[399.026153] Starting subtest: plane-position-covered
[399.539298] Starting dynamic subtest: pipe-A-plane-1
[400.861705] Dynamic subtest pipe-A-plane-1: SUCCESS (1.322s)
[400.871821] Starting dynamic subtest: pipe-A-plane-2
[402.182115] Dynamic subtest pipe-A-plane-2: SUCCESS (1.319s)
[402.196489] Starting dynamic subtest: pipe-A-plane-3
[403.574952] Dynamic subtest pipe-A-plane-3: SUCCESS (1.389s)
[403.584735] Starting dynamic subtest: pipe-A-plane-4
[404.885100] Dynamic subtest pipe-A-plane-4: SUCCESS (1.313s)
[404.895092] Starting dynamic subtest: pipe-A-plane-5
[404.912281] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[406.109732] Starting dynamic subtest: pipe-B-plane-1
[407.423383] Dynamic subtest pipe-B-plane-1: SUCCESS (1.319s)
[407.432858] Starting dynamic subtest: pipe-B-plane-2
[408.736258] Dynamic subtest pipe-B-plane-2: SUCCESS (1.312s)
[408.746340] Starting dynamic subtest: pipe-B-plane-3
[409.967904] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[409.977911] Starting dynamic subtest: pipe-B-plane-4
[411.286354] Dynamic subtest pipe-B-plane-4: SUCCESS (1.318s)
[411.297980] Starting dynamic subtest: pipe-B-plane-5
[411.312739] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[411.314931] Subtest plane-position-covered: SUCCESS (12.286s)
[412.082249] [056/132] (608s left) kms_rotation_crc (exhaust-fences)
[412.174065] Starting subtest: exhaust-fences
[412.178014] Subtest exhaust-fences: SKIP (0.000s)
[412.246168] [057/132] (608s left) gem_huc_copy (huc-copy)
[412.310733] Starting subtest: huc-copy
[412.315619] Subtest huc-copy: SUCCESS (0.003s)
[412.418506] [058/132] (608s left) kms_hdr (static-toggle-suspend)
[412.509963] Starting subtest: static-toggle-suspend
[412.516555] Subtest static-toggle-suspend: SKIP (0.000s)
[412.586088] [059/132] (607s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[412.688306] Starting subtest: 4-tiled-16bpp-rotate-90
[412.708426] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[412.818465] [060/132] (607s left) kms_properties (connector-properties-atomic)
[412.904503] Starting subtest: connector-properties-atomic
[412.906582] Starting dynamic subtest: pipe-A-eDP-1
[420.791468] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.887s)
[420.801360] Starting dynamic subtest: pipe-None-DP-1
[420.805557] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[420.813984] Starting dynamic subtest: pipe-None-HDMI-A-1
[420.818136] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[420.826693] Starting dynamic subtest: pipe-None-DP-2
[420.830645] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[420.838587] Starting dynamic subtest: pipe-None-HDMI-A-2
[420.842735] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[420.852933] Starting dynamic subtest: pipe-None-DP-3
[420.857516] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[420.866735] Starting dynamic subtest: pipe-None-DP-4
[420.871181] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[420.873399] Subtest connector-properties-atomic: SUCCESS (7.898s)
[421.659186] [061/132] (598s left) kms_psr (psr-primary-blt)
[421.739497] Starting subtest: psr-primary-blt
[421.741700] Starting dynamic subtest: eDP-1
[423.454115] Dynamic subtest eDP-1: SUCCESS (1.714s)
[423.456332] Subtest psr-primary-blt: SUCCESS (1.715s)
[424.317829] [062/132] (596s left) gem_exec_reloc (basic-gtt-active)
[424.382787] Subtest basic-gtt-active: SKIP (0.000s)
[424.454510] [063/132] (596s left) kms_psr (pr-cursor-plane-onoff)
[424.542846] Starting subtest: pr-cursor-plane-onoff
[424.546914] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[424.613578] [064/132] (596s left) kms_cursor_crc (cursor-size-hints)
[424.745064] Starting subtest: cursor-size-hints
[424.746943] Starting dynamic subtest: pipe-A-eDP-1
[425.363501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[425.372487] Starting dynamic subtest: pipe-D-eDP-1
[426.625302] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.259s)
[426.627622] Subtest cursor-size-hints: SUCCESS (1.882s)
[427.486668] [065/132] (593s left) kms_flip (2x-flip-vs-modeset)
[427.574529] Starting subtest: 2x-flip-vs-modeset
[427.582526] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[427.664565] [066/132] (593s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[427.748974] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[427.753368] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[427.820326] [067/132] (593s left) kms_psr (fbc-psr-cursor-plane-onoff)
[427.903333] Starting subtest: fbc-psr-cursor-plane-onoff
[427.905295] Starting dynamic subtest: eDP-1
[427.909513] Dynamic subtest eDP-1: SKIP (0.000s)
[427.913712] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[427.989182] [068/132] (592s left) gem_tiled_wb
[428.109280] [069/132] (592s left) prime_busy (hang-wait)
[428.161936] Starting subtest: hang-wait
[428.163806] Starting dynamic subtest: rcs0
[454.497769] Dynamic subtest rcs0: SUCCESS (26.334s)
[454.506267] Starting dynamic subtest: bcs0
[461.583810] Dynamic subtest bcs0: SUCCESS (7.083s)
[461.592079] Starting dynamic subtest: vcs0
[468.560748] Dynamic subtest vcs0: SUCCESS (6.975s)
[468.569622] Starting dynamic subtest: vcs1
[475.606505] Dynamic subtest vcs1: SUCCESS (7.041s)
[475.617109] Starting dynamic subtest: vecs0
[482.572683] Dynamic subtest vecs0: SUCCESS (6.965s)
[482.581349] Starting dynamic subtest: ccs0
[496.410557] Dynamic subtest ccs0: SUCCESS (13.835s)
[496.412720] Subtest hang-wait: SUCCESS (68.249s)
[496.537764] [070/132] (524s left) perf_pmu (busy-idle)
[496.589308] Starting subtest: busy-idle
[496.591550] Starting dynamic subtest: rcs0
[497.290637] Dynamic subtest rcs0: SUCCESS (0.702s)
[497.301752] Starting dynamic subtest: bcs0
[497.956431] Dynamic subtest bcs0: SUCCESS (0.663s)
[497.967523] Starting dynamic subtest: vcs0
[499.969691] Dynamic subtest vcs0: SUCCESS (2.009s)
[499.980727] Starting dynamic subtest: vcs1
[501.953815] Dynamic subtest vcs1: SUCCESS (1.981s)
[501.964136] Starting dynamic subtest: vecs0
[503.937950] Dynamic subtest vecs0: SUCCESS (1.981s)
[503.949172] Starting dynamic subtest: ccs0
[504.607295] Dynamic subtest ccs0: SUCCESS (0.668s)
[504.609897] Subtest busy-idle: SUCCESS (8.021s)
[504.703216] [071/132] (516s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[504.755931] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[504.862127] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[504.938616] [072/132] (516s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[505.032970] Starting subtest: fbc-pr-sprite-mmap-gtt
[505.037502] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[505.108279] [073/132] (515s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[505.162307] Starting subtest: invalid-single-wait-all-unsubmitted
[505.164436] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[505.246592] [074/132] (515s left) kms_flip (flip-vs-wf_vblank-interruptible)
[505.338832] Starting subtest: flip-vs-wf_vblank-interruptible
[505.341156] Starting dynamic subtest: A-eDP1
[507.227713] Dynamic subtest A-eDP1: SUCCESS (1.887s)
[507.240009] Starting dynamic subtest: B-eDP1
[509.159198] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[509.168223] Starting dynamic subtest: C-eDP1
[511.080241] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[511.090371] Starting dynamic subtest: D-eDP1
[512.924279] Dynamic subtest D-eDP1: SUCCESS (1.842s)
[512.929564] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.589s)
[514.181270] [075/132] (507s left) gem_spin_batch (spin-all)
[514.245929] Starting subtest: spin-all
[514.260930] Subtest spin-all: SUCCESS (0.015s)
[515.944918] [076/132] (505s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[516.032692] Starting subtest: plane-primary-toggle-with-vblank-wait
[516.035038] Starting dynamic subtest: pipe-A-eDP-1
[516.205012] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[516.514496] Starting dynamic subtest: pipe-B-eDP-1
[517.445395] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.940s)
[517.740408] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.709s)
[518.600522] [077/132] (502s left) gem_vm_create (create-ext)
[518.660478] Starting subtest: create-ext
[518.665836] Subtest create-ext: SUCCESS (0.005s)
[518.778154] [078/132] (502s left) dmabuf_sync_file (export-multiwait)
[518.833859] Starting subtest: export-multiwait
[518.835757] Subtest export-multiwait: SUCCESS (0.000s)
[518.926996] [079/132] (502s left) i915_pm_rpm (gem-execbuf-stress)
[521.153428] Starting subtest: gem-execbuf-stress
[521.156389] Starting dynamic subtest: smem0
[533.993085] Dynamic subtest smem0: SUCCESS (12.839s)
[534.004549] Starting dynamic subtest: extra-wait-smem0
[596.029489] Dynamic subtest extra-wait-smem0: SUCCESS (62.030s)
[596.032237] Subtest gem-execbuf-stress: SUCCESS (74.875s)
[596.416202] [080/132] (425s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[596.802669] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[597.598107] [081/132] (423s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[597.690570] Starting subtest: fbc-pr-cursor-plane-update-sf
[597.694744] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[597.759652] [082/132] (423s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[597.865429] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[597.869863] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[597.971507] [083/132] (423s left) gen7_exec_parse (basic-rejected)
[598.031921] Subtest basic-rejected: SKIP (0.000s)
[598.112983] [084/132] (423s left) gem_exec_whisper (basic-queues)
[598.159724] Starting subtest: basic-queues
[603.489451] Subtest basic-queues: SUCCESS (5.326s)
[603.685567] [085/132] (417s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[603.787812] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[603.790213] Starting dynamic subtest: pipe-A-default-mode
[604.977582] Dynamic subtest pipe-A-default-mode: SKIP (1.188s)
[604.981794] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.190s)
[605.138861] [086/132] (416s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[605.700739] Starting subtest: syncobj-timeline-invalid-wait
[605.703211] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[607.055060] [087/132] (414s left) sysfs_heartbeat_interval (nopreempt)
[607.110245] Starting subtest: nopreempt
[607.112495] Starting dynamic subtest: vecs0
[616.964856] Dynamic subtest vecs0: SUCCESS (9.848s)
[616.976658] Starting dynamic subtest: ccs0
[620.921657] Dynamic subtest ccs0: SUCCESS (3.959s)
[620.933785] Starting dynamic subtest: vcs0
[630.985784] Dynamic subtest vcs0: SUCCESS (10.063s)
[631.007755] Starting dynamic subtest: bcs0
[634.949391] Dynamic subtest bcs0: SUCCESS (3.961s)
[634.961733] Starting dynamic subtest: rcs0
[639.006359] Dynamic subtest rcs0: SUCCESS (4.055s)
[639.020670] Starting dynamic subtest: vcs1
[648.959161] Dynamic subtest vcs1: SUCCESS (9.948s)
[648.961750] Subtest nopreempt: SUCCESS (41.845s)
[649.035559] [088/132] (372s left) gem_flink_basic (flink-lifetime)
[649.088293] Starting subtest: flink-lifetime
[649.090671] Subtest flink-lifetime: SUCCESS (0.002s)
[649.198270] [089/132] (372s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[649.303085] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[649.307226] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[649.404638] [090/132] (372s left) fbdev (eof)
[649.457339] Starting subtest: eof
[649.459743] Subtest eof: SUCCESS (0.000s)
[649.524783] [091/132] (372s left) gem_exec_reloc (basic-concurrent16)
[649.580446] Subtest basic-concurrent16: SKIP (0.000s)
[649.651538] [092/132] (372s left) gem_exec_params (invalid-bsd1-flag-on-render)
[649.707120] Starting subtest: invalid-bsd1-flag-on-render
[649.709315] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[649.806162] [093/132] (372s left) gem_ctx_engines (independent)
[649.862637] Starting subtest: independent
[649.865015] Starting dynamic subtest: rcs0
[650.013039] Dynamic subtest rcs0: SUCCESS (0.149s)
[650.023088] Starting dynamic subtest: bcs0
[650.159901] Dynamic subtest bcs0: SUCCESS (0.145s)
[650.173230] Starting dynamic subtest: vcs0
[650.310102] Dynamic subtest vcs0: SUCCESS (0.149s)
[650.322603] Starting dynamic subtest: vcs1
[650.483691] Dynamic subtest vcs1: SUCCESS (0.172s)
[650.496568] Starting dynamic subtest: vecs0
[650.671200] Dynamic subtest vecs0: SUCCESS (0.187s)
[650.681125] Starting dynamic subtest: ccs0
[650.834208] Dynamic subtest ccs0: SUCCESS (0.162s)
[650.846902] Starting dynamic subtest: all-engines
[651.564845] Dynamic subtest all-engines: SUCCESS (0.730s)
[651.567390] Subtest independent: SUCCESS (1.702s)
[652.090669] [094/132] (369s left) gem_flink_basic (bad-flink)
[652.141329] Starting subtest: bad-flink
[652.143248] Subtest bad-flink: SUCCESS (0.000s)
[652.241297] [095/132] (369s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[652.334378] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[652.338705] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[652.429987] [096/132] (369s left) gem_ctx_persistence (engines-cleanup)
[652.481702] Starting subtest: engines-cleanup
[652.483946] Starting dynamic subtest: rcs0
[652.543816] Dynamic subtest rcs0: SUCCESS (0.064s)
[652.555868] Starting dynamic subtest: bcs0
[652.591533] Dynamic subtest bcs0: SUCCESS (0.046s)
[652.602959] Starting dynamic subtest: vcs0
[652.630501] Dynamic subtest vcs0: SUCCESS (0.037s)
[652.640636] Starting dynamic subtest: vcs1
[652.671320] Dynamic subtest vcs1: SUCCESS (0.039s)
[652.681747] Starting dynamic subtest: vecs0
[652.707328] Dynamic subtest vecs0: SUCCESS (0.034s)
[652.717475] Starting dynamic subtest: ccs0
[652.742343] Dynamic subtest ccs0: SUCCESS (0.033s)
[652.744644] Subtest engines-cleanup: SUCCESS (0.264s)
[652.835961] [097/132] (369s left) gem_madvise (dontneed-before-exec)
[652.886088] Starting subtest: dontneed-before-exec
[652.901216] Subtest dontneed-before-exec: SKIP (0.013s)
[652.957128] [098/132] (369s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[653.049416] Starting subtest: primary-y-tiled-reflect-x-90
[653.053431] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[653.123087] [099/132] (369s left) gem_exec_fence (basic-busy-all)
[653.187301] Starting subtest: basic-busy-all
[653.253014] Subtest basic-busy-all: SUCCESS (0.068s)
[655.055379] [100/132] (367s left) kms_psr (psr2-no-drrs)
[655.150066] Starting subtest: psr2-no-drrs
[655.152345] Starting dynamic subtest: eDP-1
[656.712722] Dynamic subtest eDP-1: SUCCESS (1.562s)
[656.715040] Subtest psr2-no-drrs: SUCCESS (1.563s)
[657.503301] [101/132] (364s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[657.602083] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[657.604328] Starting dynamic subtest: pipe-A-eDP-1
[657.697757] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[657.709104] Starting dynamic subtest: pipe-B-eDP-1
[658.878614] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[658.882965] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.281s)
[660.081026] [102/132] (362s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[660.172621] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[660.177038] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[661.312278] [103/132] (361s left) gem_exec_balancer (individual)
[661.382978] Starting subtest: individual
[662.969858] Subtest individual: SUCCESS (1.585s)
[663.302230] [104/132] (359s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[663.401703] Starting subtest: yf-tiled-32bpp-rotate-180
[663.405965] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[663.514031] [105/132] (359s left) gem_pxp (protected-raw-src-copy-not-readible)
[663.639772] Starting subtest: protected-raw-src-copy-not-readible
[663.696425] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[663.822464] [106/132] (358s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[663.871779] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[663.972866] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[664.055723] [107/132] (358s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[664.138581] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[664.140738] Starting dynamic subtest: pipe-A
[664.162217] Dynamic subtest pipe-A: SKIP (0.017s)
[664.174356] Starting dynamic subtest: pipe-B
[664.189122] Dynamic subtest pipe-B: SKIP (0.031s)
[664.198754] Starting dynamic subtest: pipe-C
[664.220301] Dynamic subtest pipe-C: SKIP (0.031s)
[664.229556] Starting dynamic subtest: pipe-D
[664.253301] Dynamic subtest pipe-D: SKIP (0.031s)
[664.256730] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.112s)
[664.356009] [108/132] (358s left) gem_exec_params (no-blt)
[664.411721] Starting subtest: no-blt
[664.413586] Subtest no-blt: SUCCESS (0.002s)
[664.524727] [109/132] (358s left) kms_cursor_crc (cursor-sliding-256x256)
[664.771619] Starting subtest: cursor-sliding-256x256
[664.773507] Starting dynamic subtest: pipe-A-eDP-1
[667.983700] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.209s)
[668.012623] Starting dynamic subtest: pipe-D-eDP-1
[671.884505] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.878s)
[671.886426] Subtest cursor-sliding-256x256: SUCCESS (7.112s)
[672.686883] [110/132] (350s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[672.787412] Starting subtest: 4-tiled-16bpp-rotate-180
[674.166362] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.379s)
[674.302009] [111/132] (348s left) syncobj_wait (invalid-reset-zero-handles)
[674.366500] Starting subtest: invalid-reset-zero-handles
[674.368517] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[674.463673] [112/132] (348s left) kms_cursor_crc (cursor-onscreen-32x10)
[674.621125] Starting subtest: cursor-onscreen-32x10
[674.670372] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[674.927785] [113/132] (347s left) gem_pread (display)
[674.984988] Subtest display: SKIP (0.000s)
[675.042060] [114/132] (347s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[675.135901] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[679.216359] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.082s)
[680.396780] [115/132] (342s left) gem_ctx_persistence (legacy-engines-queued)
[680.453254] Starting subtest: legacy-engines-queued
[680.455711] Starting dynamic subtest: render
[680.501933] Dynamic subtest render: SUCCESS (0.049s)
[680.511623] Starting dynamic subtest: bsd1
[681.954776] Dynamic subtest bsd1: SUCCESS (1.449s)
[681.968065] Starting dynamic subtest: bsd2
[683.936158] Dynamic subtest bsd2: SUCCESS (1.977s)
[683.952199] Starting dynamic subtest: blt
[683.983524] Dynamic subtest blt: SUCCESS (0.045s)
[683.995498] Starting dynamic subtest: vebox
[685.920406] Dynamic subtest vebox: SUCCESS (1.933s)
[685.923473] Subtest legacy-engines-queued: SUCCESS (5.467s)
[686.007857] [116/132] (336s left) drm_read (invalid-buffer)
[686.157006] Starting subtest: invalid-buffer
[686.159471] Subtest invalid-buffer: SUCCESS (0.000s)
[686.296141] [117/132] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[686.396640] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[686.401054] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[686.505317] [118/132] (336s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[686.612641] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[686.617037] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[686.734513] [119/132] (336s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[686.844829] Starting subtest: psr2-overlay-plane-update-continuous-sf
[686.847353] Starting dynamic subtest: pipe-A-eDP-1
[687.977150] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.137s)
[687.987010] Starting dynamic subtest: pipe-B-eDP-1
[689.730219] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.752s)
[689.732142] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.891s)
[690.536556] [120/132] (332s left) gen9_exec_parse (unaligned-jump)
[690.599271] Subtest unaligned-jump: SKIP (0.000s)
[690.668458] [121/132] (332s left) kms_vblank (ts-continuation-idle)
[690.754040] Starting subtest: ts-continuation-idle
[690.755847] Starting dynamic subtest: pipe-A-eDP-1
[691.159669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[691.175213] Starting dynamic subtest: pipe-D-eDP-1
[692.216416] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.055s)
[692.218828] Subtest ts-continuation-idle: SUCCESS (1.463s)
[693.085775] [122/132] (330s left) i915_drm_fdinfo (virtual-busy-hang-all)
[693.128957] Starting subtest: virtual-busy-hang-all
[693.133682] Subtest virtual-busy-hang-all: SKIP (0.000s)
[693.195349] [123/132] (330s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[693.304517] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[693.308906] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[693.404547] [124/132] (329s left) gem_exec_reloc (basic-wc-cpu)
[693.463477] Subtest basic-wc-cpu: SKIP (0.000s)
[693.541403] [125/132] (329s left) kms_flip (dpms-vs-vblank-race)
[693.640591] Starting subtest: dpms-vs-vblank-race
[693.642891] Starting dynamic subtest: A-eDP1
[697.451121] Dynamic subtest A-eDP1: SUCCESS (3.810s)
[697.460991] Starting dynamic subtest: B-eDP1
[700.974276] Dynamic subtest B-eDP1: SUCCESS (3.521s)
[700.985053] Starting dynamic subtest: C-eDP1
[705.562328] Dynamic subtest C-eDP1: SUCCESS (4.586s)
[705.573651] Starting dynamic subtest: D-eDP1
[710.201754] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[710.204048] Subtest dpms-vs-vblank-race: SUCCESS (16.566s)
[711.076484] [126/132] (312s left) kms_chamelium_hpd (common-hpd-after-suspend)
[711.468719] Subtest common-hpd-after-suspend: SKIP (0.000s)
[712.293804] [127/132] (311s left) gem_userptr_blits (unsync-unmap)
[712.345315] Subtest unsync-unmap: SKIP (0.000s)
[712.469464] [128/132] (311s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[712.564993] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[719.494178] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.931s)
[719.610166] [129/132] (303s left) gem_exec_reloc (basic-cpu-read-noreloc)
[719.679712] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[719.749475] [130/132] (303s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[719.872899] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[719.877498] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[720.024225] [131/132] (303s left) api_intel_bb (object-noreloc-purge-cache-simple)
[720.091889] Starting subtest: object-noreloc-purge-cache-simple
[720.096506] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[720.213948] [132/132] (303s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[720.309771] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[726.964712] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.657s)
[727.098456] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_shared
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_exec_flush
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_sequence
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_plane_lowres
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_selftest
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: api_intel_allocator
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_render_linear_blits
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: gem_huc_copy
results: parsing output: 57/ for test: kms_hdr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_properties
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_tiled_wb
results: parsing output: 68/ for test: prime_busy
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: kms_atomic_transition
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gen7_exec_parse
results: parsing output: 83/ for test: gem_exec_whisper
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: gem_flink_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: fbdev
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: gem_ctx_engines
results: parsing output: 93/ for test: gem_flink_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: gem_madvise
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: gem_pread
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: drm_read
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.