[55.359330] Initializing watchdogs
[55.359378]   /dev/watchdog0
[55.373871] [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]
[55.379154] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.381187] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.383191] [001/131] (960s left) kms_content_protection (dp-mst-lic-type-1)
[55.522902] Starting subtest: dp-mst-lic-type-1
[55.524976] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[55.633511] [002/131] (960s left) kms_psr (psr-sprite-render)
[55.725015] Starting subtest: psr-sprite-render
[55.725918] Starting dynamic subtest: eDP-1
[57.516560] Dynamic subtest eDP-1: SUCCESS (1.800s)
[57.517630] Subtest psr-sprite-render: SUCCESS (1.801s)
[58.340220] [003/131] (957s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[58.446166] Starting subtest: x-tiled-64bpp-rotate-90
[58.469136] Subtest x-tiled-64bpp-rotate-90: SKIP (0.023s)
[58.585568] [004/131] (957s left) sysfs_heartbeat_interval (nopreempt)
[58.640071] Starting subtest: nopreempt
[58.640912] Starting dynamic subtest: vecs0
[67.945996] Dynamic subtest vecs0: SUCCESS (9.325s)
[67.954831] Starting dynamic subtest: ccs0
[72.069150] Dynamic subtest ccs0: SUCCESS (4.126s)
[72.078218] Starting dynamic subtest: vcs0
[81.879957] Dynamic subtest vcs0: SUCCESS (9.816s)
[81.888610] Starting dynamic subtest: bcs0
[85.679606] Dynamic subtest bcs0: SUCCESS (3.799s)
[85.687888] Starting dynamic subtest: rcs0
[89.678413] Dynamic subtest rcs0: SUCCESS (3.998s)
[89.686715] Starting dynamic subtest: vcs1
[98.907728] Dynamic subtest vcs1: SUCCESS (9.228s)
[98.909467] Subtest nopreempt: SUCCESS (40.295s)
[98.975497] [005/131] (917s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[99.081483] Starting subtest: 4-tiled-32bpp-rotate-90
[99.101189] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[99.203854] [006/131] (916s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[99.301416] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[99.313161] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[99.375590] [007/131] (916s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[99.458675] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[99.459724] Starting dynamic subtest: pipe-A-eDP-1
[100.202925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[100.209815] Starting dynamic subtest: pipe-B-eDP-1
[102.056911] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.853s)
[102.063957] Starting dynamic subtest: pipe-C-eDP-1
[103.875766] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[103.882202] Starting dynamic subtest: pipe-D-eDP-1
[105.716675] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.841s)
[105.717548] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.255s)
[106.839299] [008/131] (909s left) kms_lease (cursor-implicit-plane)
[106.936673] Starting subtest: cursor-implicit-plane
[106.937741] Starting dynamic subtest: pipe-A-eDP-1
[107.392166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[107.398923] Starting dynamic subtest: pipe-B-eDP-1
[108.474836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.081s)
[108.481752] Starting dynamic subtest: pipe-C-eDP-1
[109.595471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[109.602175] Starting dynamic subtest: pipe-D-eDP-1
[110.732421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[110.733342] Subtest cursor-implicit-plane: SUCCESS (3.796s)
[111.579556] [009/131] (904s left) kms_draw_crc (draw-method-mmap-cpu)
[111.671514] Starting subtest: draw-method-mmap-cpu
[111.672520] Starting dynamic subtest: xrgb8888-untiled
[111.904146] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[111.910785] Starting dynamic subtest: rgb565-untiled
[112.081712] Dynamic subtest rgb565-untiled: SUCCESS (0.177s)
[112.088333] Starting dynamic subtest: xrgb2101010-untiled
[112.259616] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.178s)
[112.265421] Starting dynamic subtest: xbgr16161616f-untiled
[112.471354] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[112.478043] Starting dynamic subtest: xrgb8888-xtiled
[112.593220] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[112.599938] Starting dynamic subtest: rgb565-xtiled
[112.704122] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[112.712209] Starting dynamic subtest: xrgb2101010-xtiled
[112.815199] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[112.823450] Starting dynamic subtest: xbgr16161616f-xtiled
[112.937866] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[112.943753] Starting dynamic subtest: xrgb8888-4tiled
[113.059634] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[113.066785] Starting dynamic subtest: rgb565-4tiled
[113.181821] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[113.187416] Starting dynamic subtest: xrgb2101010-4tiled
[113.304206] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[113.310070] Starting dynamic subtest: xbgr16161616f-4tiled
[113.448411] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[113.449268] Subtest draw-method-mmap-cpu: SUCCESS (1.778s)
[113.541872] [010/131] (902s left) kms_addfb_basic (basic-x-tiled-legacy)
[113.598352] Starting subtest: basic-x-tiled-legacy
[113.600423] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[113.719796] [011/131] (902s left) kms_addfb_basic (bad-pitch-256)
[113.758652] Starting subtest: bad-pitch-256
[113.759757] Subtest bad-pitch-256: SUCCESS (0.000s)
[113.915022] [012/131] (902s left) gem_ctx_isolation (preservation)
[113.971849] Starting subtest: preservation
[113.972932] Starting dynamic subtest: rcs0
[114.122377] Dynamic subtest rcs0: SUCCESS (0.150s)
[114.129397] Starting dynamic subtest: bcs0
[114.284757] Dynamic subtest bcs0: SUCCESS (0.162s)
[114.293300] Starting dynamic subtest: vcs0
[114.442694] Dynamic subtest vcs0: SUCCESS (0.158s)
[114.449375] Starting dynamic subtest: vcs1
[116.076552] Dynamic subtest vcs1: SUCCESS (1.634s)
[116.082997] Starting dynamic subtest: vecs0
[118.060336] Dynamic subtest vecs0: SUCCESS (1.983s)
[118.069771] Starting dynamic subtest: ccs0
[120.053579] Dynamic subtest ccs0: SUCCESS (1.993s)
[120.054903] Subtest preservation: SUCCESS (6.081s)
[120.245296] [013/131] (895s left) perf_pmu (gt-awake)
[120.276182] Starting subtest: gt-awake
[128.921942] Subtest gt-awake: SUCCESS (8.643s)
[129.031029] [014/131] (887s left) gem_exec_fence (syncobj-export)
[129.477502] Starting subtest: syncobj-export
[129.485255] Subtest syncobj-export: SUCCESS (0.007s)
[130.956314] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[130.958060] [015/131] (885s left) gem_wait (invalid-flags)
[131.009320] Starting subtest: invalid-flags
[131.010303] Subtest invalid-flags: SUCCESS (0.000s)
[131.211225] [016/131] (885s left) gem_pwrite_snooped
[131.340537] [017/131] (885s left) kms_invalid_mode (bad-hsync-end)
[131.433535] Starting subtest: bad-hsync-end
[131.434517] Starting dynamic subtest: pipe-A-eDP-1
[131.717149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[131.724075] Starting dynamic subtest: pipe-B-eDP-1
[131.724963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[131.730877] Starting dynamic subtest: pipe-C-eDP-1
[131.731809] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[131.738374] Starting dynamic subtest: pipe-D-eDP-1
[131.739437] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[131.740334] Subtest bad-hsync-end: SUCCESS (0.287s)
[132.513097] [018/131] (883s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[132.606876] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[132.608567] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[132.707573] [019/131] (883s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[132.805416] Starting subtest: fbcpsr-indfb-scaledprimary
[140.576575] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (7.773s)
[140.702523] [020/131] (875s left) kms_psr (psr2-sprite-render)
[140.792816] Starting subtest: psr2-sprite-render
[140.793799] Starting dynamic subtest: eDP-1
[142.532226] Dynamic subtest eDP-1: SUCCESS (1.738s)
[142.533076] Subtest psr2-sprite-render: SUCCESS (1.739s)
[143.395190] [021/131] (873s left) gem_exec_balancer (bonded-true-hang)
[143.645617] Starting subtest: bonded-true-hang
[143.647959] Subtest bonded-true-hang: SKIP (0.000s)
[143.752285] [022/131] (872s left) gem_exec_balancer (semaphore)
[143.809187] Starting subtest: semaphore
[145.943457] Subtest semaphore: SUCCESS (2.134s)
[146.263590] [023/131] (870s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[146.318451] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[146.428632] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[146.498456] [024/131] (870s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[146.623163] Starting subtest: 2x-long-flip-vs-cursor-atomic
[146.625722] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[146.768601] [025/131] (869s left) kms_color (ctm-max)
[146.854791] Starting subtest: ctm-max
[146.855815] Starting dynamic subtest: pipe-A-eDP-1
[147.559128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[147.565848] Starting dynamic subtest: pipe-B-eDP-1
[148.997523] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[149.007227] Starting dynamic subtest: pipe-C-eDP-1
[150.353654] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[150.362536] Starting dynamic subtest: pipe-D-eDP-1
[151.697186] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[151.698124] Subtest ctm-max: SUCCESS (4.839s)
[152.537649] [026/131] (864s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[152.631947] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[156.265917] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.634s)
[157.452519] [027/131] (859s left) kms_fb_coherency (memset-crc)
[157.544180] Starting subtest: memset-crc
[157.545079] Starting dynamic subtest: mmap-offset-wc
[157.918821] Dynamic subtest mmap-offset-wc: SUCCESS (0.376s)
[158.218863] Starting dynamic subtest: mmap-offset-uc
[164.381408] Dynamic subtest mmap-offset-uc: SUCCESS (6.170s)
[164.670746] Subtest memset-crc: SUCCESS (7.127s)
[165.517760] [028/131] (851s left) kms_pm_backlight (brightness-with-dpms)
[165.611369] Starting subtest: brightness-with-dpms
[165.663192] Starting dynamic subtest: eDP-1
[168.028316] Dynamic subtest eDP-1: SUCCESS (2.365s)
[168.029326] Subtest brightness-with-dpms: SUCCESS (2.418s)
[168.869347] [029/131] (847s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[168.961761] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[168.963336] Starting dynamic subtest: pipe-A-eDP-1
[169.104208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[169.113051] Starting dynamic subtest: pipe-B-eDP-1
[169.121403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[169.128150] Starting dynamic subtest: pipe-C-eDP-1
[169.135920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[169.142550] Starting dynamic subtest: pipe-D-eDP-1
[169.149985] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[169.150846] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[171.384818] [030/131] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[171.478893] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[175.702925] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.225s)
[176.870601] [031/131] (839s left) kms_vblank (query-forked-hang)
[176.964103] Starting subtest: query-forked-hang
[176.965287] Starting dynamic subtest: pipe-A-eDP-1
[203.735166] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.770s)
[203.744116] Starting dynamic subtest: pipe-D-eDP-1
[218.698767] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s)
[218.700074] Subtest query-forked-hang: SUCCESS (41.734s)
[219.518075] [032/131] (797s left) gem_mmap_wc (close)
[219.568103] Subtest close: SKIP (0.000s)
[219.625318] [033/131] (797s left) gem_exec_schedule (u-semaphore-codependency)
[219.671736] Starting subtest: u-semaphore-codependency
[219.686735] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[220.020075] [034/131] (796s left) gem_blits (basic)
[220.072255] Starting subtest: basic
[221.477386] Subtest basic: SUCCESS (1.404s)
[221.592667] [035/131] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[221.690619] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[221.692429] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[221.798801] [036/131] (795s left) gem_mmap_gtt (basic-read-write)
[221.846227] Subtest basic-read-write: SKIP (0.000s)
[221.906836] [037/131] (795s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[221.994890] Starting subtest: disable-crc-after-crtc
[221.997553] Starting dynamic subtest: pipe-A-eDP-1
[223.667549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s)
[223.674575] Starting dynamic subtest: pipe-B-eDP-1
[225.957579] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.290s)
[225.965479] Starting dynamic subtest: pipe-C-eDP-1
[228.177248] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.218s)
[228.183807] Starting dynamic subtest: pipe-D-eDP-1
[230.420091] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.242s)
[230.421048] Subtest disable-crc-after-crtc: SUCCESS (8.425s)
[231.266692] [038/131] (785s left) kms_plane_cursor (viewport)
[231.351809] Starting subtest: viewport
[231.353857] Starting dynamic subtest: pipe-A-eDP-1-size-64
[234.085200] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.733s)
[234.146064] Starting dynamic subtest: pipe-A-eDP-1-size-128
[236.885041] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.748s)
[236.945824] Starting dynamic subtest: pipe-A-eDP-1-size-256
[239.686068] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.748s)
[240.028778] Starting dynamic subtest: pipe-B-eDP-1-size-64
[243.522444] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.501s)
[243.582782] Starting dynamic subtest: pipe-B-eDP-1-size-128
[246.323732] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.748s)
[246.385355] Starting dynamic subtest: pipe-B-eDP-1-size-256
[249.114179] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.738s)
[249.457441] Starting dynamic subtest: pipe-C-eDP-1-size-64
[252.570079] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.119s)
[252.608079] Starting dynamic subtest: pipe-C-eDP-1-size-128
[254.959113] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.357s)
[254.997048] Starting dynamic subtest: pipe-C-eDP-1-size-256
[257.347828] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.357s)
[257.672965] Starting dynamic subtest: pipe-D-eDP-1-size-64
[260.750342] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.085s)
[260.788463] Starting dynamic subtest: pipe-D-eDP-1-size-128
[263.128145] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.346s)
[263.169984] Starting dynamic subtest: pipe-D-eDP-1-size-256
[265.516986] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.357s)
[265.833355] Subtest viewport: SUCCESS (34.481s)
[266.687282] [039/131] (750s left) kms_psr (pr-sprite-plane-move)
[266.782416] Starting subtest: pr-sprite-plane-move
[266.784262] Subtest pr-sprite-plane-move: SKIP (0.000s)
[266.846977] [040/131] (750s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[267.222514] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[267.990432] [041/131] (749s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[268.370583] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[269.140204] [042/131] (748s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[269.292063] Starting subtest: cursor-rapid-movement-32x32
[269.329635] Subtest cursor-rapid-movement-32x32: SKIP (0.034s)
[269.628616] [043/131] (747s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[269.750967] Starting subtest: cursorA-vs-flipB-varying-size
[269.752777] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[269.892857] [044/131] (747s left) gem_request_retire (retire-vma-not-inactive)
[269.946623] Starting subtest: retire-vma-not-inactive
[270.006635] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[270.127975] [045/131] (747s left) gen7_exec_parse (cmd-crossing-page)
[270.185621] Subtest cmd-crossing-page: SKIP (0.000s)
[270.260451] [046/131] (747s left) i915_hangman (gt-error-state-capture)
[270.317167] Starting subtest: gt-error-state-capture
[270.318122] Starting dynamic subtest: rcs0
[281.912762] Dynamic subtest rcs0: SUCCESS (11.591s)
[281.922418] Starting dynamic subtest: bcs0
[293.879051] Dynamic subtest bcs0: SUCCESS (11.965s)
[293.888742] Starting dynamic subtest: vcs0
[305.847619] Dynamic subtest vcs0: SUCCESS (11.966s)
[305.857547] Starting dynamic subtest: vcs1
[317.877636] Dynamic subtest vcs1: SUCCESS (12.029s)
[317.887789] Starting dynamic subtest: vecs0
[328.887646] Dynamic subtest vecs0: SUCCESS (11.006s)
[328.897999] Starting dynamic subtest: ccs0
[340.855066] Dynamic subtest ccs0: SUCCESS (11.965s)
[340.856658] Subtest gt-error-state-capture: SUCCESS (70.536s)
[340.929332] [047/131] (676s left) gem_userptr_blits (probe)
[340.994256] Starting subtest: probe
[341.071716] Subtest probe: SUCCESS (0.077s)
[341.184440] [048/131] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[341.292370] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[348.123458] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.832s)
[348.242039] [049/131] (669s left) i915_drm_fdinfo (idle)
[348.278029] Starting subtest: idle
[348.278953] Starting dynamic subtest: rcs0
[348.875592] Dynamic subtest rcs0: SUCCESS (0.597s)
[348.885329] Starting dynamic subtest: bcs0
[349.381141] Dynamic subtest bcs0: SUCCESS (0.502s)
[349.389516] Starting dynamic subtest: vcs0
[349.886588] Dynamic subtest vcs0: SUCCESS (0.503s)
[349.898040] Starting dynamic subtest: vcs1
[350.393485] Dynamic subtest vcs1: SUCCESS (0.503s)
[350.403086] Starting dynamic subtest: vecs0
[350.898411] Dynamic subtest vecs0: SUCCESS (0.503s)
[350.908285] Starting dynamic subtest: ccs0
[351.407729] Dynamic subtest ccs0: SUCCESS (0.503s)
[351.408818] Subtest idle: SUCCESS (3.125s)
[351.473528] [050/131] (665s left) gem_exec_schedule (pi-userfault)
[351.642870] Starting subtest: pi-userfault
[351.643884] Starting dynamic subtest: rcs0
[351.654480] Dynamic subtest rcs0: SUCCESS (0.013s)
[351.663953] Starting dynamic subtest: bcs0
[351.666209] Dynamic subtest bcs0: SUCCESS (0.011s)
[351.672991] Starting dynamic subtest: vcs0
[351.678255] Dynamic subtest vcs0: SUCCESS (0.012s)
[351.684821] Starting dynamic subtest: vcs1
[351.690438] Dynamic subtest vcs1: SUCCESS (0.012s)
[351.697778] Starting dynamic subtest: vecs0
[351.706315] Dynamic subtest vecs0: SUCCESS (0.016s)
[351.712873] Starting dynamic subtest: ccs0
[351.717879] Dynamic subtest ccs0: SUCCESS (0.011s)
[351.718790] Subtest pi-userfault: SUCCESS (0.078s)
[351.894143] [051/131] (665s left) gem_exec_fence (submit3)
[352.073538] Starting subtest: submit3
[352.075566] Subtest submit3: SKIP (0.000s)
[354.049884] [052/131] (663s left) gem_exec_reloc (basic-wc-noreloc)
[354.108753] Subtest basic-wc-noreloc: SKIP (0.000s)
[354.197212] [053/131] (663s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[354.292584] Starting subtest: fbc-pr-cursor-mmap-cpu
[354.294421] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[354.356181] [054/131] (663s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[354.459248] Starting subtest: protected-encrypted-src-copy-not-readible
[354.570091] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[354.703609] [055/131] (662s left) syncobj_timeline (multi-wait-all-available-signaled)
[354.757049] Starting subtest: multi-wait-all-available-signaled
[354.758033] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[354.857420] [056/131] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[354.950645] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[361.522500] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.573s)
[361.640568] [057/131] (655s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[361.733911] Starting subtest: psr-shrfb-scaledprimary
[367.501458] Subtest psr-shrfb-scaledprimary: SUCCESS (5.769s)
[367.630879] [058/131] (650s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[367.689479] Starting subtest: yf-tiled-to-vebox-yf-tiled
[367.691554] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[367.868134] [059/131] (649s left) prime_vgem (fence-read-hang)
[367.935815] Subtest fence-read-hang: SKIP (0.000s)
[368.020624] [060/131] (649s left) kms_async_flips (alternate-sync-async-flip)
[368.111751] Starting subtest: alternate-sync-async-flip
[368.491421] Starting dynamic subtest: pipe-A-eDP-1
[371.273706] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.782s)
[371.651259] Starting dynamic subtest: pipe-B-eDP-1
[374.415700] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[374.781451] Starting dynamic subtest: pipe-C-eDP-1
[377.550374] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[377.911549] Starting dynamic subtest: pipe-D-eDP-1
[380.686000] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[380.687091] Subtest alternate-sync-async-flip: SUCCESS (12.576s)
[381.850676] [061/131] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[381.937815] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[381.939787] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[382.038330] [062/131] (635s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[382.126338] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[382.137654] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[382.252022] [063/131] (635s left) syncobj_wait (wait-for-submit-snapshot)
[382.296985] Starting subtest: wait-for-submit-snapshot
[382.377918] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[382.445969] [064/131] (635s left) dmabuf_sync_file (export-multiwait)
[382.483345] Starting subtest: export-multiwait
[382.484561] Subtest export-multiwait: SUCCESS (0.000s)
[382.532428] [065/131] (635s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[382.596965] Subtest writes-after-reads: SKIP (0.000s)
[382.666930] [066/131] (635s left) perf (short-reads)
[382.771860] Starting subtest: short-reads
[382.786882] Subtest short-reads: SUCCESS (0.016s)
[382.823942] [067/131] (635s left) syncobj_wait (wait-for-submit-delayed-submit)
[382.868597] Starting subtest: wait-for-submit-delayed-submit
[382.971677] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[383.040181] [068/131] (634s left) core_sysfs (read-all-entries)
[383.093514] Starting subtest: read-all-entries
[383.102269] Subtest read-all-entries: SUCCESS (0.011s)
[383.204823] [069/131] (634s left) perf (global-sseu-config-invalid)
[383.279477] Starting subtest: global-sseu-config-invalid
[383.281482] Subtest global-sseu-config-invalid: SKIP (0.000s)
[383.315759] [070/131] (634s left) gem_exec_flush (basic-wb-rw-before-default)
[383.368682] Starting subtest: basic-wb-rw-before-default
[388.820566] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[389.001297] [071/131] (629s left) gem_exec_params (rel-constants-invalid)
[389.061223] Starting subtest: rel-constants-invalid
[389.062129] Subtest rel-constants-invalid: SUCCESS (0.000s)
[389.174291] [072/131] (628s left) kms_psr (fbc-psr2-sprite-blt)
[389.266032] Starting subtest: fbc-psr2-sprite-blt
[389.266986] Starting dynamic subtest: eDP-1
[389.268667] Dynamic subtest eDP-1: SKIP (0.000s)
[389.270319] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[389.333622] [073/131] (628s left) kms_cursor_crc (cursor-offscreen-max-size)
[389.620857] Starting subtest: cursor-offscreen-max-size
[389.623869] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[389.767962] [074/131] (628s left) gem_exec_reloc (basic-concurrent16)
[389.825435] Subtest basic-concurrent16: SKIP (0.000s)
[389.898144] [075/131] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[389.991836] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[396.628472] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.638s)
[396.758228] [076/131] (621s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[396.860463] Starting subtest: extended-modeset-hang-newfb-with-reset
[396.861383] Starting dynamic subtest: pipe-A
[411.077321] Dynamic subtest pipe-A: SUCCESS (14.215s)
[411.088918] Starting dynamic subtest: pipe-D
[426.666218] Dynamic subtest pipe-D: SUCCESS (15.586s)
[426.667162] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.805s)
[427.467354] [077/131] (590s left) kms_getfb (getfb2-accept-nv12)
[427.552456] Starting subtest: getfb2-accept-nv12
[427.553429] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[427.659882] [078/131] (590s left) gem_exec_reloc (basic-write-cpu-active)
[427.714321] Subtest basic-write-cpu-active: SKIP (0.000s)
[427.790204] [079/131] (590s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[427.890427] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[428.548854] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[428.705472] [080/131] (589s left) gem_ctx_persistence (legacy-engines-mixed-process)
[428.764760] Starting subtest: legacy-engines-mixed-process
[428.765644] Starting dynamic subtest: render
[429.926365] Dynamic subtest render: SUCCESS (1.161s)
[429.937054] Starting dynamic subtest: bsd1
[431.922598] Dynamic subtest bsd1: SUCCESS (1.994s)
[431.933224] Starting dynamic subtest: bsd2
[433.892112] Dynamic subtest bsd2: SUCCESS (1.967s)
[433.901591] Starting dynamic subtest: blt
[435.931025] Dynamic subtest blt: SUCCESS (2.037s)
[435.942519] Starting dynamic subtest: vebox
[437.930410] Dynamic subtest vebox: SUCCESS (1.998s)
[437.931622] Subtest legacy-engines-mixed-process: SUCCESS (9.166s)
[438.006129] [081/131] (580s left) gem_exec_whisper (basic-queues-priority-all)
[438.076107] Starting subtest: basic-queues-priority-all
[460.375792] Subtest basic-queues-priority-all: SUCCESS (22.296s)
[460.548405] [082/131] (557s left) gem_pread (uncached)
[460.599963] Subtest uncached: SKIP (0.000s)
[460.657167] [083/131] (557s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[460.756898] Starting subtest: fbc-rgb101010-draw-blt
[465.402413] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.646s)
[466.566539] [084/131] (551s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[466.623991] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[466.690940] [085/131] (551s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[466.779966] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[466.780942] Starting dynamic subtest: pipe-A-eDP-1
[483.139356] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[483.150352] Starting dynamic subtest: pipe-B-eDP-1
[501.047277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s)
[501.055696] Starting dynamic subtest: pipe-C-eDP-1
[519.012452] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.702s)
[519.021903] Starting dynamic subtest: pipe-D-eDP-1
[537.005195] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.615s)
[537.006124] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.003s)
[544.231942] [086/131] (480s left) gem_ctx_persistence (engines-queued)
[544.280139] Starting subtest: engines-queued
[544.281226] Starting dynamic subtest: rcs0
[544.338774] Dynamic subtest rcs0: SUCCESS (0.059s)
[544.347807] Starting dynamic subtest: bcs0
[544.418637] Dynamic subtest bcs0: SUCCESS (0.080s)
[544.435347] Starting dynamic subtest: vcs0
[546.098780] Dynamic subtest vcs0: SUCCESS (1.693s)
[546.109130] Starting dynamic subtest: vcs1
[548.084361] Dynamic subtest vcs1: SUCCESS (1.996s)
[548.095698] Starting dynamic subtest: vecs0
[550.068617] Dynamic subtest vecs0: SUCCESS (1.994s)
[550.084584] Starting dynamic subtest: ccs0
[550.256607] Dynamic subtest ccs0: SUCCESS (0.189s)
[550.257942] Subtest engines-queued: SUCCESS (6.022s)
[550.392801] [087/131] (474s left) gem_exec_fence (basic-busy-all)
[550.450434] Starting subtest: basic-busy-all
[550.562287] Subtest basic-busy-all: SUCCESS (0.112s)
[552.207829] [088/131] (472s left) i915_query (query-regions-garbage-items)
[552.253828] Starting subtest: query-regions-garbage-items
[552.254695] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[552.350121] [089/131] (472s left) gem_mmap_offset (partial-remap)
[552.404084] Starting subtest: partial-remap
[552.404865] Starting dynamic subtest: smem0
[552.414270] Dynamic subtest smem0: SUCCESS (0.008s)
[552.415110] Subtest partial-remap: SUCCESS (0.008s)
[552.547581] [090/131] (472s left) gem_lmem_swapping (verify-ccs)
[552.577833] Subtest verify-ccs: SKIP (0.000s)
[552.619662] [091/131] (472s left) kms_properties (invalid-properties-atomic)
[552.704233] Starting subtest: invalid-properties-atomic
[552.952209] Subtest invalid-properties-atomic: SUCCESS (0.247s)
[553.016169] [092/131] (471s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[553.110958] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[553.122041] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[553.191988] [093/131] (471s left) perf (invalid-oa-metric-set-id)
[553.262922] Starting subtest: invalid-oa-metric-set-id
[553.272134] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[553.316165] [094/131] (471s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[553.364297] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[553.475255] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[553.548036] [095/131] (471s left) syncobj_timeline (single-wait-all-available-submitted)
[553.593728] Starting subtest: single-wait-all-available-submitted
[553.595192] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[553.691867] [096/131] (471s left) kms_pm_rpm (modeset-stress-extra-wait)
[555.221770] Starting subtest: modeset-stress-extra-wait
[609.478468] Subtest modeset-stress-extra-wait: SUCCESS (54.300s)
[609.560045] [097/131] (415s left) kms_psr (pr-basic)
[609.645871] Starting subtest: pr-basic
[609.648005] Subtest pr-basic: SKIP (0.000s)
[609.716106] [098/131] (415s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[609.765884] Starting subtest: invalid-bsd1-flag-on-vebox
[609.767216] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[609.860095] [099/131] (415s left) gem_exec_params (rsvd2-dirt)
[609.919048] Starting subtest: rsvd2-dirt
[609.921291] Subtest rsvd2-dirt: SKIP (0.000s)
[610.027194] [100/131] (414s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[610.113362] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[610.114497] Starting dynamic subtest: pipe-A-default-mode
[610.399036] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[610.401091] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.285s)
[611.261179] [101/131] (413s left) gem_ringfill (legacy-basic)
[617.112786] Starting subtest: legacy-basic
[617.114192] Starting dynamic subtest: default
[617.189910] Dynamic subtest default: SUCCESS (0.075s)
[617.203072] Starting dynamic subtest: render
[617.234932] Dynamic subtest render: SUCCESS (0.042s)
[617.245738] Starting dynamic subtest: bsd
[617.278944] Dynamic subtest bsd: SUCCESS (0.042s)
[617.291667] Starting dynamic subtest: bsd1
[617.319736] Dynamic subtest bsd1: SUCCESS (0.039s)
[617.330641] Starting dynamic subtest: bsd2
[617.368933] Dynamic subtest bsd2: SUCCESS (0.046s)
[617.380162] Starting dynamic subtest: blt
[617.414777] Dynamic subtest blt: SUCCESS (0.044s)
[617.425140] Starting dynamic subtest: vebox
[617.457785] Dynamic subtest vebox: SUCCESS (0.041s)
[617.459477] Subtest legacy-basic: SUCCESS (0.345s)
[617.530552] [102/131] (407s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[617.633098] Starting subtest: psr-2p-primscrn-cur-indfb-move
[617.635073] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[617.745332] [103/131] (407s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[617.837238] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[617.838344] Starting dynamic subtest: pipe-A-eDP-1
[617.846293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[617.855375] Starting dynamic subtest: pipe-B-eDP-1
[617.863037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[617.871918] Starting dynamic subtest: pipe-C-eDP-1
[617.879898] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[617.888085] Starting dynamic subtest: pipe-D-eDP-1
[617.895996] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[617.897007] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[620.020443] [104/131] (405s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[620.111972] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[620.113575] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[620.219337] [105/131] (404s left) gem_mmap_gtt (fault-concurrent-x)
[620.273679] Subtest fault-concurrent-X: SKIP (0.000s)
[620.338037] [106/131] (404s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[625.315311] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[625.319152] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[626.164077] [107/131] (399s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[626.256290] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[626.257347] Starting dynamic subtest: pipe-A-default-mode
[626.541898] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[626.543780] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.285s)
[627.388503] [108/131] (397s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[627.506951] Starting subtest: cursor-vs-flip-toggle
[657.842494] Subtest cursor-vs-flip-toggle: SUCCESS (30.323s)
[658.625141] [109/131] (366s left) i915_drm_fdinfo (all-busy-check-all)
[658.656906] Starting subtest: all-busy-check-all
[658.662128] Subtest all-busy-check-all: SKIP (0.004s)
[658.723766] [110/131] (366s left) prime_busy (after)
[658.812299] Starting subtest: after
[658.815114] Starting dynamic subtest: rcs0
[658.865961] Dynamic subtest rcs0: SUCCESS (0.050s)
[658.877062] Starting dynamic subtest: bcs0
[658.938808] Dynamic subtest bcs0: SUCCESS (0.072s)
[658.947618] Starting dynamic subtest: vcs0
[658.979578] Dynamic subtest vcs0: SUCCESS (0.040s)
[658.988279] Starting dynamic subtest: vcs1
[659.020165] Dynamic subtest vcs1: SUCCESS (0.040s)
[659.028654] Starting dynamic subtest: vecs0
[659.059605] Dynamic subtest vecs0: SUCCESS (0.039s)
[659.068237] Starting dynamic subtest: ccs0
[659.099534] Dynamic subtest ccs0: SUCCESS (0.039s)
[659.208559] Subtest after: SUCCESS (0.394s)
[659.281543] [111/131] (366s left) gem_userptr_blits (sync-unmap-cycles)
[659.341104] Starting subtest: sync-unmap-cycles
[664.725317] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[664.865245] [112/131] (360s left) kms_vblank (ts-continuation-modeset-hang)
[664.958912] Starting subtest: ts-continuation-modeset-hang
[664.960161] Starting dynamic subtest: pipe-A-eDP-1
[691.917349] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.953s)
[691.929226] Starting dynamic subtest: pipe-D-eDP-1
[706.894018] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[706.894869] Subtest ts-continuation-modeset-hang: SUCCESS (41.933s)
[707.691142] [113/131] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[707.790333] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[707.792130] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[707.899590] [114/131] (317s left) kms_rotation_crc (bad-tiling)
[707.989987] Starting subtest: bad-tiling
[707.991837] Subtest bad-tiling: SKIP (0.001s)
[708.059968] [115/131] (317s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[708.147224] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[708.148374] Starting dynamic subtest: pipe-A
[708.489738] Dynamic subtest pipe-A: SUCCESS (0.342s)
[708.498554] Starting dynamic subtest: pipe-B
[709.900103] Dynamic subtest pipe-B: SUCCESS (1.410s)
[709.910134] Starting dynamic subtest: pipe-C
[711.329374] Dynamic subtest pipe-C: SUCCESS (1.429s)
[711.338233] Starting dynamic subtest: pipe-D
[712.759727] Dynamic subtest pipe-D: SUCCESS (1.430s)
[712.761265] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.613s)
[713.928755] [116/131] (311s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[714.026838] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[717.782892] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.757s)
[718.931431] [117/131] (306s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[718.986148] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[718.987132] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[719.083181] [118/131] (306s left) gem_fence_thrash (bo-write-verify-threaded-y)
[719.107294] Starting subtest: bo-write-verify-threaded-y
[719.136473] Subtest bo-write-verify-threaded-y: SKIP (0.027s)
[719.202033] [119/131] (306s left) kms_cursor_edge_walk (64x64-right-edge)
[719.295188] Starting subtest: 64x64-right-edge
[719.296208] Starting dynamic subtest: pipe-A-eDP-1
[722.786654] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[722.795502] Starting dynamic subtest: pipe-D-eDP-1
[725.908491] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[725.909432] Subtest 64x64-right-edge: SUCCESS (6.614s)
[726.716947] [120/131] (298s left) gem_exec_params (sol-reset-not-gen7)
[726.769204] Starting subtest: sol-reset-not-gen7
[726.772025] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[726.900329] [121/131] (298s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[727.000187] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[727.002021] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[727.105065] [122/131] (298s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[727.156446] Subtest tiled-to-untiled: SKIP (0.000s)
[727.249659] [123/131] (298s left) kms_big_fb (yf-tiled-addfb)
[727.344317] Starting subtest: yf-tiled-addfb
[727.346174] Subtest yf-tiled-addfb: SKIP (0.000s)
[727.452663] [124/131] (298s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[732.507422] Starting subtest: pr-overlay-plane-move-continuous-sf
[732.512498] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[733.352581] [125/131] (292s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[733.452331] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[733.454037] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[733.555089] [126/131] (292s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[733.635924] Starting subtest: crc-primary-basic-yf-tiled-ccs
[733.636920] Starting dynamic subtest: pipe-A-eDP-1
[733.644726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[733.652934] Starting dynamic subtest: pipe-B-eDP-1
[733.660778] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[733.669481] Starting dynamic subtest: pipe-C-eDP-1
[733.677285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[733.685162] Starting dynamic subtest: pipe-D-eDP-1
[733.693244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[733.694780] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[735.830110] [127/131] (290s left) kms_flip (2x-wf_vblank-ts-check)
[735.925405] Starting subtest: 2x-wf_vblank-ts-check
[735.937015] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[736.045716] [128/131] (289s left) api_intel_bb (crc32)
[736.099635] Starting subtest: crc32
[736.100786] Starting dynamic subtest: rcs0-smem0
[736.405270] Dynamic subtest rcs0-smem0: SUCCESS (0.304s)
[736.418450] Starting dynamic subtest: bcs0-smem0
[736.739527] Dynamic subtest bcs0-smem0: SUCCESS (0.334s)
[736.753109] Starting dynamic subtest: vcs0-smem0
[737.107107] Dynamic subtest vcs0-smem0: SUCCESS (0.364s)
[737.117809] Starting dynamic subtest: vcs1-smem0
[737.529372] Dynamic subtest vcs1-smem0: SUCCESS (0.418s)
[737.541327] Starting dynamic subtest: vecs0-smem0
[737.875722] Dynamic subtest vecs0-smem0: SUCCESS (0.343s)
[737.886900] Starting dynamic subtest: ccs0-smem0
[738.181547] Dynamic subtest ccs0-smem0: SUCCESS (0.304s)
[738.182807] Subtest crc32: SUCCESS (2.083s)
[738.297939] [129/131] (287s left) drm_read (short-buffer-nonblock)
[738.467830] Starting subtest: short-buffer-nonblock
[738.469551] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[738.611670] [130/131] (287s left) kms_pm_rpm (fences-dpms)
[740.328965] Starting subtest: fences-dpms
[740.331310] Subtest fences-dpms: SKIP (0.000s)
[740.869490] [131/131] (285s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[740.961355] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[741.861189] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.900s)
[741.999742] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: sysfs_heartbeat_interval
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_draw_crc
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_ctx_isolation
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: gem_pwrite_snooped
results: parsing output: 16/ for test: kms_invalid_mode
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_fb_coherency
results: parsing output: 27/ for test: kms_pm_backlight
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: gem_blits
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_pipe_crc_basic
results: parsing output: 37/ for test: kms_plane_cursor
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_request_retire
results: parsing output: 44/ for test: gen7_exec_parse
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_pxp
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: dmabuf_sync_file
results: parsing output: 64/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: core_sysfs
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_busy
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_pread
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_exec_params
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_ringfill
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: prime_busy
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_fence_thrash
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_set_tiling_vs_blt
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: drm_read
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: kms_big_fb
Done.