[60.029239] Initializing watchdogs
[60.029303]   /dev/watchdog0
[60.045097] [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]
[60.049869] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.052317] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.055658] [001/133] (960s left) api_intel_bb (reset-flags)
[60.145438] Starting subtest: reset-flags
[60.157720] Subtest reset-flags: SUCCESS (0.013s)
[60.285775] [002/133] (960s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[60.392796] Starting subtest: y-tiled-32bpp-rotate-0
[60.397052] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[60.500568] [003/133] (960s left) dumb_buffer (create-valid-dumb)
[60.556705] Starting subtest: create-valid-dumb
[60.558993] Subtest create-valid-dumb: SUCCESS (0.000s)
[60.649360] [004/133] (960s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[60.771889] Starting subtest: 2x-flip-vs-cursor-atomic
[60.776864] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[60.915775] [005/133] (959s left) kms_plane (planar-pixel-format-settings)
[61.015252] Starting subtest: planar-pixel-format-settings
[61.105082] Subtest planar-pixel-format-settings: SUCCESS (0.091s)
[61.221935] [006/133] (959s left) kms_addfb_basic (bad-pitch-63)
[61.279304] Starting subtest: bad-pitch-63
[61.281026] Subtest bad-pitch-63: SUCCESS (0.000s)
[61.419405] [007/133] (959s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[61.509211] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[61.511155] Starting dynamic subtest: pipe-A
[61.574156] Dynamic subtest pipe-A: SUCCESS (0.066s)
[61.584051] Starting dynamic subtest: pipe-B
[62.731454] Dynamic subtest pipe-B: SUCCESS (1.154s)
[62.744338] Starting dynamic subtest: pipe-C
[63.858102] Dynamic subtest pipe-C: SUCCESS (1.122s)
[63.868709] Starting dynamic subtest: pipe-D
[64.996194] Dynamic subtest pipe-D: SUCCESS (1.138s)
[64.998348] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.481s)
[66.147321] [008/133] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[66.247740] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[70.014996] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.768s)
[71.190349] [009/133] (949s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[71.302278] Starting subtest: 2x-cursor-vs-flip-atomic
[71.306955] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[71.443918] [010/133] (949s left) i915_drm_fdinfo (context-close-stress)
[71.484675] Starting subtest: context-close-stress
[82.234778] Subtest context-close-stress: SUCCESS (10.744s)
[82.310316] [011/133] (938s left) gem_exec_gttfill (multigpu-basic)
[82.663280] Starting subtest: multigpu-basic
[96.401445] Subtest multigpu-basic: SUCCESS (13.739s)
[96.456250] [012/133] (924s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[96.546623] Starting subtest: wait-all-for-submit-delayed-submit
[96.650354] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[96.726523] [013/133] (924s left) kms_fbcon_fbt (fbc-suspend)
[96.785051] Starting subtest: fbc-suspend
[146.152481] Subtest fbc-suspend: SUCCESS (20.710s)
[152.510605] [014/133] (873s left) kms_lease (multimaster-lease)
[152.628640] Starting subtest: multimaster-lease
[152.631015] Subtest multimaster-lease: SUCCESS (0.004s)
[152.769956] [015/133] (873s left) kms_properties (plane-properties-legacy)
[152.867632] Starting subtest: plane-properties-legacy
[152.870264] Starting dynamic subtest: pipe-A-eDP-1
[153.447077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[153.461090] Starting dynamic subtest: pipe-B-eDP-1
[154.702978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[154.713406] Starting dynamic subtest: pipe-C-eDP-1
[155.940850] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[155.951384] Starting dynamic subtest: pipe-D-eDP-1
[157.164748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[157.166983] Subtest plane-properties-legacy: SUCCESS (4.268s)
[157.978903] [016/133] (868s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[158.568683] Starting subtest: syncobj-backward-timeline-chain-engines
[158.675555] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.106s)
[160.104783] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[160.108280] [017/133] (866s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[160.163361] Starting subtest: y-tiled-ccs-to-y-tiled
[160.167899] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[160.347356] [018/133] (865s left) kms_dp_link_training (uhbr-sst)
[160.442879] Starting subtest: uhbr-sst
[160.451682] Subtest uhbr-sst: SKIP (0.000s)
[160.518388] [019/133] (865s left) kms_cursor_crc (cursor-offscreen-64x64)
[160.684433] Starting subtest: cursor-offscreen-64x64
[160.688982] Starting dynamic subtest: pipe-A-eDP-1
[162.637986] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[162.669143] Starting dynamic subtest: pipe-D-eDP-1
[165.238822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[165.241171] Subtest cursor-offscreen-64x64: SUCCESS (4.540s)
[166.100537] [020/133] (860s left) kms_psr (fbc-pr-primary-blt)
[166.199506] Starting subtest: fbc-pr-primary-blt
[166.204028] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[166.273442] [021/133] (860s left) gem_exec_reloc (basic-write-read-active)
[166.331343] Subtest basic-write-read-active: SKIP (0.000s)
[166.406080] [022/133] (860s left) syncobj_basic (bad-pad-fd-to-handle)
[166.457533] Starting subtest: bad-pad-fd-to-handle
[166.459976] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[166.563429] [023/133] (859s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[166.659181] Starting subtest: bad-pixel-format-yf-tiled-ccs
[166.661422] Starting dynamic subtest: pipe-A-eDP-1
[166.684025] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.695181] Starting dynamic subtest: pipe-B-eDP-1
[166.716879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.726487] Starting dynamic subtest: pipe-C-eDP-1
[166.748139] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.757189] Starting dynamic subtest: pipe-D-eDP-1
[166.779101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.783528] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[168.952754] [024/133] (857s left) gem_spin_batch (legacy-resubmit-new)
[169.019614] Starting subtest: legacy-resubmit-new
[169.021720] Starting dynamic subtest: default
[169.026863] Dynamic subtest default: SUCCESS (0.007s)
[169.039483] Starting dynamic subtest: render
[169.041695] Dynamic subtest render: SUCCESS (0.003s)
[169.051749] Starting dynamic subtest: bsd
[169.054106] Dynamic subtest bsd: SUCCESS (0.004s)
[169.064220] Starting dynamic subtest: bsd1
[169.066286] Dynamic subtest bsd1: SUCCESS (0.004s)
[169.076098] Starting dynamic subtest: bsd2
[169.078178] Dynamic subtest bsd2: SUCCESS (0.003s)
[169.087461] Starting dynamic subtest: blt
[169.089607] Dynamic subtest blt: SUCCESS (0.003s)
[169.098778] Starting dynamic subtest: vebox
[169.100894] Dynamic subtest vebox: SUCCESS (0.004s)
[169.102996] Subtest legacy-resubmit-new: SUCCESS (0.031s)
[171.003960] [025/133] (855s left) gem_exec_await (wide-all)
[171.204609] Starting subtest: wide-all
[194.706570] Subtest wide-all: SUCCESS (23.493s)
[194.903047] [026/133] (831s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[195.056566] Starting subtest: pixel-format-linear-modifier-source-clamping
[195.084060] Starting dynamic subtest: pipe-A-plane-0
[195.671153] Dynamic subtest pipe-A-plane-0: SUCCESS (0.589s)
[195.681816] Starting dynamic subtest: pipe-A-plane-3
[196.115388] Dynamic subtest pipe-A-plane-3: SUCCESS (0.443s)
[197.256288] Starting dynamic subtest: pipe-B-plane-0
[197.835322] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[197.845698] Starting dynamic subtest: pipe-B-plane-3
[198.268789] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[198.590501] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.533s)
[199.442823] [027/133] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[199.544382] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[199.548944] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[199.638561] [028/133] (827s left) kms_psr (fbc-psr-primary-page-flip)
[199.732618] Starting subtest: fbc-psr-primary-page-flip
[199.734960] Starting dynamic subtest: eDP-1
[199.739286] Dynamic subtest eDP-1: SKIP (0.000s)
[199.743751] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[199.811061] [029/133] (826s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[199.914557] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[199.916852] Starting dynamic subtest: pipe-A-eDP-1
[199.926087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[199.938290] Starting dynamic subtest: pipe-B-eDP-1
[199.947822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[199.959398] Starting dynamic subtest: pipe-C-eDP-1
[199.967831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[199.977371] Starting dynamic subtest: pipe-D-eDP-1
[199.985829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[199.989870] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[202.214485] [030/133] (824s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[202.315430] Starting subtest: plane-lut1d-pre-ctm3x4
[202.483419] Starting dynamic subtest: pipe-A-plane-0
[202.661560] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[202.673125] Starting dynamic subtest: pipe-A-plane-1
[202.850078] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[202.860569] Starting dynamic subtest: pipe-A-plane-2
[203.005828] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[204.211797] Starting dynamic subtest: pipe-B-plane-0
[204.369941] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[204.381295] Starting dynamic subtest: pipe-B-plane-1
[204.525284] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[204.536271] Starting dynamic subtest: pipe-B-plane-2
[204.680883] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[205.932253] Starting dynamic subtest: pipe-C-plane-0
[206.076862] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[206.090174] Starting dynamic subtest: pipe-C-plane-1
[206.231791] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[206.243390] Starting dynamic subtest: pipe-C-plane-2
[206.398838] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[207.561588] Starting dynamic subtest: pipe-D-plane-0
[207.698770] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[207.709608] Starting dynamic subtest: pipe-D-plane-1
[207.852829] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[207.864390] Starting dynamic subtest: pipe-D-plane-2
[208.019741] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[208.310574] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.994s)
[209.141389] [031/133] (817s left) gem_madvise (dontneed-before-mmap)
[209.176931] Starting subtest: dontneed-before-mmap
[209.200625] Subtest dontneed-before-mmap: SUCCESS (0.025s)
[209.320411] [032/133] (817s left) syncobj_wait (reset-signaled)
[209.385185] Starting subtest: reset-signaled
[209.387473] Subtest reset-signaled: SUCCESS (0.000s)
[209.476851] [033/133] (817s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[209.603941] Starting subtest: cursorA-vs-flipA-atomic-transitions
[220.812028] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.205s)
[221.679921] [034/133] (805s left) gem_softpin (noreloc-s3)
[221.742574] Starting subtest: noreloc-S3
[241.803104] Subtest noreloc-S3: SUCCESS (5.422s)
[249.933555] [035/133] (785s left) gem_tiling_max_stride
[250.062428] [036/133] (784s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[250.164392] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[250.788601] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[250.979741] [037/133] (784s left) kms_psr (pr-sprite-plane-move)
[251.073230] Starting subtest: pr-sprite-plane-move
[251.077297] Subtest pr-sprite-plane-move: SKIP (0.000s)
[251.145829] [038/133] (783s left) kms_cursor_crc (cursor-sliding-512x512)
[251.425324] Starting subtest: cursor-sliding-512x512
[251.429688] Subtest cursor-sliding-512x512: SKIP (0.001s)
[251.603498] [039/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[251.702747] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[251.706261] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[251.800156] [040/133] (783s left) gem_lmem_swapping (parallel-random-verify-ccs)
[251.843585] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[251.888140] [041/133] (783s left) gem_exec_reloc (basic-write-cpu)
[251.941307] Subtest basic-write-cpu: SKIP (0.000s)
[252.017578] [042/133] (783s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[252.406151] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[253.271745] [043/133] (782s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[253.389510] Starting subtest: 2x-cursor-vs-flip-legacy
[253.393920] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[253.534033] [044/133] (781s left) kms_addfb_basic (size-max)
[253.627558] Starting subtest: size-max
[253.629422] Subtest size-max: SUCCESS (0.000s)
[253.721183] [045/133] (781s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[253.836095] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[253.884229] [046/133] (781s left) syncobj_timeline (invalid-wait-illegal-handle)
[253.944973] Starting subtest: invalid-wait-illegal-handle
[253.947319] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[254.047578] [047/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[254.141603] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[254.145694] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[254.242991] [048/133] (781s left) gem_mmap_gtt (pf-nonblock)
[254.295069] Subtest pf-nonblock: SKIP (0.000s)
[254.354075] [049/133] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[254.444950] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[254.448317] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[254.530257] [050/133] (781s left) gem_render_copy_redux (interruptible)
[254.587077] Starting subtest: interruptible
[254.866110] Subtest interruptible: SUCCESS (0.279s)
[254.992248] [051/133] (780s left) syncobj_timeline (wait-for-submit-delayed-submit)
[255.046517] Starting subtest: wait-for-submit-delayed-submit
[255.151729] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[255.231457] [052/133] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[255.323048] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[255.330596] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[255.423716] [053/133] (780s left) sw_sync (sync_merge_invalid)
[255.460093] Starting subtest: sync_merge_invalid
[255.479486] Subtest sync_merge_invalid: SUCCESS (0.021s)
[255.564438] [054/133] (780s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[255.623701] Starting subtest: yf-tiled-to-vebox-x-tiled
[255.628228] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[255.810919] [055/133] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[255.907506] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[255.911609] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[256.007811] [056/133] (779s left) gem_exec_whisper (basic-fds-forked)
[256.073295] Starting subtest: basic-fds-forked
[280.545330] Subtest basic-fds-forked: SUCCESS (24.393s)
[280.734543] [057/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[280.832687] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[280.836597] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.928327] [058/133] (755s left) syncobj_wait (wait-all-complex)
[280.984756] Starting subtest: wait-all-complex
[281.197439] Subtest wait-all-complex: SUCCESS (0.212s)
[281.275753] [059/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[281.365690] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[287.992065] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.623s)
[288.125032] [060/133] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[288.236416] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[288.894301] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[289.075844] [061/133] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[289.180447] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[296.778225] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.598s)
[297.932028] [062/133] (738s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[298.031305] Starting subtest: fbc-2p-pri-indfb-multidraw
[298.035449] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[298.133754] [063/133] (738s left) fbdev (write)
[298.180684] Starting subtest: write
[298.620611] Subtest write: SUCCESS (0.438s)
[298.688291] [064/133] (737s left) kms_content_protection (uevent)
[298.833846] Starting subtest: uevent
[298.838303] Subtest uevent: SKIP (0.000s)
[298.967517] [065/133] (737s left) gem_sync (basic-store-all)
[299.029372] Starting subtest: basic-store-all
[301.285674] Subtest basic-store-all: SUCCESS (2.266s)
[301.472097] [066/133] (734s left) gem_ctx_engines (invalid-engines)
[301.548727] Starting subtest: invalid-engines
[301.558779] Subtest invalid-engines: SUCCESS (0.013s)
[301.789957] [067/133] (734s left) kms_flip (dpms-off-confusion)
[301.898165] Starting subtest: dpms-off-confusion
[301.900554] Starting dynamic subtest: A-eDP1
[310.618379] Dynamic subtest A-eDP1: SUCCESS (8.720s)
[310.634317] Starting dynamic subtest: B-eDP1
[319.274760] Dynamic subtest B-eDP1: SUCCESS (8.661s)
[319.287082] Starting dynamic subtest: C-eDP1
[328.007878] Dynamic subtest C-eDP1: SUCCESS (8.734s)
[328.022168] Starting dynamic subtest: D-eDP1
[336.639868] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[336.642130] Subtest dpms-off-confusion: SUCCESS (34.753s)
[337.801074] [068/133] (698s left) kms_plane_cursor (viewport)
[337.893181] Starting subtest: viewport
[337.897358] Starting dynamic subtest: pipe-A-eDP-1-size-64
[340.512215] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.620s)
[340.578381] Starting dynamic subtest: pipe-A-eDP-1-size-128
[343.169668] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.605s)
[343.232502] Starting dynamic subtest: pipe-A-eDP-1-size-256
[345.805523] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[346.166387] Starting dynamic subtest: pipe-B-eDP-1-size-64
[349.513641] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.360s)
[349.577037] Starting dynamic subtest: pipe-B-eDP-1-size-128
[352.205193] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.638s)
[352.266376] Starting dynamic subtest: pipe-B-eDP-1-size-256
[354.840277] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[355.190728] Starting dynamic subtest: pipe-C-eDP-1-size-64
[358.058082] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.876s)
[358.098783] Starting dynamic subtest: pipe-C-eDP-1-size-128
[360.291643] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[360.332063] Starting dynamic subtest: pipe-C-eDP-1-size-256
[362.525340] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[362.854497] Starting dynamic subtest: pipe-D-eDP-1-size-64
[365.804635] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.962s)
[365.848839] Starting dynamic subtest: pipe-D-eDP-1-size-128
[368.117350] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.282s)
[368.157503] Starting dynamic subtest: pipe-D-eDP-1-size-256
[370.361482] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[370.682059] Subtest viewport: SUCCESS (32.780s)
[371.549619] [069/133] (664s left) gem_pread (exhaustion)
[371.614240] Subtest exhaustion: SKIP (0.000s)
[371.681255] [070/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[371.772682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[378.419654] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.652s)
[378.569714] [071/133] (657s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[378.979683] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[379.793389] [072/133] (656s left) gem_ctx_sseu (invalid-args)
[379.860321] Subtest invalid-args: SKIP (0.000s)
[379.938007] [073/133] (656s left) perf (invalid-remove-userspace-config)
[380.073822] Starting subtest: invalid-remove-userspace-config
[380.080062] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[380.126830] [074/133] (656s left) gem_exec_balancer (parallel-keep-in-fence)
[380.388663] Starting subtest: parallel-keep-in-fence
[381.628460] Subtest parallel-keep-in-fence: SUCCESS (1.240s)
[381.727057] [075/133] (654s left) gem_lmem_swapping (parallel-random-engines)
[381.767171] Subtest parallel-random-engines: SKIP (0.000s)
[381.812898] [076/133] (654s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[381.914117] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[381.916376] Starting dynamic subtest: pipe-A-eDP-1
[381.937052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[381.949489] Starting dynamic subtest: pipe-B-eDP-1
[381.968765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[381.981096] Starting dynamic subtest: pipe-C-eDP-1
[382.000534] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[382.011269] Starting dynamic subtest: pipe-D-eDP-1
[382.030660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[382.032859] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[384.184410] [077/133] (652s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[384.287319] Starting subtest: async-flip-with-page-flip-events-linear
[384.660577] Starting dynamic subtest: pipe-A-eDP-1
[387.446107] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s)
[387.815524] Starting dynamic subtest: pipe-B-eDP-1
[390.575383] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[390.945056] Starting dynamic subtest: pipe-C-eDP-1
[393.704805] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[394.080998] Starting dynamic subtest: pipe-D-eDP-1
[396.847834] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[396.850506] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.563s)
[398.050905] [078/133] (638s left) syncobj_eventfd (timeline-wait-before-signal)
[398.104472] Starting subtest: timeline-wait-before-signal
[398.134990] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[398.225437] [079/133] (638s left) gem_exec_schedule (preempt-other-chain)
[398.301426] Starting subtest: preempt-other-chain
[398.303513] Starting dynamic subtest: rcs0
[398.377996] Dynamic subtest rcs0: SUCCESS (0.084s)
[398.389273] Starting dynamic subtest: bcs0
[398.459935] Dynamic subtest bcs0: SUCCESS (0.079s)
[398.477717] Starting dynamic subtest: vcs0
[398.536910] Dynamic subtest vcs0: SUCCESS (0.076s)
[398.554119] Starting dynamic subtest: vcs1
[398.616378] Dynamic subtest vcs1: SUCCESS (0.079s)
[398.629179] Starting dynamic subtest: vecs0
[398.697130] Dynamic subtest vecs0: SUCCESS (0.080s)
[398.709985] Starting dynamic subtest: ccs0
[398.774459] Dynamic subtest ccs0: SUCCESS (0.076s)
[398.776851] Subtest preempt-other-chain: SUCCESS (0.481s)
[399.702193] [080/133] (637s left) gem_userptr_blits (sync-overlap)
[399.764909] Starting subtest: sync-overlap
[399.767307] Subtest sync-overlap: SUCCESS (0.000s)
[399.888226] [081/133] (637s left) prime_vgem (fence-write-hang)
[399.961070] Subtest fence-write-hang: SKIP (0.000s)
[400.068970] [082/133] (636s left) kms_atomic_transition (modeset-transition)
[400.169804] Starting subtest: modeset-transition
[400.171938] Starting dynamic subtest: 1x-outputs
[411.001193] Dynamic subtest 1x-outputs: SUCCESS (10.832s)
[411.003820] Subtest modeset-transition: SUCCESS (10.833s)
[411.871570] [083/133] (625s left) perf_pmu (busy-double-start)
[411.913491] Starting subtest: busy-double-start
[411.915378] Starting dynamic subtest: rcs0
[415.553808] Dynamic subtest rcs0: FAIL (3.586s)
[415.565819] Starting dynamic subtest: bcs0
[419.070633] Dynamic subtest bcs0: SUCCESS (3.570s)
[419.082863] Starting dynamic subtest: vcs0
[423.193104] Dynamic subtest vcs0: SUCCESS (4.119s)
[423.206496] Starting dynamic subtest: vcs1
[427.162683] Dynamic subtest vcs1: SUCCESS (3.967s)
[427.179410] Starting dynamic subtest: vecs0
[431.188944] Dynamic subtest vecs0: SUCCESS (4.023s)
[431.202927] Starting dynamic subtest: ccs0
[434.825616] Dynamic subtest ccs0: FAIL (3.565s)
[434.827596] Subtest busy-double-start: FAIL (22.842s)
[434.872132] [084/133] (602s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[434.985179] Starting subtest: pr-cursor-plane-update-sf
[434.989204] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[435.057014] [085/133] (602s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[435.158144] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[442.063566] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.908s)
[442.207330] [086/133] (594s left) kms_chamelium_color (ctm-max)
[442.305793] Subtest ctm-max: SKIP (0.000s)
[442.355194] [087/133] (594s left) kms_psr (psr-cursor-mmap-cpu)
[442.439974] Starting subtest: psr-cursor-mmap-cpu
[442.442264] Starting dynamic subtest: eDP-1
[444.174247] Dynamic subtest eDP-1: SUCCESS (1.733s)
[444.176560] Subtest psr-cursor-mmap-cpu: SUCCESS (1.734s)
[445.055127] [088/133] (592s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[445.154735] Starting subtest: x-tiled-32bpp-rotate-90
[445.174515] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[445.289570] [089/133] (592s left) kms_vblank (ts-continuation-dpms-suspend)
[445.392445] Starting subtest: ts-continuation-dpms-suspend
[445.394641] Starting dynamic subtest: pipe-A-eDP-1
[462.644741] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.272s)
[462.662178] Starting dynamic subtest: pipe-D-eDP-1
[480.628620] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s)
[480.631314] Subtest ts-continuation-dpms-suspend: SUCCESS (5.127s)
[486.454097] [090/133] (555s left) gem_userptr_blits (dmabuf-unsync)
[486.526876] Subtest dmabuf-unsync: SKIP (0.000s)
[486.636656] [091/133] (555s left) gem_exec_schedule (submit-golden-slice)
[486.710832] Starting subtest: submit-golden-slice
[486.713043] Starting dynamic subtest: rcs0
[486.762412] Dynamic subtest rcs0: SUCCESS (0.061s)
[486.775952] Starting dynamic subtest: bcs0
[486.815508] Dynamic subtest bcs0: SUCCESS (0.051s)
[486.827210] Starting dynamic subtest: vcs0
[486.880103] Dynamic subtest vcs0: SUCCESS (0.063s)
[486.891938] Starting dynamic subtest: vcs1
[486.943677] Dynamic subtest vcs1: SUCCESS (0.062s)
[486.955768] Starting dynamic subtest: vecs0
[486.996221] Dynamic subtest vecs0: SUCCESS (0.051s)
[487.009193] Starting dynamic subtest: ccs0
[487.042744] Dynamic subtest ccs0: SUCCESS (0.045s)
[487.045683] Subtest submit-golden-slice: SUCCESS (0.339s)
[488.861622] [092/133] (553s left) kms_flip (wf_vblank-ts-check)
[488.966037] Starting subtest: wf_vblank-ts-check
[488.968719] Starting dynamic subtest: A-eDP1
[497.954643] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[497.966997] Starting dynamic subtest: B-eDP1
[506.911777] Dynamic subtest B-eDP1: SUCCESS (8.939s)
[506.925799] Starting dynamic subtest: C-eDP1
[515.842196] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[515.854153] Starting dynamic subtest: D-eDP1
[524.778541] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[524.781117] Subtest wf_vblank-ts-check: SUCCESS (35.748s)
[526.001404] [093/133] (516s left) gem_softpin (evict-snoop-interruptible)
[526.077278] Starting subtest: evict-snoop-interruptible
[526.082532] Subtest evict-snoop-interruptible: SKIP (0.000s)
[526.158578] [094/133] (516s left) kms_plane_alpha_blend (constant-alpha-min)
[526.254869] Starting subtest: constant-alpha-min
[526.537661] Starting dynamic subtest: pipe-A-eDP-1
[527.238107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[527.250057] Starting dynamic subtest: pipe-D-eDP-1
[528.672562] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s)
[528.674869] Subtest constant-alpha-min: SUCCESS (2.420s)
[529.563955] [095/133] (513s left) kms_big_fb (linear-64bpp-rotate-0)
[529.668130] Starting subtest: linear-64bpp-rotate-0
[531.314818] Subtest linear-64bpp-rotate-0: SUCCESS (1.646s)
[531.483001] [096/133] (511s left) kms_draw_crc (draw-method-mmap-gtt)
[531.593813] Starting subtest: draw-method-mmap-gtt
[531.598430] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[531.697778] [097/133] (511s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[531.794722] Starting subtest: yf-tiled-64bpp-rotate-270
[531.799068] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[531.906690] [098/133] (510s left) kms_pm_rpm (pc8-residency)
[533.833004] Starting subtest: pc8-residency
[533.838988] Subtest pc8-residency: SKIP (0.000s)
[534.221445] [099/133] (508s left) i915_pm_rps (reset)
[534.280109] Starting subtest: reset
[542.731757] Subtest reset: SUCCESS (8.449s)
[542.844357] [100/133] (500s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[542.941921] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[542.946933] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[543.040748] [101/133] (499s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[544.870397] Starting subtest: dpms-mode-unset-lpsp
[548.942882] Subtest dpms-mode-unset-lpsp: SUCCESS (4.075s)
[549.322637] [102/133] (493s left) gen7_exec_parse (batch-without-end)
[549.377461] Subtest batch-without-end: SKIP (0.000s)
[549.449958] [103/133] (493s left) kms_busy (basic)
[549.552848] Starting subtest: basic
[549.555134] Starting dynamic subtest: flip
[550.145576] Dynamic subtest flip: SUCCESS (0.591s)
[550.158143] Starting dynamic subtest: modeset
[553.797451] Dynamic subtest modeset: SUCCESS (3.650s)
[553.800557] Subtest basic: SUCCESS (4.243s)
[554.600912] [104/133] (488s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[554.699843] Starting subtest: psr-1p-primscrn-cur-indfb-move
[562.107067] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.409s)
[562.246408] [105/133] (480s left) sw_sync (sync_multi_consumer_producer)
[562.283981] Starting subtest: sync_multi_consumer_producer
[562.730508] Subtest sync_multi_consumer_producer: SUCCESS (0.447s)
[562.808888] [106/133] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[562.913135] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[570.324708] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.412s)
[570.464210] [107/133] (472s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[570.553354] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[570.557589] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[570.649588] [108/133] (472s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[570.701025] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[570.703960] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[570.809834] [109/133] (472s left) perf_pmu (busy-idle)
[570.848451] Starting subtest: busy-idle
[570.851130] Starting dynamic subtest: rcs0
[571.532297] Dynamic subtest rcs0: SUCCESS (0.683s)
[571.548988] Starting dynamic subtest: bcs0
[572.193157] Dynamic subtest bcs0: SUCCESS (0.658s)
[572.208596] Starting dynamic subtest: vcs0
[573.727606] Dynamic subtest vcs0: SUCCESS (1.530s)
[573.742743] Starting dynamic subtest: vcs1
[575.713770] Dynamic subtest vcs1: SUCCESS (1.982s)
[575.728991] Starting dynamic subtest: vecs0
[577.760286] Dynamic subtest vecs0: SUCCESS (2.043s)
[577.776397] Starting dynamic subtest: ccs0
[578.426628] Dynamic subtest ccs0: SUCCESS (0.664s)
[578.429802] Subtest busy-idle: SUCCESS (7.577s)
[578.531155] [110/133] (464s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[578.625818] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[578.628327] Starting dynamic subtest: pipe-A-eDP-1
[578.693442] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[578.705752] Starting dynamic subtest: pipe-B-eDP-1
[578.773922] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[578.787629] Starting dynamic subtest: pipe-C-eDP-1
[578.854530] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[578.867107] Starting dynamic subtest: pipe-D-eDP-1
[578.933389] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[578.938508] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[580.938570] [111/133] (462s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[581.034915] Starting subtest: fbcpsr-rgb565-draw-blt
[588.170828] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.142s)
[588.300229] [112/133] (455s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[588.392286] Starting subtest: flip-primary-invalidate-overlay
[600.123613] Subtest flip-primary-invalidate-overlay: SUCCESS (11.737s)
[600.284222] [113/133] (443s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[600.345883] Starting subtest: x-tiled-to-vebox-y-tiled
[600.350808] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[600.533758] [114/133] (442s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[600.653874] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[600.658990] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[600.799189] [115/133] (442s left) kms_invalid_mode (uint-max-clock)
[600.899828] Starting subtest: uint-max-clock
[600.902511] Starting dynamic subtest: pipe-A-eDP-1
[601.189928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[601.202956] Starting dynamic subtest: pipe-B-eDP-1
[601.205791] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[601.217940] Starting dynamic subtest: pipe-C-eDP-1
[601.220253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.231409] Starting dynamic subtest: pipe-D-eDP-1
[601.233657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.235971] Subtest uint-max-clock: SUCCESS (0.302s)
[602.003347] [116/133] (441s left) gem_ctx_isolation (clean)
[602.056917] Starting subtest: clean
[602.059731] Starting dynamic subtest: rcs0
[602.104016] Dynamic subtest rcs0: SUCCESS (0.047s)
[602.117118] Starting dynamic subtest: bcs0
[602.181957] Dynamic subtest bcs0: SUCCESS (0.077s)
[602.194874] Starting dynamic subtest: vcs0
[602.235677] Dynamic subtest vcs0: SUCCESS (0.052s)
[602.248773] Starting dynamic subtest: vcs1
[603.740319] Dynamic subtest vcs1: SUCCESS (1.503s)
[603.753156] Starting dynamic subtest: vecs0
[605.729587] Dynamic subtest vecs0: SUCCESS (1.988s)
[605.744176] Starting dynamic subtest: ccs0
[607.735628] Dynamic subtest ccs0: SUCCESS (2.006s)
[607.738458] Subtest clean: SUCCESS (5.680s)
[607.966033] [117/133] (435s left) gem_wait (busy)
[608.034587] Starting subtest: busy
[608.037063] Starting dynamic subtest: all-engines
[609.759649] Dynamic subtest all-engines: SUCCESS (1.723s)
[609.773023] Starting dynamic subtest: rcs0
[610.303120] Dynamic subtest rcs0: SUCCESS (0.542s)
[610.318873] Starting dynamic subtest: bcs0
[610.845410] Dynamic subtest bcs0: SUCCESS (0.541s)
[610.859776] Starting dynamic subtest: vcs0
[612.704127] Dynamic subtest vcs0: SUCCESS (1.856s)
[612.717853] Starting dynamic subtest: vcs1
[614.751530] Dynamic subtest vcs1: SUCCESS (2.045s)
[614.766245] Starting dynamic subtest: vecs0
[616.736472] Dynamic subtest vecs0: SUCCESS (1.983s)
[616.750151] Starting dynamic subtest: ccs0
[617.279125] Dynamic subtest ccs0: SUCCESS (0.541s)
[617.282126] Subtest busy: SUCCESS (9.245s)
[617.477312] [118/133] (426s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[617.579889] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[622.008737] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.433s)
[623.191486] [119/133] (420s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[623.287118] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[630.340979] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.057s)
[630.480463] [120/133] (413s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[630.581258] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[630.586641] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[630.660259] [121/133] (413s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[630.947840] Starting subtest: cursor-rapid-movement-512x512
[630.953310] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[631.110988] [122/133] (412s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[631.204780] Starting subtest: psr-rgb565-draw-render
[638.250030] Subtest psr-rgb565-draw-render: SUCCESS (7.050s)
[638.365223] [123/133] (405s left) gem_ctx_shared (detached-shared-gtt)
[638.430456] Starting subtest: detached-shared-gtt
[640.582716] Subtest detached-shared-gtt: SUCCESS (2.151s)
[640.904658] [124/133] (403s left) perf (polling-parameterized)
[641.001212] Starting subtest: polling-parameterized
[661.020785] Subtest polling-parameterized: SUCCESS (20.017s)
[661.074961] [125/133] (382s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[661.125063] Starting subtest: invalid-multi-wait-all-unsubmitted
[661.128030] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[661.219071] [126/133] (382s left) i915_hangman (engine-error-state-capture)
[661.275919] Starting subtest: engine-error-state-capture
[661.278311] Starting dynamic subtest: rcs0
[664.703668] Dynamic subtest rcs0: SUCCESS (3.425s)
[664.719579] Starting dynamic subtest: bcs0
[670.719752] Dynamic subtest bcs0: SUCCESS (6.013s)
[670.735456] Starting dynamic subtest: vcs0
[676.734937] Dynamic subtest vcs0: SUCCESS (6.011s)
[676.753813] Starting dynamic subtest: vcs1
[682.687685] Dynamic subtest vcs1: SUCCESS (5.949s)
[682.703526] Starting dynamic subtest: vecs0
[688.702420] Dynamic subtest vecs0: SUCCESS (6.011s)
[688.717488] Starting dynamic subtest: ccs0
[694.718533] Dynamic subtest ccs0: SUCCESS (6.013s)
[694.721936] Subtest engine-error-state-capture: SUCCESS (33.437s)
[694.841266] [127/133] (349s left) gem_exec_balancer (nop)
[694.897361] Starting subtest: nop
[741.733597] Subtest nop: SUCCESS (46.825s)
[742.036970] [128/133] (302s left) kms_psr (fbc-pr-primary-page-flip)
[742.136143] Starting subtest: fbc-pr-primary-page-flip
[742.141158] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[742.220076] [129/133] (301s left) prime_mmap (test_map_unmap)
[742.275851] Starting subtest: test_map_unmap
[742.278667] Starting dynamic subtest: test_map_unmap-smem
[742.305596] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[742.308439] Subtest test_map_unmap: SUCCESS (0.033s)
[742.422929] [130/133] (301s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[742.517988] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[742.522970] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[742.589477] [131/133] (301s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[742.688440] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[742.699741] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[742.780231] [132/133] (301s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[742.874169] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[742.878954] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[742.962078] [133/133] (301s left) i915_selftest (live)
[744.763259] Starting subtest: live
[744.765998] Starting dynamic subtest: sanitycheck
[750.062569] Dynamic subtest sanitycheck: SUCCESS (5.300s)
[750.077881] Starting dynamic subtest: uncore
[753.701063] Dynamic subtest uncore: SUCCESS (3.636s)
[753.714004] Starting dynamic subtest: workarounds
[757.789726] Dynamic subtest workarounds: SUCCESS (4.086s)
[757.801502] Starting dynamic subtest: gt_engines
[761.939424] Dynamic subtest gt_engines: SUCCESS (4.147s)
[761.951137] Starting dynamic subtest: gt_timelines
[778.589123] Dynamic subtest gt_timelines: SUCCESS (16.643s)
[778.600052] Starting dynamic subtest: gt_contexts
[782.284379] Dynamic subtest gt_contexts: SUCCESS (3.693s)
[782.295931] Starting dynamic subtest: gt_lrc
[787.535052] Dynamic subtest gt_lrc: SUCCESS (5.247s)
[787.544920] Starting dynamic subtest: gt_mocs
[791.428727] Dynamic subtest gt_mocs: SUCCESS (3.890s)
[791.440452] Starting dynamic subtest: gt_pm
[797.183480] Dynamic subtest gt_pm: SUCCESS (5.750s)
[797.194826] Starting dynamic subtest: gt_heartbeat
[800.860445] Dynamic subtest gt_heartbeat: SUCCESS (3.675s)
[800.871967] Starting dynamic subtest: gt_tlb
[811.171129] Dynamic subtest gt_tlb: SUCCESS (10.306s)
[811.184850] Starting dynamic subtest: requests
[823.722638] Dynamic subtest requests: SUCCESS (12.547s)
[823.739866] Starting dynamic subtest: migrate
[830.396516] Dynamic subtest migrate: SUCCESS (6.670s)
[830.412694] Starting dynamic subtest: active
[835.678455] Dynamic subtest active: SUCCESS (5.278s)
[835.690439] Starting dynamic subtest: objects
[841.428302] Dynamic subtest objects: SUCCESS (5.747s)
[841.439864] Starting dynamic subtest: mman
[845.727203] Dynamic subtest mman: SUCCESS (4.295s)
[845.738256] Starting dynamic subtest: dmabuf
[850.986783] Dynamic subtest dmabuf: SUCCESS (5.256s)
[850.998694] Starting dynamic subtest: vma
[854.612146] Dynamic subtest vma: SUCCESS (3.623s)
[854.629913] Starting dynamic subtest: coherency
[859.023959] Dynamic subtest coherency: SUCCESS (4.409s)
[859.034974] Starting dynamic subtest: gtt
[869.837052] Dynamic subtest gtt: SUCCESS (10.810s)
[869.849281] Starting dynamic subtest: gem
[876.429243] Dynamic subtest gem: SUCCESS (6.596s)
[876.441872] Starting dynamic subtest: evict
[882.919948] Dynamic subtest evict: SUCCESS (6.494s)
[882.940112] Starting dynamic subtest: hugepages
[894.550623] Dynamic subtest hugepages: SUCCESS (11.635s)
[894.562948] Starting dynamic subtest: gem_contexts
[922.608772] Dynamic subtest gem_contexts: SUCCESS (28.065s)
[922.623299] Starting dynamic subtest: client
[926.303763] Dynamic subtest client: SUCCESS (3.695s)
[926.315722] Starting dynamic subtest: gem_migrate
[929.977800] Dynamic subtest gem_migrate: SUCCESS (3.673s)
[929.988312] Starting dynamic subtest: reset
[935.270270] Dynamic subtest reset: SUCCESS (5.291s)
[935.281339] Starting dynamic subtest: memory_region
[940.515529] Dynamic subtest memory_region: SUCCESS (5.244s)
[940.525963] Starting dynamic subtest: hangcheck
[954.446820] Dynamic subtest hangcheck: SUCCESS (13.930s)
[954.458691] Starting dynamic subtest: execlists
[959.708190] Dynamic subtest execlists: SUCCESS (5.260s)
[959.720444] Starting dynamic subtest: ring_submission
[963.282265] Dynamic subtest ring_submission: SUCCESS (3.574s)
[963.296767] Starting dynamic subtest: perf
[967.028510] Dynamic subtest perf: SUCCESS (3.743s)
[967.038776] Starting dynamic subtest: slpc
[980.095161] Dynamic subtest slpc: SUCCESS (13.065s)
[980.112310] Starting dynamic subtest: guc
[984.968889] Dynamic subtest guc: SUCCESS (4.872s)
[984.979003] Starting dynamic subtest: guc_multi_lrc
[988.586837] Dynamic subtest guc_multi_lrc: SUCCESS (3.616s)
[988.599009] Starting dynamic subtest: guc_hang
[992.948152] Dynamic subtest guc_hang: SUCCESS (4.359s)
[992.960661] Starting dynamic subtest: late_gt_pm
[996.578972] Dynamic subtest late_gt_pm: SUCCESS (3.628s)
[996.581778] Subtest live: SUCCESS (251.815s)
[996.612672] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[996.613475] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[996.613621] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: dumb_buffer
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: gem_exec_gttfill
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_fbcon_fbt
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_dp_link_training
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: gem_exec_await
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_color_pipeline
results: parsing output: 30/ for test: gem_madvise
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: gem_tiling_max_stride
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_tiled_display
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: fbdev
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: gem_sync
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_plane_cursor
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: gem_ctx_sseu
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_exec_balancer
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: syncobj_eventfd
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_draw_crc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_pm_rpm
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: gen7_exec_parse
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr_stress_test
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_ctx_isolation
results: parsing output: 116/ for test: gem_wait
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_shared
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: i915_hangman
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: prime_mmap
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: i915_selftest
Done.