[59.835180] Initializing watchdogs
[59.835235]   /dev/watchdog0
[59.850767] [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]
[59.855387] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.857529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.860972] [001/133] (960s left) perf_pmu (busy-start)
[59.929034] Starting subtest: busy-start
[59.931768] Starting dynamic subtest: rcs0
[62.506757] Dynamic subtest rcs0: SUCCESS (2.556s)
[62.516348] Starting dynamic subtest: bcs0
[65.054042] Dynamic subtest bcs0: SUCCESS (2.548s)
[65.063102] Starting dynamic subtest: vcs0
[68.887996] Dynamic subtest vcs0: SUCCESS (3.851s)
[68.898199] Starting dynamic subtest: vcs1
[72.917075] Dynamic subtest vcs1: SUCCESS (4.026s)
[72.926041] Starting dynamic subtest: vecs0
[76.886270] Dynamic subtest vecs0: SUCCESS (3.968s)
[76.894646] Starting dynamic subtest: ccs0
[79.458153] Dynamic subtest ccs0: SUCCESS (2.552s)
[79.460128] Subtest busy-start: SUCCESS (19.511s)
[79.569183] [002/133] (940s left) gem_exec_flush (basic-wb-rw-before-default)
[79.629971] Starting subtest: basic-wb-rw-before-default
[85.090788] Subtest basic-wb-rw-before-default: SUCCESS (5.463s)
[85.280435] [003/133] (935s left) kms_lease (lessee-list)
[85.377476] Starting subtest: lessee-list
[85.379959] Starting dynamic subtest: pipe-A-eDP-1
[85.382310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[85.389702] Starting dynamic subtest: pipe-B-eDP-1
[85.391668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[85.398949] Starting dynamic subtest: pipe-C-eDP-1
[85.400901] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[85.409024] Starting dynamic subtest: pipe-D-eDP-1
[85.411097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[85.413078] Subtest lessee-list: SUCCESS (0.007s)
[85.512941] [004/133] (934s left) i915_drm_fdinfo (virtual-busy-hang-all)
[85.549869] Starting subtest: virtual-busy-hang-all
[85.554246] Subtest virtual-busy-hang-all: SKIP (0.000s)
[85.631757] [005/133] (934s left) kms_atomic_interruptible (legacy-setmode)
[85.725723] Starting subtest: legacy-setmode
[85.727815] Starting dynamic subtest: pipe-A-eDP-1
[92.602248] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.875s)
[92.604552] Subtest legacy-setmode: SUCCESS (6.876s)
[93.421739] [006/133] (927s left) kms_color (ctm-max)
[93.520269] Starting subtest: ctm-max
[93.522553] Starting dynamic subtest: pipe-A-eDP-1
[94.223821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[94.232348] Starting dynamic subtest: pipe-B-eDP-1
[95.610480] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[95.619068] Starting dynamic subtest: pipe-C-eDP-1
[96.999118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[97.007777] Starting dynamic subtest: pipe-D-eDP-1
[98.313502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[98.315822] Subtest ctm-max: SUCCESS (4.795s)
[99.134871] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[99.239727] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[103.715850] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.481s)
[104.856637] [008/133] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[104.954821] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[104.959411] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[105.072737] [009/133] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[105.160889] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[105.163308] Starting dynamic subtest: pipe-A
[105.181265] Dynamic subtest pipe-A: SKIP (0.017s)
[105.189769] Starting dynamic subtest: pipe-B
[105.212518] Dynamic subtest pipe-B: SKIP (0.030s)
[105.220058] Starting dynamic subtest: pipe-C
[105.242268] Dynamic subtest pipe-C: SKIP (0.030s)
[105.249751] Starting dynamic subtest: pipe-D
[105.272195] Dynamic subtest pipe-D: SKIP (0.030s)
[105.276513] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[105.405151] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[105.520147] Starting subtest: y-tiled-64bpp-rotate-180
[105.524643] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[105.639189] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[105.734330] Starting subtest: primary-x-tiled-reflect-x-180
[112.707212] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.973s)
[113.910348] [012/133] (906s left) kms_flip (2x-flip-vs-expired-vblank)
[114.013092] Starting subtest: 2x-flip-vs-expired-vblank
[114.021505] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[114.111192] [013/133] (906s left) api_intel_allocator (fork-simple-stress)
[114.157330] Starting subtest: fork-simple-stress
[119.607405] Subtest fork-simple-stress: SUCCESS (5.395s)
[119.696282] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[119.798435] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[126.347591] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.555s)
[126.523341] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[126.628069] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[126.632302] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[126.761725] [016/133] (894s left) gem_mmap (bad-size)
[126.811038] Subtest bad-size: SKIP (0.000s)
[126.866604] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[126.926290] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[126.930696] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[127.116218] [018/133] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[127.210833] Starting subtest: psr-2p-primscrn-cur-indfb-move
[127.215328] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[127.349377] [019/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[127.454095] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[133.910661] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.458s)
[134.077758] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[134.133096] Starting subtest: wait-all-snapshot
[134.213552] Subtest wait-all-snapshot: SUCCESS (0.081s)
[134.306275] [021/133] (886s left) gem_partial_pwrite_pread (reads)
[134.365459] Subtest reads: SKIP (0.000s)
[134.427842] [022/133] (886s left) syncobj_basic (create-signaled)
[134.493287] Starting subtest: create-signaled
[134.495284] Subtest create-signaled: SUCCESS (0.000s)
[134.611751] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[135.003301] Subtest dp-crc-multiple: SKIP (0.000s)
[135.845560] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[135.971044] Starting subtest: cursorA-vs-flipA-varying-size
[147.143471] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.171s)
[148.009181] [025/133] (873s left) gem_ctx_persistence (hang)
[148.071725] Starting subtest: hang
[148.076405] Subtest hang: SKIP (0.000s)
[148.212054] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[148.310128] Starting subtest: pr-primary-page-flip
[148.314263] Subtest pr-primary-page-flip: SKIP (0.000s)
[148.392976] [027/133] (872s left) gem_lmem_swapping (heavy-random)
[148.438627] Subtest heavy-random: SKIP (0.000s)
[148.477982] [028/133] (872s left) kms_addfb_basic (master-rmfb)
[148.539486] Starting subtest: master-rmfb
[148.541376] Subtest master-rmfb: SUCCESS (0.001s)
[148.706698] [029/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[148.758097] Starting subtest: invalid-get-prop-any
[148.760273] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[148.934971] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[149.030230] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[149.031970] Starting dynamic subtest: pipe-A-eDP-1
[149.052221] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.060221] Starting dynamic subtest: pipe-B-eDP-1
[149.079186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.091937] Starting dynamic subtest: pipe-C-eDP-1
[149.111125] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.118946] Starting dynamic subtest: pipe-D-eDP-1
[149.138479] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.141912] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[151.274098] [031/133] (870s left) gem_exec_basic (basic)
[151.336944] Starting subtest: basic
[151.339258] Starting dynamic subtest: rcs0-smem
[151.341568] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[151.349515] Starting dynamic subtest: bcs0-smem
[151.351843] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[151.359296] Starting dynamic subtest: vcs0-smem
[151.361182] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[151.367999] Starting dynamic subtest: vcs1-smem
[151.369923] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[151.376801] Starting dynamic subtest: vecs0-smem
[151.378796] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[151.385744] Starting dynamic subtest: ccs0-smem
[151.387662] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[151.389586] Subtest basic: SUCCESS (0.016s)
[152.966506] [032/133] (868s left) gem_mmap_offset (oob-read)
[153.027663] Starting subtest: oob-read
[153.030066] Subtest oob-read: SUCCESS (0.000s)
[153.147853] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[153.248064] Starting subtest: bad-pixel-format-yf-tiled-ccs
[153.250359] Starting dynamic subtest: pipe-A-eDP-1
[153.273352] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.282717] Starting dynamic subtest: pipe-B-eDP-1
[153.305575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.313824] Starting dynamic subtest: pipe-C-eDP-1
[153.336109] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.345122] Starting dynamic subtest: pipe-D-eDP-1
[153.366179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.370184] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.012s)
[155.527913] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[155.707369] Starting subtest: cursor-random-64x21
[155.750111] Subtest cursor-random-64x21: SKIP (0.040s)
[156.024549] [035/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[156.143877] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[156.148057] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[156.253577] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[156.344635] Starting subtest: constant-alpha-max
[156.627753] Starting dynamic subtest: pipe-A-eDP-1
[157.721260] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.093s)
[157.729625] Starting dynamic subtest: pipe-D-eDP-1
[159.325715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.602s)
[159.328185] Subtest constant-alpha-max: SUCCESS (2.982s)
[160.194666] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[160.373847] Starting subtest: keep-in-fence
[160.375989] Starting dynamic subtest: rcs0
[160.462075] Dynamic subtest rcs0: SUCCESS (0.091s)
[160.472985] Starting dynamic subtest: bcs0
[160.515810] Dynamic subtest bcs0: SUCCESS (0.052s)
[160.525946] Starting dynamic subtest: vcs0
[161.943085] Dynamic subtest vcs0: SUCCESS (1.424s)
[161.953659] Starting dynamic subtest: vcs1
[163.926736] Dynamic subtest vcs1: SUCCESS (1.981s)
[163.937206] Starting dynamic subtest: vecs0
[165.909870] Dynamic subtest vecs0: SUCCESS (1.982s)
[165.920693] Starting dynamic subtest: ccs0
[166.162334] Dynamic subtest ccs0: SUCCESS (0.251s)
[166.165603] Subtest keep-in-fence: SUCCESS (5.792s)
[167.970854] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[167.974415] [038/133] (853s left) i915_pm_rps (min-max-config-idle)
[168.044892] Starting subtest: min-max-config-idle
[168.049870] Subtest min-max-config-idle: SKIP (0.001s)
[168.163027] [039/133] (853s left) dumb_buffer (map-invalid-size)
[168.211744] Starting subtest: map-invalid-size
[168.214165] Subtest map-invalid-size: SUCCESS (0.000s)
[168.316121] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[168.378201] Subtest basic-write-gtt: SKIP (0.000s)
[168.448535] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[168.525165] Starting subtest: set-cache-level
[168.529232] Subtest set-cache-level: SKIP (0.000s)
[168.685681] [042/133] (853s left) kms_psr (psr-primary-render)
[168.777828] Starting subtest: psr-primary-render
[168.781568] Starting dynamic subtest: eDP-1
[170.487350] Dynamic subtest eDP-1: SUCCESS (1.710s)
[170.489673] Subtest psr-primary-render: SUCCESS (1.711s)
[171.359562] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[171.539083] Starting subtest: create-ext-placement-sanity-check
[171.541611] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[171.671490] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[171.773219] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[171.784198] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[171.877940] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[171.943423] Starting subtest: u-lateslice
[171.945413] Starting dynamic subtest: rcs0
[171.953596] Dynamic subtest rcs0: SUCCESS (0.021s)
[171.963331] Starting dynamic subtest: bcs0
[171.971481] Dynamic subtest bcs0: SUCCESS (0.017s)
[171.979972] Starting dynamic subtest: vcs0
[171.988827] Dynamic subtest vcs0: SUCCESS (0.017s)
[171.996703] Starting dynamic subtest: vcs1
[172.007678] Dynamic subtest vcs1: SUCCESS (0.018s)
[172.015198] Starting dynamic subtest: vecs0
[172.025229] Dynamic subtest vecs0: SUCCESS (0.017s)
[172.032820] Starting dynamic subtest: ccs0
[172.042075] Dynamic subtest ccs0: SUCCESS (0.016s)
[172.044273] Subtest u-lateslice: SUCCESS (0.110s)
[174.002400] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[174.112235] Starting subtest: dpms-off-confusion-interruptible
[174.114499] Starting dynamic subtest: A-eDP1
[182.780493] Dynamic subtest A-eDP1: SUCCESS (8.634s)
[182.790879] Starting dynamic subtest: B-eDP1
[191.415930] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[191.425644] Starting dynamic subtest: C-eDP1
[200.041417] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[200.051747] Starting dynamic subtest: D-eDP1
[208.679788] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[208.682236] Subtest dpms-off-confusion-interruptible: SUCCESS (34.521s)
[209.825403] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[209.927928] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[216.731182] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.805s)
[216.926032] [048/133] (805s left) kms_plane (plane-position-hole)
[217.037109] Starting subtest: plane-position-hole
[217.539230] Starting dynamic subtest: pipe-A-plane-1
[218.828691] Dynamic subtest pipe-A-plane-1: SUCCESS (1.292s)
[218.837781] Starting dynamic subtest: pipe-A-plane-2
[220.117457] Dynamic subtest pipe-A-plane-2: SUCCESS (1.287s)
[220.126075] Starting dynamic subtest: pipe-A-plane-3
[221.357336] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s)
[221.368527] Starting dynamic subtest: pipe-A-plane-4
[222.578791] Dynamic subtest pipe-A-plane-4: SUCCESS (1.220s)
[222.588056] Starting dynamic subtest: pipe-A-plane-5
[222.607374] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[223.748538] Starting dynamic subtest: pipe-B-plane-1
[224.995436] Dynamic subtest pipe-B-plane-1: SUCCESS (1.255s)
[225.011885] Starting dynamic subtest: pipe-B-plane-2
[226.292425] Dynamic subtest pipe-B-plane-2: SUCCESS (1.294s)
[226.301872] Starting dynamic subtest: pipe-B-plane-3
[227.532539] Dynamic subtest pipe-B-plane-3: SUCCESS (1.242s)
[227.541408] Starting dynamic subtest: pipe-B-plane-4
[228.854040] Dynamic subtest pipe-B-plane-4: SUCCESS (1.320s)
[228.868296] Starting dynamic subtest: pipe-B-plane-5
[228.878477] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[228.880450] Subtest plane-position-hole: SUCCESS (11.842s)
[229.666961] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[229.775134] Starting subtest: draw-method-mmap-cpu
[229.777033] Starting dynamic subtest: xrgb8888-untiled
[230.005808] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[230.013681] Starting dynamic subtest: rgb565-untiled
[230.217169] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[230.225408] Starting dynamic subtest: xrgb2101010-untiled
[230.428489] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[230.436400] Starting dynamic subtest: xbgr16161616f-untiled
[230.627954] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[230.635982] Starting dynamic subtest: xrgb8888-xtiled
[230.749880] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[230.757998] Starting dynamic subtest: rgb565-xtiled
[230.872283] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[230.880339] Starting dynamic subtest: xrgb2101010-xtiled
[230.983839] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[230.991387] Starting dynamic subtest: xbgr16161616f-xtiled
[231.105876] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[231.113870] Starting dynamic subtest: xrgb8888-4tiled
[231.238932] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[231.247118] Starting dynamic subtest: rgb565-4tiled
[231.372263] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[231.380333] Starting dynamic subtest: xrgb2101010-4tiled
[231.494602] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[231.502461] Starting dynamic subtest: xbgr16161616f-4tiled
[231.638943] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[231.640744] Subtest draw-method-mmap-cpu: SUCCESS (1.867s)
[231.766192] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[231.832319] Subtest medium-copy-XY: SKIP (0.000s)
[231.898401] [051/133] (790s left) vgem_basic (bad-flag)
[231.943217] Starting subtest: bad-flag
[231.944991] Subtest bad-flag: SUCCESS (0.000s)
[232.011659] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[232.075296] Starting subtest: engines-hostile-preempt
[232.077220] Starting dynamic subtest: rcs0
[232.189549] Dynamic subtest rcs0: SUCCESS (0.113s)
[232.200387] Starting dynamic subtest: bcs0
[232.261530] Dynamic subtest bcs0: SUCCESS (0.070s)
[232.271237] Starting dynamic subtest: vcs0
[233.958937] Dynamic subtest vcs0: SUCCESS (1.694s)
[233.969626] Starting dynamic subtest: vcs1
[235.954105] Dynamic subtest vcs1: SUCCESS (1.993s)
[235.964716] Starting dynamic subtest: vecs0
[237.993114] Dynamic subtest vecs0: SUCCESS (1.977s)
[238.003474] Starting dynamic subtest: ccs0
[238.005652] Dynamic subtest ccs0: SUCCESS (0.032s)
[238.007774] Subtest engines-hostile-preempt: SUCCESS (5.891s)
[238.116862] [053/133] (784s left) kms_sequence (queue-idle)
[238.224873] Starting subtest: queue-idle
[238.227039] Starting dynamic subtest: pipe-A-eDP-1
[240.046418] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[240.055258] Starting dynamic subtest: pipe-B-eDP-1
[242.551894] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[242.560086] Starting dynamic subtest: pipe-C-eDP-1
[244.978947] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[244.988620] Starting dynamic subtest: pipe-D-eDP-1
[247.388783] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.407s)
[247.390653] Subtest queue-idle: SUCCESS (9.163s)
[248.226534] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[248.339413] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[248.341821] Starting dynamic subtest: pipe-A-eDP-1
[248.411769] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[248.422533] Starting dynamic subtest: pipe-B-eDP-1
[249.505344] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[249.509880] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.170s)
[250.709632] [055/133] (771s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[250.814035] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[250.818652] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[250.927517] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[251.022129] Starting subtest: atomic-plane-damage
[251.071053] Starting dynamic subtest: pipe-A-eDP-1
[251.587710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[251.590191] Subtest atomic-plane-damage: SUCCESS (0.565s)
[252.432080] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[252.537662] Starting subtest: linear-16bpp-rotate-90
[252.556941] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[252.729449] [058/133] (769s left) perf (stress-open-close)
[252.867646] Starting subtest: stress-open-close
[252.869856] Starting dynamic subtest: 0-rcs0
[255.031446] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[255.041383] Starting dynamic subtest: 1-vcs0
[257.204770] Dynamic subtest 1-vcs0: SUCCESS (2.172s)
[257.206825] Subtest stress-open-close: SUCCESS (4.339s)
[257.249172] [059/133] (765s left) gem_workarounds (basic-read-fd)
[257.310810] Starting subtest: basic-read-fd
[257.321133] Subtest basic-read-fd: SUCCESS (0.013s)
[257.491288] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[257.597659] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[258.599950] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.001s)
[258.775403] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[258.882059] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[258.885563] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[258.997082] [062/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[259.089245] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[259.092600] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[259.206852] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[259.309483] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[259.313053] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[259.425694] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[259.581690] Starting subtest: cursor-offscreen-32x10
[259.624097] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[259.958527] [065/133] (763s left) kms_psr (psr2-primary-render)
[260.056470] Starting subtest: psr2-primary-render
[260.058329] Starting dynamic subtest: eDP-1
[261.813958] Dynamic subtest eDP-1: SUCCESS (1.757s)
[261.816307] Subtest psr2-primary-render: SUCCESS (1.758s)
[262.685230] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[262.785616] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[262.790345] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[262.886463] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[263.072325] Starting subtest: noreorder-priority
[263.074940] Starting dynamic subtest: rcs0
[264.209870] Dynamic subtest rcs0: SUCCESS (1.139s)
[264.221299] Starting dynamic subtest: vcs0
[265.966242] Dynamic subtest vcs0: SUCCESS (1.753s)
[265.978112] Starting dynamic subtest: vcs1
[267.963558] Dynamic subtest vcs1: SUCCESS (1.994s)
[267.975208] Starting dynamic subtest: vecs0
[269.891668] Dynamic subtest vecs0: SUCCESS (1.926s)
[269.902327] Starting dynamic subtest: ccs0
[271.064339] Dynamic subtest ccs0: SUCCESS (1.171s)
[271.067063] Subtest noreorder-priority: SUCCESS (7.995s)
[271.270116] [068/133] (751s left) gem_softpin (allocator-evict)
[271.330653] Starting subtest: allocator-evict
[271.332995] Starting dynamic subtest: rcs0
[295.101521] Dynamic subtest rcs0: SUCCESS (23.769s)
[295.112912] Starting dynamic subtest: bcs0
[318.778499] Dynamic subtest bcs0: SUCCESS (23.674s)
[318.789659] Starting dynamic subtest: vcs0
[342.547383] Dynamic subtest vcs0: SUCCESS (23.767s)
[342.556130] Starting dynamic subtest: vcs1
[366.062368] Dynamic subtest vcs1: SUCCESS (23.511s)
[366.073861] Starting dynamic subtest: vecs0
[389.573057] Dynamic subtest vecs0: SUCCESS (23.508s)
[389.584704] Starting dynamic subtest: ccs0
[413.315322] Dynamic subtest ccs0: SUCCESS (23.740s)
[413.318073] Subtest allocator-evict: SUCCESS (141.979s)
[413.412117] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[413.573018] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[418.327046] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.759s)
[419.478644] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[419.542537] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[419.631912] [071/133] (603s left) gem_ctx_shared (single-timeline)
[419.695304] Starting subtest: single-timeline
[419.714394] Subtest single-timeline: SUCCESS (0.013s)
[419.957076] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[420.011596] Starting subtest: etime-multi-wait-all-for-submit-submitted
[420.122167] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[420.209382] [073/133] (603s left) syncobj_timeline (etime-single-wait-all-submitted)
[420.261445] Starting subtest: etime-single-wait-all-submitted
[420.370288] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[420.460351] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[420.843651] Subtest dp-hpd-storm: SKIP (0.000s)
[421.660038] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[421.758532] Starting subtest: 2x-flip-vs-suspend
[421.767876] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[421.872707] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[421.972516] Starting subtest: fbc-psr2-sprite-plane-move
[421.974504] Starting dynamic subtest: eDP-1
[421.978691] Dynamic subtest eDP-1: SKIP (0.000s)
[421.982856] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[422.077668] [077/133] (601s left) gem_exec_params (mmapped)
[422.153261] Starting subtest: mmapped
[422.155696] Subtest mmapped: SUCCESS (0.003s)
[422.324411] [078/133] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[422.422824] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[422.426771] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[422.559181] [079/133] (600s left) sw_sync (sync_merge_invalid)
[422.598777] Starting subtest: sync_merge_invalid
[422.615423] Subtest sync_merge_invalid: SUCCESS (0.016s)
[422.697386] [080/133] (600s left) perf_pmu (busy)
[422.743631] Starting subtest: busy
[422.745513] Starting dynamic subtest: rcs0
[423.361769] Dynamic subtest rcs0: SUCCESS (0.618s)
[423.371973] Starting dynamic subtest: bcs0
[423.920832] Dynamic subtest bcs0: SUCCESS (0.557s)
[423.931364] Starting dynamic subtest: vcs0
[425.878482] Dynamic subtest vcs0: SUCCESS (1.953s)
[425.890216] Starting dynamic subtest: vcs1
[427.926556] Dynamic subtest vcs1: SUCCESS (2.044s)
[427.938132] Starting dynamic subtest: vecs0
[429.910640] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.922577] Starting dynamic subtest: ccs0
[430.482728] Dynamic subtest ccs0: SUCCESS (0.571s)
[430.485479] Subtest busy: SUCCESS (7.740s)
[430.600024] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[430.646273] Starting subtest: multi-wait-for-submit-submitted-signaled
[430.648514] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[430.751122] [082/133] (592s left) gem_mmap_wc (write-wc-read-gtt)
[430.814628] Subtest write-wc-read-gtt: SKIP (0.000s)
[430.886311] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[431.237601] Starting subtest: inject-audio
[431.519304] Subtest inject-audio: SUCCESS (0.284s)
[432.159434] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[432.278255] Starting subtest: 2x-blocking-wf_vblank
[432.301728] Subtest 2x-blocking-wf_vblank: SKIP (0.024s)
[432.409423] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[432.507156] Starting subtest: plane-all-transition-nonblocking-fencing
[432.509349] Starting dynamic subtest: pipe-A-eDP-1
[435.001080] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[435.307533] Starting dynamic subtest: pipe-B-eDP-1
[438.514987] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[438.817210] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.312s)
[439.615741] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[439.747729] Starting subtest: flip-vs-cursor-crc-legacy
[440.452436] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.705s)
[441.315829] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[441.405416] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[441.409673] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[441.483083] [088/133] (582s left) gem_exec_params (invalid-ring2)
[441.548197] Starting subtest: invalid-ring2
[441.550053] Subtest invalid-ring2: SUCCESS (0.000s)
[441.664668] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[441.767291] Starting subtest: fbcpsr-slowdraw
[466.987756] Subtest fbcpsr-slowdraw: SUCCESS (25.223s)
[467.145643] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[467.251339] Starting subtest: basic-force-ultra-joiner
[467.255292] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[467.331897] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[467.424167] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[467.450376] Starting dynamic subtest: pipe-A-plane-0
[467.738507] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[467.748204] Starting dynamic subtest: pipe-A-plane-3
[467.972246] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[469.071421] Starting dynamic subtest: pipe-B-plane-0
[469.364128] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[469.374250] Starting dynamic subtest: pipe-B-plane-3
[469.597369] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[469.905013] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.482s)
[470.725282] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[470.829496] Starting subtest: query-forked-busy-hang
[470.831759] Starting dynamic subtest: pipe-A-eDP-1
[497.688912] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.858s)
[497.703337] Starting dynamic subtest: pipe-D-eDP-1
[522.652932] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[522.654898] Subtest query-forked-busy-hang: SUCCESS (51.822s)
[523.509446] [093/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[523.603890] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[523.607921] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[523.736397] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[523.849278] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[524.429149] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.581s)
[524.651262] [095/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[524.760334] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[524.762599] Starting dynamic subtest: pipe-A-default-mode
[527.497879] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[527.500277] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.740s)
[528.331905] [096/133] (495s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[528.390270] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[528.497450] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[528.589495] [097/133] (495s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[528.687774] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[528.692190] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[528.840021] [098/133] (495s left) gem_exec_whisper (basic-fds-forked)
[528.903058] Starting subtest: basic-fds-forked
[552.081288] Subtest basic-fds-forked: SUCCESS (23.169s)
[552.283542] [099/133] (472s left) kms_addfb_basic (bad-pitch-999)
[552.353515] Starting subtest: bad-pitch-999
[552.355501] Subtest bad-pitch-999: SUCCESS (0.000s)
[552.512677] [100/133] (471s left) kms_prop_blob (basic)
[552.567666] Starting subtest: basic
[552.569975] Subtest basic: SUCCESS (0.000s)
[552.697541] [101/133] (471s left) syncobj_basic (bad-pad-fd-to-handle)
[552.760175] Starting subtest: bad-pad-fd-to-handle
[552.762424] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[552.889223] [102/133] (471s left) kms_cursor_crc (cursor-sliding-256x256)
[553.115424] Starting subtest: cursor-sliding-256x256
[553.120433] Starting dynamic subtest: pipe-A-eDP-1
[556.370693] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.251s)
[556.397145] Starting dynamic subtest: pipe-D-eDP-1
[560.293066] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.902s)
[560.295432] Subtest cursor-sliding-256x256: SUCCESS (7.177s)
[561.151884] [103/133] (463s left) gem_busy (busy)
[561.225491] Starting subtest: busy
[561.227614] Starting dynamic subtest: all-engines
[561.297818] Dynamic subtest all-engines: SUCCESS (0.072s)
[561.306784] Starting dynamic subtest: rcs0
[562.909080] Dynamic subtest rcs0: SUCCESS (1.610s)
[562.922606] Starting dynamic subtest: bcs0
[562.977244] Dynamic subtest bcs0: SUCCESS (0.064s)
[562.987395] Starting dynamic subtest: vcs0
[563.017220] Dynamic subtest vcs0: SUCCESS (0.039s)
[563.026097] Starting dynamic subtest: vcs1
[564.894303] Dynamic subtest vcs1: SUCCESS (1.873s)
[564.905225] Starting dynamic subtest: vecs0
[566.990650] Dynamic subtest vecs0: SUCCESS (2.043s)
[567.001971] Starting dynamic subtest: ccs0
[568.860369] Dynamic subtest ccs0: SUCCESS (1.919s)
[568.862631] Subtest busy: SUCCESS (7.632s)
[569.253387] [104/133] (455s left) i915_pm_rps (thresholds)
[569.318447] Starting subtest: thresholds
[569.323237] Subtest thresholds: SKIP (0.001s)
[569.450893] [105/133] (455s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[569.565055] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[569.567452] Starting dynamic subtest: pipe-A-eDP-1
[569.591322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.603060] Starting dynamic subtest: pipe-B-eDP-1
[569.624324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.632692] Starting dynamic subtest: pipe-C-eDP-1
[569.653806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.663626] Starting dynamic subtest: pipe-D-eDP-1
[569.685679] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.690172] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[571.820612] [106/133] (452s left) gem_softpin (evict-snoop-interruptible)
[571.885727] Starting subtest: evict-snoop-interruptible
[571.890192] Subtest evict-snoop-interruptible: SKIP (0.000s)
[572.036927] [107/133] (452s left) gem_mmap_gtt (big-bo)
[572.095543] Subtest big-bo: SKIP (0.000s)
[572.163203] [108/133] (452s left) gem_partial_pwrite_pread (write-display)
[572.217999] Subtest write-display: SKIP (0.000s)
[572.296385] [109/133] (452s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[572.386330] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[572.388648] Starting dynamic subtest: pipe-A-eDP-1
[572.410546] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.422080] Starting dynamic subtest: pipe-B-eDP-1
[572.443109] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[572.451265] Starting dynamic subtest: pipe-C-eDP-1
[572.472396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[572.481079] Starting dynamic subtest: pipe-D-eDP-1
[572.502923] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[572.506984] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[574.619816] [110/133] (450s left) kms_psr (fbc-pr-cursor-blt)
[574.716809] Starting subtest: fbc-pr-cursor-blt
[574.721083] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[574.811722] [111/133] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[574.876566] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[574.878714] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[575.002537] [112/133] (449s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[575.058857] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[575.063377] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[575.265018] [113/133] (449s left) gem_mmap (basic)
[575.324734] Subtest basic: SKIP (0.000s)
[575.389716] [114/133] (449s left) gem_exec_gttfill (basic)
[575.456818] Starting subtest: basic
[577.983321] Subtest basic: SUCCESS (2.526s)
[578.189280] [115/133] (446s left) kms_addfb_basic (size-max)
[578.337943] Starting subtest: size-max
[578.340240] Subtest size-max: SUCCESS (0.000s)
[578.460209] [116/133] (446s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[578.549052] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[578.551187] Starting dynamic subtest: pipe-A-eDP-1
[578.573091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.583759] Starting dynamic subtest: pipe-B-eDP-1
[578.604242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.612764] Starting dynamic subtest: pipe-C-eDP-1
[578.634604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.645224] Starting dynamic subtest: pipe-D-eDP-1
[578.668593] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.672706] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[580.805761] [117/133] (444s left) api_intel_bb (purge-bb)
[580.864393] Starting subtest: purge-bb
[580.866672] Subtest purge-bb: SUCCESS (0.004s)
[581.034970] [118/133] (444s left) kms_cursor_legacy (forked-move)
[581.159540] Starting subtest: forked-move
[581.162052] Starting dynamic subtest: pipe-A
[586.613295] Dynamic subtest pipe-A: SUCCESS (5.450s)
[586.624465] Starting dynamic subtest: pipe-B
[592.085637] Dynamic subtest pipe-B: SUCCESS (5.470s)
[592.096756] Starting dynamic subtest: pipe-C
[597.565986] Dynamic subtest pipe-C: SUCCESS (5.477s)
[597.577107] Starting dynamic subtest: pipe-D
[603.088965] Dynamic subtest pipe-D: SUCCESS (5.470s)
[603.098467] Starting dynamic subtest: all-pipes
[608.550324] Dynamic subtest all-pipes: SUCCESS (5.508s)
[608.553055] Subtest forked-move: SUCCESS (27.386s)
[608.729138] [119/133] (416s left) gen9_exec_parse (bb-chained)
[608.807949] Subtest bb-chained: SKIP (0.000s)
[608.899145] [120/133] (416s left) kms_concurrent (multi-plane-atomic-lowres)
[608.988088] Starting subtest: multi-plane-atomic-lowres
[608.990261] Starting dynamic subtest: pipe-A-eDP-1
[609.533108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[609.535248] Subtest multi-plane-atomic-lowres: SUCCESS (0.543s)
[610.401614] [121/133] (414s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[610.463804] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[610.547014] [122/133] (414s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[610.617016] Starting subtest: multi-wait-available-unsubmitted-submitted
[610.619438] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[610.744589] [123/133] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[610.852251] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[615.290757] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.444s)
[616.644479] [124/133] (408s left) kms_pm_dc (dc3co-vpb-simulation)
[617.750198] Starting subtest: dc3co-vpb-simulation
[626.390935] Subtest dc3co-vpb-simulation: SKIP (8.637s)
[626.544223] [125/133] (398s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[626.653059] Starting subtest: x-tiled-8bpp-rotate-90
[626.673914] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[626.810667] [126/133] (398s left) kms_plane_multiple (2x-tiling-none)
[626.910432] Starting subtest: 2x-tiling-none
[626.914899] Subtest 2x-tiling-none: SKIP (0.000s)
[627.000538] [127/133] (398s left) gem_exec_balancer (bonded-false-hang)
[627.257209] Starting subtest: bonded-false-hang
[627.262150] Subtest bonded-false-hang: SKIP (0.000s)
[627.388949] [128/133] (398s left) i915_drm_fdinfo (idle)
[627.432960] Starting subtest: idle
[627.434952] Starting dynamic subtest: rcs0
[628.043114] Dynamic subtest rcs0: SUCCESS (0.612s)
[628.054868] Starting dynamic subtest: bcs0
[628.550310] Dynamic subtest bcs0: SUCCESS (0.503s)
[628.562209] Starting dynamic subtest: vcs0
[629.055376] Dynamic subtest vcs0: SUCCESS (0.503s)
[629.066973] Starting dynamic subtest: vcs1
[629.561202] Dynamic subtest vcs1: SUCCESS (0.503s)
[629.573054] Starting dynamic subtest: vecs0
[630.066443] Dynamic subtest vecs0: SUCCESS (0.503s)
[630.078181] Starting dynamic subtest: ccs0
[630.572078] Dynamic subtest ccs0: SUCCESS (0.503s)
[630.574848] Subtest idle: SUCCESS (3.141s)
[630.662711] [129/133] (394s left) kms_getfb (getfb2-handle-closed)
[630.763708] Starting subtest: getfb2-handle-closed
[630.765890] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[630.906037] [130/133] (394s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[630.962080] Starting subtest: invalid-bsd1-flag-on-vebox
[630.964387] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[631.079992] [131/133] (394s left) kms_psr (fbc-pr-suspend)
[631.177800] Starting subtest: fbc-pr-suspend
[631.181678] Subtest fbc-pr-suspend: SKIP (0.000s)
[631.266867] [132/133] (394s left) gem_softpin (overlap)
[631.329044] Starting subtest: overlap
[632.157285] Subtest overlap: SUCCESS (0.827s)
[632.327319] [133/133] (393s left) gem_madvise (dontneed-before-mmap)
[632.365367] Starting subtest: dontneed-before-mmap
[632.379413] Subtest dontneed-before-mmap: SUCCESS (0.016s)
[632.487409] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_basic
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_concurrent
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_madvise
Done.