[57.553047] Initializing watchdogs
[57.553141]   /dev/watchdog0
[57.567935] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.572336] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.574550] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.577863] [001/133] (960s left) kms_pm_backlight (fade)
[57.701901] Starting subtest: fade
[57.800629] Starting dynamic subtest: eDP-1
[60.278156] Dynamic subtest eDP-1: SUCCESS (2.486s)
[60.280509] Subtest fade: SUCCESS (2.585s)
[61.142214] [002/133] (956s left) gem_ctx_persistence (file)
[61.219632] Starting subtest: file
[61.336974] Subtest file: SUCCESS (0.120s)
[61.454698] [003/133] (956s left) gem_cs_tlb (engines)
[61.522984] Starting subtest: engines
[61.525248] Starting dynamic subtest: rcs0
[63.673042] Dynamic subtest rcs0: SUCCESS (2.152s)
[63.680659] Starting dynamic subtest: bcs0
[65.824509] Dynamic subtest bcs0: SUCCESS (2.153s)
[65.834140] Starting dynamic subtest: vcs0
[67.972947] Dynamic subtest vcs0: SUCCESS (2.152s)
[67.982808] Starting dynamic subtest: vcs1
[70.125070] Dynamic subtest vcs1: SUCCESS (2.153s)
[70.134653] Starting dynamic subtest: vecs0
[72.275835] Dynamic subtest vecs0: SUCCESS (2.152s)
[72.286104] Starting dynamic subtest: ccs0
[74.426361] Dynamic subtest ccs0: SUCCESS (2.152s)
[74.428805] Subtest engines: SUCCESS (12.917s)
[74.525205] [004/133] (943s left) kms_chamelium_audio (hdmi-audio)
[74.911274] Subtest hdmi-audio: SKIP (0.000s)
[75.732555] [005/133] (942s left) kms_big_fb (linear-32bpp-rotate-270)
[75.839836] Starting subtest: linear-32bpp-rotate-270
[75.858329] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[75.993607] [006/133] (942s left) gem_ctx_param (invalid-ctx-get)
[76.053063] Starting subtest: invalid-ctx-get
[76.055271] Subtest invalid-ctx-get: SUCCESS (0.000s)
[76.135389] [007/133] (942s left) fbdev (unaligned-read)
[76.178851] Starting subtest: unaligned-read
[76.192323] Subtest unaligned-read: SUCCESS (0.015s)
[76.244552] [008/133] (942s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[76.341992] Starting subtest: y-tiled-16bpp-rotate-180
[76.346756] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[76.437929] [009/133] (941s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[76.535757] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[76.538056] Starting dynamic subtest: pipe-A
[76.606846] Dynamic subtest pipe-A: SUCCESS (0.072s)
[76.616143] Starting dynamic subtest: pipe-B
[77.780204] Dynamic subtest pipe-B: SUCCESS (1.173s)
[77.789934] Starting dynamic subtest: pipe-C
[78.885804] Dynamic subtest pipe-C: SUCCESS (1.105s)
[78.894288] Starting dynamic subtest: pipe-D
[80.014809] Dynamic subtest pipe-D: SUCCESS (1.128s)
[80.017079] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.481s)
[81.166250] [010/133] (937s left) kms_plane_multiple (tiling-none)
[81.251505] Starting subtest: tiling-none
[81.253890] Starting dynamic subtest: pipe-A-eDP-1
[84.987897] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.736s)
[84.999869] Starting dynamic subtest: pipe-B-eDP-1
[89.435915] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.446s)
[89.444279] Starting dynamic subtest: pipe-C-eDP-1
[93.782691] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.345s)
[93.791394] Starting dynamic subtest: pipe-D-eDP-1
[98.142368] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.358s)
[98.144705] Subtest tiling-none: SUCCESS (16.888s)
[98.939489] [011/133] (919s left) gen3_render_mixed_blits
[99.064368] [012/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[99.168563] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[99.172969] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[99.259298] [013/133] (919s left) gem_exec_params (invalid-batch-start-offset)
[99.309300] Starting subtest: invalid-batch-start-offset
[99.311618] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[99.412230] [014/133] (919s left) kms_scaling_modes (scaling-mode-center)
[99.511018] Starting subtest: scaling-mode-center
[99.513487] Starting dynamic subtest: pipe-A-eDP-1
[99.605388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[99.616582] Starting dynamic subtest: pipe-B-eDP-1
[100.765910] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[100.775853] Starting dynamic subtest: pipe-C-eDP-1
[101.882652] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[101.893222] Starting dynamic subtest: pipe-D-eDP-1
[103.027473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[103.029803] Subtest scaling-mode-center: SUCCESS (3.518s)
[104.182634] [015/133] (914s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[104.269099] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[104.271053] Starting dynamic subtest: pipe-A-eDP-1
[105.147035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[105.154975] Starting dynamic subtest: pipe-B-eDP-1
[106.752105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.600s)
[106.767967] Starting dynamic subtest: pipe-C-eDP-1
[108.213150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s)
[108.222398] Starting dynamic subtest: pipe-D-eDP-1
[109.776503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.561s)
[109.778910] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.500s)
[110.915250] [016/133] (907s left) testdisplay
[111.268860] [017/133] (907s left) vgem_basic (bad-flag)
[111.388866] Starting subtest: bad-flag
[111.391273] Subtest bad-flag: SUCCESS (0.000s)
[111.444511] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[111.447846] [018/133] (907s left) gem_mmap (short-mmap)
[111.510963] Subtest short-mmap: SKIP (0.000s)
[111.570969] [019/133] (907s left) kms_psr (pr-cursor-blt)
[111.651981] Starting subtest: pr-cursor-blt
[111.656592] Subtest pr-cursor-blt: SKIP (0.000s)
[111.724894] [020/133] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[111.820562] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[111.824929] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[111.921887] [021/133] (906s left) kms_joiner (invalid-modeset-big-joiner)
[112.019828] Starting subtest: invalid-modeset-big-joiner
[112.023347] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[112.089120] [022/133] (906s left) i915_query (query-garbage)
[112.145834] Starting subtest: query-garbage
[112.147750] Subtest query-garbage: SUCCESS (0.000s)
[112.249742] [023/133] (906s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[112.330317] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[112.332180] Starting dynamic subtest: pipe-A-eDP-1
[112.350995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[112.360167] Starting dynamic subtest: pipe-B-eDP-1
[112.377454] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.384131] Starting dynamic subtest: pipe-C-eDP-1
[112.401162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.407508] Starting dynamic subtest: pipe-D-eDP-1
[112.425326] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.428847] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[114.577494] [024/133] (904s left) gem_exec_reloc (basic-write-gtt)
[114.644077] Subtest basic-write-gtt: SKIP (0.000s)
[114.713196] [025/133] (904s left) gem_mmap (pf-nonblock)
[114.758493] Subtest pf-nonblock: SKIP (0.000s)
[114.816306] [026/133] (904s left) kms_addfb_basic (size-max)
[114.904065] Starting subtest: size-max
[114.905954] Subtest size-max: SUCCESS (0.000s)
[114.989909] [027/133] (904s left) i915_suspend (forcewake)
[115.042857] Starting subtest: forcewake
[147.689621] Subtest forcewake: SUCCESS (3.152s)
[157.771520] [028/133] (871s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[157.888295] Starting subtest: 4-tiled-64bpp-rotate-90
[157.907478] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[158.008432] [029/133] (871s left) gem_exec_reloc (basic-gtt-cpu)
[158.077843] Subtest basic-gtt-cpu: SKIP (0.000s)
[158.137808] [030/133] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[158.237330] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[158.241625] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[158.335352] [031/133] (870s left) gem_eio (wait-10ms)
[158.566168] Starting subtest: wait-10ms
[158.931983] Subtest wait-10ms: SUCCESS (0.373s)
[159.074845] [032/133] (870s left) kms_draw_crc (draw-method-render)
[159.164109] Starting subtest: draw-method-render
[159.165961] Starting dynamic subtest: xrgb8888-untiled
[159.414065] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[159.422564] Starting dynamic subtest: rgb565-untiled
[159.643795] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[159.651966] Starting dynamic subtest: xrgb2101010-untiled
[159.873228] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[159.887133] Starting dynamic subtest: xbgr16161616f-untiled
[160.114435] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[160.123596] Starting dynamic subtest: xrgb8888-xtiled
[160.245757] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[160.254780] Starting dynamic subtest: rgb565-xtiled
[160.366636] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[160.374920] Starting dynamic subtest: xrgb2101010-xtiled
[160.487563] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[160.496642] Starting dynamic subtest: xbgr16161616f-xtiled
[160.618415] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[160.626539] Starting dynamic subtest: xrgb8888-4tiled
[160.740374] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[160.750036] Starting dynamic subtest: rgb565-4tiled
[160.860237] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[160.870673] Starting dynamic subtest: xrgb2101010-4tiled
[161.013355] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[161.023832] Starting dynamic subtest: xbgr16161616f-4tiled
[161.145462] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[161.147369] Subtest draw-method-render: SUCCESS (2.011s)
[161.251778] [033/133] (868s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[161.368113] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[161.371876] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[161.507970] [034/133] (867s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[161.602177] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[161.603993] Starting dynamic subtest: pipe-A-eDP-1
[161.721014] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[161.730117] Starting dynamic subtest: pipe-B-eDP-1
[162.872224] Dynamic subtest pipe-B-eDP-1: SKIP (1.161s)
[162.876804] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.285s)
[164.050610] [035/133] (865s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[164.144002] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[164.146325] Starting dynamic subtest: pipe-A-eDP-1
[164.203664] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[164.211290] Starting dynamic subtest: pipe-B-eDP-1
[164.267852] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[164.277440] Starting dynamic subtest: pipe-C-eDP-1
[164.334736] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[164.344945] Starting dynamic subtest: pipe-D-eDP-1
[164.401275] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[164.405196] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[166.400214] [036/133] (863s left) gem_ctx_shared (q-independent)
[166.467344] Starting subtest: Q-independent
[166.469759] Starting dynamic subtest: rcs0
[166.545782] Dynamic subtest rcs0: SUCCESS (0.078s)
[166.556838] Starting dynamic subtest: vcs0
[166.601913] Dynamic subtest vcs0: SUCCESS (0.055s)
[166.612751] Starting dynamic subtest: vcs1
[166.664669] Dynamic subtest vcs1: SUCCESS (0.063s)
[166.677672] Starting dynamic subtest: vecs0
[166.719766] Dynamic subtest vecs0: SUCCESS (0.055s)
[166.731847] Starting dynamic subtest: ccs0
[166.774869] Dynamic subtest ccs0: SUCCESS (0.055s)
[166.777322] Subtest Q-independent: SUCCESS (0.310s)
[168.478115] [037/133] (861s left) gem_ctx_persistence (engines-persistence)
[168.540072] Starting subtest: engines-persistence
[168.542386] Starting dynamic subtest: rcs0
[169.351741] Dynamic subtest rcs0: SUCCESS (0.815s)
[169.361878] Starting dynamic subtest: bcs0
[170.096088] Dynamic subtest bcs0: SUCCESS (0.745s)
[170.106295] Starting dynamic subtest: vcs0
[170.885820] Dynamic subtest vcs0: SUCCESS (0.791s)
[170.896441] Starting dynamic subtest: vcs1
[171.632070] Dynamic subtest vcs1: SUCCESS (0.747s)
[171.641143] Starting dynamic subtest: vecs0
[172.399159] Dynamic subtest vecs0: SUCCESS (0.768s)
[172.408211] Starting dynamic subtest: ccs0
[173.204064] Dynamic subtest ccs0: SUCCESS (0.805s)
[173.206784] Subtest engines-persistence: SUCCESS (4.683s)
[173.294924] [038/133] (856s left) kms_cursor_edge_walk (64x64-top-edge)
[173.404060] Starting subtest: 64x64-top-edge
[173.406416] Starting dynamic subtest: pipe-A-eDP-1
[176.852998] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[176.862250] Starting dynamic subtest: pipe-D-eDP-1
[179.973811] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[179.976050] Subtest 64x64-top-edge: SUCCESS (6.585s)
[180.784554] [039/133] (848s left) api_intel_allocator (two-level-inception-interruptible)
[180.849403] Starting subtest: two-level-inception-interruptible
[186.254123] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[186.392197] [040/133] (843s left) gem_softpin (allocator-basic)
[186.451462] Starting subtest: allocator-basic
[186.540611] Subtest allocator-basic: SUCCESS (0.089s)
[186.678036] [041/133] (843s left) kms_cursor_crc (cursor-random-32x10)
[186.846668] Starting subtest: cursor-random-32x10
[186.892910] Subtest cursor-random-32x10: SKIP (0.044s)
[187.186855] [042/133] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[187.297129] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[194.293978] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.002s)
[194.409532] [043/133] (835s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[194.517458] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[195.198579] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.683s)
[195.362930] [044/133] (834s left) sw_sync (alloc_fence)
[195.400320] Starting subtest: alloc_fence
[195.402289] Subtest alloc_fence: SUCCESS (0.000s)
[195.463685] [045/133] (834s left) gem_wait (write-wait)
[195.528744] Starting subtest: write-wait
[195.531232] Starting dynamic subtest: all-engines
[196.654242] Dynamic subtest all-engines: SUCCESS (1.125s)
[196.671825] Starting dynamic subtest: rcs0
[197.715469] Dynamic subtest rcs0: SUCCESS (1.060s)
[197.733094] Starting dynamic subtest: bcs0
[198.775083] Dynamic subtest bcs0: SUCCESS (1.058s)
[198.792429] Starting dynamic subtest: vcs0
[199.829754] Dynamic subtest vcs0: SUCCESS (1.053s)
[199.847449] Starting dynamic subtest: vcs1
[200.893003] Dynamic subtest vcs1: SUCCESS (1.061s)
[200.914461] Starting dynamic subtest: vecs0
[201.956169] Dynamic subtest vecs0: SUCCESS (1.060s)
[201.977623] Starting dynamic subtest: ccs0
[203.023192] Dynamic subtest ccs0: SUCCESS (1.064s)
[203.026398] Subtest write-wait: SUCCESS (7.499s)
[203.238415] [046/133] (826s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[203.299377] Subtest writes-after-reads: SKIP (0.000s)
[203.365864] [047/133] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[203.466339] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[210.020135] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.560s)
[210.131215] [048/133] (819s left) kms_setmode (basic)
[210.188002] Starting subtest: basic
[210.515289] Starting dynamic subtest: pipe-A-eDP-1
[212.571902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.054s)
[212.913488] Starting dynamic subtest: pipe-B-eDP-1
[215.001939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.093s)
[215.317211] Subtest basic: SUCCESS (5.131s)
[216.140284] [049/133] (813s left) gem_mmap_offset (bad-object)
[216.206957] Starting subtest: bad-object
[216.209229] Subtest bad-object: SUCCESS (0.001s)
[216.316555] [050/133] (813s left) syncobj_timeline (wait-all-snapshot)
[216.370853] Starting subtest: wait-all-snapshot
[216.454003] Subtest wait-all-snapshot: SUCCESS (0.082s)
[216.541886] [051/133] (813s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[216.646769] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[216.650894] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[216.716182] [052/133] (813s left) vgem_slow (nohang)
[216.769275] Starting subtest: nohang
[227.241906] Subtest nohang: SUCCESS (10.475s)
[227.304850] [053/133] (802s left) kms_psr (fbc-psr-cursor-blt)
[227.413035] Starting subtest: fbc-psr-cursor-blt
[227.415260] Starting dynamic subtest: eDP-1
[227.419279] Dynamic subtest eDP-1: SKIP (0.000s)
[227.423346] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[227.492839] [054/133] (802s left) i915_pm_rc6_residency (media-rc6-accuracy)
[227.554066] Starting subtest: media-rc6-accuracy
[227.558622] Subtest media-rc6-accuracy: SKIP (0.000s)
[227.665985] [055/133] (802s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[227.718005] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[227.793414] [056/133] (802s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[227.902309] Starting subtest: x-tiled-64bpp-rotate-90
[227.921999] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[228.039387] [057/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[228.133847] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[235.619358] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.492s)
[235.733871] [058/133] (794s left) kms_cursor_crc (cursor-offscreen-64x21)
[235.927523] Starting subtest: cursor-offscreen-64x21
[235.974387] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[236.198643] [059/133] (794s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[236.296312] Starting subtest: psr-rgb565-draw-mmap-cpu
[243.169852] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.880s)
[243.276395] [060/133] (787s left) i915_drm_fdinfo (busy-hang)
[243.316938] Starting subtest: busy-hang
[243.319223] Starting dynamic subtest: rcs0
[243.342746] Dynamic subtest rcs0: SKIP (0.025s)
[243.351975] Starting dynamic subtest: bcs0
[243.356058] Dynamic subtest bcs0: SKIP (0.001s)
[243.364525] Starting dynamic subtest: vcs0
[243.368835] Dynamic subtest vcs0: SKIP (0.000s)
[243.377263] Starting dynamic subtest: vcs1
[243.381182] Dynamic subtest vcs1: SKIP (0.000s)
[243.389148] Starting dynamic subtest: vecs0
[243.393204] Dynamic subtest vecs0: SKIP (0.000s)
[243.401234] Starting dynamic subtest: ccs0
[243.405230] Dynamic subtest ccs0: SKIP (0.001s)
[243.409175] Subtest busy-hang: SKIP (0.033s)
[243.446249] [061/133] (787s left) gem_exec_create (basic)
[243.506210] Starting subtest: basic
[243.508501] Starting dynamic subtest: smem
[247.435832] Dynamic subtest smem: SUCCESS (3.926s)
[247.438624] Subtest basic: SUCCESS (3.928s)
[247.625682] [062/133] (782s left) gem_exec_whisper (basic-normal-all)
[247.685887] Starting subtest: basic-normal-all
[251.090012] Subtest basic-normal-all: SUCCESS (3.399s)
[251.274653] [063/133] (779s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[251.400071] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[251.404079] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[251.493276] [064/133] (779s left) gem_mmap_gtt (bad-object)
[251.562498] Subtest bad-object: SKIP (0.000s)
[251.626470] [065/133] (779s left) gem_exec_schedule (noreorder)
[251.809978] Starting subtest: noreorder
[251.812820] Starting dynamic subtest: rcs0
[251.895604] Dynamic subtest rcs0: SUCCESS (0.086s)
[251.907731] Starting dynamic subtest: vcs0
[253.359408] Dynamic subtest vcs0: SUCCESS (1.459s)
[253.371654] Starting dynamic subtest: vcs1
[255.428323] Dynamic subtest vcs1: SUCCESS (2.065s)
[255.439880] Starting dynamic subtest: vecs0
[257.392359] Dynamic subtest vecs0: SUCCESS (1.961s)
[257.403616] Starting dynamic subtest: ccs0
[257.455708] Dynamic subtest ccs0: SUCCESS (0.063s)
[257.458093] Subtest noreorder: SUCCESS (5.645s)
[257.647964] [066/133] (773s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.028702] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[258.813307] [067/133] (772s left) kms_frontbuffer_tracking (psr-slowdraw)
[258.905593] Starting subtest: psr-slowdraw
[284.170146] Subtest psr-slowdraw: SUCCESS (25.264s)
[284.306979] [068/133] (746s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[284.372605] Starting subtest: invalid-multi-wait-all-unsubmitted
[284.374836] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[284.464553] [069/133] (746s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[284.572809] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[284.575042] Starting dynamic subtest: pipe-A
[285.744870] Dynamic subtest pipe-A: SUCCESS (1.174s)
[285.753732] Starting dynamic subtest: pipe-B
[288.033755] Dynamic subtest pipe-B: SUCCESS (2.288s)
[288.042498] Starting dynamic subtest: pipe-C
[289.267309] Dynamic subtest pipe-C: SUCCESS (1.232s)
[289.276447] Starting dynamic subtest: pipe-D
[290.504711] Dynamic subtest pipe-D: SUCCESS (1.237s)
[290.506861] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.934s)
[291.693973] [070/133] (739s left) perf_pmu (interrupts-sync)
[291.742945] Starting subtest: interrupts-sync
[292.833847] Subtest interrupts-sync: SUCCESS (1.090s)
[292.943881] [071/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[293.030688] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[293.034803] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[293.135684] [072/133] (737s left) kms_chamelium_hpd (dp-hpd)
[293.527068] Subtest dp-hpd: SKIP (0.000s)
[294.306176] [073/133] (736s left) kms_busy (extended-modeset-hang-oldfb)
[294.404636] Starting subtest: extended-modeset-hang-oldfb
[294.406814] Starting dynamic subtest: pipe-A
[305.912005] Dynamic subtest pipe-A: SUCCESS (11.509s)
[305.921598] Starting dynamic subtest: pipe-D
[318.207087] Dynamic subtest pipe-D: SUCCESS (12.296s)
[318.209428] Subtest extended-modeset-hang-oldfb: SUCCESS (23.810s)
[319.005493] [074/133] (712s left) drm_mm (drm_mm)
[319.047659] Starting subtest: drm_mm
[319.078114] Starting dynamic subtest: drm_test_mm_init
[319.162086] Dynamic subtest drm_test_mm_init: SUCCESS (0.084s)
[319.172084] Starting dynamic subtest: drm_test_mm_debug
[319.250164] Dynamic subtest drm_test_mm_debug: SUCCESS (0.087s)
[319.260576] Starting dynamic subtest: drm_test_mm_align32
[319.339995] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[319.349972] Starting dynamic subtest: drm_test_mm_align64
[319.434357] Dynamic subtest drm_test_mm_align64: SUCCESS (0.093s)
[319.449004] Starting dynamic subtest: drm_test_mm_lowest
[319.518533] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.084s)
[319.527580] Starting dynamic subtest: drm_test_mm_highest
[319.611652] Dynamic subtest drm_test_mm_highest: SUCCESS (0.091s)
[319.613814] Subtest drm_mm: SUCCESS (0.566s)
[319.763347] [075/133] (711s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[319.855891] Starting subtest: bad-aux-stride-yf-tiled-ccs
[319.858143] Starting dynamic subtest: pipe-A-eDP-1
[319.880499] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.891328] Starting dynamic subtest: pipe-B-eDP-1
[319.911335] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.920003] Starting dynamic subtest: pipe-C-eDP-1
[319.938311] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.946131] Starting dynamic subtest: pipe-D-eDP-1
[319.963583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.967144] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[322.155237] [076/133] (709s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[322.266224] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[322.279071] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[322.377819] [077/133] (708s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[322.438365] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[322.440556] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[322.548612] [078/133] (708s left) gem_exec_whisper (basic-sync-all)
[322.607370] Starting subtest: basic-sync-all
[330.103172] Subtest basic-sync-all: SUCCESS (7.496s)
[330.291539] [079/133] (701s left) kms_vrr (seamless-rr-switch-vrr)
[330.403206] Starting subtest: seamless-rr-switch-vrr
[330.409898] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[330.486026] [080/133] (700s left) api_intel_bb (purge-bb)
[330.545574] Starting subtest: purge-bb
[330.550600] Subtest purge-bb: SUCCESS (0.005s)
[330.661693] [081/133] (700s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[330.784783] Starting subtest: cursor-vs-flip-atomic
[360.131402] Subtest cursor-vs-flip-atomic: SUCCESS (29.358s)
[360.972851] [082/133] (670s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[361.065995] Starting subtest: fbc-dirtyfb-ioctl
[361.068292] Starting dynamic subtest: A-eDP-1
[363.652551] Dynamic subtest A-eDP-1: SUCCESS (2.588s)
[363.654806] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.589s)
[364.466132] [083/133] (667s left) perf_pmu (init-sema)
[364.511466] Starting subtest: init-sema
[364.513798] Starting dynamic subtest: rcs0
[364.516382] Dynamic subtest rcs0: SUCCESS (0.002s)
[364.527041] Starting dynamic subtest: bcs0
[364.528853] Dynamic subtest bcs0: SUCCESS (0.001s)
[364.537951] Starting dynamic subtest: vcs0
[364.540176] Dynamic subtest vcs0: SUCCESS (0.001s)
[364.548710] Starting dynamic subtest: vcs1
[364.550617] Dynamic subtest vcs1: SUCCESS (0.000s)
[364.559381] Starting dynamic subtest: vecs0
[364.561516] Dynamic subtest vecs0: SUCCESS (0.000s)
[364.570426] Starting dynamic subtest: ccs0
[364.572609] Dynamic subtest ccs0: SUCCESS (0.000s)
[364.574688] Subtest init-sema: SUCCESS (0.008s)
[364.634095] [084/133] (666s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[364.734193] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[368.895567] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.167s)
[370.067440] [085/133] (661s left) prime_self_import (basic-llseek-size)
[370.107181] Starting subtest: basic-llseek-size
[370.121962] Subtest basic-llseek-size: SUCCESS (0.016s)
[370.232182] [086/133] (661s left) gem_exec_fence (parallel)
[370.409818] Starting subtest: parallel
[370.411730] Starting dynamic subtest: rcs0
[372.559850] Dynamic subtest rcs0: SUCCESS (2.154s)
[372.570101] Starting dynamic subtest: bcs0
[374.716508] Dynamic subtest bcs0: SUCCESS (2.153s)
[374.727140] Starting dynamic subtest: vcs0
[376.870123] Dynamic subtest vcs0: SUCCESS (2.150s)
[376.880297] Starting dynamic subtest: vcs1
[379.024775] Dynamic subtest vcs1: SUCCESS (2.151s)
[379.035208] Starting dynamic subtest: vecs0
[381.178861] Dynamic subtest vecs0: SUCCESS (2.151s)
[381.189256] Starting dynamic subtest: ccs0
[383.342824] Dynamic subtest ccs0: SUCCESS (2.152s)
[383.352353] Subtest parallel: SUCCESS (12.917s)
[384.512371] [087/133] (647s left) gem_flink_race (flink_close)
[384.615086] Starting subtest: flink_close
[389.704688] Subtest flink_close: SUCCESS (5.089s)
[389.831145] [088/133] (641s left) gem_exec_balancer (sequential)
[389.962663] Starting subtest: sequential
[393.062810] Subtest sequential: SUCCESS (3.117s)
[393.367641] [089/133] (638s left) kms_plane (pixel-format-x-tiled-modifier)
[393.458984] Starting subtest: pixel-format-x-tiled-modifier
[393.485057] Starting dynamic subtest: pipe-A-plane-0
[394.118440] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[394.129189] Starting dynamic subtest: pipe-A-plane-3
[394.540773] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[394.549927] Starting dynamic subtest: pipe-A-plane-5
[394.553586] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[395.662557] Starting dynamic subtest: pipe-B-plane-0
[396.421944] Dynamic subtest pipe-B-plane-0: SUCCESS (0.767s)
[396.432731] Starting dynamic subtest: pipe-B-plane-3
[396.889066] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[396.897870] Starting dynamic subtest: pipe-B-plane-5
[396.901635] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[397.213513] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.751s)
[398.048731] [090/133] (633s left) gem_ppgtt (flink-and-close-vma-leak)
[398.113695] Starting subtest: flink-and-close-vma-leak
[398.155255] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[398.290354] [091/133] (633s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[398.389365] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[398.393632] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[398.483882] [092/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[398.578302] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[398.582424] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[398.680160] [093/133] (633s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[400.502896] Starting subtest: modeset-lpsp-stress-no-wait
[410.532071] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.026s)
[410.609878] [094/133] (621s left) i915_hangman (gt-engine-error)
[410.675617] Starting subtest: gt-engine-error
[410.677654] Starting dynamic subtest: rcs0
[412.393067] Dynamic subtest rcs0: SUCCESS (1.717s)
[412.405417] Starting dynamic subtest: bcs0
[414.376870] Dynamic subtest bcs0: SUCCESS (1.980s)
[414.390703] Starting dynamic subtest: vcs0
[416.360032] Dynamic subtest vcs0: SUCCESS (1.979s)
[416.376089] Starting dynamic subtest: vcs1
[418.344786] Dynamic subtest vcs1: SUCCESS (1.981s)
[418.360495] Starting dynamic subtest: vecs0
[420.329052] Dynamic subtest vecs0: SUCCESS (1.981s)
[420.341415] Starting dynamic subtest: ccs0
[422.375281] Dynamic subtest ccs0: SUCCESS (2.044s)
[422.377911] Subtest gt-engine-error: SUCCESS (11.700s)
[422.493227] [095/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[422.593305] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[422.597645] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.706531] [096/133] (609s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[422.810535] Starting subtest: yf-tiled-addfb-size-offset-overflow
[422.814578] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[422.911617] [097/133] (609s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[423.006380] Starting subtest: 4-tiled-16bpp-rotate-180
[424.308949] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[424.445054] [098/133] (607s left) gem_exec_reloc (basic-wc-noreloc)
[424.505323] Subtest basic-wc-noreloc: SKIP (0.000s)
[424.594622] [099/133] (607s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[424.696192] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[424.697960] Starting dynamic subtest: pipe-A-default-mode
[427.456136] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s)
[427.458423] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.761s)
[428.303509] [100/133] (604s left) kms_universal_plane (disable-primary-vs-flip)
[428.409792] Starting subtest: disable-primary-vs-flip
[428.412083] Starting dynamic subtest: pipe-A-eDP-1
[429.985172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.574s)
[429.998360] Starting dynamic subtest: pipe-B-eDP-1
[432.226878] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.238s)
[432.236428] Starting dynamic subtest: pipe-C-eDP-1
[434.403941] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.176s)
[434.414136] Starting dynamic subtest: pipe-D-eDP-1
[436.574793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[436.577334] Subtest disable-primary-vs-flip: SUCCESS (8.166s)
[437.373084] [101/133] (595s left) gem_ctx_param (set-priority-range)
[437.440065] Starting subtest: set-priority-range
[437.454960] Subtest set-priority-range: SUCCESS (0.015s)
[437.568691] [102/133] (594s left) kms_psr (psr2-primary-mmap-cpu)
[437.659344] Starting subtest: psr2-primary-mmap-cpu
[437.661683] Starting dynamic subtest: eDP-1
[439.362969] Dynamic subtest eDP-1: SUCCESS (1.704s)
[439.365309] Subtest psr2-primary-mmap-cpu: SUCCESS (1.705s)
[440.235896] [103/133] (592s left) kms_content_protection (mei-interface)
[440.384535] Starting subtest: mei-interface
[440.389165] Subtest mei-interface: SKIP (0.001s)
[440.532102] [104/133] (591s left) kms_getfb (getfb-handle-protection)
[440.631088] Starting subtest: getfb-handle-protection
[440.643257] Subtest getfb-handle-protection: SUCCESS (0.013s)
[440.754261] [105/133] (591s left) gem_exec_balancer (nohangcheck)
[441.017524] Starting subtest: nohangcheck
[441.957692] Subtest nohangcheck: SUCCESS (0.939s)
[442.089788] [106/133] (590s left) kms_color (ctm-0-75)
[442.185338] Starting subtest: ctm-0-75
[442.187224] Starting dynamic subtest: pipe-A-eDP-1
[447.195826] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.010s)
[447.206305] Starting dynamic subtest: pipe-B-eDP-1
[452.891628] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.696s)
[452.901024] Starting dynamic subtest: pipe-C-eDP-1
[458.189928] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.298s)
[458.200549] Starting dynamic subtest: pipe-D-eDP-1
[463.524573] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.333s)
[463.527075] Subtest ctm-0-75: SUCCESS (21.341s)
[464.346491] [107/133] (568s left) kms_vblank (ts-continuation-modeset-hang)
[464.447786] Starting subtest: ts-continuation-modeset-hang
[464.449986] Starting dynamic subtest: pipe-A-eDP-1
[491.210485] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.765s)
[491.225239] Starting dynamic subtest: pipe-D-eDP-1
[506.188784] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[506.190769] Subtest ts-continuation-modeset-hang: SUCCESS (41.744s)
[507.079898] [108/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[507.173875] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[514.556567] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.386s)
[514.686974] [109/133] (518s left) gem_softpin (noreloc)
[514.758356] Starting subtest: noreloc
[520.161070] Subtest noreloc: SUCCESS (5.400s)
[520.291748] [110/133] (512s left) kms_setmode (basic-clone-single-crtc)
[520.361834] Starting subtest: basic-clone-single-crtc
[520.368319] Subtest basic-clone-single-crtc: SKIP (0.000s)
[520.476050] [111/133] (512s left) kms_flip (2x-blocking-absolute-wf_vblank)
[520.578186] Starting subtest: 2x-blocking-absolute-wf_vblank
[520.590230] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[520.671310] [112/133] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[520.761535] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[520.765983] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[520.865171] [113/133] (512s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[520.958131] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[520.962234] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[521.052550] [114/133] (511s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[521.113107] Starting subtest: yf-tiled-to-vebox-y-tiled
[521.117264] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[521.304775] [115/133] (511s left) kms_properties (plane-properties-legacy)
[521.399649] Starting subtest: plane-properties-legacy
[521.402102] Starting dynamic subtest: pipe-A-eDP-1
[521.953474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[521.963346] Starting dynamic subtest: pipe-B-eDP-1
[523.259283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[523.268943] Starting dynamic subtest: pipe-C-eDP-1
[524.492821] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[524.502237] Starting dynamic subtest: pipe-D-eDP-1
[525.730710] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[525.733096] Subtest plane-properties-legacy: SUCCESS (4.333s)
[526.528615] [116/133] (506s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[526.625163] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[526.627443] Starting dynamic subtest: pipe-A-default-mode
[527.775010] Dynamic subtest pipe-A-default-mode: SKIP (1.147s)
[527.779338] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.148s)
[527.923102] [117/133] (505s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[528.046503] Starting subtest: basic-flip-after-cursor-atomic
[528.963497] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[529.778996] [118/133] (503s left) prime_busy (after-wait)
[529.844073] Starting subtest: after-wait
[529.846351] Starting dynamic subtest: rcs0
[529.868843] Dynamic subtest rcs0: SUCCESS (0.024s)
[529.879101] Starting dynamic subtest: bcs0
[529.908719] Dynamic subtest bcs0: SUCCESS (0.039s)
[529.918072] Starting dynamic subtest: vcs0
[529.950279] Dynamic subtest vcs0: SUCCESS (0.041s)
[529.959563] Starting dynamic subtest: vcs1
[529.993032] Dynamic subtest vcs1: SUCCESS (0.042s)
[530.002529] Starting dynamic subtest: vecs0
[530.034333] Dynamic subtest vecs0: SUCCESS (0.041s)
[530.045628] Starting dynamic subtest: ccs0
[530.075340] Dynamic subtest ccs0: SUCCESS (0.040s)
[530.184251] Subtest after-wait: SUCCESS (0.341s)
[530.295057] [119/133] (502s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[530.363932] Starting subtest: yf-tiled-ccs-to-yf-tiled
[530.368201] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[530.559204] [120/133] (502s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[530.661896] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[530.664304] Starting dynamic subtest: pipe-A-eDP-1
[537.468459] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.811s)
[537.479966] Starting dynamic subtest: pipe-B-eDP-1
[544.696623] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.225s)
[544.698785] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.039s)
[545.567585] [121/133] (487s left) kms_plane_alpha_blend (alpha-transparent-fb)
[545.663621] Starting subtest: alpha-transparent-fb
[545.955938] Starting dynamic subtest: pipe-A-eDP-1
[546.570926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[546.584071] Starting dynamic subtest: pipe-D-eDP-1
[547.950757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.381s)
[547.953178] Subtest alpha-transparent-fb: SUCCESS (2.290s)
[548.828694] [122/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[548.922765] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[552.959699] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.039s)
[554.136666] [123/133] (479s left) intel_hwmon (hwmon-write)
[554.194524] Subtest hwmon-write: SKIP (0.000s)
[554.250407] [124/133] (479s left) gen7_exec_parse (load-register-reg)
[554.311878] Subtest load-register-reg: SKIP (0.000s)
[554.388780] [125/133] (479s left) prime_mmap (test_userptr)
[554.447072] Starting subtest: test_userptr
[554.449353] Starting dynamic subtest: test_userptr-smem
[554.451585] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[554.453883] Subtest test_userptr: SUCCESS (0.001s)
[554.548466] [126/133] (478s left) kms_lease (implicit-plane-lease)
[554.646907] Starting subtest: implicit-plane-lease
[554.649131] Subtest implicit-plane-lease: SUCCESS (0.002s)
[554.745835] [127/133] (478s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[554.842240] Starting subtest: fbc-pr-sprite-mmap-gtt
[554.846156] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[554.916711] [128/133] (478s left) gem_exec_schedule (smoketest)
[555.089500] Starting subtest: smoketest
[555.091583] Starting dynamic subtest: rcs0
[560.636657] Dynamic subtest rcs0: SUCCESS (5.498s)
[560.648115] Starting dynamic subtest: bcs0
[566.138984] Dynamic subtest bcs0: SUCCESS (5.498s)
[566.150289] Starting dynamic subtest: vcs0
[571.644145] Dynamic subtest vcs0: SUCCESS (5.506s)
[571.655120] Starting dynamic subtest: vcs1
[577.124954] Dynamic subtest vcs1: SUCCESS (5.476s)
[577.136409] Starting dynamic subtest: vecs0
[582.607530] Dynamic subtest vecs0: SUCCESS (5.487s)
[582.621909] Starting dynamic subtest: ccs0
[588.133208] Dynamic subtest ccs0: SUCCESS (5.522s)
[588.135475] Subtest smoketest: SUCCESS (32.995s)
[588.325456] [129/133] (445s left) syncobj_wait (reset-during-wait-for-submit)
[588.398124] Starting subtest: reset-during-wait-for-submit
[588.501393] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[588.596275] [130/133] (445s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[588.658276] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[588.660480] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[588.785466] [131/133] (444s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[588.893333] Starting subtest: fbcpsr-modesetfrombusy
[595.110632] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.221s)
[595.240748] [132/133] (438s left) syncobj_eventfd (timeline-wait-before-signal)
[595.308377] Starting subtest: timeline-wait-before-signal
[595.337816] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[595.434556] [133/133] (438s left) gem_fence_thrash (bo-write-verify-threaded-none)
[595.472767] Starting subtest: bo-write-verify-threaded-none
[595.487254] Subtest bo-write-verify-threaded-none: SKIP (0.014s)
[595.545401] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_backlight
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_cs_tlb
results: parsing output: 3/ for test: kms_chamelium_audio
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: gen3_render_mixed_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_scaling_modes
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: testdisplay
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_draw_crc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_cursor_edge_walk
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: gem_wait
results: parsing output: 45/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_setmode
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: vgem_slow
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: i915_pm_rc6_residency
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: drm_mm
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_vrr
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_dirtyfb
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_flink_race
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_universal_plane
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_setmode
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_plane_alpha_blend
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: intel_hwmon
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: prime_mmap
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: gem_fence_thrash
Done.