[58.180496] Initializing watchdogs
[58.180544]   /dev/watchdog0
[58.195041] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.199369] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.201520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.204988] [001/133] (960s left) perf_pmu (busy-start)
[58.271953] Starting subtest: busy-start
[58.274183] Starting dynamic subtest: rcs0
[60.827238] Dynamic subtest rcs0: SUCCESS (2.554s)
[60.836982] Starting dynamic subtest: bcs0
[63.379296] Dynamic subtest bcs0: SUCCESS (2.550s)
[63.389289] Starting dynamic subtest: vcs0
[67.059031] Dynamic subtest vcs0: SUCCESS (3.676s)
[67.066200] Starting dynamic subtest: vcs1
[70.933252] Dynamic subtest vcs1: SUCCESS (3.871s)
[70.942898] Starting dynamic subtest: vecs0
[74.904079] Dynamic subtest vecs0: SUCCESS (3.968s)
[74.911962] Starting dynamic subtest: ccs0
[77.453441] Dynamic subtest ccs0: SUCCESS (2.549s)
[77.456106] Subtest busy-start: SUCCESS (19.174s)
[77.566679] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[77.623081] Starting subtest: basic-wb-rw-before-default
[83.085830] Subtest basic-wb-rw-before-default: SUCCESS (5.464s)
[83.280556] [003/133] (935s left) kms_lease (lessee-list)
[83.376549] Starting subtest: lessee-list
[83.378749] Starting dynamic subtest: pipe-A-eDP-1
[83.381075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.388379] Starting dynamic subtest: pipe-B-eDP-1
[83.390301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.396955] Starting dynamic subtest: pipe-C-eDP-1
[83.398847] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.405520] Starting dynamic subtest: pipe-D-eDP-1
[83.407434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.409382] Subtest lessee-list: SUCCESS (0.007s)
[83.518503] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[83.562972] Starting subtest: virtual-busy-hang-all
[83.567429] Subtest virtual-busy-hang-all: SKIP (0.000s)
[83.647861] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[83.745141] Starting subtest: legacy-setmode
[83.747925] Starting dynamic subtest: pipe-A-eDP-1
[90.651402] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[90.653681] Subtest legacy-setmode: SUCCESS (6.907s)
[91.524017] [006/133] (927s left) kms_color (ctm-max)
[91.644116] Starting subtest: ctm-max
[91.646452] Starting dynamic subtest: pipe-A-eDP-1
[92.356771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[92.366421] Starting dynamic subtest: pipe-B-eDP-1
[93.726058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[93.734834] Starting dynamic subtest: pipe-C-eDP-1
[95.117967] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[95.125500] Starting dynamic subtest: pipe-D-eDP-1
[96.451651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[96.454033] Subtest ctm-max: SUCCESS (4.807s)
[97.269495] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[97.372648] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[101.658604] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.289s)
[102.814160] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.913051] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.917439] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[103.046742] [009/133] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[103.152852] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[103.155108] Starting dynamic subtest: pipe-A
[103.174714] Dynamic subtest pipe-A: SKIP (0.018s)
[103.182718] Starting dynamic subtest: pipe-B
[103.206802] Dynamic subtest pipe-B: SKIP (0.031s)
[103.214580] Starting dynamic subtest: pipe-C
[103.238052] Dynamic subtest pipe-C: SKIP (0.031s)
[103.245286] Starting dynamic subtest: pipe-D
[103.269080] Dynamic subtest pipe-D: SKIP (0.032s)
[103.272686] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.113s)
[103.380506] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[103.485756] Starting subtest: y-tiled-64bpp-rotate-180
[103.489792] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.613700] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[103.718208] Starting subtest: primary-x-tiled-reflect-x-180
[110.777126] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.060s)
[112.053254] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[112.156221] Starting subtest: 2x-flip-vs-expired-vblank
[112.165187] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[112.301348] [013/133] (906s left) api_intel_allocator (fork-simple-stress)
[112.364091] Starting subtest: fork-simple-stress
[117.765396] Subtest fork-simple-stress: SUCCESS (5.402s)
[117.909479] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[118.027429] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.634445] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.613s)
[124.802227] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[124.902532] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[124.906683] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[125.037288] [016/133] (894s left) gem_mmap (bad-size)
[125.097984] Subtest bad-size: SKIP (0.000s)
[125.184482] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[125.257734] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[125.262159] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[125.449240] [018/133] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[125.552299] Starting subtest: psr-2p-primscrn-cur-indfb-move
[125.556648] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.641341] [019/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[125.752869] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[132.330805] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.581s)
[132.488822] [020/133] (886s left) syncobj_timeline (wait-all-snapshot)
[132.562929] Starting subtest: wait-all-snapshot
[132.645024] Subtest wait-all-snapshot: SUCCESS (0.082s)
[132.740379] [021/133] (886s left) gem_partial_pwrite_pread (reads)
[132.809119] Subtest reads: SKIP (0.000s)
[132.878287] [022/133] (886s left) syncobj_basic (create-signaled)
[132.922532] Starting subtest: create-signaled
[132.924391] Subtest create-signaled: SUCCESS (0.000s)
[133.028791] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[133.428389] Subtest dp-crc-multiple: SKIP (0.000s)
[134.199570] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[134.331854] Starting subtest: cursorA-vs-flipA-varying-size
[145.505569] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.170s)
[146.367300] [025/133] (873s left) gem_ctx_persistence (hang)
[146.434899] Starting subtest: hang
[146.439384] Subtest hang: SKIP (0.000s)
[146.562657] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[146.667297] Starting subtest: pr-primary-page-flip
[146.671672] Subtest pr-primary-page-flip: SKIP (0.000s)
[146.762950] [027/133] (872s left) gem_lmem_swapping (heavy-random)
[146.809273] Subtest heavy-random: SKIP (0.000s)
[146.852198] [028/133] (872s left) kms_addfb_basic (master-rmfb)
[146.901395] Starting subtest: master-rmfb
[146.903615] Subtest master-rmfb: SUCCESS (0.001s)
[147.076263] [029/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[147.142407] Starting subtest: invalid-get-prop-any
[147.144346] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[147.312615] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[147.410670] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[147.412524] Starting dynamic subtest: pipe-A-eDP-1
[147.433481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.442961] Starting dynamic subtest: pipe-B-eDP-1
[147.461557] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.469691] Starting dynamic subtest: pipe-C-eDP-1
[147.488542] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.495296] Starting dynamic subtest: pipe-D-eDP-1
[147.514739] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.518267] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[149.722517] [031/133] (870s left) gem_exec_basic (basic)
[149.769621] Starting subtest: basic
[149.772019] Starting dynamic subtest: rcs0-smem
[149.774341] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[149.783962] Starting dynamic subtest: bcs0-smem
[149.786219] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[149.793494] Starting dynamic subtest: vcs0-smem
[149.795712] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[149.802998] Starting dynamic subtest: vcs1-smem
[149.805265] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[149.812592] Starting dynamic subtest: vecs0-smem
[149.814836] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[149.822115] Starting dynamic subtest: ccs0-smem
[149.824311] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[149.826532] Subtest basic: SUCCESS (0.014s)
[150.980614] [032/133] (868s left) gem_mmap_offset (oob-read)
[151.038246] Starting subtest: oob-read
[151.040562] Subtest oob-read: SUCCESS (0.000s)
[151.148166] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[151.249082] Starting subtest: bad-pixel-format-yf-tiled-ccs
[151.251359] Starting dynamic subtest: pipe-A-eDP-1
[151.274317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.283498] Starting dynamic subtest: pipe-B-eDP-1
[151.304789] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.311922] Starting dynamic subtest: pipe-C-eDP-1
[151.333182] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.340448] Starting dynamic subtest: pipe-D-eDP-1
[151.362537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.366954] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[153.495293] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[153.679807] Starting subtest: cursor-random-64x21
[153.723574] Subtest cursor-random-64x21: SKIP (0.041s)
[153.984273] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[154.090846] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[154.095347] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[154.178336] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[154.273115] Starting subtest: constant-alpha-max
[154.564561] Starting dynamic subtest: pipe-A-eDP-1
[155.598176] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.030s)
[155.605886] Starting dynamic subtest: pipe-D-eDP-1
[157.273788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.676s)
[157.276190] Subtest constant-alpha-max: SUCCESS (3.001s)
[158.160720] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[158.343632] Starting subtest: keep-in-fence
[158.345789] Starting dynamic subtest: rcs0
[158.419664] Dynamic subtest rcs0: SUCCESS (0.078s)
[158.435274] Starting dynamic subtest: bcs0
[158.473620] Dynamic subtest bcs0: SUCCESS (0.052s)
[158.483431] Starting dynamic subtest: vcs0
[159.893692] Dynamic subtest vcs0: SUCCESS (1.417s)
[159.904190] Starting dynamic subtest: vcs1
[161.942068] Dynamic subtest vcs1: SUCCESS (2.046s)
[161.952608] Starting dynamic subtest: vecs0
[163.926124] Dynamic subtest vecs0: SUCCESS (1.982s)
[163.936628] Starting dynamic subtest: ccs0
[164.163066] Dynamic subtest ccs0: SUCCESS (0.236s)
[164.165845] Subtest keep-in-fence: SUCCESS (5.822s)
[166.028556] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[166.031625] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[166.086934] Starting subtest: min-max-config-idle
[166.091729] Subtest min-max-config-idle: SKIP (0.001s)
[166.175496] [039/133] (853s left) dumb_buffer (map-invalid-size)
[166.238398] Starting subtest: map-invalid-size
[166.240290] Subtest map-invalid-size: SUCCESS (0.000s)
[166.357190] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[166.427146] Subtest basic-write-gtt: SKIP (0.000s)
[166.483405] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[166.553828] Starting subtest: set-cache-level
[166.558441] Subtest set-cache-level: SKIP (0.000s)
[166.711123] [042/133] (853s left) kms_psr (psr-primary-render)
[166.810879] Starting subtest: psr-primary-render
[166.813157] Starting dynamic subtest: eDP-1
[168.558741] Dynamic subtest eDP-1: SUCCESS (1.746s)
[168.560969] Subtest psr-primary-render: SUCCESS (1.747s)
[169.427396] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[169.602927] Starting subtest: create-ext-placement-sanity-check
[169.609396] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[169.733709] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.835181] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.844240] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[169.978823] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[170.061060] Starting subtest: u-lateslice
[170.062917] Starting dynamic subtest: rcs0
[170.072978] Dynamic subtest rcs0: SUCCESS (0.021s)
[170.081838] Starting dynamic subtest: bcs0
[170.092053] Dynamic subtest bcs0: SUCCESS (0.018s)
[170.100024] Starting dynamic subtest: vcs0
[170.112237] Dynamic subtest vcs0: SUCCESS (0.019s)
[170.120105] Starting dynamic subtest: vcs1
[170.132880] Dynamic subtest vcs1: SUCCESS (0.020s)
[170.140995] Starting dynamic subtest: vecs0
[170.151245] Dynamic subtest vecs0: SUCCESS (0.018s)
[170.159353] Starting dynamic subtest: ccs0
[170.170573] Dynamic subtest ccs0: SUCCESS (0.019s)
[170.172780] Subtest u-lateslice: SUCCESS (0.119s)
[172.041747] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[172.148509] Starting subtest: dpms-off-confusion-interruptible
[172.150947] Starting dynamic subtest: A-eDP1
[180.809399] Dynamic subtest A-eDP1: SUCCESS (8.660s)
[180.820881] Starting dynamic subtest: B-eDP1
[189.438424] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[189.448402] Starting dynamic subtest: C-eDP1
[198.049476] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[198.060692] Starting dynamic subtest: D-eDP1
[206.680198] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[206.685428] Subtest dpms-off-confusion-interruptible: SUCCESS (34.535s)
[207.881516] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[207.995766] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[214.856044] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.864s)
[215.041183] [048/133] (805s left) kms_plane (plane-position-hole)
[215.144730] Starting subtest: plane-position-hole
[215.674370] Starting dynamic subtest: pipe-A-plane-1
[217.066643] Dynamic subtest pipe-A-plane-1: SUCCESS (1.393s)
[217.076814] Starting dynamic subtest: pipe-A-plane-2
[218.296689] Dynamic subtest pipe-A-plane-2: SUCCESS (1.229s)
[218.307483] Starting dynamic subtest: pipe-A-plane-3
[219.541073] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s)
[219.551841] Starting dynamic subtest: pipe-A-plane-4
[220.781283] Dynamic subtest pipe-A-plane-4: SUCCESS (1.240s)
[220.791600] Starting dynamic subtest: pipe-A-plane-5
[220.807406] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[221.972022] Starting dynamic subtest: pipe-B-plane-1
[223.307130] Dynamic subtest pipe-B-plane-1: SUCCESS (1.342s)
[223.316685] Starting dynamic subtest: pipe-B-plane-2
[224.602926] Dynamic subtest pipe-B-plane-2: SUCCESS (1.294s)
[224.611938] Starting dynamic subtest: pipe-B-plane-3
[225.989423] Dynamic subtest pipe-B-plane-3: SUCCESS (1.385s)
[225.998413] Starting dynamic subtest: pipe-B-plane-4
[227.314712] Dynamic subtest pipe-B-plane-4: SUCCESS (1.325s)
[227.331525] Starting dynamic subtest: pipe-B-plane-5
[227.340816] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[227.343216] Subtest plane-position-hole: SUCCESS (12.201s)
[228.167102] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[228.267151] Starting subtest: draw-method-mmap-cpu
[228.269184] Starting dynamic subtest: xrgb8888-untiled
[228.487226] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[228.495563] Starting dynamic subtest: rgb565-untiled
[228.697931] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[228.706194] Starting dynamic subtest: xrgb2101010-untiled
[228.921060] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[228.930423] Starting dynamic subtest: xbgr16161616f-untiled
[229.153484] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[229.161557] Starting dynamic subtest: xrgb8888-xtiled
[229.286806] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[229.294722] Starting dynamic subtest: rgb565-xtiled
[229.419829] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[229.428226] Starting dynamic subtest: xrgb2101010-xtiled
[229.554470] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[229.562408] Starting dynamic subtest: xbgr16161616f-xtiled
[229.686860] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[229.694799] Starting dynamic subtest: xrgb8888-4tiled
[229.831099] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[229.839497] Starting dynamic subtest: rgb565-4tiled
[229.997709] Dynamic subtest rgb565-4tiled: SUCCESS (0.165s)
[230.005899] Starting dynamic subtest: xrgb2101010-4tiled
[230.121765] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.123s)
[230.132349] Starting dynamic subtest: xbgr16161616f-4tiled
[230.253893] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[230.256075] Subtest draw-method-mmap-cpu: SUCCESS (1.989s)
[230.382477] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[230.450045] Subtest medium-copy-XY: SKIP (0.000s)
[230.517984] [051/133] (790s left) vgem_basic (bad-flag)
[230.561551] Starting subtest: bad-flag
[230.563356] Subtest bad-flag: SUCCESS (0.000s)
[230.631903] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[230.699474] Starting subtest: engines-hostile-preempt
[230.701314] Starting dynamic subtest: rcs0
[230.780352] Dynamic subtest rcs0: SUCCESS (0.082s)
[230.790346] Starting dynamic subtest: bcs0
[230.900032] Dynamic subtest bcs0: SUCCESS (0.119s)
[230.916433] Starting dynamic subtest: vcs0
[232.941516] Dynamic subtest vcs0: SUCCESS (2.037s)
[232.952723] Starting dynamic subtest: vcs1
[234.930896] Dynamic subtest vcs1: SUCCESS (1.987s)
[234.942059] Starting dynamic subtest: vecs0
[236.917233] Dynamic subtest vecs0: SUCCESS (1.984s)
[236.928100] Starting dynamic subtest: ccs0
[236.954403] Dynamic subtest ccs0: SUCCESS (0.037s)
[236.956765] Subtest engines-hostile-preempt: SUCCESS (6.258s)
[237.122190] [053/133] (783s left) kms_sequence (queue-idle)
[237.232980] Starting subtest: queue-idle
[237.235296] Starting dynamic subtest: pipe-A-eDP-1
[239.045758] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[239.061295] Starting dynamic subtest: pipe-B-eDP-1
[241.544085] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.497s)
[241.554578] Starting dynamic subtest: pipe-C-eDP-1
[243.958697] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s)
[243.974651] Starting dynamic subtest: pipe-D-eDP-1
[246.405150] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s)
[246.407499] Subtest queue-idle: SUCCESS (9.172s)
[247.229176] [054/133] (773s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[247.338637] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[247.340775] Starting dynamic subtest: pipe-A-eDP-1
[247.411985] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[247.421069] Starting dynamic subtest: pipe-B-eDP-1
[248.506364] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[248.510840] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.171s)
[249.806195] [055/133] (771s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[249.934219] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[249.938826] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[250.076394] [056/133] (770s left) kms_atomic (atomic-plane-damage)
[250.174712] Starting subtest: atomic-plane-damage
[250.222251] Starting dynamic subtest: pipe-A-eDP-1
[250.778053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[250.779949] Subtest atomic-plane-damage: SUCCESS (0.602s)
[251.635268] [057/133] (769s left) kms_big_fb (linear-16bpp-rotate-90)
[251.740499] Starting subtest: linear-16bpp-rotate-90
[251.760174] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[251.887104] [058/133] (769s left) perf (stress-open-close)
[252.020624] Starting subtest: stress-open-close
[252.022780] Starting dynamic subtest: 0-rcs0
[254.187901] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[254.195931] Starting dynamic subtest: 1-vcs1
[256.352621] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[256.354563] Subtest stress-open-close: SUCCESS (4.335s)
[256.404295] [059/133] (764s left) gem_workarounds (basic-read-fd)
[256.479488] Starting subtest: basic-read-fd
[256.493886] Subtest basic-read-fd: SUCCESS (0.014s)
[256.641346] [060/133] (764s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[256.731760] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[257.734681] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.000s)
[257.905526] [061/133] (763s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[258.004319] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[258.007785] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[258.127980] [062/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[258.219763] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[258.223196] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[258.338718] [063/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[258.427287] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[258.430794] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[258.563958] [064/133] (762s left) kms_cursor_crc (cursor-offscreen-32x10)
[258.728465] Starting subtest: cursor-offscreen-32x10
[258.774563] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[259.075431] [065/133] (762s left) kms_psr (psr2-primary-render)
[259.177172] Starting subtest: psr2-primary-render
[259.179182] Starting dynamic subtest: eDP-1
[260.916341] Dynamic subtest eDP-1: SUCCESS (1.737s)
[260.918579] Subtest psr2-primary-render: SUCCESS (1.738s)
[261.788029] [066/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[261.893908] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[261.898498] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[262.026500] [067/133] (759s left) gem_exec_schedule (noreorder-priority)
[262.224114] Starting subtest: noreorder-priority
[262.226462] Starting dynamic subtest: rcs0
[263.389840] Dynamic subtest rcs0: SUCCESS (1.168s)
[263.400942] Starting dynamic subtest: vcs0
[264.948856] Dynamic subtest vcs0: SUCCESS (1.556s)
[264.960189] Starting dynamic subtest: vcs1
[266.883867] Dynamic subtest vcs1: SUCCESS (1.932s)
[266.895280] Starting dynamic subtest: vecs0
[268.867647] Dynamic subtest vecs0: SUCCESS (1.981s)
[268.878662] Starting dynamic subtest: ccs0
[270.010834] Dynamic subtest ccs0: SUCCESS (1.142s)
[270.013341] Subtest noreorder-priority: SUCCESS (7.791s)
[270.208669] [068/133] (751s left) gem_softpin (allocator-evict)
[270.276128] Starting subtest: allocator-evict
[270.278121] Starting dynamic subtest: rcs0
[294.376563] Dynamic subtest rcs0: SUCCESS (24.101s)
[294.386912] Starting dynamic subtest: bcs0
[318.409366] Dynamic subtest bcs0: SUCCESS (24.032s)
[318.418901] Starting dynamic subtest: vcs0
[342.098525] Dynamic subtest vcs0: SUCCESS (23.687s)
[342.108883] Starting dynamic subtest: vcs1
[365.750702] Dynamic subtest vcs1: SUCCESS (23.651s)
[365.759876] Starting dynamic subtest: vecs0
[389.220728] Dynamic subtest vecs0: SUCCESS (23.468s)
[389.231899] Starting dynamic subtest: ccs0
[413.098711] Dynamic subtest ccs0: SUCCESS (23.875s)
[413.101125] Subtest allocator-evict: SUCCESS (142.825s)
[413.193485] [069/133] (608s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[413.339930] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[418.319058] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.981s)
[419.485398] [070/133] (601s left) gem_exec_reloc (basic-cpu-gtt-active)
[419.563750] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[419.659891] [071/133] (601s left) gem_ctx_shared (single-timeline)
[419.725143] Starting subtest: single-timeline
[419.746428] Subtest single-timeline: SUCCESS (0.015s)
[420.015738] [072/133] (601s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[420.090827] Starting subtest: etime-multi-wait-all-for-submit-submitted
[420.193182] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[420.284317] [073/133] (601s left) syncobj_timeline (etime-single-wait-all-submitted)
[420.352482] Starting subtest: etime-single-wait-all-submitted
[420.458060] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[420.562181] [074/133] (601s left) kms_chamelium_hpd (dp-hpd-storm)
[420.949316] Subtest dp-hpd-storm: SKIP (0.000s)
[421.757387] [075/133] (599s left) kms_flip (2x-flip-vs-suspend)
[421.854202] Starting subtest: 2x-flip-vs-suspend
[421.866215] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[422.012613] [076/133] (599s left) kms_psr (fbc-psr2-sprite-plane-move)
[422.114720] Starting subtest: fbc-psr2-sprite-plane-move
[422.116936] Starting dynamic subtest: eDP-1
[422.121065] Dynamic subtest eDP-1: SKIP (0.000s)
[422.125130] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[422.204790] [077/133] (599s left) gem_exec_params (mmapped)
[422.273819] Starting subtest: mmapped
[422.276340] Subtest mmapped: SUCCESS (0.003s)
[422.435659] [078/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[422.544722] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[422.548921] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[422.688355] [079/133] (599s left) sw_sync (sync_merge_invalid)
[422.727246] Starting subtest: sync_merge_invalid
[422.753539] Subtest sync_merge_invalid: SUCCESS (0.027s)
[422.847757] [080/133] (599s left) perf_pmu (busy)
[422.888528] Starting subtest: busy
[422.890153] Starting dynamic subtest: rcs0
[423.494822] Dynamic subtest rcs0: SUCCESS (0.607s)
[423.506890] Starting dynamic subtest: bcs0
[424.062806] Dynamic subtest bcs0: SUCCESS (0.566s)
[424.074443] Starting dynamic subtest: vcs0
[425.877654] Dynamic subtest vcs0: SUCCESS (1.811s)
[425.889654] Starting dynamic subtest: vcs1
[427.925759] Dynamic subtest vcs1: SUCCESS (2.046s)
[427.937244] Starting dynamic subtest: vecs0
[429.909458] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.920530] Starting dynamic subtest: ccs0
[430.483563] Dynamic subtest ccs0: SUCCESS (0.573s)
[430.485999] Subtest busy: SUCCESS (7.598s)
[430.627659] [081/133] (591s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[430.684598] Starting subtest: multi-wait-for-submit-submitted-signaled
[430.687052] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[430.805093] [082/133] (591s left) gem_mmap_wc (write-wc-read-gtt)
[430.865370] Subtest write-wc-read-gtt: SKIP (0.000s)
[430.940833] [083/133] (591s left) kms_hdmi_inject (inject-audio)
[431.285686] Starting subtest: inject-audio
[431.558038] Subtest inject-audio: SUCCESS (0.275s)
[432.153163] [084/133] (589s left) kms_flip (2x-blocking-wf_vblank)
[432.240324] Starting subtest: 2x-blocking-wf_vblank
[432.249168] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[432.395184] [085/133] (589s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[432.488157] Starting subtest: plane-all-transition-nonblocking-fencing
[432.490376] Starting dynamic subtest: pipe-A-eDP-1
[434.982804] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[435.302276] Starting dynamic subtest: pipe-B-eDP-1
[438.505184] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[438.801669] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.315s)
[439.610582] [086/133] (582s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[439.737802] Starting subtest: flip-vs-cursor-crc-legacy
[440.436224] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.697s)
[441.336160] [087/133] (580s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[441.436235] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[441.440517] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[441.516460] [088/133] (580s left) gem_exec_params (invalid-ring2)
[441.574600] Starting subtest: invalid-ring2
[441.576877] Subtest invalid-ring2: SUCCESS (0.000s)
[441.695149] [089/133] (580s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[441.799038] Starting subtest: fbcpsr-slowdraw
[466.930043] Subtest fbcpsr-slowdraw: SUCCESS (25.134s)
[467.114773] [090/133] (555s left) kms_joiner (basic-force-ultra-joiner)
[467.206038] Starting subtest: basic-force-ultra-joiner
[467.210126] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[467.286768] [091/133] (555s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[467.382660] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[467.408448] Starting dynamic subtest: pipe-A-plane-0
[467.696791] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[467.705308] Starting dynamic subtest: pipe-A-plane-3
[467.941385] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[469.062447] Starting dynamic subtest: pipe-B-plane-0
[469.352816] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[469.362052] Starting dynamic subtest: pipe-B-plane-3
[469.586840] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[469.900758] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.519s)
[470.716478] [092/133] (551s left) kms_vblank (query-forked-busy-hang)
[470.828980] Starting subtest: query-forked-busy-hang
[470.831207] Starting dynamic subtest: pipe-A-eDP-1
[497.747807] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.918s)
[497.761591] Starting dynamic subtest: pipe-D-eDP-1
[521.689532] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.940s)
[521.691914] Subtest query-forked-busy-hang: SUCCESS (50.862s)
[522.498744] [093/133] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[522.605443] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[522.609419] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[522.719148] [094/133] (499s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[522.833399] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[523.446548] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.615s)
[523.654836] [095/133] (498s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[523.755771] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[523.757992] Starting dynamic subtest: pipe-A-default-mode
[526.479348] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[526.481255] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.723s)
[527.304493] [096/133] (495s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[527.365521] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[527.473753] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[527.559392] [097/133] (495s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[527.661036] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[527.665546] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[527.765886] [098/133] (494s left) gem_exec_whisper (basic-fds-forked)
[527.817383] Starting subtest: basic-fds-forked
[551.085180] Subtest basic-fds-forked: SUCCESS (23.261s)
[551.285899] [099/133] (471s left) kms_addfb_basic (bad-pitch-999)
[551.349115] Starting subtest: bad-pitch-999
[551.351025] Subtest bad-pitch-999: SUCCESS (0.000s)
[551.520640] [100/133] (471s left) kms_prop_blob (basic)
[551.579617] Starting subtest: basic
[551.581585] Subtest basic: SUCCESS (0.000s)
[551.710249] [101/133] (471s left) syncobj_basic (bad-pad-fd-to-handle)
[551.760103] Starting subtest: bad-pad-fd-to-handle
[551.761933] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[551.866532] [102/133] (470s left) kms_cursor_crc (cursor-sliding-256x256)
[552.096591] Starting subtest: cursor-sliding-256x256
[552.101348] Starting dynamic subtest: pipe-A-eDP-1
[555.365041] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.262s)
[555.391742] Starting dynamic subtest: pipe-D-eDP-1
[559.292372] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.908s)
[559.294754] Subtest cursor-sliding-256x256: SUCCESS (7.196s)
[560.110448] [103/133] (462s left) gem_busy (busy)
[560.182717] Starting subtest: busy
[560.185089] Starting dynamic subtest: all-engines
[560.262749] Dynamic subtest all-engines: SUCCESS (0.079s)
[560.273186] Starting dynamic subtest: rcs0
[561.883744] Dynamic subtest rcs0: SUCCESS (1.620s)
[561.895993] Starting dynamic subtest: bcs0
[561.945383] Dynamic subtest bcs0: SUCCESS (0.058s)
[561.956334] Starting dynamic subtest: vcs0
[561.986125] Dynamic subtest vcs0: SUCCESS (0.040s)
[561.995316] Starting dynamic subtest: vcs1
[563.930300] Dynamic subtest vcs1: SUCCESS (1.940s)
[563.941270] Starting dynamic subtest: vecs0
[565.913871] Dynamic subtest vecs0: SUCCESS (1.982s)
[565.924807] Starting dynamic subtest: ccs0
[567.898685] Dynamic subtest ccs0: SUCCESS (1.984s)
[567.900807] Subtest busy: SUCCESS (7.714s)
[568.290359] [104/133] (454s left) i915_pm_rps (thresholds)
[568.359040] Starting subtest: thresholds
[568.363309] Subtest thresholds: SKIP (0.001s)
[568.489621] [105/133] (454s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[568.603824] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[568.606180] Starting dynamic subtest: pipe-A-eDP-1
[568.628516] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.638631] Starting dynamic subtest: pipe-B-eDP-1
[568.659680] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.668029] Starting dynamic subtest: pipe-C-eDP-1
[568.689220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.697982] Starting dynamic subtest: pipe-D-eDP-1
[568.719189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.723476] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[570.897855] [106/133] (452s left) gem_softpin (evict-snoop-interruptible)
[570.962420] Starting subtest: evict-snoop-interruptible
[570.966495] Subtest evict-snoop-interruptible: SKIP (0.000s)
[571.119292] [107/133] (451s left) gem_mmap_gtt (big-bo)
[571.177514] Subtest big-bo: SKIP (0.000s)
[571.246886] [108/133] (451s left) gem_partial_pwrite_pread (write-display)
[571.299608] Subtest write-display: SKIP (0.000s)
[571.369042] [109/133] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[571.465078] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[571.467295] Starting dynamic subtest: pipe-A-eDP-1
[571.488949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.500890] Starting dynamic subtest: pipe-B-eDP-1
[571.521073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.529791] Starting dynamic subtest: pipe-C-eDP-1
[571.550170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.558827] Starting dynamic subtest: pipe-D-eDP-1
[571.580673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.584631] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[573.691773] [110/133] (449s left) kms_psr (fbc-pr-cursor-blt)
[573.793719] Starting subtest: fbc-pr-cursor-blt
[573.797660] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[573.878298] [111/133] (449s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[573.938279] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[573.940549] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[574.066205] [112/133] (449s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[574.136676] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[574.140998] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[574.335324] [113/133] (448s left) gem_mmap (basic)
[574.398706] Subtest basic: SKIP (0.000s)
[574.456976] [114/133] (448s left) gem_exec_gttfill (basic)
[574.513616] Starting subtest: basic
[576.873879] Subtest basic: SUCCESS (2.360s)
[577.090247] [115/133] (446s left) kms_addfb_basic (size-max)
[577.240834] Starting subtest: size-max
[577.242620] Subtest size-max: SUCCESS (0.000s)
[577.349993] [116/133] (446s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[577.438896] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[577.441060] Starting dynamic subtest: pipe-A-eDP-1
[577.462839] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.472775] Starting dynamic subtest: pipe-B-eDP-1
[577.494361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.503066] Starting dynamic subtest: pipe-C-eDP-1
[577.523482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.532069] Starting dynamic subtest: pipe-D-eDP-1
[577.553080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.556911] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[579.697836] [117/133] (443s left) api_intel_bb (purge-bb)
[579.766281] Starting subtest: purge-bb
[579.768572] Subtest purge-bb: SUCCESS (0.003s)
[579.941988] [118/133] (443s left) kms_cursor_legacy (forked-move)
[580.065652] Starting subtest: forked-move
[580.067993] Starting dynamic subtest: pipe-A
[585.543886] Dynamic subtest pipe-A: SUCCESS (5.475s)
[585.555706] Starting dynamic subtest: pipe-B
[591.018882] Dynamic subtest pipe-B: SUCCESS (5.472s)
[591.030841] Starting dynamic subtest: pipe-C
[596.483526] Dynamic subtest pipe-C: SUCCESS (5.463s)
[596.494740] Starting dynamic subtest: pipe-D
[601.940929] Dynamic subtest pipe-D: SUCCESS (5.455s)
[601.952533] Starting dynamic subtest: all-pipes
[607.448151] Dynamic subtest all-pipes: SUCCESS (5.505s)
[607.450427] Subtest forked-move: SUCCESS (27.381s)
[607.639909] [119/133] (415s left) gen9_exec_parse (bb-chained)
[607.715745] Subtest bb-chained: SKIP (0.000s)
[607.802240] [120/133] (415s left) kms_concurrent (multi-plane-atomic-lowres)
[607.898032] Starting subtest: multi-plane-atomic-lowres
[607.900165] Starting dynamic subtest: pipe-A-eDP-1
[608.405187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[608.407517] Subtest multi-plane-atomic-lowres: SUCCESS (0.508s)
[609.301220] [121/133] (414s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[609.382955] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[609.482089] [122/133] (414s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[609.549775] Starting subtest: multi-wait-available-unsubmitted-submitted
[609.552125] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[609.678997] [123/133] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[609.783407] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[614.253597] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.474s)
[615.419699] [124/133] (408s left) kms_pm_dc (dc3co-vpb-simulation)
[616.523795] Starting subtest: dc3co-vpb-simulation
[625.818937] Subtest dc3co-vpb-simulation: SKIP (9.291s)
[625.972974] [125/133] (397s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[626.088470] Starting subtest: x-tiled-8bpp-rotate-90
[626.109582] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[626.268654] [126/133] (397s left) kms_plane_multiple (2x-tiling-none)
[626.364301] Starting subtest: 2x-tiling-none
[626.368299] Subtest 2x-tiling-none: SKIP (0.000s)
[626.447559] [127/133] (397s left) gem_exec_balancer (bonded-false-hang)
[626.696094] Starting subtest: bonded-false-hang
[626.701560] Subtest bonded-false-hang: SKIP (0.000s)
[626.821289] [128/133] (397s left) i915_drm_fdinfo (idle)
[626.857525] Starting subtest: idle
[626.859916] Starting dynamic subtest: rcs0
[627.422059] Dynamic subtest rcs0: SUCCESS (0.567s)
[627.433925] Starting dynamic subtest: bcs0
[627.929197] Dynamic subtest bcs0: SUCCESS (0.503s)
[627.940941] Starting dynamic subtest: vcs0
[628.434844] Dynamic subtest vcs0: SUCCESS (0.503s)
[628.446814] Starting dynamic subtest: vcs1
[628.938082] Dynamic subtest vcs1: SUCCESS (0.503s)
[628.949226] Starting dynamic subtest: vecs0
[629.444633] Dynamic subtest vecs0: SUCCESS (0.503s)
[629.456589] Starting dynamic subtest: ccs0
[629.949719] Dynamic subtest ccs0: SUCCESS (0.503s)
[629.952598] Subtest idle: SUCCESS (3.095s)
[630.037503] [129/133] (393s left) kms_getfb (getfb2-handle-closed)
[630.141120] Starting subtest: getfb2-handle-closed
[630.143392] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[630.265365] [130/133] (393s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[630.316349] Starting subtest: invalid-bsd1-flag-on-vebox
[630.318606] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[630.436696] [131/133] (393s left) kms_psr (fbc-pr-suspend)
[630.525795] Starting subtest: fbc-pr-suspend
[630.529692] Subtest fbc-pr-suspend: SKIP (0.000s)
[630.610647] [132/133] (393s left) gem_softpin (overlap)
[630.673972] Starting subtest: overlap
[631.525477] Subtest overlap: SUCCESS (0.850s)
[631.645763] [133/133] (392s left) gem_madvise (dontneed-before-mmap)
[631.679706] Starting subtest: dontneed-before-mmap
[631.708060] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[631.825998] 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.