[56.947251] Initializing watchdogs
[56.947294]   /dev/watchdog0
[56.963291] [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]
[56.967421] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.969565] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.972927] [001/133] (960s left) gem_exec_fence (syncobj-timeline-export)
[57.553196] Starting subtest: syncobj-timeline-export
[57.563194] Subtest syncobj-timeline-export: SUCCESS (0.012s)
[59.318060] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[59.321068] [002/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[59.435247] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[59.439584] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[59.541487] [003/133] (958s left) kms_cursor_crc (cursor-random-max-size)
[59.843724] Starting subtest: cursor-random-max-size
[59.850525] Subtest cursor-random-max-size: SKIP (0.000s)
[59.977101] [004/133] (957s left) kms_plane_multiple (2x-tiling-x)
[60.064321] Starting subtest: 2x-tiling-x
[60.068797] Subtest 2x-tiling-x: SKIP (0.000s)
[60.139774] [005/133] (957s left) gem_mmap_offset (bad-flags)
[60.195761] Starting subtest: bad-flags
[60.197723] Subtest bad-flags: SUCCESS (0.000s)
[60.293407] [006/133] (957s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[60.344823] Starting subtest: y-tiled-ccs-to-x-tiled
[60.348815] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[60.539674] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[60.628811] Starting subtest: psr2-overlay-plane-move-continuous-sf
[60.631251] Starting dynamic subtest: pipe-A-eDP-1
[66.661257] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.037s)
[66.670426] Starting dynamic subtest: pipe-B-eDP-1
[73.398280] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.737s)
[73.400556] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.776s)
[74.277442] [008/133] (943s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[74.409577] Starting subtest: cursorA-vs-flipB-varying-size
[74.415678] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[74.564439] [009/133] (943s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[74.659266] Starting subtest: plane-use-after-nonblocking-unbind
[74.661508] Starting dynamic subtest: pipe-A-eDP-1
[74.721222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[75.025757] Starting dynamic subtest: pipe-B-eDP-1
[75.866324] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.849s)
[76.163774] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.503s)
[77.023052] [010/133] (940s left) kms_psr (fbc-pr-primary-mmap-gtt)
[77.122759] Starting subtest: fbc-pr-primary-mmap-gtt
[77.127200] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[77.193195] [011/133] (940s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[77.278830] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[77.281220] Starting dynamic subtest: pipe-A-eDP-1
[77.304295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.313500] Starting dynamic subtest: pipe-B-eDP-1
[77.334881] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.342025] Starting dynamic subtest: pipe-C-eDP-1
[77.363157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.372622] Starting dynamic subtest: pipe-D-eDP-1
[77.394279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.398799] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[79.581682] [012/133] (938s left) gem_exec_params (invalid-ring2)
[79.645202] Starting subtest: invalid-ring2
[79.647590] Subtest invalid-ring2: SUCCESS (0.000s)
[79.739857] [013/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[79.840767] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[79.844829] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[79.948715] [014/133] (938s left) kms_hdr (invalid-hdr)
[80.049284] Starting subtest: invalid-hdr
[82.201935] Starting dynamic subtest: pipe-A-eDP-1
[84.745856] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.544s)
[84.748273] Subtest invalid-hdr: SUCCESS (4.698s)
[84.848363] [015/133] (933s left) kms_atomic (atomic-invalid-params)
[84.948126] Starting subtest: atomic-invalid-params
[84.950462] Starting dynamic subtest: pipe-A-eDP-1
[86.432734] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.485s)
[86.435075] Subtest atomic-invalid-params: SUCCESS (1.486s)
[87.279810] [016/133] (930s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[87.380054] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[87.384410] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[87.478901] [017/133] (930s left) gem_pwrite (basic-exhaustion)
[87.532679] Subtest basic-exhaustion: SKIP (0.000s)
[87.592171] [018/133] (930s left) gem_exec_flush (basic-uc-rw-default)
[87.644703] Starting subtest: basic-uc-rw-default
[93.103468] Subtest basic-uc-rw-default: SUCCESS (5.460s)
[93.293969] [019/133] (924s left) kms_atomic_interruptible (legacy-cursor)
[93.406904] Starting subtest: legacy-cursor
[93.409241] Starting dynamic subtest: pipe-A-eDP-1
[100.803206] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[100.805589] Subtest legacy-cursor: SUCCESS (7.397s)
[101.649196] [020/133] (916s left) kms_flip (flip-vs-suspend-interruptible)
[101.742781] Starting subtest: flip-vs-suspend-interruptible
[101.745095] Starting dynamic subtest: A-eDP1
[247.504887] Dynamic subtest A-eDP1: SUCCESS (11.558s)
[247.507581] Subtest flip-vs-suspend-interruptible: SUCCESS (11.560s)
[247.653850] [021/133] (770s left) gem_pipe_control_store_loop (reused-buffer)
[247.723226] Starting subtest: reused-buffer
[249.879669] Subtest reused-buffer: SUCCESS (2.154s)
[250.006529] [022/133] (768s left) prime_self_import (basic-llseek-size)
[250.056478] Starting subtest: basic-llseek-size
[250.072486] Subtest basic-llseek-size: SUCCESS (0.016s)
[250.176855] [023/133] (768s left) sysfs_timeslice_duration (invalid)
[250.228696] Starting subtest: invalid
[250.231534] Starting dynamic subtest: vecs0
[250.234195] Dynamic subtest vecs0: SUCCESS (0.000s)
[250.243207] Starting dynamic subtest: ccs0
[250.245470] Dynamic subtest ccs0: SUCCESS (0.000s)
[250.253514] Starting dynamic subtest: vcs0
[250.255769] Dynamic subtest vcs0: SUCCESS (0.000s)
[250.264065] Starting dynamic subtest: bcs0
[250.266687] Dynamic subtest bcs0: SUCCESS (0.000s)
[250.275304] Starting dynamic subtest: rcs0
[250.277966] Dynamic subtest rcs0: SUCCESS (0.000s)
[250.286371] Starting dynamic subtest: vcs1
[250.288679] Dynamic subtest vcs1: SUCCESS (0.000s)
[250.291114] Subtest invalid: SUCCESS (0.004s)
[250.329024] [024/133] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[250.418182] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[257.110026] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.692s)
[257.247466] [025/133] (761s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[257.339416] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[261.427420] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.090s)
[262.628025] [026/133] (755s left) gem_exec_whisper (basic-contexts-all)
[262.715699] Starting subtest: basic-contexts-all
[274.468758] Subtest basic-contexts-all: SUCCESS (11.747s)
[274.652101] [027/133] (743s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[274.710514] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[274.713495] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[274.832176] [028/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[274.950487] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[274.955390] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[275.055014] [029/133] (743s left) kms_addfb_basic (bad-pitch-128)
[275.121436] Starting subtest: bad-pitch-128
[275.123655] Subtest bad-pitch-128: SUCCESS (0.000s)
[275.242405] [030/133] (743s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[275.355787] Starting subtest: 2x-cursor-vs-flip-atomic
[275.361090] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[275.502330] [031/133] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[275.598451] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[283.008398] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.412s)
[283.157775] [032/133] (735s left) gem_exec_balancer (bonded-pair)
[283.222944] Starting subtest: bonded-pair
[283.228276] Subtest bonded-pair: SKIP (0.000s)
[283.507922] [033/133] (735s left) gem_close_race (multigpu-basic-process)
[283.585336] Starting subtest: multigpu-basic-process
[283.590517] Subtest multigpu-basic-process: SKIP (0.000s)
[283.800980] [034/133] (735s left) kms_fbcon_fbt (fbc)
[283.858674] Starting subtest: fbc
[290.274153] Subtest fbc: SUCCESS (6.414s)
[291.364128] [035/133] (727s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[291.453036] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[291.455424] Starting dynamic subtest: pipe-A-eDP-1
[291.599091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[291.611424] Starting dynamic subtest: pipe-B-eDP-1
[291.634121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[291.643164] Starting dynamic subtest: pipe-C-eDP-1
[291.666884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[291.675462] Starting dynamic subtest: pipe-D-eDP-1
[291.698534] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[291.700838] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[293.850059] [036/133] (725s left) gen7_exec_parse (bitmasks)
[293.907509] Subtest bitmasks: SKIP (0.000s)
[293.972484] [037/133] (724s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[294.032832] Starting subtest: invalid-single-wait-unsubmitted
[294.035505] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[294.159218] [038/133] (724s left) kms_display_modes (extended-mode-basic)
[294.249331] Starting subtest: extended-mode-basic
[294.254450] Subtest extended-mode-basic: SKIP (0.000s)
[294.298813] [039/133] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[294.388441] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[294.393411] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[294.487618] [040/133] (724s left) gem_exec_schedule (preempt-other)
[294.560340] Starting subtest: preempt-other
[294.563093] Starting dynamic subtest: rcs0
[294.626530] Dynamic subtest rcs0: SUCCESS (0.078s)
[294.636788] Starting dynamic subtest: bcs0
[294.697339] Dynamic subtest bcs0: SUCCESS (0.070s)
[294.708325] Starting dynamic subtest: vcs0
[294.762653] Dynamic subtest vcs0: SUCCESS (0.065s)
[294.774015] Starting dynamic subtest: vcs1
[294.825009] Dynamic subtest vcs1: SUCCESS (0.062s)
[294.838277] Starting dynamic subtest: vecs0
[294.888450] Dynamic subtest vecs0: SUCCESS (0.063s)
[294.902144] Starting dynamic subtest: ccs0
[294.951559] Dynamic subtest ccs0: SUCCESS (0.062s)
[294.954357] Subtest preempt-other: SUCCESS (0.404s)
[296.590497] [041/133] (722s left) dumb_buffer (map-invalid-size)
[296.643670] Starting subtest: map-invalid-size
[296.646454] Subtest map-invalid-size: SUCCESS (0.000s)
[296.727689] [042/133] (722s left) kms_cursor_crc (cursor-sliding-512x170)
[297.007570] Starting subtest: cursor-sliding-512x170
[297.012898] Subtest cursor-sliding-512x170: SKIP (0.001s)
[297.134388] [043/133] (722s left) sw_sync (sync_busy_fork_unixsocket)
[297.169460] Starting subtest: sync_busy_fork_unixsocket
[297.177639] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[297.234513] [044/133] (722s left) perf (non-zero-reason)
[297.354157] Starting subtest: non-zero-reason
[297.356342] Starting dynamic subtest: 0-rcs0
[302.649369] Dynamic subtest 0-rcs0: SUCCESS (5.296s)
[302.662553] Starting dynamic subtest: 1-vcs1
[306.504421] Dynamic subtest 1-vcs1: SUCCESS (3.853s)
[306.507481] Subtest non-zero-reason: SUCCESS (9.151s)
[306.550034] [045/133] (712s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[306.657452] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[306.660257] Starting dynamic subtest: pipe-A-eDP-1
[306.687116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.698531] Starting dynamic subtest: pipe-B-eDP-1
[306.725125] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.735466] Starting dynamic subtest: pipe-C-eDP-1
[306.761526] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.770867] Starting dynamic subtest: pipe-D-eDP-1
[306.796051] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.800400] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[308.861856] [046/133] (710s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[308.969299] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[308.974445] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[309.052867] [047/133] (710s left) gem_render_copy_redux (flink)
[309.118255] Starting subtest: flink
[309.901890] Subtest flink: SUCCESS (0.784s)
[310.018496] [048/133] (709s left) sriov_basic (enable-vfs-bind-unbind-each)
[310.080743] Starting subtest: enable-vfs-bind-unbind-each
[310.083513] Starting dynamic subtest: numvfs-1
[310.158356] Dynamic subtest numvfs-1: FAIL (0.025s)
[310.169565] Starting dynamic subtest: numvfs-2
[310.242693] Dynamic subtest numvfs-2: FAIL (0.004s)
[310.252563] Starting dynamic subtest: numvfs-3
[310.324261] Dynamic subtest numvfs-3: FAIL (0.003s)
[310.333949] Starting dynamic subtest: numvfs-4
[310.405008] Dynamic subtest numvfs-4: FAIL (0.003s)
[310.415290] Starting dynamic subtest: numvfs-5
[310.486298] Dynamic subtest numvfs-5: FAIL (0.004s)
[310.495906] Starting dynamic subtest: numvfs-6
[310.566499] Dynamic subtest numvfs-6: FAIL (0.004s)
[310.576339] Starting dynamic subtest: numvfs-7
[310.649336] Dynamic subtest numvfs-7: FAIL (0.004s)
[310.659385] Starting dynamic subtest: numvfs-random
[310.731046] Dynamic subtest numvfs-random: FAIL (0.003s)
[310.733211] Subtest enable-vfs-bind-unbind-each: FAIL (0.055s)
[310.774066] [049/133] (708s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[310.877151] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[311.702682] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[311.851991] [050/133] (707s left) kms_addfb_basic (bad-pitch-256)
[311.915817] Starting subtest: bad-pitch-256
[311.918383] Subtest bad-pitch-256: SUCCESS (0.000s)
[312.059606] [051/133] (707s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[312.149137] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[312.151222] Starting dynamic subtest: pipe-A-eDP-1
[312.602488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[312.611498] Starting dynamic subtest: pipe-B-eDP-1
[314.117315] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[314.128245] Starting dynamic subtest: pipe-C-eDP-1
[315.455498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[315.466594] Starting dynamic subtest: pipe-D-eDP-1
[316.780482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[316.782974] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.601s)
[317.973508] [052/133] (701s left) gem_userptr_blits (sync-unmap-after-close)
[318.049129] Starting subtest: sync-unmap-after-close
[318.062510] Subtest sync-unmap-after-close: SUCCESS (0.014s)
[318.202141] [053/133] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[318.297637] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[318.302525] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[318.414367] [054/133] (701s left) gem_exec_async (forked-writes)
[318.481410] Starting subtest: forked-writes
[318.483487] Starting dynamic subtest: rcs0
[318.507929] Dynamic subtest rcs0: SUCCESS (0.029s)
[318.518426] Starting dynamic subtest: bcs0
[318.531637] Dynamic subtest bcs0: SUCCESS (0.022s)
[318.541790] Starting dynamic subtest: vcs0
[318.553675] Dynamic subtest vcs0: SUCCESS (0.021s)
[318.565948] Starting dynamic subtest: vcs1
[318.576147] Dynamic subtest vcs1: SUCCESS (0.022s)
[318.586599] Starting dynamic subtest: vecs0
[318.596532] Dynamic subtest vecs0: SUCCESS (0.020s)
[318.606829] Starting dynamic subtest: ccs0
[318.619552] Dynamic subtest ccs0: SUCCESS (0.022s)
[318.622409] Subtest forked-writes: SUCCESS (0.142s)
[318.852904] [055/133] (700s left) gem_userptr_blits (process-exit-busy)
[318.921985] Starting subtest: process-exit-busy
[318.935656] Subtest process-exit-busy: SUCCESS (0.015s)
[319.063049] [056/133] (700s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[319.123425] Subtest no-spare-fences-busy: SKIP (0.000s)
[319.195855] [057/133] (700s left) kms_flip (busy-flip)
[319.298443] Starting subtest: busy-flip
[319.301082] Starting dynamic subtest: A-eDP1
[320.993444] Dynamic subtest A-eDP1: SUCCESS (1.694s)
[321.005188] Starting dynamic subtest: B-eDP1
[322.641345] Dynamic subtest B-eDP1: SUCCESS (1.646s)
[322.653658] Starting dynamic subtest: C-eDP1
[324.271533] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[324.282707] Starting dynamic subtest: D-eDP1
[325.901568] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[325.904489] Subtest busy-flip: SUCCESS (6.607s)
[327.068235] [058/133] (692s left) vgem_basic (sysfs)
[327.119688] Starting subtest: sysfs
[327.122499] Subtest sysfs: SUCCESS (0.000s)
[327.177944] [059/133] (692s left) gem_exec_balancer (parallel-contexts)
[327.438474] Starting subtest: parallel-contexts
[330.129239] Subtest parallel-contexts: SUCCESS (2.690s)
[330.241992] [060/133] (689s left) api_intel_allocator (fork-simple-stress)
[330.306357] Starting subtest: fork-simple-stress
[335.703509] Subtest fork-simple-stress: SUCCESS (5.396s)
[335.819252] [061/133] (684s left) gem_vm_create (execbuf)
[335.886574] Starting subtest: execbuf
[335.902429] Subtest execbuf: SUCCESS (0.016s)
[336.024209] [062/133] (684s left) gem_ctx_isolation (dirty-create)
[336.097292] Starting subtest: dirty-create
[336.099895] Starting dynamic subtest: rcs0
[336.346895] Dynamic subtest rcs0: SUCCESS (0.248s)
[336.359692] Starting dynamic subtest: bcs0
[336.604647] Dynamic subtest bcs0: SUCCESS (0.257s)
[336.617252] Starting dynamic subtest: vcs0
[336.889499] Dynamic subtest vcs0: SUCCESS (0.284s)
[336.901295] Starting dynamic subtest: vcs1
[338.726901] Dynamic subtest vcs1: SUCCESS (1.836s)
[338.736918] Starting dynamic subtest: vecs0
[340.680436] Dynamic subtest vecs0: SUCCESS (1.952s)
[340.691987] Starting dynamic subtest: ccs0
[342.759668] Dynamic subtest ccs0: SUCCESS (2.078s)
[342.762674] Subtest dirty-create: SUCCESS (6.661s)
[342.993463] [063/133] (677s left) api_intel_bb (intel-bb-blit-none)
[343.055231] Starting subtest: intel-bb-blit-none
[346.859371] Subtest intel-bb-blit-none: SUCCESS (3.806s)
[346.985327] [064/133] (673s left) kms_psr (pr-sprite-render)
[347.090480] Starting subtest: pr-sprite-render
[347.095699] Subtest pr-sprite-render: SKIP (0.000s)
[347.168983] [065/133] (673s left) gem_userptr_blits (sync-unmap-cycles)
[347.235405] Starting subtest: sync-unmap-cycles
[352.604662] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[352.725106] [066/133] (667s left) gem_pxp (reject-modify-context-protection-off-3)
[352.854396] Starting subtest: reject-modify-context-protection-off-3
[352.856970] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[352.962033] [067/133] (667s left) gem_render_copy_redux (interruptible)
[353.008078] Starting subtest: interruptible
[353.396198] Subtest interruptible: SUCCESS (0.388s)
[353.525312] [068/133] (666s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[353.622317] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[353.626409] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[353.705489] [069/133] (666s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[353.794872] Starting subtest: fbc-psr2-sprite-mmap-gtt
[353.796678] Starting dynamic subtest: eDP-1
[353.800385] Dynamic subtest eDP-1: SKIP (0.000s)
[353.804358] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[353.870773] [070/133] (666s left) kms_content_protection (dp-mst-type-1)
[354.003139] Starting subtest: dp-mst-type-1
[354.007671] Subtest dp-mst-type-1: SKIP (0.000s)
[354.124426] [071/133] (666s left) gem_workarounds (reset-fd)
[354.184684] Starting subtest: reset-fd
[354.360220] Subtest reset-fd: SUCCESS (0.176s)
[354.481859] [072/133] (665s left) fbdev (write)
[354.531796] Starting subtest: write
[354.889066] Subtest write: SUCCESS (0.355s)
[354.962924] [073/133] (665s left) kms_chamelium_frames (dp-crc-multiple)
[355.340449] Subtest dp-crc-multiple: SKIP (0.000s)
[356.178934] [074/133] (664s left) kms_lease (lease-invalid-crtc)
[356.272312] Starting subtest: lease-invalid-crtc
[356.274909] Starting dynamic subtest: pipe-A-eDP-1
[356.277491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[356.288823] Starting dynamic subtest: pipe-B-eDP-1
[356.291295] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.301679] Starting dynamic subtest: pipe-C-eDP-1
[356.304491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.314568] Starting dynamic subtest: pipe-D-eDP-1
[356.317436] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.320233] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[356.364017] [075/133] (664s left) kms_properties (crtc-properties-atomic)
[356.448162] Starting subtest: crtc-properties-atomic
[356.450663] Starting dynamic subtest: pipe-A-eDP-1
[356.903377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[356.918439] Starting dynamic subtest: pipe-B-eDP-1
[358.047220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[358.059540] Starting dynamic subtest: pipe-C-eDP-1
[359.177669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[359.189660] Starting dynamic subtest: pipe-D-eDP-1
[360.302672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[360.305667] Subtest crtc-properties-atomic: SUCCESS (3.856s)
[361.117278] [076/133] (659s left) kms_chamelium_color (ctm-0-75)
[361.216112] Subtest ctm-0-75: SKIP (0.000s)
[361.264311] [077/133] (659s left) gem_exec_parallel (userptr)
[361.319442] Starting subtest: userptr
[361.322447] Starting dynamic subtest: rcs0
[363.060315] Dynamic subtest rcs0: SUCCESS (1.740s)
[363.071951] Starting dynamic subtest: bcs0
[364.784929] Dynamic subtest bcs0: SUCCESS (1.724s)
[364.795652] Starting dynamic subtest: vcs0
[366.487409] Dynamic subtest vcs0: SUCCESS (1.699s)
[366.498433] Starting dynamic subtest: vcs1
[368.513679] Dynamic subtest vcs1: SUCCESS (2.025s)
[368.526728] Starting dynamic subtest: vecs0
[370.511851] Dynamic subtest vecs0: SUCCESS (1.995s)
[370.526649] Starting dynamic subtest: ccs0
[372.419672] Dynamic subtest ccs0: SUCCESS (1.906s)
[372.422547] Subtest userptr: SUCCESS (11.101s)
[372.609392] [078/133] (648s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[372.727458] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[372.754642] Starting dynamic subtest: pipe-A-plane-0
[373.176430] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[373.191328] Starting dynamic subtest: pipe-A-plane-3
[373.455198] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[373.465416] Starting dynamic subtest: pipe-A-plane-5
[373.471213] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[374.609898] Starting dynamic subtest: pipe-B-plane-0
[375.068664] Dynamic subtest pipe-B-plane-0: SUCCESS (0.467s)
[375.080513] Starting dynamic subtest: pipe-B-plane-3
[375.334159] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[375.351447] Starting dynamic subtest: pipe-B-plane-5
[375.356316] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[375.645181] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.920s)
[376.488209] [079/133] (644s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[376.588714] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[376.593683] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[376.656590] [080/133] (644s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[376.758281] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[377.873672] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.114s)
[377.995175] [081/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[378.086858] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[378.090710] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[378.179069] [082/133] (642s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[378.275301] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[378.280204] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[378.390381] [083/133] (642s left) kms_color (ctm-max)
[378.473442] Starting subtest: ctm-max
[378.475785] Starting dynamic subtest: pipe-A-eDP-1
[379.220002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[379.231597] Starting dynamic subtest: pipe-B-eDP-1
[380.601311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[380.614237] Starting dynamic subtest: pipe-C-eDP-1
[381.977083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[381.988623] Starting dynamic subtest: pipe-D-eDP-1
[383.305266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[383.307914] Subtest ctm-max: SUCCESS (4.833s)
[384.113582] [084/133] (636s left) kms_cursor_crc (cursor-onscreen-128x128)
[384.344274] Starting subtest: cursor-onscreen-128x128
[384.350009] Starting dynamic subtest: pipe-A-eDP-1
[386.458262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[386.488048] Starting dynamic subtest: pipe-D-eDP-1
[389.186535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[389.189428] Subtest cursor-onscreen-128x128: SUCCESS (4.842s)
[389.991181] [085/133] (631s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[390.078119] Starting subtest: multiplane-rotation-cropping-bottom
[407.683346] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.605s)
[407.788764] [086/133] (613s left) gem_exec_params (sol-reset-invalid)
[407.844263] Starting subtest: sol-reset-invalid
[407.849438] Subtest sol-reset-invalid: SUCCESS (0.003s)
[409.547085] [087/133] (611s left) gem_eio (reset-stress)
[409.781410] Starting subtest: reset-stress
[409.784150] Starting dynamic subtest: render
[414.853917] Dynamic subtest render: SUCCESS (5.071s)
[414.867206] Starting dynamic subtest: bsd1
[433.037649] Dynamic subtest bsd1: SUCCESS (18.181s)
[433.056175] Starting dynamic subtest: bsd2
[451.026805] Dynamic subtest bsd2: SUCCESS (17.987s)
[451.044482] Starting dynamic subtest: blt
[451.049407] Dynamic subtest blt: SKIP (0.000s)
[451.059826] Starting dynamic subtest: vebox
[468.998542] Dynamic subtest vebox: SUCCESS (17.968s)
[469.001344] Subtest reset-stress: SUCCESS (59.212s)
[470.507538] [088/133] (550s left) gem_softpin (reverse)
[470.565688] Starting subtest: reverse
[470.570961] Subtest reverse: SUCCESS (0.005s)
[470.686509] [089/133] (550s left) perf_pmu (multi-client)
[470.731716] Starting subtest: multi-client
[470.734650] Starting dynamic subtest: rcs0
[471.785282] Dynamic subtest rcs0: SUCCESS (1.055s)
[471.798376] Starting dynamic subtest: bcs0
[472.842161] Dynamic subtest bcs0: SUCCESS (1.053s)
[472.854658] Starting dynamic subtest: vcs0
[473.895980] Dynamic subtest vcs0: SUCCESS (1.052s)
[473.907708] Starting dynamic subtest: vcs1
[475.511235] Dynamic subtest vcs1: SUCCESS (1.613s)
[475.522760] Starting dynamic subtest: vecs0
[477.496866] Dynamic subtest vecs0: SUCCESS (1.983s)
[477.509659] Starting dynamic subtest: ccs0
[479.544674] Dynamic subtest ccs0: SUCCESS (2.045s)
[479.547580] Subtest multi-client: SUCCESS (8.818s)
[479.664775] [090/133] (541s left) gem_mmap (bad-object)
[479.729045] Subtest bad-object: SKIP (0.000s)
[479.795627] [091/133] (541s left) i915_drm_fdinfo (memory-info-purgeable)
[479.840312] Starting subtest: memory-info-purgeable
[479.843110] Starting dynamic subtest: smem0
[482.681472] Dynamic subtest smem0: SUCCESS (2.843s)
[482.684299] Subtest memory-info-purgeable: SUCCESS (2.844s)
[482.762754] [092/133] (538s left) gem_tiled_partial_pwrite_pread (writes)
[482.832493] Subtest writes: SKIP (0.000s)
[482.904889] [093/133] (538s left) kms_joiner (basic-force-big-joiner)
[482.998422] Starting subtest: basic-force-big-joiner
[483.002410] Subtest basic-force-big-joiner: SKIP (0.000s)
[483.077800] [094/133] (538s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[483.177191] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[483.181438] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[483.251236] [095/133] (538s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[483.351046] Starting subtest: y-tiled-8bpp-rotate-180
[483.355493] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[483.440060] [096/133] (538s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[483.530225] Starting subtest: psr-rgb565-draw-blt
[490.508569] Subtest psr-rgb565-draw-blt: SUCCESS (6.980s)
[490.632063] [097/133] (530s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[490.722260] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[497.420712] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.700s)
[497.538456] [098/133] (524s left) gen3_render_mixed_blits
[497.662827] [099/133] (523s left) kms_vblank (wait-forked-hang)
[497.755371] Starting subtest: wait-forked-hang
[497.757829] Starting dynamic subtest: pipe-A-eDP-1
[524.295599] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.538s)
[524.314371] Starting dynamic subtest: pipe-D-eDP-1
[539.264951] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[539.267626] Subtest wait-forked-hang: SUCCESS (41.511s)
[540.123742] [100/133] (481s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[540.223490] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[540.225837] Starting dynamic subtest: pipe-A
[540.249404] Dynamic subtest pipe-A: SKIP (0.018s)
[540.261902] Starting dynamic subtest: pipe-B
[540.275110] Dynamic subtest pipe-B: SKIP (0.029s)
[540.285679] Starting dynamic subtest: pipe-C
[540.303472] Dynamic subtest pipe-C: SKIP (0.028s)
[540.314061] Starting dynamic subtest: pipe-D
[540.333400] Dynamic subtest pipe-D: SKIP (0.028s)
[540.337651] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.105s)
[540.429792] [101/133] (481s left) perf_pmu (all-busy-check-all)
[540.473372] Starting subtest: all-busy-check-all
[542.529651] Subtest all-busy-check-all: SUCCESS (2.056s)
[542.637082] [102/133] (479s left) syncobj_timeline (host-signal-points)
[542.696322] Starting subtest: host-signal-points
[542.698516] Subtest host-signal-points: SUCCESS (0.004s)
[542.809491] [103/133] (479s left) kms_fbcon_fbt (fbc-suspend)
[542.866400] Starting subtest: fbc-suspend
[592.775839] Subtest fbc-suspend: SUCCESS (19.158s)
[594.108348] [104/133] (427s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[594.209382] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[601.191339] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.977s)
[601.318542] [105/133] (420s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[601.407770] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[601.412044] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[601.511853] [106/133] (420s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[601.616265] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[601.620877] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[601.713519] [107/133] (420s left) kms_flip (flip-vs-fences-interruptible)
[601.806262] Starting subtest: flip-vs-fences-interruptible
[601.810331] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[601.902479] [108/133] (420s left) kms_plane (plane-position-hole)
[601.989260] Starting subtest: plane-position-hole
[602.541464] Starting dynamic subtest: pipe-A-plane-1
[603.861050] Dynamic subtest pipe-A-plane-1: SUCCESS (1.321s)
[603.871411] Starting dynamic subtest: pipe-A-plane-2
[605.158764] Dynamic subtest pipe-A-plane-2: SUCCESS (1.293s)
[605.170139] Starting dynamic subtest: pipe-A-plane-3
[606.409195] Dynamic subtest pipe-A-plane-3: SUCCESS (1.250s)
[606.420903] Starting dynamic subtest: pipe-A-plane-4
[607.727506] Dynamic subtest pipe-A-plane-4: SUCCESS (1.316s)
[607.738896] Starting dynamic subtest: pipe-A-plane-5
[607.752388] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[608.873975] Starting dynamic subtest: pipe-B-plane-1
[610.130139] Dynamic subtest pipe-B-plane-1: SUCCESS (1.266s)
[610.142357] Starting dynamic subtest: pipe-B-plane-2
[611.438325] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[611.449204] Starting dynamic subtest: pipe-B-plane-3
[612.746591] Dynamic subtest pipe-B-plane-3: SUCCESS (1.307s)
[612.758464] Starting dynamic subtest: pipe-B-plane-4
[613.999578] Dynamic subtest pipe-B-plane-4: SUCCESS (1.250s)
[614.014197] Starting dynamic subtest: pipe-B-plane-5
[614.024526] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[614.026635] Subtest plane-position-hole: SUCCESS (12.028s)
[614.804215] [109/133] (407s left) i915_pm_rpm (gem-evict-pwrite)
[616.344595] Starting subtest: gem-evict-pwrite
[616.349205] Subtest gem-evict-pwrite: SKIP (0.000s)
[617.131708] [110/133] (404s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[617.177631] Starting subtest: etime-multi-wait-all-available-unsubmitted
[617.285747] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[617.376379] [111/133] (404s left) gem_exec_schedule (u-semaphore-resolve)
[617.448594] Starting subtest: u-semaphore-resolve
[617.477122] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[617.835282] [112/133] (404s left) syncobj_timeline (signal-array)
[617.881466] Starting subtest: signal-array
[617.883744] Subtest signal-array: SUCCESS (0.000s)
[617.985017] [113/133] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[618.084530] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[618.088879] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[618.175973] [114/133] (404s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[618.274397] Starting subtest: yf-tiled-16bpp-rotate-0
[618.278638] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[618.373096] [115/133] (403s left) i915_selftest (perf)
[621.675011] Starting subtest: perf
[621.677480] Starting dynamic subtest: engine_cs
[625.960273] Dynamic subtest engine_cs: SUCCESS (4.286s)
[625.968430] Starting dynamic subtest: request
[633.280846] Dynamic subtest request: SUCCESS (7.318s)
[633.293830] Starting dynamic subtest: migrate
[637.627287] Dynamic subtest migrate: SUCCESS (4.343s)
[637.637743] Starting dynamic subtest: region
[641.684765] Dynamic subtest region: SUCCESS (4.055s)
[641.687840] Subtest perf: SUCCESS (20.011s)
[641.713699] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[641.714754] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[641.718502] [116/133] (380s left) kms_panel_fitting (legacy)
[643.291846] Starting subtest: legacy
[643.294224] Starting dynamic subtest: pipe-A-eDP-1
[643.860745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[643.885456] Starting dynamic subtest: pipe-B-eDP-1
[645.482481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.603s)
[645.518612] Starting dynamic subtest: pipe-C-eDP-1
[646.981581] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.479s)
[647.007768] Starting dynamic subtest: pipe-D-eDP-1
[648.535382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[648.537710] Subtest legacy: SUCCESS (5.245s)
[649.936150] [FACT kms_panel_fitting (legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[649.937558] [FACT kms_panel_fitting (legacy)] new: kernel.kmod_is_loaded.i915: true
[649.941874] [117/133] (372s left) gem_ctx_persistence (legacy-engines-mixed)
[650.020014] Starting subtest: legacy-engines-mixed
[650.022224] Starting dynamic subtest: render
[650.109000] Dynamic subtest render: SUCCESS (0.091s)
[650.120561] Starting dynamic subtest: bsd1
[650.153411] Dynamic subtest bsd1: SUCCESS (0.041s)
[650.164129] Starting dynamic subtest: bsd2
[650.197599] Dynamic subtest bsd2: SUCCESS (0.042s)
[650.208647] Starting dynamic subtest: blt
[650.248938] Dynamic subtest blt: SUCCESS (0.049s)
[650.260505] Starting dynamic subtest: vebox
[650.294645] Dynamic subtest vebox: SUCCESS (0.043s)
[650.297243] Subtest legacy-engines-mixed: SUCCESS (0.278s)
[650.373469] [118/133] (372s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[650.471449] Starting subtest: 4-tiled-8bpp-rotate-270
[650.493081] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[650.595689] [119/133] (371s left) kms_busy (extended-modeset-hang-newfb)
[650.693506] Starting subtest: extended-modeset-hang-newfb
[650.695995] Starting dynamic subtest: pipe-A
[686.874461] Dynamic subtest pipe-A: SUCCESS (36.172s)
[686.886274] Starting dynamic subtest: pipe-D
[707.159897] Dynamic subtest pipe-D: SUCCESS (20.286s)
[707.162872] Subtest extended-modeset-hang-newfb: SUCCESS (56.462s)
[707.959374] [120/133] (314s left) kms_mmap_write_crc (main)
[708.053008] Starting subtest: main
[708.055264] Starting dynamic subtest: pipe-A-eDP-1
[711.392920] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.337s)
[711.395170] Subtest main: SUCCESS (3.339s)
[712.201273] [121/133] (310s left) syncobj_wait (multi-wait-submitted-signaled)
[712.258401] Starting subtest: multi-wait-submitted-signaled
[712.260540] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[712.357312] [122/133] (310s left) i915_hangman (engine-engine-error)
[712.436728] Starting subtest: engine-engine-error
[712.438980] Starting dynamic subtest: rcs0
[714.217752] Dynamic subtest rcs0: SUCCESS (1.780s)
[714.233699] Starting dynamic subtest: bcs0
[716.200507] Dynamic subtest bcs0: SUCCESS (1.980s)
[716.213004] Starting dynamic subtest: vcs0
[718.184233] Dynamic subtest vcs0: SUCCESS (1.981s)
[718.199659] Starting dynamic subtest: vcs1
[720.232160] Dynamic subtest vcs1: SUCCESS (2.045s)
[720.244238] Starting dynamic subtest: vecs0
[722.216345] Dynamic subtest vecs0: SUCCESS (1.982s)
[722.230928] Starting dynamic subtest: ccs0
[724.200329] Dynamic subtest ccs0: SUCCESS (1.981s)
[724.203308] Subtest engine-engine-error: SUCCESS (11.765s)
[724.292977] [123/133] (298s left) gem_readwrite (read-bad-handle)
[724.348161] Subtest read-bad-handle: SKIP (0.000s)
[724.431112] [124/133] (298s left) gem_mmap_gtt (fault-concurrent-x)
[724.491463] Subtest fault-concurrent-X: SKIP (0.000s)
[724.563215] [125/133] (298s left) kms_prime (basic-modeset-hybrid)
[724.648644] Subtest basic-modeset-hybrid: SKIP (0.000s)
[724.755055] [126/133] (298s left) gem_lmem_swapping (massive-random)
[724.800149] Subtest massive-random: SKIP (0.000s)
[724.843251] [127/133] (297s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[725.218490] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[726.005725] [128/133] (296s left) kms_pm_backlight (fade-with-suspend)
[726.097999] Starting subtest: fade-with-suspend
[742.505242] Starting dynamic subtest: eDP-1
[745.496395] Dynamic subtest eDP-1: SUCCESS (3.003s)
[745.498813] Subtest fade-with-suspend: SUCCESS (4.236s)
[746.298302] [129/133] (276s left) kms_async_flips (async-flip-suspend-resume)
[746.414382] Starting subtest: async-flip-suspend-resume
[746.786261] Starting dynamic subtest: pipe-A-eDP-1
[764.517176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.003s)
[764.954114] Starting dynamic subtest: pipe-B-eDP-1
[782.495029] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.811s)
[782.882176] Starting dynamic subtest: pipe-C-eDP-1
[800.514373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.886s)
[800.894028] Starting dynamic subtest: pipe-D-eDP-1
[818.515420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[818.518266] Subtest async-flip-suspend-resume: SUCCESS (13.141s)
[819.689349] [130/133] (203s left) kms_sequence (get-idle)
[819.786261] Starting subtest: get-idle
[819.788396] Starting dynamic subtest: pipe-A-eDP-1
[821.600232] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[821.610533] Starting dynamic subtest: pipe-B-eDP-1
[824.056504] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[824.068109] Starting dynamic subtest: pipe-C-eDP-1
[826.498131] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.444s)
[826.515762] Starting dynamic subtest: pipe-D-eDP-1
[828.907390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.409s)
[828.910106] Subtest get-idle: SUCCESS (9.131s)
[829.725998] [131/133] (193s left) kms_psr (psr2-cursor-plane-move)
[829.816714] Starting subtest: psr2-cursor-plane-move
[829.818953] Starting dynamic subtest: eDP-1
[831.486072] Dynamic subtest eDP-1: SUCCESS (1.670s)
[831.488359] Subtest psr2-cursor-plane-move: SUCCESS (1.671s)
[832.282948] [132/133] (190s left) kms_dsc (dsc-with-output-formats-with-bpc)
[832.377839] Starting subtest: dsc-with-output-formats-with-bpc
[832.443880] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[832.484235] [133/133] (190s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[832.541427] Starting subtest: y-tiled-to-vebox-yf-tiled
[832.546717] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[832.726280] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_atomic
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_pipe_control_store_loop
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_close_race
results: parsing output: 33/ for test: kms_fbcon_fbt
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gen7_exec_parse
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_display_modes
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: dumb_buffer
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_render_copy_redux
results: parsing output: 47/ for test: sriov_basic
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_async
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: gem_fenced_exec_thrash
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: gem_vm_create
results: parsing output: 61/ for test: gem_ctx_isolation
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: gem_render_copy_redux
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: fbdev
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_chamelium_color
results: parsing output: 76/ for test: gem_exec_parallel
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_mmap
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gen3_render_mixed_blits
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_fbcon_fbt
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: i915_selftest
results: parsing output: 115/ for test: kms_panel_fitting
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_mmap_write_crc
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_pm_backlight
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: kms_sequence
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_dsc
results: parsing output: 132/ for test: gem_render_copy
Done.