[58.475581] Initializing watchdogs
[58.475704]   /dev/watchdog0
[58.491373] [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]
[58.495800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.498072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.501351] [001/131] (960s left) gen9_exec_parse (bb-chained)
[58.584834] Subtest bb-chained: SKIP (0.000s)
[58.657627] [002/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[58.752255] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[58.754581] Starting dynamic subtest: pipe-A-eDP-1
[58.776958] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.784660] Starting dynamic subtest: pipe-B-eDP-1
[58.806402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.813096] Starting dynamic subtest: pipe-C-eDP-1
[58.836299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.843765] Starting dynamic subtest: pipe-D-eDP-1
[58.865090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.869503] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[60.976558] [003/131] (958s left) kms_properties (crtc-properties-atomic)
[61.068541] Starting subtest: crtc-properties-atomic
[61.070822] Starting dynamic subtest: pipe-A-eDP-1
[61.548064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[61.560155] Starting dynamic subtest: pipe-B-eDP-1
[62.737839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.186s)
[62.746926] Starting dynamic subtest: pipe-C-eDP-1
[63.864719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[63.873624] Starting dynamic subtest: pipe-D-eDP-1
[64.993420] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[64.995342] Subtest crtc-properties-atomic: SUCCESS (3.915s)
[65.832916] [004/131] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[65.947047] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[65.951295] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.059685] [005/131] (953s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[66.150657] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[66.152880] Starting dynamic subtest: pipe-A-default-mode
[66.438662] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[66.443256] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.287s)
[67.257579] [006/131] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[67.364430] Starting subtest: psr-1p-primscrn-cur-indfb-move
[74.779870] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.413s)
[74.958972] [007/131] (944s left) kms_psr (psr2-primary-mmap-cpu)
[75.064569] Starting subtest: psr2-primary-mmap-cpu
[75.066885] Starting dynamic subtest: eDP-1
[76.779144] Dynamic subtest eDP-1: SUCCESS (1.714s)
[76.781500] Subtest psr2-primary-mmap-cpu: SUCCESS (1.714s)
[77.666929] [008/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[77.763564] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[77.767813] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[77.869634] [009/131] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[77.971250] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[77.975603] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[78.076451] [010/131] (941s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[78.180263] Starting subtest: 4-tiled-addfb-size-offset-overflow
[78.182538] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[78.292669] [011/131] (941s left) gem_eio (wait-immediate)
[78.456404] Starting subtest: wait-immediate
[78.699334] Subtest wait-immediate: SUCCESS (0.244s)
[78.875247] [012/131] (940s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[83.880486] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[83.885601] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[84.743087] [013/131] (934s left) gem_exec_alignment (many)
[84.801380] Starting subtest: many
[106.875342] Subtest many: SUCCESS (22.070s)
[107.897232] [014/131] (911s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[108.054398] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[112.606980] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.555s)
[113.741274] [015/131] (905s left) kms_psr (fbc-psr-cursor-blt)
[113.823427] Starting subtest: fbc-psr-cursor-blt
[113.825607] Starting dynamic subtest: eDP-1
[113.829576] Dynamic subtest eDP-1: SKIP (0.000s)
[113.833580] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[113.917740] [016/131] (905s left) gem_fence_thrash (bo-write-verify-threaded-y)
[113.951997] Starting subtest: bo-write-verify-threaded-y
[113.967589] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[114.035794] [017/131] (905s left) fbdev (unaligned-read)
[114.073893] Starting subtest: unaligned-read
[114.089390] Subtest unaligned-read: SUCCESS (0.015s)
[114.167809] [018/131] (905s left) kms_lease (lease-unleased-crtc)
[114.260305] Starting subtest: lease-unleased-crtc
[114.262631] Starting dynamic subtest: pipe-A-eDP-1
[114.547091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[114.555818] Starting dynamic subtest: pipe-B-eDP-1
[115.270728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.721s)
[115.281206] Starting dynamic subtest: pipe-C-eDP-1
[115.283491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[115.291062] Starting dynamic subtest: pipe-D-eDP-1
[115.292922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[115.294808] Subtest lease-unleased-crtc: SUCCESS (1.022s)
[115.652155] [019/131] (904s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[115.764069] Starting subtest: x-tiled-16bpp-rotate-0
[117.176423] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.412s)
[117.343872] [020/131] (902s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[122.358841] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[122.363821] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[123.204194] [021/131] (896s left) gem_exec_balancer (bonded-false-hang)
[123.465335] Starting subtest: bonded-false-hang
[123.470589] Subtest bonded-false-hang: SKIP (0.000s)
[123.589227] [022/131] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[123.703471] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[130.304706] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.604s)
[130.464075] [023/131] (889s left) gem_exec_params (mmapped)
[130.530709] Starting subtest: mmapped
[130.532661] Subtest mmapped: SUCCESS (0.003s)
[130.694718] [024/131] (889s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[130.804645] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[137.961777] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.162s)
[139.146106] [025/131] (880s left) gem_mmap_gtt (cpuset-big-copy)
[139.210204] Subtest cpuset-big-copy: SKIP (0.000s)
[139.275955] [026/131] (880s left) kms_psr (fbc-psr2-sprite-blt)
[139.365856] Starting subtest: fbc-psr2-sprite-blt
[139.368164] Starting dynamic subtest: eDP-1
[139.372488] Dynamic subtest eDP-1: SKIP (0.000s)
[139.376886] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[139.460849] [027/131] (880s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[139.549028] Starting subtest: flip-primary-invalidate-overlay
[151.147119] Subtest flip-primary-invalidate-overlay: SUCCESS (11.600s)
[151.342313] [028/131] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[151.445487] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[151.448835] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[151.577525] [029/131] (868s left) kms_getfb (getfb-handle-protection)
[151.672125] Starting subtest: getfb-handle-protection
[151.699442] Subtest getfb-handle-protection: SUCCESS (0.027s)
[151.827632] [030/131] (868s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[151.894230] Starting subtest: multi-wait-all-for-submit-submitted
[151.999724] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[152.087267] [031/131] (868s left) kms_flip (2x-plain-flip-ts-check)
[152.185974] Starting subtest: 2x-plain-flip-ts-check
[152.197815] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[152.282539] [032/131] (867s left) gem_pxp (reject-modify-context-protection-on)
[152.403420] Starting subtest: reject-modify-context-protection-on
[152.405845] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[152.518830] [033/131] (867s left) kms_chamelium_audio (dp-audio-edid)
[152.897646] Subtest dp-audio-edid: SKIP (0.000s)
[153.726835] [034/131] (866s left) sysfs_timeslice_duration (timeout)
[153.787285] Starting subtest: timeout
[153.789440] Starting dynamic subtest: vecs0
[162.907376] Dynamic subtest vecs0: SUCCESS (9.115s)
[162.918715] Starting dynamic subtest: ccs0
[164.396082] Dynamic subtest ccs0: SUCCESS (1.490s)
[164.408911] Starting dynamic subtest: vcs0
[173.919715] Dynamic subtest vcs0: SUCCESS (9.517s)
[173.928354] Starting dynamic subtest: bcs0
[174.684384] Dynamic subtest bcs0: SUCCESS (0.763s)
[174.694284] Starting dynamic subtest: rcs0
[176.014051] Dynamic subtest rcs0: SUCCESS (1.327s)
[176.024788] Starting dynamic subtest: vcs1
[185.892449] Dynamic subtest vcs1: SUCCESS (9.875s)
[185.894934] Subtest timeout: SUCCESS (32.101s)
[185.977968] [035/131] (834s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[186.030065] Starting subtest: invalid-bsd2-flag-on-vebox
[186.032195] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[186.149363] [036/131] (834s left) gem_exercise_blt (fast-copy-emit)
[186.199664] Starting subtest: fast-copy-emit
[186.201909] Starting dynamic subtest: linear-smem-smem-emit
[186.227019] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s)
[186.235217] Starting dynamic subtest: xmajor-smem-smem-emit
[186.250738] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.023s)
[186.259014] Starting dynamic subtest: tile4-smem-smem-emit
[186.271410] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.020s)
[186.282769] Starting dynamic subtest: tile64-smem-smem-emit
[186.293033] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.021s)
[186.295359] Subtest fast-copy-emit: SUCCESS (0.093s)
[186.439310] [037/131] (833s left) kms_plane_multiple (2x-tiling-4)
[186.541168] Starting subtest: 2x-tiling-4
[186.545282] Subtest 2x-tiling-4: SKIP (0.000s)
[186.618725] [038/131] (833s left) dmabuf_sync_file (export-before-signal)
[186.733625] Starting subtest: export-before-signal
[186.735907] Subtest export-before-signal: SUCCESS (0.002s)
[186.798469] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[186.801525] [039/131] (833s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[186.893316] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[186.895937] Starting dynamic subtest: pipe-A-eDP-1
[186.945564] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[186.955069] Starting dynamic subtest: pipe-B-eDP-1
[187.002049] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[187.011472] Starting dynamic subtest: pipe-C-eDP-1
[187.061455] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[187.071279] Starting dynamic subtest: pipe-D-eDP-1
[187.121756] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[187.125524] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[189.219136] [040/131] (831s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[189.322323] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[189.326530] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[189.450080] [041/131] (831s left) i915_pm_rpm (gem-pread)
[191.084620] Starting subtest: gem-pread
[193.406313] Subtest gem-pread: SUCCESS (2.325s)
[193.521812] [042/131] (827s left) prime_vgem (fence-wait)
[193.589978] Starting subtest: fence-wait
[193.592346] Starting dynamic subtest: rcs0
[194.643859] Dynamic subtest rcs0: SUCCESS (1.052s)
[194.654762] Starting dynamic subtest: bcs0
[195.725041] Dynamic subtest bcs0: SUCCESS (1.080s)
[195.736257] Starting dynamic subtest: vcs0
[196.769263] Dynamic subtest vcs0: SUCCESS (1.043s)
[196.779417] Starting dynamic subtest: vcs1
[197.810012] Dynamic subtest vcs1: SUCCESS (1.039s)
[197.821631] Starting dynamic subtest: vecs0
[198.855222] Dynamic subtest vecs0: SUCCESS (1.043s)
[198.866030] Starting dynamic subtest: ccs0
[199.899961] Dynamic subtest ccs0: SUCCESS (1.043s)
[199.902760] Subtest fence-wait: SUCCESS (6.309s)
[200.076941] [043/131] (820s left) syncobj_timeline (invalid-wait-bad-flags)
[200.135861] Starting subtest: invalid-wait-bad-flags
[200.138157] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[200.259313] [044/131] (820s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[200.351317] Starting subtest: fbcpsr-rgb565-draw-render
[207.441373] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.092s)
[207.611771] [045/131] (813s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[207.674216] Starting subtest: wait-all-for-submit-delayed-submit
[207.775898] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[207.866420] [046/131] (812s left) gem_exec_flush (basic-wb-rw-default)
[207.933437] Starting subtest: basic-wb-rw-default
[213.384379] Subtest basic-wb-rw-default: SUCCESS (5.452s)
[213.582807] [047/131] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[213.698141] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[213.702105] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.819175] [048/131] (807s left) kms_pipe_crc_basic (suspend-read-crc)
[213.916732] Starting subtest: suspend-read-crc
[213.918951] Starting dynamic subtest: pipe-A-eDP-1
[231.927751] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.115s)
[231.937676] Starting dynamic subtest: pipe-B-eDP-1
[250.675246] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.305s)
[250.685612] Starting dynamic subtest: pipe-C-eDP-1
[270.320313] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.942s)
[270.333989] Starting dynamic subtest: pipe-D-eDP-1
[288.634031] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.743s)
[288.636271] Subtest suspend-read-crc: SUCCESS (13.115s)
[298.509171] [049/131] (731s left) gem_exec_reloc (basic-gtt-wc)
[298.587820] Subtest basic-gtt-wc: SKIP (0.000s)
[298.681052] [050/131] (731s left) gem_watchdog (default-physical)
[298.750901] Starting subtest: default-physical
[300.779889] Subtest default-physical: SUCCESS (2.016s)
[300.871485] [051/131] (729s left) gem_fence_thrash (bo-write-verify-threaded-x)
[300.902924] Starting subtest: bo-write-verify-threaded-x
[300.925148] Subtest bo-write-verify-threaded-x: SKIP (0.018s)
[300.987429] [052/131] (729s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[301.095082] Starting subtest: fbc-rgb565-draw-blt
[305.311184] Subtest fbc-rgb565-draw-blt: SUCCESS (4.191s)
[306.459757] [053/131] (723s left) kms_universal_plane (disable-primary-vs-flip)
[306.558803] Starting subtest: disable-primary-vs-flip
[306.561499] Starting dynamic subtest: pipe-A-eDP-1
[308.094166] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.528s)
[308.105532] Starting dynamic subtest: pipe-B-eDP-1
[310.270256] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.169s)
[310.280668] Starting dynamic subtest: pipe-C-eDP-1
[312.459711] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.184s)
[312.470403] Starting dynamic subtest: pipe-D-eDP-1
[314.647342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.180s)
[314.649542] Subtest disable-primary-vs-flip: SUCCESS (8.067s)
[315.466052] [054/131] (714s left) kms_cursor_edge_walk (128x128-top-edge)
[315.562644] Starting subtest: 128x128-top-edge
[315.564942] Starting dynamic subtest: pipe-A-eDP-1
[319.019006] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[319.030063] Starting dynamic subtest: pipe-D-eDP-1
[322.148569] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[322.150834] Subtest 128x128-top-edge: SUCCESS (6.580s)
[322.962042] [055/131] (707s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[323.080155] Starting subtest: flip-vs-cursor-busy-crc-legacy
[323.883539] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.803s)
[324.705302] [056/131] (705s left) kms_flip (modeset-vs-vblank-race-interruptible)
[324.804874] Starting subtest: modeset-vs-vblank-race-interruptible
[324.807267] Starting dynamic subtest: A-eDP1
[329.517541] Dynamic subtest A-eDP1: SUCCESS (4.707s)
[329.529862] Starting dynamic subtest: B-eDP1
[334.168298] Dynamic subtest B-eDP1: SUCCESS (4.649s)
[334.182302] Starting dynamic subtest: C-eDP1
[338.781749] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[338.791265] Starting dynamic subtest: D-eDP1
[343.314809] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[343.317101] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.511s)
[344.579535] [057/131] (685s left) perf_pmu (busy-start)
[344.619882] Starting subtest: busy-start
[344.621724] Starting dynamic subtest: rcs0
[347.168592] Dynamic subtest rcs0: SUCCESS (2.550s)
[347.180988] Starting dynamic subtest: bcs0
[349.717587] Dynamic subtest bcs0: SUCCESS (2.546s)
[349.730223] Starting dynamic subtest: vcs0
[353.524284] Dynamic subtest vcs0: SUCCESS (3.802s)
[353.537174] Starting dynamic subtest: vcs1
[357.492911] Dynamic subtest vcs1: SUCCESS (3.965s)
[357.505613] Starting dynamic subtest: vecs0
[361.524646] Dynamic subtest vecs0: SUCCESS (4.029s)
[361.536590] Starting dynamic subtest: ccs0
[364.075050] Dynamic subtest ccs0: SUCCESS (2.548s)
[364.077619] Subtest busy-start: SUCCESS (19.454s)
[364.210268] [058/131] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[364.316873] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[370.842122] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.525s)
[370.999554] [059/131] (659s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[371.107694] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[371.109979] Starting dynamic subtest: pipe-A-eDP-1
[388.214985] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.848s)
[388.226501] Starting dynamic subtest: pipe-B-eDP-1
[406.186508] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.836s)
[406.199623] Starting dynamic subtest: pipe-C-eDP-1
[424.122533] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.695s)
[424.149926] Starting dynamic subtest: pipe-D-eDP-1
[442.123212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[442.125489] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.145s)
[449.346200] [060/131] (587s left) kms_flip (2x-flip-vs-expired-vblank)
[449.432845] Starting subtest: 2x-flip-vs-expired-vblank
[449.443973] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[449.563829] [061/131] (586s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[449.681200] Starting subtest: basic-flip-before-cursor-atomic
[450.611563] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s)
[451.476000] [062/131] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[451.577499] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[451.581635] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[451.718127] [063/131] (584s left) gem_ctx_param (basic)
[451.777305] Starting subtest: basic
[451.779793] Subtest basic: SUCCESS (0.001s)
[451.924901] [064/131] (584s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[452.026489] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[452.028775] Starting dynamic subtest: pipe-A-default-mode
[452.343523] Dynamic subtest pipe-A-default-mode: SKIP (0.310s)
[452.347855] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.312s)
[453.139232] [065/131] (583s left) gem_create (create-ext-placement-each)
[453.307810] Starting subtest: create-ext-placement-each
[453.310446] Subtest create-ext-placement-each: SUCCESS (0.000s)
[453.437803] [066/131] (583s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[453.809318] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[454.649868] [067/131] (582s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[454.758489] Starting subtest: extended-pageflip-modeset-hang-oldfb
[454.760639] Starting dynamic subtest: pipe-A
[462.686960] Dynamic subtest pipe-A: SUCCESS (7.893s)
[462.699128] Starting dynamic subtest: pipe-D
[471.314433] Dynamic subtest pipe-D: SUCCESS (8.609s)
[471.317318] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.507s)
[472.192075] [068/131] (564s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[472.252207] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[472.254486] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[472.375116] [069/131] (564s left) api_intel_bb (add-remove-objects)
[472.426633] Starting subtest: add-remove-objects
[472.432162] Subtest add-remove-objects: SUCCESS (0.007s)
[472.601444] [070/131] (564s left) gem_exec_fence (keep-in-fence)
[472.772260] Starting subtest: keep-in-fence
[472.774503] Starting dynamic subtest: rcs0
[472.839554] Dynamic subtest rcs0: SUCCESS (0.067s)
[472.851770] Starting dynamic subtest: bcs0
[472.893535] Dynamic subtest bcs0: SUCCESS (0.052s)
[472.905738] Starting dynamic subtest: vcs0
[474.362640] Dynamic subtest vcs0: SUCCESS (1.464s)
[474.375334] Starting dynamic subtest: vcs1
[476.409949] Dynamic subtest vcs1: SUCCESS (2.043s)
[476.423000] Starting dynamic subtest: vecs0
[478.395512] Dynamic subtest vecs0: SUCCESS (1.982s)
[478.408518] Starting dynamic subtest: ccs0
[478.625133] Dynamic subtest ccs0: SUCCESS (0.228s)
[478.627532] Subtest keep-in-fence: SUCCESS (5.849s)
[480.494786] [071/131] (556s left) api_intel_bb (destroy-bb)
[480.559109] Starting subtest: destroy-bb
[480.575590] Subtest destroy-bb: SUCCESS (0.014s)
[480.683822] [072/131] (556s left) kms_psr (fbc-pr-cursor-render)
[480.790436] Starting subtest: fbc-pr-cursor-render
[480.794342] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[480.883833] [073/131] (556s left) gem_softpin (safe-alignment)
[480.947676] Starting subtest: safe-alignment
[480.976951] Subtest safe-alignment: SUCCESS (0.029s)
[482.417666] [074/131] (554s left) i915_hangman (gt-engine-error)
[482.493428] Starting subtest: gt-engine-error
[482.495645] Starting dynamic subtest: rcs0
[484.376152] Dynamic subtest rcs0: SUCCESS (1.885s)
[484.387973] Starting dynamic subtest: bcs0
[486.359844] Dynamic subtest bcs0: SUCCESS (1.981s)
[486.373685] Starting dynamic subtest: vcs0
[488.343743] Dynamic subtest vcs0: SUCCESS (1.982s)
[488.356408] Starting dynamic subtest: vcs1
[490.328157] Dynamic subtest vcs1: SUCCESS (1.982s)
[490.341463] Starting dynamic subtest: vecs0
[492.375659] Dynamic subtest vecs0: SUCCESS (2.045s)
[492.388668] Starting dynamic subtest: ccs0
[494.361594] Dynamic subtest ccs0: SUCCESS (1.984s)
[494.364441] Subtest gt-engine-error: SUCCESS (11.873s)
[494.455115] [075/131] (542s left) kms_cursor_crc (cursor-onscreen-512x512)
[494.721948] Starting subtest: cursor-onscreen-512x512
[494.726093] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[494.873379] [076/131] (542s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[494.964373] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[494.966673] Starting dynamic subtest: pipe-A
[495.026593] Dynamic subtest pipe-A: SUCCESS (0.065s)
[495.038843] Starting dynamic subtest: pipe-B
[496.203009] Dynamic subtest pipe-B: SUCCESS (1.176s)
[496.214701] Starting dynamic subtest: pipe-C
[497.313542] Dynamic subtest pipe-C: SUCCESS (1.108s)
[497.330650] Starting dynamic subtest: pipe-D
[498.446915] Dynamic subtest pipe-D: SUCCESS (1.131s)
[498.449221] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.485s)
[499.651534] [077/131] (537s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[499.764210] Starting subtest: flip-vs-cursor-busy-crc-atomic
[500.576206] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s)
[501.464138] [078/131] (535s left) kms_dp_link_training (uhbr-sst)
[501.565362] Starting subtest: uhbr-sst
[501.574074] Subtest uhbr-sst: SKIP (0.000s)
[501.664125] [079/131] (535s left) perf (blocking-parameterized)
[501.805571] Starting subtest: blocking-parameterized
[521.827078] Subtest blocking-parameterized: SUCCESS (20.015s)
[521.877316] [080/131] (515s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[521.973702] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[521.978091] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[522.090647] [081/131] (515s left) vgem_basic (sysfs)
[522.138841] Starting subtest: sysfs
[522.140836] Subtest sysfs: SUCCESS (0.000s)
[522.212105] [082/131] (515s left) gem_ctx_persistence (engines-hostile)
[522.272819] Starting subtest: engines-hostile
[522.275028] Starting dynamic subtest: rcs0
[522.449622] Dynamic subtest rcs0: SUCCESS (0.176s)
[522.461646] Starting dynamic subtest: bcs0
[522.559468] Dynamic subtest bcs0: SUCCESS (0.108s)
[522.572207] Starting dynamic subtest: vcs0
[522.665148] Dynamic subtest vcs0: SUCCESS (0.104s)
[522.675181] Starting dynamic subtest: vcs1
[522.780766] Dynamic subtest vcs1: SUCCESS (0.113s)
[522.794185] Starting dynamic subtest: vecs0
[522.885605] Dynamic subtest vecs0: SUCCESS (0.103s)
[522.898194] Starting dynamic subtest: ccs0
[522.997932] Dynamic subtest ccs0: SUCCESS (0.111s)
[522.999981] Subtest engines-hostile: SUCCESS (0.726s)
[523.090239] [083/131] (514s left) i915_suspend (fence-restore-untiled)
[523.142076] Starting subtest: fence-restore-untiled
[523.145527] Subtest fence-restore-untiled: SKIP (0.000s)
[523.248097] [084/131] (514s left) syncobj_wait (invalid-reset-illegal-handle)
[523.289366] Starting subtest: invalid-reset-illegal-handle
[523.291266] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[523.409066] [085/131] (514s left) gem_readwrite (write-bad-handle)
[523.470340] Subtest write-bad-handle: SKIP (0.000s)
[523.538377] [086/131] (513s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[523.603276] Subtest no-spare-fences-busy: SKIP (0.000s)
[523.673534] [087/131] (513s left) gem_ctx_persistence (heartbeat-close)
[523.734210] Starting subtest: heartbeat-close
[523.737909] Subtest heartbeat-close: SKIP (0.000s)
[523.855221] [088/131] (513s left) kms_cursor_crc (cursor-onscreen-256x256)
[524.073791] Starting subtest: cursor-onscreen-256x256
[524.075848] Starting dynamic subtest: pipe-A-eDP-1
[526.199438] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[526.232003] Starting dynamic subtest: pipe-D-eDP-1
[528.954996] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.730s)
[528.957277] Subtest cursor-onscreen-256x256: SUCCESS (4.881s)
[529.840111] [089/131] (507s left) gem_ringfill (engines-basic)
[535.357905] Starting subtest: engines-basic
[535.360609] Starting dynamic subtest: rcs0
[535.447801] Dynamic subtest rcs0: SUCCESS (0.089s)
[535.460290] Starting dynamic subtest: bcs0
[535.494576] Dynamic subtest bcs0: SUCCESS (0.045s)
[535.505847] Starting dynamic subtest: vcs0
[535.538494] Dynamic subtest vcs0: SUCCESS (0.042s)
[535.549236] Starting dynamic subtest: vcs1
[535.580698] Dynamic subtest vcs1: SUCCESS (0.040s)
[535.591117] Starting dynamic subtest: vecs0
[535.622569] Dynamic subtest vecs0: SUCCESS (0.040s)
[535.633196] Starting dynamic subtest: ccs0
[535.668388] Dynamic subtest ccs0: SUCCESS (0.044s)
[535.670774] Subtest engines-basic: SUCCESS (0.312s)
[535.760922] [090/131] (501s left) kms_pm_rpm (cursor)
[537.584569] Starting subtest: cursor
[537.589511] Subtest cursor: SKIP (0.000s)
[538.084638] [091/131] (499s left) gem_pread (bench)
[538.137483] Subtest bench: SKIP (0.000s)
[538.198340] [092/131] (499s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[538.289240] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[541.866412] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.579s)
[542.995400] [093/131] (494s left) gem_exec_schedule (submit-golden-slice)
[543.062293] Starting subtest: submit-golden-slice
[543.064298] Starting dynamic subtest: rcs0
[543.094075] Dynamic subtest rcs0: SUCCESS (0.040s)
[543.106934] Starting dynamic subtest: bcs0
[543.124587] Dynamic subtest bcs0: SUCCESS (0.030s)
[543.135197] Starting dynamic subtest: vcs0
[543.163581] Dynamic subtest vcs0: SUCCESS (0.038s)
[543.174026] Starting dynamic subtest: vcs1
[543.200561] Dynamic subtest vcs1: SUCCESS (0.036s)
[543.210635] Starting dynamic subtest: vecs0
[543.231874] Dynamic subtest vecs0: SUCCESS (0.031s)
[543.245016] Starting dynamic subtest: ccs0
[543.262351] Dynamic subtest ccs0: SUCCESS (0.030s)
[543.264443] Subtest submit-golden-slice: SUCCESS (0.209s)
[544.523905] [094/131] (493s left) gem_exec_schedule (preempt-contexts)
[544.593525] Starting subtest: preempt-contexts
[544.595786] Starting dynamic subtest: rcs0
[544.646272] Dynamic subtest rcs0: SUCCESS (0.061s)
[544.658252] Starting dynamic subtest: bcs0
[544.706640] Dynamic subtest bcs0: SUCCESS (0.059s)
[544.717453] Starting dynamic subtest: vcs0
[544.758123] Dynamic subtest vcs0: SUCCESS (0.050s)
[544.769115] Starting dynamic subtest: vcs1
[544.799390] Dynamic subtest vcs1: SUCCESS (0.041s)
[544.809755] Starting dynamic subtest: vecs0
[544.841410] Dynamic subtest vecs0: SUCCESS (0.040s)
[544.852315] Starting dynamic subtest: ccs0
[544.886279] Dynamic subtest ccs0: SUCCESS (0.044s)
[544.888454] Subtest preempt-contexts: SUCCESS (0.300s)
[546.493648] [095/131] (491s left) kms_frontbuffer_tracking (psr-suspend)
[546.602009] Starting subtest: psr-suspend
[585.247047] Subtest psr-suspend: SUCCESS (8.432s)
[594.435542] [096/131] (452s left) gem_exec_capture (capture-invisible)
[594.504760] Starting subtest: capture-invisible
[594.507234] Starting dynamic subtest: smem0
[594.511844] Dynamic subtest smem0: SKIP (0.000s)
[594.516062] Subtest capture-invisible: SKIP (0.001s)
[594.652389] [097/131] (452s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[594.751834] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[594.753694] Starting dynamic subtest: pipe-A-eDP-1
[594.773334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[594.784680] Starting dynamic subtest: pipe-B-eDP-1
[594.803894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[594.814178] Starting dynamic subtest: pipe-C-eDP-1
[594.834370] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[594.844698] Starting dynamic subtest: pipe-D-eDP-1
[594.865068] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[594.867268] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[597.039880] [098/131] (449s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[597.148119] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[598.159749] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[598.329450] [099/131] (448s left) kms_big_fb (linear-64bpp-rotate-90)
[598.428214] Starting subtest: linear-64bpp-rotate-90
[598.450517] Subtest linear-64bpp-rotate-90: SKIP (0.021s)
[598.578273] [100/131] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[598.680895] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[605.273011] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.555s)
[605.412013] [101/131] (441s left) kms_content_protection (dp-mst-suspend-resume)
[605.542104] Starting subtest: dp-mst-suspend-resume
[605.546687] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[605.700523] [102/131] (441s left) kms_atomic (plane-primary-legacy)
[605.789385] Starting subtest: plane-primary-legacy
[605.791637] Starting dynamic subtest: pipe-A-eDP-1
[606.236324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[606.238652] Subtest plane-primary-legacy: SUCCESS (0.448s)
[607.141105] [103/131] (440s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[607.201410] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[607.203395] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[607.311430] [104/131] (439s left) gem_userptr_blits (unsync-unmap-after-close)
[607.369392] Subtest unsync-unmap-after-close: SKIP (0.000s)
[607.512872] [105/131] (439s left) drm_read (empty-nonblock)
[607.658831] Starting subtest: empty-nonblock
[607.661233] Subtest empty-nonblock: SUCCESS (0.000s)
[607.825932] [106/131] (439s left) gem_eio (suspend)
[608.069583] Starting subtest: suspend
[620.008067] Subtest suspend: SUCCESS (11.921s)
[632.193223] [107/131] (427s left) kms_psr (pr-primary-render)
[632.296607] Starting subtest: pr-primary-render
[632.300970] Subtest pr-primary-render: SKIP (0.000s)
[632.381634] [108/131] (427s left) kms_vblank (ts-continuation-suspend)
[632.487494] Starting subtest: ts-continuation-suspend
[632.489680] Starting dynamic subtest: pipe-A-eDP-1
[649.293101] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[649.311151] Starting dynamic subtest: pipe-D-eDP-1
[667.258464] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[667.260619] Subtest ts-continuation-suspend: SUCCESS (4.508s)
[677.138136] [109/131] (391s left) kms_flip (2x-nonexisting-fb-interruptible)
[677.244730] Starting subtest: 2x-nonexisting-fb-interruptible
[677.257564] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[677.342507] [110/131] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[677.443538] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[684.241674] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.800s)
[684.410331] [111/131] (384s left) kms_invalid_mode (uint-max-clock)
[684.527218] Starting subtest: uint-max-clock
[684.529752] Starting dynamic subtest: pipe-A-eDP-1
[684.809446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[684.830346] Starting dynamic subtest: pipe-B-eDP-1
[684.833330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[684.846574] Starting dynamic subtest: pipe-C-eDP-1
[684.849760] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[684.861634] Starting dynamic subtest: pipe-D-eDP-1
[684.864523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[684.867220] Subtest uint-max-clock: SUCCESS (0.292s)
[685.670595] [112/131] (382s left) kms_properties (get_properties-sanity-non-atomic)
[685.761490] Starting subtest: get_properties-sanity-non-atomic
[685.764301] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[685.849960] [113/131] (382s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[688.071114] Starting subtest: modeset-non-lpsp-stress-no-wait
[688.113715] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.041s)
[688.452790] [114/131] (380s left) kms_flip (flip-vs-absolute-wf_vblank)
[688.557041] Starting subtest: flip-vs-absolute-wf_vblank
[688.559763] Starting dynamic subtest: A-eDP1
[709.402092] Dynamic subtest A-eDP1: SUCCESS (20.757s)
[709.411920] Starting dynamic subtest: B-eDP1
[718.353798] Dynamic subtest B-eDP1: SUCCESS (8.938s)
[718.364271] Starting dynamic subtest: C-eDP1
[727.281286] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[727.291849] Starting dynamic subtest: D-eDP1
[736.215512] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[736.218261] Subtest flip-vs-absolute-wf_vblank: SUCCESS (47.557s)
[737.457178] [115/131] (331s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[737.513976] Starting subtest: basic-batch-kernel-default-cmd
[737.519785] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[737.710747] [116/131] (331s left) gem_exec_whisper (basic-fds-all)
[737.773152] Starting subtest: basic-fds-all
[748.828789] Subtest basic-fds-all: SUCCESS (11.052s)
[749.026234] [117/131] (319s left) kms_properties (invalid-properties-atomic)
[749.120876] Starting subtest: invalid-properties-atomic
[749.436213] Subtest invalid-properties-atomic: SUCCESS (0.317s)
[749.527282] [118/131] (319s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[749.631198] Starting subtest: plane-scaler-unity-scaling-with-rotation
[749.633532] Starting dynamic subtest: pipe-A
[749.867640] Dynamic subtest pipe-A: SUCCESS (0.240s)
[749.877566] Starting dynamic subtest: pipe-B
[751.124056] Dynamic subtest pipe-B: SUCCESS (1.255s)
[751.134739] Starting dynamic subtest: pipe-C
[752.446220] Dynamic subtest pipe-C: SUCCESS (1.320s)
[752.460502] Starting dynamic subtest: pipe-D
[753.779551] Dynamic subtest pipe-D: SUCCESS (1.333s)
[753.782339] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.152s)
[754.980277] [119/131] (313s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[755.037349] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[755.143091] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[755.234102] [120/131] (313s left) syncobj_basic (bad-pad-handle-to-fd)
[755.299774] Starting subtest: bad-pad-handle-to-fd
[755.302287] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[755.407650] [121/131] (313s left) kms_chamelium_hpd (dp-hpd)
[755.798441] Subtest dp-hpd: SKIP (0.000s)
[756.590898] [122/131] (312s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[756.689589] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[757.058903] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[758.557104] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.844s)
[758.568052] Starting dynamic subtest: pipe-A-eDP-1-4
[759.035950] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.713s)
[759.047384] Starting dynamic subtest: pipe-A-eDP-1-4
[759.241955] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.018s)
[759.253450] Starting dynamic subtest: pipe-A-eDP-1-x
[759.666084] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.678s)
[759.692354] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[761.136316] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.214s)
[761.147271] Starting dynamic subtest: pipe-B-eDP-1-4
[761.621324] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.188s)
[761.633062] Starting dynamic subtest: pipe-B-eDP-1-4
[761.821169] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.557s)
[761.831565] Starting dynamic subtest: pipe-B-eDP-1-x
[762.251456] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.186s)
[762.263046] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[764.947771] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[764.961771] Starting dynamic subtest: pipe-C-eDP-1-4
[767.123446] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.172s)
[767.135728] Starting dynamic subtest: pipe-C-eDP-1-4
[769.133990] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[769.147416] Starting dynamic subtest: pipe-C-eDP-1-x
[771.324975] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[771.689510] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[774.475083] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[774.488738] Starting dynamic subtest: pipe-D-eDP-1-4
[776.651190] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[776.669015] Starting dynamic subtest: pipe-D-eDP-1-4
[778.661648] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.007s)
[778.678994] Starting dynamic subtest: pipe-D-eDP-1-x
[780.853062] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[780.855803] Subtest async-flip-with-page-flip-events-tiled-atomic: FAIL (24.158s)
[782.085677] [123/131] (287s left) i915_drm_fdinfo (most-busy-check-all)
[782.131175] Starting subtest: most-busy-check-all
[782.133884] Starting dynamic subtest: rcs0
[782.139529] Dynamic subtest rcs0: SKIP (0.004s)
[782.156668] Starting dynamic subtest: bcs0
[782.162219] Dynamic subtest bcs0: SKIP (0.000s)
[782.174556] Starting dynamic subtest: vcs0
[782.179775] Dynamic subtest vcs0: SKIP (0.000s)
[782.189939] Starting dynamic subtest: vcs1
[782.195284] Dynamic subtest vcs1: SKIP (0.000s)
[782.205629] Starting dynamic subtest: vecs0
[782.211240] Dynamic subtest vecs0: SKIP (0.000s)
[782.221575] Starting dynamic subtest: ccs0
[782.227162] Dynamic subtest ccs0: SKIP (0.000s)
[782.232504] Subtest most-busy-check-all: SKIP (0.009s)
[782.273463] [124/131] (286s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[782.399176] Starting subtest: fb-8bpc-vs-panel-6bpc
[782.401750] Starting dynamic subtest: pipe-A-eDP-1
[783.820737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.421s)
[783.823631] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.422s)
[784.637223] [125/131] (284s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[784.752626] Starting subtest: cursorB-vs-flipA-atomic-transitions
[784.757525] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[784.900166] [126/131] (284s left) gem_set_tiling_vs_pwrite
[785.035532] [127/131] (284s left) gem_mmap (bad-object)
[785.086334] Subtest bad-object: SKIP (0.000s)
[785.148041] [128/131] (284s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[785.245578] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[785.251186] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[785.350009] [129/131] (284s left) syncobj_wait (multi-wait-for-submit-submitted)
[785.405719] Starting subtest: multi-wait-for-submit-submitted
[785.510664] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[785.600767] [130/131] (283s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[785.709589] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[785.714478] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[785.831798] [131/131] (283s left) gem_mmap_offset (isolation)
[785.892283] Starting subtest: isolation
[785.914213] Subtest isolation: SUCCESS (0.005s)
[786.037207] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_exec_alignment
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exercise_blt
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: i915_suspend
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
Done.