[57.860925] Initializing watchdogs
[57.860971]   /dev/watchdog0
[57.874624] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.878828] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.881050] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.884431] [001/133] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[58.001283] Starting subtest: wf_vblank-ts-check-interruptible
[58.003434] Starting dynamic subtest: A-eDP1
[66.935511] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[66.945260] Starting dynamic subtest: B-eDP1
[75.873238] Dynamic subtest B-eDP1: SUCCESS (8.941s)
[75.883561] Starting dynamic subtest: C-eDP1
[84.798723] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[84.808573] Starting dynamic subtest: D-eDP1
[93.722924] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[93.725343] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.744s)
[94.949277] [002/133] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[95.066223] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[95.070134] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[95.148653] [003/133] (923s left) kms_plane (pixel-format-linear-modifier)
[95.232897] Starting subtest: pixel-format-linear-modifier
[95.268808] Starting dynamic subtest: pipe-A-plane-0
[98.812762] Dynamic subtest pipe-A-plane-0: SUCCESS (3.544s)
[98.822147] Starting dynamic subtest: pipe-A-plane-3
[100.479487] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s)
[100.488488] Starting dynamic subtest: pipe-A-plane-5
[100.680053] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[101.755038] Starting dynamic subtest: pipe-B-plane-0
[105.270096] Dynamic subtest pipe-B-plane-0: SUCCESS (3.522s)
[105.285332] Starting dynamic subtest: pipe-B-plane-3
[106.881612] Dynamic subtest pipe-B-plane-3: SUCCESS (1.611s)
[106.890574] Starting dynamic subtest: pipe-B-plane-5
[107.092406] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[107.401673] Subtest pixel-format-linear-modifier: SUCCESS (12.169s)
[108.226175] [004/133] (910s left) sysfs_heartbeat_interval (nopreempt)
[108.280983] Starting subtest: nopreempt
[108.283523] Starting dynamic subtest: vecs0
[117.908285] Dynamic subtest vecs0: SUCCESS (9.627s)
[117.919556] Starting dynamic subtest: ccs0
[121.923664] Dynamic subtest ccs0: SUCCESS (4.013s)
[121.931244] Starting dynamic subtest: vcs0
[130.895353] Dynamic subtest vcs0: SUCCESS (8.970s)
[130.905884] Starting dynamic subtest: bcs0
[134.941220] Dynamic subtest bcs0: SUCCESS (4.045s)
[134.951694] Starting dynamic subtest: rcs0
[139.027911] Dynamic subtest rcs0: SUCCESS (4.085s)
[139.046240] Starting dynamic subtest: vcs1
[148.883720] Dynamic subtest vcs1: SUCCESS (9.852s)
[148.886176] Subtest nopreempt: SUCCESS (40.600s)
[148.965876] [005/133] (869s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[149.075538] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[149.743796] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[149.901379] [006/133] (868s left) kms_addfb_basic (bad-pitch-256)
[149.964819] Starting subtest: bad-pitch-256
[149.967057] Subtest bad-pitch-256: SUCCESS (0.000s)
[150.101858] [007/133] (868s left) kms_cursor_legacy (torture-move)
[150.229342] Starting subtest: torture-move
[150.231728] Starting dynamic subtest: pipe-A
[156.296642] Dynamic subtest pipe-A: SUCCESS (6.062s)
[156.311200] Starting dynamic subtest: pipe-B
[162.497206] Dynamic subtest pipe-B: SUCCESS (6.201s)
[162.511415] Starting dynamic subtest: pipe-C
[169.248762] Dynamic subtest pipe-C: SUCCESS (6.749s)
[169.266260] Starting dynamic subtest: pipe-D
[176.287888] Dynamic subtest pipe-D: SUCCESS (7.039s)
[176.295859] Starting dynamic subtest: all-pipes
[182.915531] Dynamic subtest all-pipes: SUCCESS (6.626s)
[182.917929] Subtest torture-move: SUCCESS (32.683s)
[183.066912] [008/133] (835s left) gem_ppgtt (shrink-vs-evict-any)
[183.138632] Starting subtest: shrink-vs-evict-any
[188.918074] Subtest shrink-vs-evict-any: SUCCESS (5.777s)
[189.011580] [009/133] (829s left) syncobj_timeline (wait-all-for-submit-snapshot)
[189.071425] Starting subtest: wait-all-for-submit-snapshot
[189.152053] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[189.229365] [010/133] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[189.329576] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[189.333978] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.425687] [011/133] (829s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[189.815053] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[190.620841] [012/133] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[190.725133] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[190.729404] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[190.811718] [013/133] (828s left) gem_mmap_gtt (basic-write-read-distinct)
[190.866758] Subtest basic-write-read-distinct: SKIP (0.000s)
[190.938489] [014/133] (827s left) perf_pmu (busy-no-semaphores)
[190.979686] Starting subtest: busy-no-semaphores
[190.982103] Starting dynamic subtest: rcs0
[191.542307] Dynamic subtest rcs0: SUCCESS (0.564s)
[191.553044] Starting dynamic subtest: bcs0
[192.091252] Dynamic subtest bcs0: SUCCESS (0.547s)
[192.102999] Starting dynamic subtest: vcs0
[192.641394] Dynamic subtest vcs0: SUCCESS (0.548s)
[192.652967] Starting dynamic subtest: vcs1
[194.393552] Dynamic subtest vcs1: SUCCESS (1.749s)
[194.402970] Starting dynamic subtest: vecs0
[196.440502] Dynamic subtest vecs0: SUCCESS (2.046s)
[196.452064] Starting dynamic subtest: ccs0
[198.425823] Dynamic subtest ccs0: SUCCESS (1.983s)
[198.429158] Subtest busy-no-semaphores: SUCCESS (7.448s)
[198.541255] [015/133] (820s left) core_getstats (basic)
[198.598042] Starting subtest: basic
[198.600382] Subtest basic: SUCCESS (0.000s)
[198.690933] [016/133] (820s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[198.750359] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[198.755066] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[198.949801] [017/133] (820s left) gem_exec_alignment (pi)
[199.018988] Starting subtest: pi
[247.733895] Subtest pi: SUCCESS (48.710s)
[248.834169] [018/133] (770s left) gem_lmem_swapping (smem-oom)
[248.917764] Subtest smem-oom: SKIP (0.000s)
[248.962796] [019/133] (770s left) kms_prop_blob (blob-prop-lifetime)
[249.023299] Starting subtest: blob-prop-lifetime
[249.025579] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[249.130379] [020/133] (770s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[249.242632] Starting subtest: extended-modeset-hang-oldfb-with-reset
[249.244949] Starting dynamic subtest: pipe-A
[261.045543] Dynamic subtest pipe-A: SUCCESS (11.801s)
[261.055138] Starting dynamic subtest: pipe-D
[273.304724] Dynamic subtest pipe-D: SUCCESS (12.255s)
[273.307128] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.062s)
[274.188988] [021/133] (744s left) gem_exec_await (wide-all)
[274.429029] Starting subtest: wide-all
[297.663273] Subtest wide-all: SUCCESS (23.231s)
[297.852625] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[297.857421] [022/133] (721s left) kms_hdr (static-toggle-suspend)
[297.990067] Starting subtest: static-toggle-suspend
[297.996547] Subtest static-toggle-suspend: SKIP (0.000s)
[298.059904] [023/133] (721s left) gem_ctx_param (vm)
[298.110687] Starting subtest: vm
[298.157792] Subtest vm: SUCCESS (0.046s)
[298.290071] [024/133] (721s left) gem_mmap_gtt (big-copy-odd)
[298.353303] Subtest big-copy-odd: SKIP (0.000s)
[298.416705] [025/133] (720s left) kms_cursor_crc (cursor-random-128x128)
[298.622339] Starting subtest: cursor-random-128x128
[298.629573] Starting dynamic subtest: pipe-A-eDP-1
[301.971789] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.344s)
[302.000564] Starting dynamic subtest: pipe-D-eDP-1
[305.978344] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s)
[305.980372] Subtest cursor-random-128x128: SUCCESS (7.353s)
[306.843325] [026/133] (712s left) vgem_basic (unload)
[306.882378] Starting subtest: unload
[335.963846] Subtest unload: SUCCESS (29.080s)
[336.063935] [027/133] (683s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[336.178228] Starting subtest: x-tiled-8bpp-rotate-90
[336.198530] Subtest x-tiled-8bpp-rotate-90: SKIP (0.019s)
[336.298496] [028/133] (683s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[336.389246] Starting subtest: multiplane-rotation-cropping-top
[353.835985] Subtest multiplane-rotation-cropping-top: SUCCESS (17.448s)
[353.964296] [029/133] (665s left) sw_sync (alloc_fence_invalid_timeline)
[354.010183] Starting subtest: alloc_fence_invalid_timeline
[354.012113] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[354.059929] [030/133] (665s left) kms_setmode (invalid-clone-exclusive-crtc)
[354.107335] Starting subtest: invalid-clone-exclusive-crtc
[354.112408] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[354.199363] [031/133] (665s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[354.248941] Starting subtest: etime-multi-wait-all-available-unsubmitted
[354.352504] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[354.431244] [032/133] (665s left) gem_mmap_gtt (big-bo-tiledx)
[354.500864] Subtest big-bo-tiledX: SKIP (0.000s)
[354.569524] [033/133] (665s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[354.666414] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[354.668573] Starting dynamic subtest: pipe-A-eDP-1
[354.690854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.702190] Starting dynamic subtest: pipe-B-eDP-1
[354.722632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.731163] Starting dynamic subtest: pipe-C-eDP-1
[354.753058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.761453] Starting dynamic subtest: pipe-D-eDP-1
[354.783176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.787148] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[356.808633] [034/133] (662s left) gem_userptr_blits (readonly-unsync)
[356.865997] Subtest readonly-unsync: SKIP (0.000s)
[356.997873] [035/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[357.087387] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[357.091761] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[357.188480] [036/133] (662s left) syncobj_wait (multi-wait-for-submit-submitted)
[357.241734] Starting subtest: multi-wait-for-submit-submitted
[357.345267] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[357.447050] [037/133] (662s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[357.506045] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[357.609055] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[357.687201] [038/133] (662s left) kms_draw_crc (draw-method-mmap-wc)
[357.774440] Starting subtest: draw-method-mmap-wc
[357.776748] Starting dynamic subtest: xrgb8888-untiled
[357.982870] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[357.992145] Starting dynamic subtest: rgb565-untiled
[358.183035] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[358.192098] Starting dynamic subtest: xrgb2101010-untiled
[358.383193] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[358.392296] Starting dynamic subtest: xbgr16161616f-untiled
[358.583201] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[358.591605] Starting dynamic subtest: xrgb8888-xtiled
[358.704715] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[358.712706] Starting dynamic subtest: rgb565-xtiled
[358.827118] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[358.835577] Starting dynamic subtest: xrgb2101010-xtiled
[358.938436] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[358.947134] Starting dynamic subtest: xbgr16161616f-xtiled
[359.061247] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[359.069186] Starting dynamic subtest: xrgb8888-4tiled
[359.216258] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[359.224166] Starting dynamic subtest: rgb565-4tiled
[359.371770] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[359.380633] Starting dynamic subtest: xrgb2101010-4tiled
[359.505123] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[359.515963] Starting dynamic subtest: xbgr16161616f-4tiled
[359.682865] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[359.684842] Subtest draw-method-mmap-wc: SUCCESS (1.912s)
[359.777145] [039/133] (660s left) gem_render_linear_blits (basic)
[359.834479] Starting subtest: basic
[359.855783] Subtest basic: SUCCESS (0.021s)
[359.948098] [040/133] (660s left) kms_pm_rpm (fences-dpms)
[362.078202] Starting subtest: fences-dpms
[362.083332] Subtest fences-dpms: SKIP (0.000s)
[362.447356] [041/133] (657s left) kms_cursor_crc (cursor-dpms)
[362.577189] Starting subtest: cursor-dpms
[362.579465] Starting dynamic subtest: pipe-A-eDP-1
[365.587471] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.008s)
[365.597441] Starting dynamic subtest: pipe-D-eDP-1
[369.202739] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.612s)
[369.205072] Subtest cursor-dpms: SUCCESS (6.623s)
[370.045584] [042/133] (649s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[370.143723] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[370.146062] Starting dynamic subtest: pipe-A
[370.164305] Dynamic subtest pipe-A: SKIP (0.017s)
[370.173617] Starting dynamic subtest: pipe-B
[370.229037] Dynamic subtest pipe-B: SKIP (0.065s)
[370.237633] Starting dynamic subtest: pipe-C
[370.282329] Dynamic subtest pipe-C: SKIP (0.049s)
[370.291063] Starting dynamic subtest: pipe-D
[370.327401] Dynamic subtest pipe-D: SKIP (0.046s)
[370.331274] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.183s)
[370.440980] [043/133] (649s left) kms_color (ctm-blue-to-red)
[370.526428] Starting subtest: ctm-blue-to-red
[370.528683] Starting dynamic subtest: pipe-A-eDP-1
[371.206379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[371.214804] Starting dynamic subtest: pipe-B-eDP-1
[372.679062] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s)
[372.688419] Starting dynamic subtest: pipe-C-eDP-1
[373.987157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.307s)
[374.005572] Starting dynamic subtest: pipe-D-eDP-1
[375.331868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[375.334144] Subtest ctm-blue-to-red: SUCCESS (4.807s)
[376.189436] [044/133] (643s left) kms_plane_alpha_blend (constant-alpha-min)
[376.293387] Starting subtest: constant-alpha-min
[376.574235] Starting dynamic subtest: pipe-A-eDP-1
[377.276648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[377.287247] Starting dynamic subtest: pipe-D-eDP-1
[378.735106] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.457s)
[378.737538] Subtest constant-alpha-min: SUCCESS (2.443s)
[379.558812] [045/133] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[379.660168] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[379.664595] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[379.780175] [046/133] (640s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[379.863113] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[379.865201] Starting dynamic subtest: pipe-A-eDP-1
[379.887502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.900015] Starting dynamic subtest: pipe-B-eDP-1
[379.920412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.928978] Starting dynamic subtest: pipe-C-eDP-1
[379.949300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.957911] Starting dynamic subtest: pipe-D-eDP-1
[379.978725] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.982587] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[382.030332] [047/133] (638s left) kms_lease (lease-uevent)
[382.120049] Starting subtest: lease-uevent
[383.135994] Subtest lease-uevent: SUCCESS (1.016s)
[383.242258] [048/133] (637s left) gen7_exec_parse (oacontrol-tracking)
[383.304636] Subtest oacontrol-tracking: SKIP (0.000s)
[383.372399] [049/133] (636s left) gem_userptr_blits (unsync-unmap-cycles)
[383.450332] Subtest unsync-unmap-cycles: SKIP (0.000s)
[383.580031] [050/133] (636s left) kms_flip (basic-flip-vs-modeset)
[383.676255] Starting subtest: basic-flip-vs-modeset
[383.678768] Starting dynamic subtest: A-eDP1
[386.207326] Dynamic subtest A-eDP1: SUCCESS (2.534s)
[386.220067] Starting dynamic subtest: B-eDP1
[388.379084] Dynamic subtest B-eDP1: SUCCESS (2.171s)
[388.388179] Starting dynamic subtest: C-eDP1
[390.545079] Dynamic subtest C-eDP1: SUCCESS (2.163s)
[390.554904] Starting dynamic subtest: D-eDP1
[392.628201] Dynamic subtest D-eDP1: SUCCESS (2.081s)
[392.630153] Subtest basic-flip-vs-modeset: SUCCESS (8.956s)
[393.419459] [051/133] (626s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[393.477483] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[393.479635] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[393.582442] [052/133] (626s left) syncobj_timeline (reset-during-wait-for-submit)
[393.631080] Starting subtest: reset-during-wait-for-submit
[393.734348] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[393.813317] [053/133] (626s left) perf (buffer-fill)
[393.939474] Starting subtest: buffer-fill
[393.941406] Starting dynamic subtest: 0-rcs0
[396.188436] Dynamic subtest 0-rcs0: SUCCESS (2.248s)
[396.198943] Starting dynamic subtest: 1-vecs0
[400.586065] Dynamic subtest 1-vecs0: SUCCESS (4.396s)
[400.588423] Subtest buffer-fill: SUCCESS (6.647s)
[400.625425] [054/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[400.731902] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[405.010224] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.281s)
[406.159862] [055/133] (614s left) prime_vgem (wait)
[406.233192] Starting subtest: wait
[406.235168] Starting dynamic subtest: rcs0
[406.282706] Dynamic subtest rcs0: SUCCESS (0.052s)
[406.293059] Starting dynamic subtest: bcs0
[406.345956] Dynamic subtest bcs0: SUCCESS (0.061s)
[406.355076] Starting dynamic subtest: vcs0
[406.390238] Dynamic subtest vcs0: SUCCESS (0.043s)
[406.399269] Starting dynamic subtest: vcs1
[406.436231] Dynamic subtest vcs1: SUCCESS (0.045s)
[406.445374] Starting dynamic subtest: vecs0
[406.484392] Dynamic subtest vecs0: SUCCESS (0.047s)
[406.493934] Starting dynamic subtest: ccs0
[406.531837] Dynamic subtest ccs0: SUCCESS (0.047s)
[406.534169] Subtest wait: SUCCESS (0.302s)
[406.656374] [056/133] (613s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[406.752811] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[407.843555] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s)
[407.963556] [057/133] (612s left) gem_exec_fence (syncobj-timeline-unused-fence)
[408.504186] Starting subtest: syncobj-timeline-unused-fence
[408.509949] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[409.975915] [058/133] (610s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[410.062858] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[410.065043] Starting dynamic subtest: pipe-A-default-mode
[412.780896] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[412.783389] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.719s)
[413.656283] [059/133] (607s left) kms_psr (pr-basic)
[413.755211] Starting subtest: pr-basic
[413.759795] Subtest pr-basic: SKIP (0.000s)
[413.826980] [060/133] (606s left) dmabuf_sync_file (export-wait-after-attach)
[413.869205] Starting subtest: export-wait-after-attach
[413.871484] Subtest export-wait-after-attach: SUCCESS (0.001s)
[413.923627] [061/133] (606s left) gem_exec_balancer (busy)
[413.974433] Starting subtest: busy
[415.867215] Subtest busy: SUCCESS (1.892s)
[416.175926] [062/133] (604s left) gem_userptr_blits (dmabuf-unsync)
[416.256978] Subtest dmabuf-unsync: SKIP (0.000s)
[416.371595] [063/133] (604s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[416.505647] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[417.904495] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.399s)
[418.709469] [064/133] (602s left) gem_render_copy (yf-tiled-ccs-to-linear)
[418.771327] Starting subtest: yf-tiled-ccs-to-linear
[418.775785] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[418.974157] [065/133] (602s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[419.073235] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[419.075603] Starting dynamic subtest: pipe-A-eDP-1
[435.537495] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.469s)
[435.546912] Starting dynamic subtest: pipe-B-eDP-1
[452.699765] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.160s)
[452.702201] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.632s)
[453.504747] [066/133] (567s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[453.600435] Starting subtest: pr-overlay-plane-move-continuous-sf
[453.604922] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[453.668426] [067/133] (567s left) i915_selftest (mock)
[456.960769] Starting subtest: mock
[456.964136] Starting dynamic subtest: sanitycheck
[457.675196] Dynamic subtest sanitycheck: SUCCESS (0.714s)
[457.684996] Starting dynamic subtest: shmem
[458.339168] Dynamic subtest shmem: SUCCESS (0.662s)
[458.349121] Starting dynamic subtest: fence
[466.026405] Dynamic subtest fence: SUCCESS (7.684s)
[466.041195] Starting dynamic subtest: scatterlist
[467.708124] Dynamic subtest scatterlist: SUCCESS (1.680s)
[467.717735] Starting dynamic subtest: syncmap
[471.182060] Dynamic subtest syncmap: SUCCESS (3.472s)
[471.191835] Starting dynamic subtest: uncore
[471.820362] Dynamic subtest uncore: SUCCESS (0.636s)
[471.835547] Starting dynamic subtest: ring
[472.459378] Dynamic subtest ring: SUCCESS (0.637s)
[472.468178] Starting dynamic subtest: engine
[473.110169] Dynamic subtest engine: SUCCESS (0.648s)
[473.119461] Starting dynamic subtest: timelines
[477.432673] Dynamic subtest timelines: SUCCESS (4.320s)
[477.447044] Starting dynamic subtest: requests
[481.052717] Dynamic subtest requests: SUCCESS (3.618s)
[481.062693] Starting dynamic subtest: objects
[481.788243] Dynamic subtest objects: SUCCESS (0.734s)
[481.798091] Starting dynamic subtest: phys
[482.536953] Dynamic subtest phys: SUCCESS (0.747s)
[482.546566] Starting dynamic subtest: dmabuf
[483.299098] Dynamic subtest dmabuf: SUCCESS (0.760s)
[483.308730] Starting dynamic subtest: vma
[488.855217] Dynamic subtest vma: SUCCESS (5.553s)
[488.862895] Starting dynamic subtest: evict
[490.195185] Dynamic subtest evict: SUCCESS (1.338s)
[490.204827] Starting dynamic subtest: gtt
[493.466368] Dynamic subtest gtt: SUCCESS (3.270s)
[493.475849] Starting dynamic subtest: hugepages
[494.318261] Dynamic subtest hugepages: SUCCESS (0.851s)
[494.327745] Starting dynamic subtest: memory_region
[496.723070] Dynamic subtest memory_region: SUCCESS (2.402s)
[496.725760] Subtest mock: SUCCESS (39.762s)
[496.754272] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[496.754967] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[496.758266] [068/133] (524s left) kms_pm_dc (dc5-dpms)
[499.338107] Starting subtest: dc5-dpms
[501.410858] Subtest dc5-dpms: SUCCESS (2.073s)
[501.516729] [FACT kms_pm_dc (dc5-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.518007] [FACT kms_pm_dc (dc5-dpms)] new: kernel.kmod_is_loaded.i915: true
[501.521514] [069/133] (519s left) kms_tiled_display (basic-test-pattern)
[501.653299] Subtest basic-test-pattern: SKIP (0.000s)
[501.697546] [070/133] (519s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[501.802084] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[509.270334] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.471s)
[509.426690] [071/133] (511s left) gem_vm_create (execbuf)
[509.484943] Starting subtest: execbuf
[509.493097] Subtest execbuf: SUCCESS (0.008s)
[509.612078] [072/133] (511s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[509.703208] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[516.742029] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.041s)
[516.852366] [073/133] (504s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[516.960018] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[523.230825] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.274s)
[524.367483] [074/133] (496s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[524.464072] Starting subtest: pipe-fbc-rte
[524.471098] Starting dynamic subtest: pipe-B-eDP-1
[529.914885] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.454s)
[529.922649] Subtest pipe-fbc-rte: SUCCESS (5.456s)
[532.165210] [075/133] (489s left) gem_userptr_blits (sync-unmap)
[532.232598] Starting subtest: sync-unmap
[532.248557] Subtest sync-unmap: SUCCESS (0.014s)
[532.378000] [076/133] (489s left) gem_exec_balancer (sliced)
[532.450660] Starting subtest: sliced
[532.455251] Subtest sliced: SKIP (0.000s)
[532.747282] [077/133] (488s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[532.850318] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[532.863164] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[532.939902] [078/133] (488s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[533.003520] Starting subtest: invalid-signal-one-illegal-handle
[533.005500] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[533.106395] [079/133] (488s left) kms_vblank (wait-busy)
[533.201612] Starting subtest: wait-busy
[533.203825] Starting dynamic subtest: pipe-A-eDP-1
[535.076621] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[535.089488] Starting dynamic subtest: pipe-D-eDP-1
[538.358803] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.278s)
[538.360698] Subtest wait-busy: SUCCESS (5.157s)
[538.708718] [080/133] (482s left) kms_psr (psr2-dpms)
[538.807084] Starting subtest: psr2-dpms
[538.809385] Starting dynamic subtest: eDP-1
[541.614529] Dynamic subtest eDP-1: SUCCESS (2.807s)
[541.616660] Subtest psr2-dpms: SUCCESS (2.808s)
[542.492864] [081/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[542.581548] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[542.585521] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[542.686448] [082/133] (478s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[542.802184] Starting subtest: cursorB-vs-flipB-toggle
[542.806590] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[542.945431] [083/133] (478s left) kms_addfb_basic (bad-pitch-65536)
[542.991231] Starting subtest: bad-pitch-65536
[542.993379] Subtest bad-pitch-65536: SUCCESS (0.000s)
[543.117109] [084/133] (478s left) fbdev (eof)
[543.155980] Starting subtest: eof
[543.158197] Subtest eof: SUCCESS (0.000s)
[543.227077] [085/133] (478s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[543.332893] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[543.335170] Starting dynamic subtest: pipe-A-eDP-1
[543.358969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.369242] Starting dynamic subtest: pipe-B-eDP-1
[543.391034] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.401807] Starting dynamic subtest: pipe-C-eDP-1
[543.425148] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.435615] Starting dynamic subtest: pipe-D-eDP-1
[543.455822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[543.459352] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[545.551955] [086/133] (476s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[545.606352] Starting subtest: legacy-engines-hostile-preempt
[545.608665] Starting dynamic subtest: render
[545.648490] Dynamic subtest render: SUCCESS (0.041s)
[545.658079] Starting dynamic subtest: bsd1
[546.876206] Dynamic subtest bsd1: SUCCESS (1.225s)
[546.887962] Starting dynamic subtest: bsd2
[548.881150] Dynamic subtest bsd2: SUCCESS (2.001s)
[548.894082] Starting dynamic subtest: blt
[548.937732] Dynamic subtest blt: SUCCESS (0.055s)
[548.953406] Starting dynamic subtest: vebox
[550.926049] Dynamic subtest vebox: SUCCESS (1.983s)
[550.928909] Subtest legacy-engines-hostile-preempt: SUCCESS (5.319s)
[551.015450] [087/133] (470s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[551.122133] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[551.126630] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[551.208234] [088/133] (470s left) gem_exec_schedule (in-order)
[551.282740] Starting subtest: in-order
[551.285068] Starting dynamic subtest: rcs0
[551.383356] Dynamic subtest rcs0: SUCCESS (0.109s)
[551.394539] Starting dynamic subtest: vcs0
[551.472623] Dynamic subtest vcs0: SUCCESS (0.089s)
[551.483385] Starting dynamic subtest: vcs1
[551.567059] Dynamic subtest vcs1: SUCCESS (0.093s)
[551.578785] Starting dynamic subtest: vecs0
[551.641268] Dynamic subtest vecs0: SUCCESS (0.073s)
[551.650384] Starting dynamic subtest: ccs0
[551.730116] Dynamic subtest ccs0: SUCCESS (0.088s)
[551.732553] Subtest in-order: SUCCESS (0.457s)
[553.024093] [089/133] (468s left) kms_psr (fbc-psr-primary-mmap-cpu)
[553.124186] Starting subtest: fbc-psr-primary-mmap-cpu
[553.126521] Starting dynamic subtest: eDP-1
[553.130904] Dynamic subtest eDP-1: SKIP (0.000s)
[553.135327] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[553.196225] [090/133] (468s left) kms_fbcon_fbt (fbc-suspend)
[553.253633] Starting subtest: fbc-suspend
[602.534440] Subtest fbc-suspend: SUCCESS (19.222s)
[603.896877] [091/133] (418s left) kms_plane_scaling (invalid-num-scalers)
[603.995903] Starting subtest: invalid-num-scalers
[603.998211] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[604.013110] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[604.029516] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[604.045366] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[604.055760] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[604.081059] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[604.091192] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[604.111962] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[604.114277] Subtest invalid-num-scalers: SUCCESS (0.118s)
[604.225655] [092/133] (417s left) gem_workarounds (reset-fd)
[604.293667] Starting subtest: reset-fd
[604.472930] Subtest reset-fd: SUCCESS (0.182s)
[604.589995] [093/133] (417s left) i915_pm_rc6_residency (rc6-idle)
[604.647912] Starting subtest: rc6-idle
[604.671128] Starting dynamic subtest: gt0-rcs0
[629.046402] Dynamic subtest gt0-rcs0: SUCCESS (24.422s)
[629.056499] Starting dynamic subtest: gt0-bcs0
[653.336599] Dynamic subtest gt0-bcs0: SUCCESS (24.283s)
[653.348296] Starting dynamic subtest: gt0-ccs0
[677.618774] Dynamic subtest gt0-ccs0: SUCCESS (24.287s)
[677.628370] Starting dynamic subtest: gt1-vcs0
[683.794531] Dynamic subtest gt1-vcs0: SUCCESS (6.173s)
[683.806848] Starting dynamic subtest: gt1-vecs0
[689.966549] Dynamic subtest gt1-vecs0: SUCCESS (6.171s)
[689.969450] Subtest rc6-idle: SUCCESS (85.375s)
[690.056386] [094/133] (332s left) i915_module_load (reload-no-display)
[690.099723] Starting subtest: reload-no-display
[695.941534] Subtest reload-no-display: SUCCESS (5.843s)
[695.968211] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[695.968999] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[695.972546] [095/133] (326s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[697.543288] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[702.066095] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.524s)
[703.287935] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[703.289185] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[703.293849] [096/133] (318s left) kms_plane_cursor (viewport)
[703.395553] Starting subtest: viewport
[703.399896] Starting dynamic subtest: pipe-A-eDP-1-size-64
[705.873689] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.478s)
[705.934777] Starting dynamic subtest: pipe-A-eDP-1-size-128
[708.320240] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.394s)
[708.380209] Starting dynamic subtest: pipe-A-eDP-1-size-256
[710.822420] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[711.170898] Starting dynamic subtest: pipe-B-eDP-1-size-64
[714.349135] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.187s)
[714.410391] Starting dynamic subtest: pipe-B-eDP-1-size-128
[716.774222] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.371s)
[716.833114] Starting dynamic subtest: pipe-B-eDP-1-size-256
[719.241453] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.416s)
[719.589163] Starting dynamic subtest: pipe-C-eDP-1-size-64
[722.378905] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.800s)
[722.417138] Starting dynamic subtest: pipe-C-eDP-1-size-128
[724.468385] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[724.506683] Starting dynamic subtest: pipe-C-eDP-1-size-256
[726.612338] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[726.941765] Starting dynamic subtest: pipe-D-eDP-1-size-64
[729.702459] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.771s)
[729.738165] Starting dynamic subtest: pipe-D-eDP-1-size-128
[731.857344] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[731.896248] Starting dynamic subtest: pipe-D-eDP-1-size-256
[733.923285] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[734.238770] Subtest viewport: SUCCESS (30.840s)
[735.089211] [097/133] (287s left) gem_exec_whisper (basic-fds-forked)
[735.148296] Starting subtest: basic-fds-forked
[759.394289] Subtest basic-fds-forked: SUCCESS (24.245s)
[759.592724] [098/133] (262s left) gem_mmap_gtt (zero-extend)
[759.647493] Subtest zero-extend: SKIP (0.000s)
[759.710028] [099/133] (262s left) kms_chamelium_frames (dp-crc-single)
[760.094172] Subtest dp-crc-single: SKIP (0.000s)
[760.888140] [100/133] (261s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[760.981645] Starting subtest: psr-rgb101010-draw-mmap-wc
[767.920234] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.945s)
[768.023090] [101/133] (254s left) gem_exec_reloc (basic-gtt-read-noreloc)
[768.085393] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[768.148744] [102/133] (254s left) kms_properties (get_properties-sanity-atomic)
[768.248431] Starting subtest: get_properties-sanity-atomic
[768.250812] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[768.328968] [103/133] (254s left) gem_softpin (evict-single-offset)
[768.395571] Starting subtest: evict-single-offset
[796.086722] Subtest evict-single-offset: SUCCESS (27.695s)
[796.214836] [104/133] (226s left) kms_addfb_basic (invalid-set-prop-any)
[796.315328] Starting subtest: invalid-set-prop-any
[796.317419] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[796.453146] [105/133] (226s left) gem_create (create-massive)
[796.504548] Starting subtest: create-massive
[796.506915] Subtest create-massive: SUCCESS (0.000s)
[796.746779] [106/133] (225s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[796.857480] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[796.861426] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[796.948832] [107/133] (225s left) kms_flip (2x-flip-vs-suspend-interruptible)
[797.046547] Starting subtest: 2x-flip-vs-suspend-interruptible
[797.060839] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.013s)
[797.139106] [108/133] (225s left) gem_exec_fence (syncobj-channel)
[797.588564] Starting subtest: syncobj-channel
[798.606400] Subtest syncobj-channel: SUCCESS (1.015s)
[799.174732] [109/133] (223s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[799.280156] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[803.275308] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.000s)
[804.417535] [110/133] (218s left) gem_eio (in-flight-contexts-immediate)
[804.652837] Starting subtest: in-flight-contexts-immediate
[816.074654] Subtest in-flight-contexts-immediate: SUCCESS (11.422s)
[816.249329] [111/133] (206s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[816.308410] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[816.368724] [112/133] (206s left) kms_async_flips (async-flip-hang)
[816.464973] Starting subtest: async-flip-hang
[816.836348] Starting dynamic subtest: pipe-A-eDP-1
[820.064310] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.229s)
[820.442289] Starting dynamic subtest: pipe-B-eDP-1
[823.660240] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.224s)
[824.040847] Starting dynamic subtest: pipe-C-eDP-1
[827.197992] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.163s)
[827.591660] Starting dynamic subtest: pipe-D-eDP-1
[830.739513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.155s)
[830.741770] Subtest async-flip-hang: SUCCESS (14.275s)
[831.954175] [113/133] (191s left) kms_psr (fbc-pr-sprite-render)
[832.055951] Starting subtest: fbc-pr-sprite-render
[832.060222] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[832.130475] [114/133] (190s left) gem_flink_basic (bad-open)
[832.195287] Starting subtest: bad-open
[832.197584] Subtest bad-open: SUCCESS (0.000s)
[832.287306] [115/133] (190s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[832.395887] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[832.400098] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[832.496804] [116/133] (190s left) kms_getfb (getfb2-handle-closed)
[832.584899] Starting subtest: getfb2-handle-closed
[832.587179] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[832.681694] [117/133] (190s left) gem_exec_params (no-vebox)
[832.737693] Starting subtest: no-vebox
[832.740028] Subtest no-vebox: SUCCESS (0.002s)
[834.187250] [118/133] (189s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[834.292313] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[834.296625] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[834.388957] [119/133] (188s left) kms_atomic (plane-immutable-zpos)
[834.477743] Starting subtest: plane-immutable-zpos
[834.480016] Starting dynamic subtest: pipe-A-eDP-1
[835.136084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.659s)
[835.138548] Subtest plane-immutable-zpos: SUCCESS (0.660s)
[835.974971] [120/133] (187s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[836.063743] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[836.067695] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[836.162067] [121/133] (187s left) api_intel_allocator (alloc-simple)
[836.222448] Starting subtest: alloc-simple
[836.225231] Subtest alloc-simple: SUCCESS (0.003s)
[836.358297] [122/133] (187s left) gem_exec_whisper (basic-queues-forked)
[836.431933] Starting subtest: basic-queues-forked
[859.606438] Subtest basic-queues-forked: SUCCESS (23.166s)
[859.787244] [123/133] (163s left) i915_drm_fdinfo (busy-idle)
[859.830624] Starting subtest: busy-idle
[859.832967] Starting dynamic subtest: rcs0
[859.847380] Dynamic subtest rcs0: SKIP (0.015s)
[859.857823] Starting dynamic subtest: bcs0
[859.862393] Dynamic subtest bcs0: SKIP (0.012s)
[859.873081] Starting dynamic subtest: vcs0
[859.877514] Dynamic subtest vcs0: SKIP (0.000s)
[859.886820] Starting dynamic subtest: vcs1
[859.891343] Dynamic subtest vcs1: SKIP (0.000s)
[859.900838] Starting dynamic subtest: vecs0
[859.905197] Dynamic subtest vecs0: SKIP (0.000s)
[859.914959] Starting dynamic subtest: ccs0
[859.919353] Dynamic subtest ccs0: SKIP (0.000s)
[859.923767] Subtest busy-idle: SKIP (0.032s)
[859.961167] [124/133] (163s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[860.045553] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[860.047835] Starting dynamic subtest: pipe-A-eDP-1
[860.071956] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[860.084227] Starting dynamic subtest: pipe-B-eDP-1
[860.105949] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[860.115861] Starting dynamic subtest: pipe-C-eDP-1
[860.138295] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[860.150202] Starting dynamic subtest: pipe-D-eDP-1
[860.172039] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[860.175972] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[862.343957] [125/133] (161s left) kms_big_fb (linear-16bpp-rotate-0)
[862.458927] Starting subtest: linear-16bpp-rotate-0
[863.828450] Subtest linear-16bpp-rotate-0: SUCCESS (1.370s)
[863.964035] [126/133] (159s left) gem_exec_schedule (u-semaphore-resolve)
[864.039556] Starting subtest: u-semaphore-resolve
[864.072112] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[864.401017] [127/133] (159s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[864.459203] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[864.461159] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[864.546878] [128/133] (159s left) perf_pmu (busy)
[864.591918] Starting subtest: busy
[864.594037] Starting dynamic subtest: rcs0
[865.176700] Dynamic subtest rcs0: SUCCESS (0.586s)
[865.190641] Starting dynamic subtest: bcs0
[865.739560] Dynamic subtest bcs0: SUCCESS (0.561s)
[865.752886] Starting dynamic subtest: vcs0
[867.063060] Dynamic subtest vcs0: SUCCESS (1.319s)
[867.076560] Starting dynamic subtest: vcs1
[869.110060] Dynamic subtest vcs1: SUCCESS (2.044s)
[869.123678] Starting dynamic subtest: vecs0
[871.094826] Dynamic subtest vecs0: SUCCESS (1.981s)
[871.108198] Starting dynamic subtest: ccs0
[871.666435] Dynamic subtest ccs0: SUCCESS (0.570s)
[871.669665] Subtest busy: SUCCESS (7.076s)
[871.776012] [129/133] (151s left) kms_chamelium_color (ctm-blue-to-red)
[871.863007] Subtest ctm-blue-to-red: SKIP (0.000s)
[871.912140] [130/133] (151s left) kms_content_protection (lic-type-0-hdcp14)
[872.060851] Starting subtest: lic-type-0-hdcp14
[872.064846] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[872.187110] [131/133] (151s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[872.287354] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[872.291795] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[872.383394] [132/133] (151s left) gem_ppgtt (flink-and-close-vma-leak)
[872.437835] Starting subtest: flink-and-close-vma-leak
[872.481855] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[872.622125] [133/133] (151s left) kms_cursor_crc (cursor-sliding-512x170)
[872.936821] Starting subtest: cursor-sliding-512x170
[872.940259] Subtest cursor-sliding-512x170: SKIP (0.002s)
[873.066397] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_plane
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_addfb_basic
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_ppgtt
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: core_getstats
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: gem_exec_await
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: gem_render_linear_blits
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: kms_plane_alpha_blend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: i915_selftest
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: kms_tiled_display
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_fbcon_fbt
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: i915_pm_rc6_residency
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_cursor
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: gem_create
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_flink_basic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_ppgtt
results: parsing output: 132/ for test: kms_cursor_crc
Done.