[58.709144] Initializing watchdogs
[58.709192]   /dev/watchdog0
[58.724666] [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.729277] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.731788] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.735169] [001/156] (960s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[58.828131] Starting subtest: invalid-bsd1-flag-on-blt
[58.830603] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[58.916273] [002/156] (960s left) kms_sequence (get-idle)
[59.019541] Starting subtest: get-idle
[59.022042] Starting dynamic subtest: pipe-A-eDP-1
[60.887772] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.859s)
[60.897343] Starting dynamic subtest: pipe-B-eDP-1
[63.361511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.461s)
[63.369089] Starting dynamic subtest: pipe-C-eDP-1
[65.892067] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.526s)
[65.900847] Starting dynamic subtest: pipe-D-eDP-1
[68.329580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[68.331634] Subtest get-idle: SUCCESS (9.279s)
[69.139117] [003/156] (950s left) vgem_basic (unload)
[69.178819] Starting subtest: unload
[98.202778] Subtest unload: SUCCESS (29.010s)
[98.309727] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[98.312811] [004/156] (921s left) gem_userptr_blits (unsync-unmap-after-close)
[98.381516] Subtest unsync-unmap-after-close: SKIP (0.000s)
[98.492098] [005/156] (920s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[98.584840] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[98.596895] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[98.674205] [006/156] (920s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[98.771034] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[98.773286] Starting dynamic subtest: pipe-A-eDP-1
[98.792595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[98.802101] Starting dynamic subtest: pipe-B-eDP-1
[98.820584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[98.827843] Starting dynamic subtest: pipe-C-eDP-1
[98.847602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[98.856443] Starting dynamic subtest: pipe-D-eDP-1
[98.875471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[98.877393] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[101.033318] [007/156] (918s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[101.132083] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[101.136405] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[101.240195] [008/156] (918s left) kms_content_protection (legacy-hdcp14)
[101.371957] Starting subtest: legacy-hdcp14
[101.376674] Subtest legacy-hdcp14: SKIP (0.000s)
[101.506631] [009/156] (918s left) kms_pipe_crc_basic (nonblocking-crc)
[101.600194] Starting subtest: nonblocking-crc
[101.602618] Starting dynamic subtest: pipe-A-eDP-1
[102.351634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s)
[102.360411] Starting dynamic subtest: pipe-B-eDP-1
[103.744683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[103.754176] Starting dynamic subtest: pipe-C-eDP-1
[105.148941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[105.158608] Starting dynamic subtest: pipe-D-eDP-1
[106.587660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[106.590057] Subtest nonblocking-crc: SUCCESS (4.987s)
[107.464064] [010/156] (912s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[107.532290] Starting subtest: invalid-bsd2-flag-on-blt
[107.534819] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[107.629427] [011/156] (911s left) kms_pm_rpm (modeset-lpsp)
[109.488667] Starting subtest: modeset-lpsp
[110.965201] Subtest modeset-lpsp: SUCCESS (1.478s)
[111.047619] [012/156] (908s left) kms_draw_crc (draw-method-mmap-wc)
[111.135599] Starting subtest: draw-method-mmap-wc
[111.137645] Starting dynamic subtest: xrgb8888-untiled
[111.398743] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[111.406435] Starting dynamic subtest: rgb565-untiled
[111.610470] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[111.619717] Starting dynamic subtest: xrgb2101010-untiled
[111.832340] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[111.840124] Starting dynamic subtest: xbgr16161616f-untiled
[112.055888] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[112.064251] Starting dynamic subtest: xrgb8888-xtiled
[112.200267] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[112.207366] Starting dynamic subtest: rgb565-xtiled
[112.342674] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[112.350238] Starting dynamic subtest: xrgb2101010-xtiled
[112.476166] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[112.484196] Starting dynamic subtest: xbgr16161616f-xtiled
[112.609727] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[112.618525] Starting dynamic subtest: xrgb8888-4tiled
[112.765055] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[112.772978] Starting dynamic subtest: rgb565-4tiled
[112.898502] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[112.906622] Starting dynamic subtest: xrgb2101010-4tiled
[113.053917] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[113.061307] Starting dynamic subtest: xbgr16161616f-4tiled
[113.231866] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[113.233854] Subtest draw-method-mmap-wc: SUCCESS (2.100s)
[113.321132] [013/156] (906s left) kms_prop_blob (invalid-get-prop-any)
[113.373382] Starting subtest: invalid-get-prop-any
[113.375374] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[113.467179] [014/156] (906s left) fbdev (unaligned-read)
[113.507353] Starting subtest: unaligned-read
[113.520992] Subtest unaligned-read: SUCCESS (0.016s)
[113.573808] [015/156] (906s left) kms_cursor_edge_walk (128x128-right-edge)
[113.664158] Starting subtest: 128x128-right-edge
[113.665939] Starting dynamic subtest: pipe-A-eDP-1
[117.085042] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[117.092633] Starting dynamic subtest: pipe-D-eDP-1
[120.216327] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[120.218562] Subtest 128x128-right-edge: SUCCESS (6.552s)
[121.032475] [016/156] (898s left) gem_create (create-valid-nonaligned)
[121.086465] Starting subtest: create-valid-nonaligned
[121.088496] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[121.267563] [017/156] (898s left) kms_chamelium_color (ctm-limited-range)
[121.357432] Subtest ctm-limited-range: SKIP (0.000s)
[121.400365] [018/156] (898s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[121.502873] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[122.660460] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.158s)
[122.776462] [019/156] (897s left) kms_psr (psr-primary-mmap-cpu)
[122.874113] Starting subtest: psr-primary-mmap-cpu
[122.876073] Starting dynamic subtest: eDP-1
[124.625970] Dynamic subtest eDP-1: SUCCESS (1.750s)
[124.627949] Subtest psr-primary-mmap-cpu: SUCCESS (1.750s)
[125.493851] [020/156] (894s left) gem_exec_balancer (parallel-contexts)
[125.748752] Starting subtest: parallel-contexts
[128.469136] Subtest parallel-contexts: SUCCESS (2.721s)
[129.369281] [021/156] (890s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[129.484440] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[129.488501] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.579886] [022/156] (890s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[129.634096] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[129.638404] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[129.818212] [023/156] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[129.914204] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[129.918309] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.010516] [024/156] (890s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[130.115426] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[130.119539] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[130.214498] [025/156] (889s left) kms_psr (fbc-pr-cursor-render)
[130.304205] Starting subtest: fbc-pr-cursor-render
[130.308644] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[130.376140] [026/156] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[130.487319] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[130.491500] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[130.581934] [027/156] (889s left) api_intel_allocator (fork-simple-stress-signal)
[130.644164] Starting subtest: fork-simple-stress-signal
[136.102707] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[136.162592] [028/156] (884s left) kms_invalid_mode (zero-vdisplay)
[136.266551] Starting subtest: zero-vdisplay
[136.268953] Starting dynamic subtest: pipe-A-eDP-1
[136.548239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[136.557719] Starting dynamic subtest: pipe-B-eDP-1
[136.559772] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[136.567766] Starting dynamic subtest: pipe-C-eDP-1
[136.570166] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[136.578144] Starting dynamic subtest: pipe-D-eDP-1
[136.580598] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[136.582852] Subtest zero-vdisplay: SUCCESS (0.288s)
[137.430782] [029/156] (882s left) gem_wait (wait)
[137.506632] Starting subtest: wait
[137.509132] Starting dynamic subtest: all-engines
[139.363691] Dynamic subtest all-engines: SUCCESS (1.855s)
[139.378496] Starting dynamic subtest: rcs0
[140.411973] Dynamic subtest rcs0: SUCCESS (1.048s)
[140.423043] Starting dynamic subtest: bcs0
[141.457382] Dynamic subtest bcs0: SUCCESS (1.045s)
[141.468244] Starting dynamic subtest: vcs0
[142.501708] Dynamic subtest vcs0: SUCCESS (1.043s)
[142.512289] Starting dynamic subtest: vcs1
[143.546123] Dynamic subtest vcs1: SUCCESS (1.043s)
[143.556697] Starting dynamic subtest: vecs0
[144.590666] Dynamic subtest vecs0: SUCCESS (1.043s)
[144.600177] Starting dynamic subtest: ccs0
[145.636535] Dynamic subtest ccs0: SUCCESS (1.044s)
[145.639071] Subtest wait: SUCCESS (8.130s)
[145.838322] [030/156] (874s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[145.946254] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[145.950972] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[146.039552] [031/156] (874s left) gem_exec_schedule (pi-shared-iova)
[146.214114] Starting subtest: pi-shared-iova
[146.216513] Starting dynamic subtest: rcs0
[146.300489] Dynamic subtest rcs0: SUCCESS (0.088s)
[146.309279] Starting dynamic subtest: vcs0
[146.356326] Dynamic subtest vcs0: SUCCESS (0.054s)
[146.366150] Starting dynamic subtest: vcs1
[146.421194] Dynamic subtest vcs1: SUCCESS (0.062s)
[146.437291] Starting dynamic subtest: vecs0
[146.470193] Dynamic subtest vecs0: SUCCESS (0.050s)
[146.483202] Starting dynamic subtest: ccs0
[146.528269] Dynamic subtest ccs0: SUCCESS (0.058s)
[146.530763] Subtest pi-shared-iova: SUCCESS (0.317s)
[148.418420] [032/156] (872s left) gem_eio (context-create)
[148.647321] Starting subtest: context-create
[148.969844] Subtest context-create: SUCCESS (0.322s)
[149.088415] [033/156] (871s left) kms_flip (2x-flip-vs-wf_vblank)
[149.192874] Starting subtest: 2x-flip-vs-wf_vblank
[149.204084] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[149.287785] [034/156] (871s left) syncobj_wait (invalid-reset-zero-handles)
[149.339808] Starting subtest: invalid-reset-zero-handles
[149.342036] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[149.448431] [035/156] (871s left) gem_mmap_gtt (basic)
[149.501051] Subtest basic: SKIP (0.000s)
[149.560437] [036/156] (871s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[149.628032] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[149.703078] [037/156] (870s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[149.793452] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[149.797189] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[149.885285] [038/156] (870s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[149.985352] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[149.988860] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[150.049612] [039/156] (870s left) gem_mmap_gtt (pf-nonblock)
[150.096365] Subtest pf-nonblock: SKIP (0.000s)
[150.154605] [040/156] (870s left) kms_plane_scaling (intel-max-src-size)
[150.250919] Starting subtest: intel-max-src-size
[150.256312] Subtest intel-max-src-size: SKIP (0.000s)
[150.349986] [041/156] (870s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[150.452809] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[150.456172] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[150.547891] [042/156] (870s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[150.647475] Starting subtest: primary-y-tiled-reflect-x-270
[150.651150] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[150.731734] [043/156] (870s left) api_intel_bb (full-batch)
[150.792125] Starting subtest: full-batch
[150.796332] Subtest full-batch: SUCCESS (0.005s)
[150.906682] [044/156] (870s left) gem_exec_fence (syncobj-export)
[151.353755] Starting subtest: syncobj-export
[151.360956] Subtest syncobj-export: SUCCESS (0.007s)
[152.447537] [045/156] (868s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[152.545043] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[152.549219] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[152.635958] [046/156] (868s left) gem_exec_gttfill (basic)
[152.702637] Starting subtest: basic
[155.312066] Subtest basic: SUCCESS (2.609s)
[155.512819] [047/156] (865s left) gem_lmem_swapping (random)
[155.613478] Subtest random: SKIP (0.000s)
[155.659326] [048/156] (865s left) kms_cursor_crc (cursor-offscreen-64x64)
[155.851309] Starting subtest: cursor-offscreen-64x64
[155.853596] Starting dynamic subtest: pipe-A-eDP-1
[157.799081] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[157.831950] Starting dynamic subtest: pipe-D-eDP-1
[160.419055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[160.421241] Subtest cursor-offscreen-64x64: SUCCESS (4.567s)
[161.295832] [049/156] (859s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[161.675337] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[162.491839] [050/156] (858s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[162.581065] Subtest writes-after-reads-uncached: SKIP (0.000s)
[162.641712] [051/156] (858s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[162.737911] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[162.763269] Starting dynamic subtest: pipe-A-plane-0
[163.151715] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[163.160618] Starting dynamic subtest: pipe-A-plane-3
[163.496035] Dynamic subtest pipe-A-plane-3: SUCCESS (0.344s)
[164.597772] Starting dynamic subtest: pipe-B-plane-0
[164.989322] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[164.999268] Starting dynamic subtest: pipe-B-plane-3
[165.345078] Dynamic subtest pipe-B-plane-3: SUCCESS (0.355s)
[165.654471] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.918s)
[166.470955] [052/156] (854s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[166.589482] Starting subtest: y-tiled-16bpp-rotate-180
[166.594114] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[166.692525] [053/156] (854s left) syncobj_timeline (wait-all-complex)
[166.750879] Starting subtest: wait-all-complex
[166.967263] Subtest wait-all-complex: SUCCESS (0.216s)
[167.044184] [054/156] (854s left) dmabuf_sync_file (export-basic)
[167.085332] Starting subtest: export-basic
[167.087160] Subtest export-basic: SUCCESS (0.001s)
[167.140589] [055/156] (854s left) gem_exec_reloc (basic-write-cpu)
[167.207396] Subtest basic-write-cpu: SKIP (0.000s)
[167.276551] [056/156] (854s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[167.399396] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[168.867437] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.469s)
[169.750368] [057/156] (851s left) gem_exec_balancer (parallel-keep-in-fence)
[170.004563] Starting subtest: parallel-keep-in-fence
[171.260373] Subtest parallel-keep-in-fence: SUCCESS (1.256s)
[171.362445] [058/156] (850s left) kms_psr (fbc-psr2-sprite-blt)
[171.464461] Starting subtest: fbc-psr2-sprite-blt
[171.466382] Starting dynamic subtest: eDP-1
[171.470426] Dynamic subtest eDP-1: SKIP (0.000s)
[171.474431] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[171.535145] [059/156] (850s left) i915_drm_fdinfo (memory-info-idle)
[171.574831] Starting subtest: memory-info-idle
[171.577080] Starting dynamic subtest: smem0
[171.626355] Dynamic subtest smem0: SUCCESS (0.051s)
[171.629063] Subtest memory-info-idle: SUCCESS (0.051s)
[171.700700] [060/156] (849s left) perf (stress-open-close)
[171.833043] Starting subtest: stress-open-close
[171.835362] Starting dynamic subtest: 0-rcs0
[174.000500] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[174.012251] Starting dynamic subtest: 1-vcs1
[176.165533] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[176.167426] Subtest stress-open-close: SUCCESS (4.333s)
[176.206786] [061/156] (845s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[176.304441] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[176.307953] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[176.408164] [062/156] (845s left) kms_getfb (getfb-handle-closed)
[176.509362] Starting subtest: getfb-handle-closed
[176.511146] Subtest getfb-handle-closed: SUCCESS (0.000s)
[176.599131] [063/156] (845s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[176.701952] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[181.032225] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.333s)
[182.181580] [064/156] (839s left) syncobj_timeline (device-signal-unordered)
[182.251483] Starting subtest: device-signal-unordered
[182.253913] Subtest device-signal-unordered: SUCCESS (0.001s)
[182.356295] [065/156] (839s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[182.457664] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[182.462042] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[182.561827] [066/156] (839s left) gem_pread (exhaustion)
[182.611590] Subtest exhaustion: SKIP (0.000s)
[182.671277] [067/156] (839s left) gem_mmap_gtt (basic-small-bo)
[182.726220] Subtest basic-small-bo: SKIP (0.000s)
[182.780504] [068/156] (839s left) kms_flip (plain-flip-fb-recreate-interruptible)
[182.870257] Starting subtest: plain-flip-fb-recreate-interruptible
[182.872616] Starting dynamic subtest: A-eDP1
[191.748665] Dynamic subtest A-eDP1: SUCCESS (8.877s)
[191.761515] Starting dynamic subtest: B-eDP1
[200.579073] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[200.590758] Starting dynamic subtest: C-eDP1
[209.400590] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[209.409563] Starting dynamic subtest: D-eDP1
[218.236561] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[218.238752] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.368s)
[219.429683] [069/156] (802s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[219.497375] Starting subtest: y-tiled-ccs-to-x-tiled
[219.501942] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[219.692766] [070/156] (802s left) gem_ctx_create (basic)
[219.750087] Starting subtest: basic
[219.752437] Subtest basic: SUCCESS (0.000s)
[219.946411] [071/156] (802s left) syncobj_timeline (multi-wait-available-signaled)
[219.990839] Starting subtest: multi-wait-available-signaled
[219.993118] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[220.088350] [072/156] (802s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[220.192856] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[227.166039] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.979s)
[227.316637] [073/156] (794s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[227.417753] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[227.421734] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[227.519099] [074/156] (794s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[227.899465] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[228.746805] [075/156] (793s left) gem_exec_schedule (reorder-wide)
[228.931676] Subtest reorder-wide: SKIP (0.000s)
[229.126483] [076/156] (793s left) kms_lease (lessee-list)
[229.218156] Starting subtest: lessee-list
[229.220653] Starting dynamic subtest: pipe-A-eDP-1
[229.223222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[229.233612] Starting dynamic subtest: pipe-B-eDP-1
[229.235776] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[229.245131] Starting dynamic subtest: pipe-C-eDP-1
[229.247422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[229.258093] Starting dynamic subtest: pipe-D-eDP-1
[229.260181] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[229.262370] Subtest lessee-list: SUCCESS (0.009s)
[229.341652] [077/156] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[229.430682] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[229.434927] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[229.519174] [078/156] (792s left) kms_addfb_basic (master-rmfb)
[229.585217] Starting subtest: master-rmfb
[229.587559] Subtest master-rmfb: SUCCESS (0.002s)
[229.732135] [079/156] (792s left) kms_properties (colorop-properties-atomic)
[229.835926] Starting subtest: colorop-properties-atomic
[229.837859] Starting dynamic subtest: pipe-A-eDP-1
[230.209673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[230.219774] Starting dynamic subtest: pipe-B-eDP-1
[231.340799] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[231.350235] Starting dynamic subtest: pipe-C-eDP-1
[232.384569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.042s)
[232.393890] Starting dynamic subtest: pipe-D-eDP-1
[233.527543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[233.529873] Subtest colorop-properties-atomic: SUCCESS (3.692s)
[234.337356] [080/156] (788s left) sysfs_heartbeat_interval (invalid)
[234.411263] Starting subtest: invalid
[234.413610] Starting dynamic subtest: vecs0
[234.415941] Dynamic subtest vecs0: SUCCESS (0.000s)
[234.425496] Starting dynamic subtest: ccs0
[234.427411] Dynamic subtest ccs0: SUCCESS (0.000s)
[234.438439] Starting dynamic subtest: vcs0
[234.440358] Dynamic subtest vcs0: SUCCESS (0.000s)
[234.449139] Starting dynamic subtest: bcs0
[234.451057] Dynamic subtest bcs0: SUCCESS (0.000s)
[234.459627] Starting dynamic subtest: rcs0
[234.461834] Dynamic subtest rcs0: SUCCESS (0.000s)
[234.470633] Starting dynamic subtest: vcs1
[234.472572] Dynamic subtest vcs1: SUCCESS (0.000s)
[234.474518] Subtest invalid: SUCCESS (0.005s)
[234.523051] [081/156] (787s left) gem_ctx_exec (basic-close-race)
[234.572716] Starting subtest: basic-close-race
[240.584843] Subtest basic-close-race: SUCCESS (5.959s)
[240.656659] [082/156] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[240.764712] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[240.769044] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[240.864438] [083/156] (781s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[240.974169] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[240.978193] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[241.069311] [084/156] (781s left) gem_eio (in-flight-contexts-immediate)
[241.294955] Starting subtest: in-flight-contexts-immediate
[255.340185] Subtest in-flight-contexts-immediate: SUCCESS (14.044s)
[255.519304] [085/156] (767s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[255.622265] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[255.626280] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[255.726389] [086/156] (766s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[255.820950] Starting subtest: psr-dirtyfb-ioctl
[255.823337] Starting dynamic subtest: A-eDP-1
[259.754076] Dynamic subtest A-eDP-1: SUCCESS (3.933s)
[259.756698] Subtest psr-dirtyfb-ioctl: SUCCESS (3.935s)
[260.642451] [087/156] (762s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[260.740716] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[260.744697] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[260.828927] [088/156] (761s left) gen9_exec_parse (basic-rejected)
[260.890878] Subtest basic-rejected: SKIP (0.000s)
[260.967149] [089/156] (761s left) kms_psr (pr-primary-render)
[261.053210] Starting subtest: pr-primary-render
[261.057632] Subtest pr-primary-render: SKIP (0.000s)
[261.129340] [090/156] (761s left) i915_suspend (basic-s3-without-i915)
[261.169615] Starting subtest: basic-s3-without-i915
[264.457132] Subtest basic-s3-without-i915: SKIP (3.287s)
[266.093613] [091/156] (756s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[266.212091] Starting subtest: fbchdr-rgb565-draw-render
[266.216164] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[266.301787] [092/156] (756s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[266.389730] Starting subtest: 4-tiled-64bpp-rotate-0
[267.950239] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.561s)
[268.137682] [093/156] (754s left) i915_hangman (engine-error-state-capture)
[268.202047] Starting subtest: engine-error-state-capture
[268.204436] Starting dynamic subtest: rcs0
[271.294575] Dynamic subtest rcs0: SUCCESS (3.091s)
[271.306136] Starting dynamic subtest: bcs0
[277.312071] Dynamic subtest bcs0: SUCCESS (6.015s)
[277.322758] Starting dynamic subtest: vcs0
[282.302316] Dynamic subtest vcs0: SUCCESS (4.986s)
[282.312987] Starting dynamic subtest: vcs1
[288.254695] Dynamic subtest vcs1: SUCCESS (5.950s)
[288.269281] Starting dynamic subtest: vecs0
[293.309993] Dynamic subtest vecs0: SUCCESS (5.052s)
[293.324331] Starting dynamic subtest: ccs0
[299.326410] Dynamic subtest ccs0: SUCCESS (6.011s)
[299.329229] Subtest engine-error-state-capture: SUCCESS (31.124s)
[299.408532] [094/156] (723s left) kms_pwrite_crc (basic)
[299.515223] Starting subtest: basic
[300.218561] Subtest basic: SUCCESS (0.703s)
[301.105523] [095/156] (721s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[301.211812] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[301.215975] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[301.303395] [096/156] (721s left) syncobj_timeline (multi-wait-signaled)
[301.349934] Starting subtest: multi-wait-signaled
[301.352142] Subtest multi-wait-signaled: SUCCESS (0.000s)
[301.455612] [097/156] (721s left) syncobj_basic (bad-handle-to-fd)
[301.503492] Starting subtest: bad-handle-to-fd
[301.506042] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[301.608744] [098/156] (721s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[301.705635] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[301.710911] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[302.838816] [099/156] (720s left) perf_pmu (most-busy-idle-check-all)
[302.884852] Starting subtest: most-busy-idle-check-all
[302.887281] Starting dynamic subtest: rcs0
[304.352404] Dynamic subtest rcs0: SUCCESS (1.465s)
[304.364590] Starting dynamic subtest: bcs0
[306.336359] Dynamic subtest bcs0: SUCCESS (1.981s)
[306.348675] Starting dynamic subtest: vcs0
[308.320634] Dynamic subtest vcs0: SUCCESS (1.981s)
[308.333237] Starting dynamic subtest: vcs1
[310.304668] Dynamic subtest vcs1: SUCCESS (1.982s)
[310.317403] Starting dynamic subtest: vecs0
[312.352264] Dynamic subtest vecs0: SUCCESS (2.044s)
[312.364175] Starting dynamic subtest: ccs0
[314.336483] Dynamic subtest ccs0: SUCCESS (1.982s)
[314.339419] Subtest most-busy-idle-check-all: SUCCESS (11.451s)
[314.443464] [100/156] (708s left) gem_exec_whisper (basic-fds-priority-all)
[314.504783] Starting subtest: basic-fds-priority-all
[338.894876] Subtest basic-fds-priority-all: SUCCESS (24.385s)
[339.077956] [101/156] (684s left) gem_exec_parallel (engines)
[339.140867] Starting subtest: engines
[339.143130] Starting dynamic subtest: basic
[341.279811] Dynamic subtest basic: SUCCESS (2.139s)
[341.296880] Starting dynamic subtest: contexts
[345.634875] Dynamic subtest contexts: SUCCESS (4.352s)
[345.649883] Starting dynamic subtest: fds
[349.475826] Dynamic subtest fds: SUCCESS (3.839s)
[349.490026] Starting dynamic subtest: userptr
[351.328293] Dynamic subtest userptr: SUCCESS (1.849s)
[351.330824] Subtest engines: SUCCESS (12.189s)
[351.525544] [102/156] (671s left) kms_flip (bo-too-big)
[351.632095] Starting subtest: bo-too-big
[351.633977] Starting dynamic subtest: A-eDP1
[352.986063] Dynamic subtest A-eDP1: SUCCESS (1.355s)
[352.996810] Starting dynamic subtest: B-eDP1
[354.314698] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[354.324128] Starting dynamic subtest: C-eDP1
[355.638978] Dynamic subtest C-eDP1: SUCCESS (1.322s)
[355.651628] Starting dynamic subtest: D-eDP1
[356.980089] Dynamic subtest D-eDP1: SUCCESS (1.338s)
[356.982639] Subtest bo-too-big: SUCCESS (5.353s)
[358.182716] [103/156] (665s left) gem_ctx_param (invalid-set-no-zeromap)
[358.242218] Starting subtest: invalid-set-no-zeromap
[358.244722] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[358.318028] [104/156] (665s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[358.407974] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[358.410289] Starting dynamic subtest: pipe-A-default-mode
[361.132541] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[361.134776] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.727s)
[361.971130] [105/156] (661s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[362.079239] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[362.083173] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[362.155617] [106/156] (661s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[362.248358] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[362.276677] Starting dynamic subtest: pipe-A-plane-0
[362.543167] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[362.555146] Starting dynamic subtest: pipe-A-plane-3
[362.754369] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[362.764859] Starting dynamic subtest: pipe-A-plane-5
[362.769532] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[363.844259] Starting dynamic subtest: pipe-B-plane-0
[364.114344] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[364.123805] Starting dynamic subtest: pipe-B-plane-3
[364.325110] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[364.334843] Starting dynamic subtest: pipe-B-plane-5
[364.339006] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[364.634695] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.386s)
[365.526314] [107/156] (658s left) prime_mmap (test_correct_cpu_write)
[365.584967] Starting subtest: test_correct_cpu_write
[365.587513] Starting dynamic subtest: test_correct_cpu_write-smem
[365.589482] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[365.591469] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[365.696255] [108/156] (657s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[365.791860] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[365.795974] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[365.915474] [109/156] (657s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[366.007588] Starting subtest: yf-tiled-64bpp-rotate-90
[366.012040] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[366.102609] [110/156] (657s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[366.202329] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[366.206581] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.295346] [111/156] (657s left) gem_exec_reloc (basic-gtt-active)
[366.349974] Subtest basic-gtt-active: SKIP (0.000s)
[366.427652] [112/156] (657s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[366.530995] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[366.534457] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[366.616068] [113/156] (657s left) gem_mmap_gtt (basic-small-copy-odd)
[366.670286] Subtest basic-small-copy-odd: SKIP (0.000s)
[366.730995] [114/156] (657s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[366.793510] Starting subtest: y-tiled-ccs-to-y-tiled
[366.797330] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[366.975470] [115/156] (656s left) gem_ctx_persistence (legacy-engines-queued)
[367.034512] Starting subtest: legacy-engines-queued
[367.036675] Starting dynamic subtest: render
[367.129071] Dynamic subtest render: SUCCESS (0.094s)
[367.140886] Starting dynamic subtest: bsd1
[368.319319] Dynamic subtest bsd1: SUCCESS (1.186s)
[368.332221] Starting dynamic subtest: bsd2
[370.301459] Dynamic subtest bsd2: SUCCESS (1.979s)
[370.313935] Starting dynamic subtest: blt
[370.363522] Dynamic subtest blt: SUCCESS (0.061s)
[370.374909] Starting dynamic subtest: vebox
[372.285906] Dynamic subtest vebox: SUCCESS (1.919s)
[372.288855] Subtest legacy-engines-queued: SUCCESS (5.253s)
[372.380672] [116/156] (651s left) gem_fenced_exec_thrash (too-many-fences)
[372.446696] Subtest too-many-fences: SKIP (0.000s)
[372.503802] [117/156] (651s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[372.563021] Starting subtest: mixed-tiled-to-y-tiled-ccs
[372.567447] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[372.747111] [118/156] (651s left) kms_atomic_interruptible (universal-setplane-primary)
[372.852058] Starting subtest: universal-setplane-primary
[372.854345] Starting dynamic subtest: pipe-A-eDP-1
[380.255305] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s)
[380.257473] Subtest universal-setplane-primary: SUCCESS (7.403s)
[381.104634] [119/156] (642s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[381.212836] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[381.217205] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[381.329590] [120/156] (642s left) i915_pm_rpm (gem-idle)
[383.473833] Starting subtest: gem-idle
[389.681529] Subtest gem-idle: SUCCESS (6.204s)
[390.020953] [121/156] (634s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[391.346058] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[391.981132] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[392.156253] [122/156] (632s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[392.266111] Starting subtest: hdr-rgb565-draw-pwrite
[392.270100] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[392.355470] [123/156] (631s left) kms_busy (extended-pageflip-hang-oldfb)
[392.451053] Starting subtest: extended-pageflip-hang-oldfb
[392.452995] Starting dynamic subtest: pipe-A
[392.867290] Dynamic subtest pipe-A: SUCCESS (0.417s)
[392.878770] Starting dynamic subtest: pipe-D
[394.046115] Dynamic subtest pipe-D: SUCCESS (1.177s)
[394.048453] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.597s)
[394.886444] [124/156] (629s left) gem_lmem_swapping (parallel-random-verify)
[394.929330] Subtest parallel-random-verify: SKIP (0.000s)
[394.970806] [125/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[395.062200] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[395.066517] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[395.169371] [126/156] (629s left) gem_exec_flush (basic-batch-kernel-default-uc)
[395.228605] Starting subtest: basic-batch-kernel-default-uc
[402.276369] Subtest basic-batch-kernel-default-uc: SUCCESS (7.048s)
[402.465235] [127/156] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[402.569652] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[402.573664] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[402.669872] [128/156] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[402.766936] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[409.842714] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.082s)
[409.981113] [129/156] (614s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[410.074188] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[410.076484] Starting dynamic subtest: pipe-A
[410.137065] Dynamic subtest pipe-A: SUCCESS (0.065s)
[410.149184] Starting dynamic subtest: pipe-B
[411.347994] Dynamic subtest pipe-B: SUCCESS (1.210s)
[411.360566] Starting dynamic subtest: pipe-C
[412.468911] Dynamic subtest pipe-C: SUCCESS (1.120s)
[412.481117] Starting dynamic subtest: pipe-D
[413.588700] Dynamic subtest pipe-D: SUCCESS (1.119s)
[413.591054] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.517s)
[414.749163] [130/156] (609s left) syncobj_wait (multi-wait-all-submitted-signaled)
[414.805345] Starting subtest: multi-wait-all-submitted-signaled
[414.908540] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[414.998118] [131/156] (609s left) perf_pmu (busy-double-start)
[415.039263] Starting subtest: busy-double-start
[415.041590] Starting dynamic subtest: rcs0
[418.679726] Dynamic subtest rcs0: FAIL (3.586s)
[418.692540] Starting dynamic subtest: bcs0
[422.199323] Dynamic subtest bcs0: SUCCESS (3.574s)
[422.210793] Starting dynamic subtest: vcs0
[425.823980] Dynamic subtest vcs0: SUCCESS (3.622s)
[425.839987] Starting dynamic subtest: vcs1
[429.810801] Dynamic subtest vcs1: SUCCESS (3.984s)
[429.821482] Starting dynamic subtest: vecs0
[433.845184] Dynamic subtest vecs0: SUCCESS (4.032s)
[433.856104] Starting dynamic subtest: ccs0
[437.478609] Dynamic subtest ccs0: FAIL (3.566s)
[437.480500] Subtest busy-double-start: FAIL (22.376s)
[437.538148] [132/156] (587s left) syncobj_wait (wait-any-snapshot)
[437.580978] Starting subtest: wait-any-snapshot
[437.662367] Subtest wait-any-snapshot: SUCCESS (0.082s)
[437.769216] [133/156] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[437.871076] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[437.875111] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[437.974861] [134/156] (586s left) prime_mmap_coherency (read)
[438.030783] Starting subtest: read
[443.463970] Subtest read: SUCCESS (5.378s)
[443.526959] [135/156] (581s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[443.621062] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[443.623375] Starting dynamic subtest: pipe-A-eDP-1
[443.646720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.659179] Starting dynamic subtest: pipe-B-eDP-1
[443.681168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.690882] Starting dynamic subtest: pipe-C-eDP-1
[443.711829] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[443.720738] Starting dynamic subtest: pipe-D-eDP-1
[443.742487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[443.746836] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[445.908116] [136/156] (578s left) gem_softpin (softpin)
[445.970920] Starting subtest: softpin
[478.278616] Subtest softpin: SUCCESS (32.301s)
[478.418454] [137/156] (546s left) kms_big_fb (linear-32bpp-rotate-90)
[478.521151] Starting subtest: linear-32bpp-rotate-90
[478.540598] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[478.654936] [138/156] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[478.764717] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[478.769204] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[478.847795] [139/156] (546s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[478.946312] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[478.950573] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[479.045172] [140/156] (545s left) gem_softpin (evict-prime)
[479.101112] Starting subtest: evict-prime
[479.103391] Starting dynamic subtest: rcs0
[480.256817] Dynamic subtest rcs0: SUCCESS (1.156s)
[480.270176] Starting dynamic subtest: bcs0
[481.380886] Dynamic subtest bcs0: SUCCESS (1.122s)
[481.393021] Starting dynamic subtest: vcs0
[483.290111] Dynamic subtest vcs0: SUCCESS (1.906s)
[483.303796] Starting dynamic subtest: vcs1
[485.354160] Dynamic subtest vcs1: SUCCESS (2.062s)
[485.365429] Starting dynamic subtest: vecs0
[487.329400] Dynamic subtest vecs0: SUCCESS (1.972s)
[487.342090] Starting dynamic subtest: ccs0
[488.472551] Dynamic subtest ccs0: SUCCESS (1.142s)
[488.484581] Starting dynamic subtest: all
[490.338831] Dynamic subtest all: SUCCESS (1.862s)
[490.341831] Subtest evict-prime: SUCCESS (11.237s)
[490.420054] [141/156] (534s left) kms_getfb (getfb-handle-protection)
[490.511468] Starting subtest: getfb-handle-protection
[490.526518] Subtest getfb-handle-protection: SUCCESS (0.017s)
[490.645982] [142/156] (534s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[490.704512] Starting subtest: etime-single-wait-all-for-submit-submitted
[490.811812] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[490.892821] [143/156] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[490.989498] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[490.993767] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[491.093399] [144/156] (534s left) kms_color (ctm-blue-to-red)
[491.190526] Starting subtest: ctm-blue-to-red
[491.192516] Starting dynamic subtest: pipe-A-eDP-1
[491.919713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[491.930218] Starting dynamic subtest: pipe-B-eDP-1
[493.326578] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[493.337717] Starting dynamic subtest: pipe-C-eDP-1
[494.706301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[494.716876] Starting dynamic subtest: pipe-D-eDP-1
[496.015660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[496.017989] Subtest ctm-blue-to-red: SUCCESS (4.828s)
[496.844426] [145/156] (528s left) perf_pmu (interrupts-sync)
[496.887820] Starting subtest: interrupts-sync
[497.992588] Subtest interrupts-sync: SUCCESS (1.103s)
[498.120295] [146/156] (527s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[498.217213] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[498.219469] Starting dynamic subtest: pipe-A-eDP-1
[498.242977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[498.254953] Starting dynamic subtest: pipe-B-eDP-1
[498.276838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[498.287646] Starting dynamic subtest: pipe-C-eDP-1
[498.309608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[498.319371] Starting dynamic subtest: pipe-D-eDP-1
[498.341518] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[498.345592] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[500.522575] [147/156] (524s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[500.792104] Starting subtest: cursor-rapid-movement-512x512
[500.796457] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[500.952413] [148/156] (524s left) kms_vblank (ts-continuation-suspend)
[501.042193] Starting subtest: ts-continuation-suspend
[501.044298] Starting dynamic subtest: pipe-A-eDP-1
[518.156282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s)
[518.172899] Starting dynamic subtest: pipe-D-eDP-1
[536.148859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[536.151143] Subtest ts-continuation-suspend: SUCCESS (4.678s)
[546.039095] [149/156] (488s left) gem_mmap_gtt (big-bo-tiledy)
[546.107139] Subtest big-bo-tiledY: SKIP (0.000s)
[546.166070] [150/156] (488s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[546.267358] Starting subtest: psr-rgb565-draw-mmap-wc
[553.244585] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.915s)
[553.366815] [151/156] (481s left) kms_flip (basic-flip-vs-wf_vblank)
[553.456784] Starting subtest: basic-flip-vs-wf_vblank
[553.459074] Starting dynamic subtest: A-eDP1
[555.412543] Dynamic subtest A-eDP1: SUCCESS (1.944s)
[555.424885] Starting dynamic subtest: B-eDP1
[557.355178] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[557.370817] Starting dynamic subtest: C-eDP1
[559.288080] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[559.310104] Starting dynamic subtest: D-eDP1
[561.223789] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[561.226256] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.738s)
[562.451915] [152/156] (472s left) syncobj_wait (single-wait-submitted)
[562.518791] Starting subtest: single-wait-submitted
[562.625085] Subtest single-wait-submitted: SUCCESS (0.105s)
[562.715545] [153/156] (471s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[562.818979] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[562.822930] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[562.918707] [154/156] (471s left) kms_atomic (test-only)
[563.017058] Starting subtest: test-only
[563.066333] Starting dynamic subtest: pipe-A-eDP-1
[565.559059] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.488s)
[565.561072] Subtest test-only: SUCCESS (2.539s)
[566.362676] [155/156] (468s left) kms_psr (fbc-psr-sprite-plane-onoff)
[566.466894] Starting subtest: fbc-psr-sprite-plane-onoff
[566.469296] Starting dynamic subtest: eDP-1
[566.473845] Dynamic subtest eDP-1: SKIP (0.000s)
[566.478425] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[566.565602] [156/156] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[566.660905] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[566.664977] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[566.751756] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_sequence
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_draw_crc
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: fbdev
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_invalid_mode
results: parsing output: 28/ for test: gem_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_fenced_exec_thrash
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_gttfill
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_chamelium_edid
results: parsing output: 49/ for test: gem_partial_pwrite_pread
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: dmabuf_sync_file
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_pread
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_ctx_create
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: sysfs_heartbeat_interval
results: parsing output: 80/ for test: gem_ctx_exec
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_dirtyfb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: i915_suspend
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: i915_hangman
results: parsing output: 93/ for test: kms_pwrite_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: gem_exec_parallel
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: gem_fenced_exec_thrash
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: kms_atomic_interruptible
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_busy
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: prime_mmap_coherency
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: gem_softpin
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_softpin
results: parsing output: 140/ for test: kms_getfb
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_color
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_cursor_crc
results: parsing output: 147/ for test: kms_vblank
results: parsing output: 148/ for test: gem_mmap_gtt
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: syncobj_wait
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_atomic
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.