[59.544674] Initializing watchdogs
[59.544751]   /dev/watchdog0
[59.563389] [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]
[59.567806] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.570495] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.573673] [001/133] (960s left) gem_exec_fence (syncobj-timeline-export)
[60.158818] Starting subtest: syncobj-timeline-export
[60.169863] Subtest syncobj-timeline-export: SUCCESS (0.013s)
[61.409363] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[61.412474] [002/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[61.515845] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[61.519662] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[61.609905] [003/133] (958s left) kms_cursor_crc (cursor-random-max-size)
[61.912138] Starting subtest: cursor-random-max-size
[61.918579] Subtest cursor-random-max-size: SKIP (0.000s)
[62.048506] [004/133] (958s left) kms_plane_multiple (2x-tiling-x)
[62.144265] Starting subtest: 2x-tiling-x
[62.148179] Subtest 2x-tiling-x: SKIP (0.000s)
[62.218896] [005/133] (958s left) gem_mmap_offset (bad-flags)
[62.275510] Starting subtest: bad-flags
[62.277344] Subtest bad-flags: SUCCESS (0.000s)
[62.366544] [006/133] (957s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[62.425075] Starting subtest: y-tiled-ccs-to-x-tiled
[62.428967] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[62.611963] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[62.702161] Starting subtest: psr2-overlay-plane-move-continuous-sf
[62.704736] Starting dynamic subtest: pipe-A-eDP-1
[68.718129] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.040s)
[68.726777] Starting dynamic subtest: pipe-B-eDP-1
[75.441508] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.731s)
[75.444058] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.773s)
[76.312175] [008/133] (944s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[76.440356] Starting subtest: cursorA-vs-flipB-varying-size
[76.445017] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[76.588998] [009/133] (943s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[76.670359] Starting subtest: plane-use-after-nonblocking-unbind
[76.672645] Starting dynamic subtest: pipe-A-eDP-1
[76.735111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[77.030173] Starting dynamic subtest: pipe-B-eDP-1
[77.806449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[78.097851] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.426s)
[78.964327] [010/133] (941s left) kms_psr (fbc-pr-primary-mmap-gtt)
[79.076085] Starting subtest: fbc-pr-primary-mmap-gtt
[79.080561] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[79.145644] [011/133] (941s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[79.243782] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[79.246056] Starting dynamic subtest: pipe-A-eDP-1
[79.268843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.278405] Starting dynamic subtest: pipe-B-eDP-1
[79.299271] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.306087] Starting dynamic subtest: pipe-C-eDP-1
[79.326478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.333119] Starting dynamic subtest: pipe-D-eDP-1
[79.354636] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.358916] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[81.425675] [012/133] (939s left) gem_exec_params (invalid-ring2)
[81.489072] Starting subtest: invalid-ring2
[81.491299] Subtest invalid-ring2: SUCCESS (0.000s)
[81.605638] [013/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[81.702931] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[81.707196] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[81.806597] [014/133] (938s left) kms_hdr (invalid-hdr)
[81.904617] Starting subtest: invalid-hdr
[84.041874] Starting dynamic subtest: pipe-A-eDP-1
[86.606108] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.564s)
[86.608646] Subtest invalid-hdr: SUCCESS (4.704s)
[86.734538] [015/133] (933s left) kms_atomic (atomic-invalid-params)
[86.829079] Starting subtest: atomic-invalid-params
[86.831298] Starting dynamic subtest: pipe-A-eDP-1
[88.272099] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.442s)
[88.274387] Subtest atomic-invalid-params: SUCCESS (1.443s)
[89.104918] [016/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[89.214063] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[89.218153] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[89.307098] [017/133] (931s left) gem_pwrite (basic-exhaustion)
[89.372207] Subtest basic-exhaustion: SKIP (0.000s)
[89.435388] [018/133] (931s left) gem_exec_flush (basic-uc-rw-default)
[89.489379] Starting subtest: basic-uc-rw-default
[94.942895] Subtest basic-uc-rw-default: SUCCESS (5.455s)
[95.135948] [019/133] (925s left) kms_atomic_interruptible (legacy-cursor)
[95.238766] Starting subtest: legacy-cursor
[95.241125] Starting dynamic subtest: pipe-A-eDP-1
[102.658727] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s)
[102.660733] Subtest legacy-cursor: SUCCESS (7.419s)
[103.510425] [020/133] (917s left) kms_flip (flip-vs-suspend-interruptible)
[103.617916] Starting subtest: flip-vs-suspend-interruptible
[103.620299] Starting dynamic subtest: A-eDP1
[249.264348] Dynamic subtest A-eDP1: SUCCESS (11.430s)
[249.266677] Subtest flip-vs-suspend-interruptible: SUCCESS (11.432s)
[249.409922] [021/133] (771s left) gem_pipe_control_store_loop (reused-buffer)
[249.465496] Starting subtest: reused-buffer
[251.593331] Subtest reused-buffer: SUCCESS (2.152s)
[251.695248] [022/133] (769s left) prime_self_import (basic-llseek-size)
[251.737607] Starting subtest: basic-llseek-size
[251.758462] Subtest basic-llseek-size: SUCCESS (0.023s)
[251.855119] [023/133] (769s left) sysfs_timeslice_duration (invalid)
[251.905159] Starting subtest: invalid
[251.907997] Starting dynamic subtest: vecs0
[251.910621] Dynamic subtest vecs0: SUCCESS (0.000s)
[251.921385] Starting dynamic subtest: ccs0
[251.923441] Dynamic subtest ccs0: SUCCESS (0.000s)
[251.931558] Starting dynamic subtest: vcs0
[251.933337] Dynamic subtest vcs0: SUCCESS (0.000s)
[251.942190] Starting dynamic subtest: bcs0
[251.944061] Dynamic subtest bcs0: SUCCESS (0.000s)
[251.952068] Starting dynamic subtest: rcs0
[251.954282] Dynamic subtest rcs0: SUCCESS (0.000s)
[251.962044] Starting dynamic subtest: vcs1
[251.964061] Dynamic subtest vcs1: SUCCESS (0.000s)
[251.966217] Subtest invalid: SUCCESS (0.004s)
[252.027532] [024/133] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[252.131963] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[258.816995] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.739s)
[258.917057] [025/133] (762s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[259.026319] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[263.130216] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.124s)
[264.311009] [026/133] (756s left) gem_exec_whisper (basic-contexts-all)
[264.379276] Starting subtest: basic-contexts-all
[275.185880] Subtest basic-contexts-all: SUCCESS (10.820s)
[275.371364] [027/133] (745s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[275.420428] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[275.422879] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[275.531029] [028/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[275.642196] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[275.646353] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[275.745147] [029/133] (745s left) kms_addfb_basic (bad-pitch-128)
[275.796498] Starting subtest: bad-pitch-128
[275.798814] Subtest bad-pitch-128: SUCCESS (0.000s)
[275.922554] [030/133] (745s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[276.043129] Starting subtest: 2x-cursor-vs-flip-atomic
[276.047804] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[276.186106] [031/133] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[276.280211] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[283.483540] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.208s)
[283.594923] [032/133] (737s left) gem_exec_balancer (bonded-pair)
[283.656059] Starting subtest: bonded-pair
[283.660431] Subtest bonded-pair: SKIP (0.000s)
[283.953848] [033/133] (737s left) gem_close_race (multigpu-basic-process)
[284.032947] Starting subtest: multigpu-basic-process
[284.037241] Subtest multigpu-basic-process: SKIP (0.000s)
[284.260804] [034/133] (737s left) kms_fbcon_fbt (fbc)
[284.317001] Starting subtest: fbc
[290.653727] Subtest fbc: SUCCESS (6.334s)
[291.746898] [035/133] (729s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[291.846058] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[291.848321] Starting dynamic subtest: pipe-A-eDP-1
[291.992192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[292.003974] Starting dynamic subtest: pipe-B-eDP-1
[292.024104] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[292.032229] Starting dynamic subtest: pipe-C-eDP-1
[292.051893] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[292.059911] Starting dynamic subtest: pipe-D-eDP-1
[292.079811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[292.081789] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[294.243477] [036/133] (727s left) gen7_exec_parse (bitmasks)
[294.304711] Subtest bitmasks: SKIP (0.000s)
[294.385148] [037/133] (727s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[294.442366] Starting subtest: invalid-single-wait-unsubmitted
[294.444668] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[294.541587] [038/133] (727s left) kms_display_modes (extended-mode-basic)
[294.636487] Starting subtest: extended-mode-basic
[294.640803] Subtest extended-mode-basic: SKIP (0.000s)
[294.683144] [039/133] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[294.777476] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[294.781676] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[294.881894] [040/133] (726s left) gem_exec_schedule (preempt-other)
[294.960411] Starting subtest: preempt-other
[294.962795] Starting dynamic subtest: rcs0
[295.023410] Dynamic subtest rcs0: SUCCESS (0.072s)
[295.033605] Starting dynamic subtest: bcs0
[295.091649] Dynamic subtest bcs0: SUCCESS (0.068s)
[295.106788] Starting dynamic subtest: vcs0
[295.153365] Dynamic subtest vcs0: SUCCESS (0.061s)
[295.162926] Starting dynamic subtest: vcs1
[295.229654] Dynamic subtest vcs1: SUCCESS (0.075s)
[295.245463] Starting dynamic subtest: vecs0
[295.289503] Dynamic subtest vecs0: SUCCESS (0.060s)
[295.302677] Starting dynamic subtest: ccs0
[295.351340] Dynamic subtest ccs0: SUCCESS (0.061s)
[295.353764] Subtest preempt-other: SUCCESS (0.401s)
[296.616752] [041/133] (725s left) dumb_buffer (map-invalid-size)
[296.669801] Starting subtest: map-invalid-size
[296.671717] Subtest map-invalid-size: SUCCESS (0.000s)
[296.756172] [042/133] (725s left) kms_cursor_crc (cursor-sliding-512x170)
[297.038029] Starting subtest: cursor-sliding-512x170
[297.042445] Subtest cursor-sliding-512x170: SKIP (0.001s)
[297.174527] [043/133] (724s left) sw_sync (sync_busy_fork_unixsocket)
[297.212472] Starting subtest: sync_busy_fork_unixsocket
[297.217990] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[297.272066] [044/133] (724s left) perf (non-zero-reason)
[297.386521] Starting subtest: non-zero-reason
[297.388807] Starting dynamic subtest: 0-rcs0
[302.671807] Dynamic subtest 0-rcs0: SUCCESS (5.285s)
[302.685261] Starting dynamic subtest: 1-vcs1
[306.533817] Dynamic subtest 1-vcs1: SUCCESS (3.862s)
[306.536826] Subtest non-zero-reason: SUCCESS (9.148s)
[306.581871] [045/133] (715s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[306.698209] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[306.700513] Starting dynamic subtest: pipe-A-eDP-1
[306.723885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.734953] Starting dynamic subtest: pipe-B-eDP-1
[306.756959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.765799] Starting dynamic subtest: pipe-C-eDP-1
[306.787895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.796984] Starting dynamic subtest: pipe-D-eDP-1
[306.819144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.823211] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[308.905305] [046/133] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[309.003911] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[309.007884] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[309.097259] [047/133] (712s left) gem_render_copy_redux (flink)
[309.159515] Starting subtest: flink
[309.984309] Subtest flink: SUCCESS (0.825s)
[310.105693] [048/133] (711s left) sriov_basic (enable-vfs-bind-unbind-each)
[310.162467] Starting subtest: enable-vfs-bind-unbind-each
[310.164491] Starting dynamic subtest: numvfs-1
[310.224889] Dynamic subtest numvfs-1: FAIL (0.013s)
[310.235933] Starting dynamic subtest: numvfs-2
[310.294542] Dynamic subtest numvfs-2: FAIL (0.004s)
[310.303965] Starting dynamic subtest: numvfs-3
[310.361773] Dynamic subtest numvfs-3: FAIL (0.004s)
[310.370334] Starting dynamic subtest: numvfs-4
[310.429336] Dynamic subtest numvfs-4: FAIL (0.004s)
[310.438366] Starting dynamic subtest: numvfs-5
[310.494800] Dynamic subtest numvfs-5: FAIL (0.003s)
[310.503635] Starting dynamic subtest: numvfs-6
[310.559837] Dynamic subtest numvfs-6: FAIL (0.004s)
[310.568299] Starting dynamic subtest: numvfs-7
[310.624961] Dynamic subtest numvfs-7: FAIL (0.003s)
[310.633707] Starting dynamic subtest: numvfs-random
[310.689383] Dynamic subtest numvfs-random: FAIL (0.003s)
[310.691161] Subtest enable-vfs-bind-unbind-each: FAIL (0.042s)
[310.725625] [049/133] (711s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[310.824842] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[311.560661] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.737s)
[311.719525] [050/133] (710s left) kms_addfb_basic (bad-pitch-256)
[311.778553] Starting subtest: bad-pitch-256
[311.781125] Subtest bad-pitch-256: SUCCESS (0.000s)
[311.907521] [051/133] (710s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[311.991096] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[311.993295] Starting dynamic subtest: pipe-A-eDP-1
[312.424247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[312.436163] Starting dynamic subtest: pipe-B-eDP-1
[313.793556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[313.805448] Starting dynamic subtest: pipe-C-eDP-1
[315.221268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.428s)
[315.232981] Starting dynamic subtest: pipe-D-eDP-1
[316.548603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[316.550886] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.534s)
[317.747177] [052/133] (704s left) gem_userptr_blits (sync-unmap-after-close)
[317.823384] Starting subtest: sync-unmap-after-close
[317.833838] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[317.948393] [053/133] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[318.047064] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[318.051489] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[318.135737] [054/133] (704s left) gem_exec_async (forked-writes)
[318.193538] Starting subtest: forked-writes
[318.195945] Starting dynamic subtest: rcs0
[318.223281] Dynamic subtest rcs0: SUCCESS (0.029s)
[318.235003] Starting dynamic subtest: bcs0
[318.244645] Dynamic subtest bcs0: SUCCESS (0.021s)
[318.254101] Starting dynamic subtest: vcs0
[318.267073] Dynamic subtest vcs0: SUCCESS (0.022s)
[318.276544] Starting dynamic subtest: vcs1
[318.289900] Dynamic subtest vcs1: SUCCESS (0.022s)
[318.300236] Starting dynamic subtest: vecs0
[318.312825] Dynamic subtest vecs0: SUCCESS (0.022s)
[318.322348] Starting dynamic subtest: ccs0
[318.336117] Dynamic subtest ccs0: SUCCESS (0.023s)
[318.338470] Subtest forked-writes: SUCCESS (0.143s)
[318.566768] [055/133] (703s left) gem_userptr_blits (process-exit-busy)
[318.631262] Starting subtest: process-exit-busy
[318.642392] Subtest process-exit-busy: SUCCESS (0.013s)
[318.787102] [056/133] (703s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[318.848387] Subtest no-spare-fences-busy: SKIP (0.000s)
[318.928810] [057/133] (703s left) kms_flip (busy-flip)
[319.034981] Starting subtest: busy-flip
[319.037129] Starting dynamic subtest: A-eDP1
[320.756414] Dynamic subtest A-eDP1: SUCCESS (1.723s)
[320.765833] Starting dynamic subtest: B-eDP1
[322.402052] Dynamic subtest B-eDP1: SUCCESS (1.645s)
[322.414333] Starting dynamic subtest: C-eDP1
[324.024933] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[324.039997] Starting dynamic subtest: D-eDP1
[325.661556] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[325.666466] Subtest busy-flip: SUCCESS (6.637s)
[326.829964] [058/133] (695s left) vgem_basic (sysfs)
[326.874067] Starting subtest: sysfs
[326.875950] Subtest sysfs: SUCCESS (0.000s)
[326.929797] [059/133] (695s left) gem_exec_balancer (parallel-contexts)
[327.196477] Starting subtest: parallel-contexts
[329.887868] Subtest parallel-contexts: SUCCESS (2.693s)
[330.612895] [060/133] (691s left) api_intel_allocator (fork-simple-stress)
[330.676584] Starting subtest: fork-simple-stress
[336.071600] Subtest fork-simple-stress: SUCCESS (5.397s)
[336.182256] [061/133] (686s left) gem_vm_create (execbuf)
[336.238774] Starting subtest: execbuf
[336.252504] Subtest execbuf: SUCCESS (0.014s)
[336.371711] [062/133] (686s left) gem_ctx_isolation (dirty-create)
[336.426145] Starting subtest: dirty-create
[336.428521] Starting dynamic subtest: rcs0
[336.712759] Dynamic subtest rcs0: SUCCESS (0.286s)
[336.725292] Starting dynamic subtest: bcs0
[336.966534] Dynamic subtest bcs0: SUCCESS (0.253s)
[336.976455] Starting dynamic subtest: vcs0
[337.222842] Dynamic subtest vcs0: SUCCESS (0.256s)
[337.232237] Starting dynamic subtest: vcs1
[338.724576] Dynamic subtest vcs1: SUCCESS (1.501s)
[338.734597] Starting dynamic subtest: vecs0
[340.669723] Dynamic subtest vecs0: SUCCESS (1.945s)
[340.681907] Starting dynamic subtest: ccs0
[342.742978] Dynamic subtest ccs0: SUCCESS (2.073s)
[342.745425] Subtest dirty-create: SUCCESS (6.320s)
[342.998381] [063/133] (679s left) api_intel_bb (intel-bb-blit-none)
[343.074225] Starting subtest: intel-bb-blit-none
[347.301285] Subtest intel-bb-blit-none: SUCCESS (4.224s)
[347.421737] [064/133] (675s left) kms_psr (pr-sprite-render)
[347.518776] Starting subtest: pr-sprite-render
[347.523399] Subtest pr-sprite-render: SKIP (0.000s)
[347.588695] [065/133] (675s left) gem_userptr_blits (sync-unmap-cycles)
[347.644586] Starting subtest: sync-unmap-cycles
[353.028495] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[353.143074] [066/133] (669s left) gem_pxp (reject-modify-context-protection-off-3)
[353.266282] Starting subtest: reject-modify-context-protection-off-3
[353.268465] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[353.400168] [067/133] (669s left) gem_render_copy_redux (interruptible)
[353.452703] Starting subtest: interruptible
[353.835258] Subtest interruptible: SUCCESS (0.382s)
[353.934962] [068/133] (668s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[354.035998] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[354.039393] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[354.104336] [069/133] (668s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[354.200409] Starting subtest: fbc-psr2-sprite-mmap-gtt
[354.202334] Starting dynamic subtest: eDP-1
[354.205871] Dynamic subtest eDP-1: SKIP (0.000s)
[354.209417] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[354.272736] [070/133] (668s left) kms_content_protection (dp-mst-type-1)
[354.416263] Starting subtest: dp-mst-type-1
[354.420049] Subtest dp-mst-type-1: SKIP (0.000s)
[354.542626] [071/133] (668s left) gem_workarounds (reset-fd)
[354.615302] Starting subtest: reset-fd
[354.792356] Subtest reset-fd: SUCCESS (0.175s)
[354.908388] [072/133] (668s left) fbdev (write)
[354.947518] Starting subtest: write
[355.304591] Subtest write: SUCCESS (0.357s)
[355.358547] [073/133] (667s left) kms_chamelium_frames (dp-crc-multiple)
[355.749048] Subtest dp-crc-multiple: SKIP (0.000s)
[356.534803] [074/133] (666s left) kms_lease (lease-invalid-crtc)
[356.621633] Starting subtest: lease-invalid-crtc
[356.624010] Starting dynamic subtest: pipe-A-eDP-1
[356.626320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[356.638493] Starting dynamic subtest: pipe-B-eDP-1
[356.640746] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.650601] Starting dynamic subtest: pipe-C-eDP-1
[356.652555] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.662917] Starting dynamic subtest: pipe-D-eDP-1
[356.664872] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.666774] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[356.704360] [075/133] (666s left) kms_properties (crtc-properties-atomic)
[356.794432] Starting subtest: crtc-properties-atomic
[356.796867] Starting dynamic subtest: pipe-A-eDP-1
[357.243709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[357.254725] Starting dynamic subtest: pipe-B-eDP-1
[358.416801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[358.427355] Starting dynamic subtest: pipe-C-eDP-1
[359.541738] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[359.551886] Starting dynamic subtest: pipe-D-eDP-1
[360.673010] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[360.674909] Subtest crtc-properties-atomic: SUCCESS (3.876s)
[361.491309] [076/133] (661s left) kms_chamelium_color (ctm-0-75)
[361.587818] Subtest ctm-0-75: SKIP (0.000s)
[361.632474] [077/133] (661s left) gem_exec_parallel (userptr)
[361.699075] Starting subtest: userptr
[361.701509] Starting dynamic subtest: rcs0
[363.108783] Dynamic subtest rcs0: SUCCESS (1.409s)
[363.121267] Starting dynamic subtest: bcs0
[364.593565] Dynamic subtest bcs0: SUCCESS (1.483s)
[364.606097] Starting dynamic subtest: vcs0
[366.474923] Dynamic subtest vcs0: SUCCESS (1.877s)
[366.487381] Starting dynamic subtest: vcs1
[368.458169] Dynamic subtest vcs1: SUCCESS (1.983s)
[368.468986] Starting dynamic subtest: vecs0
[370.508168] Dynamic subtest vecs0: SUCCESS (2.047s)
[370.520088] Starting dynamic subtest: ccs0
[371.989067] Dynamic subtest ccs0: SUCCESS (1.479s)
[371.991793] Subtest userptr: SUCCESS (10.289s)
[372.189610] [078/133] (651s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[372.288551] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[372.315488] Starting dynamic subtest: pipe-A-plane-0
[372.726374] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[372.736735] Starting dynamic subtest: pipe-A-plane-3
[372.981996] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[372.992273] Starting dynamic subtest: pipe-A-plane-5
[372.996603] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[374.061058] Starting dynamic subtest: pipe-B-plane-0
[374.485864] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[374.498348] Starting dynamic subtest: pipe-B-plane-3
[374.741829] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[374.752300] Starting dynamic subtest: pipe-B-plane-5
[374.756825] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[375.052800] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.764s)
[375.925489] [079/133] (647s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[376.031405] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[376.035566] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[376.110781] [080/133] (647s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[376.209808] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[377.276576] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[377.390219] [081/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[377.491220] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[377.494831] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.586601] [082/133] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[377.678879] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[377.682501] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[377.774989] [083/133] (645s left) kms_color (ctm-max)
[377.863818] Starting subtest: ctm-max
[377.865345] Starting dynamic subtest: pipe-A-eDP-1
[378.574061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[378.585344] Starting dynamic subtest: pipe-B-eDP-1
[380.042982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s)
[380.056458] Starting dynamic subtest: pipe-C-eDP-1
[381.428883] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[381.439699] Starting dynamic subtest: pipe-D-eDP-1
[382.759090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[382.761345] Subtest ctm-max: SUCCESS (4.896s)
[383.566821] [084/133] (639s left) kms_cursor_crc (cursor-onscreen-128x128)
[383.781426] Starting subtest: cursor-onscreen-128x128
[383.786471] Starting dynamic subtest: pipe-A-eDP-1
[385.918221] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[385.944262] Starting dynamic subtest: pipe-D-eDP-1
[388.772066] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.833s)
[388.774374] Subtest cursor-onscreen-128x128: SUCCESS (4.987s)
[389.649527] [085/133] (633s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[389.736603] Starting subtest: multiplane-rotation-cropping-bottom
[407.204730] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.473s)
[407.320874] [086/133] (616s left) gem_exec_params (sol-reset-invalid)
[407.387579] Starting subtest: sol-reset-invalid
[407.392036] Subtest sol-reset-invalid: SUCCESS (0.003s)
[408.585232] [087/133] (615s left) gem_eio (reset-stress)
[408.813342] Starting subtest: reset-stress
[408.815617] Starting dynamic subtest: render
[413.854795] Dynamic subtest render: SUCCESS (5.040s)
[413.865790] Starting dynamic subtest: bsd1
[432.000434] Dynamic subtest bsd1: SUCCESS (18.147s)
[432.017838] Starting dynamic subtest: bsd2
[450.096479] Dynamic subtest bsd2: SUCCESS (18.099s)
[450.117716] Starting dynamic subtest: blt
[450.122111] Dynamic subtest blt: SKIP (0.000s)
[450.131634] Starting dynamic subtest: vebox
[468.006794] Dynamic subtest vebox: SUCCESS (17.914s)
[468.009208] Subtest reset-stress: SUCCESS (59.206s)
[469.584227] [088/133] (554s left) gem_softpin (reverse)
[469.638176] Starting subtest: reverse
[469.643807] Subtest reverse: SUCCESS (0.005s)
[469.781936] [089/133] (553s left) perf_pmu (multi-client)
[469.820731] Starting subtest: multi-client
[469.823119] Starting dynamic subtest: rcs0
[470.873582] Dynamic subtest rcs0: SUCCESS (1.053s)
[470.886508] Starting dynamic subtest: bcs0
[471.930179] Dynamic subtest bcs0: SUCCESS (1.053s)
[471.943953] Starting dynamic subtest: vcs0
[472.982864] Dynamic subtest vcs0: SUCCESS (1.050s)
[472.995638] Starting dynamic subtest: vcs1
[474.499222] Dynamic subtest vcs1: SUCCESS (1.514s)
[474.511363] Starting dynamic subtest: vecs0
[476.546466] Dynamic subtest vecs0: SUCCESS (2.043s)
[476.558996] Starting dynamic subtest: ccs0
[478.531112] Dynamic subtest ccs0: SUCCESS (1.981s)
[478.533819] Subtest multi-client: SUCCESS (8.710s)
[478.649028] [090/133] (545s left) gem_mmap (bad-object)
[478.693076] Subtest bad-object: SKIP (0.000s)
[478.754597] [091/133] (545s left) i915_drm_fdinfo (memory-info-purgeable)
[478.795996] Starting subtest: memory-info-purgeable
[478.798300] Starting dynamic subtest: smem0
[481.767824] Dynamic subtest smem0: SUCCESS (2.972s)
[481.769981] Subtest memory-info-purgeable: SUCCESS (2.973s)
[481.842992] [092/133] (542s left) gem_tiled_partial_pwrite_pread (writes)
[481.900292] Subtest writes: SKIP (0.000s)
[481.971011] [093/133] (541s left) kms_joiner (basic-force-big-joiner)
[482.067736] Starting subtest: basic-force-big-joiner
[482.071377] Subtest basic-force-big-joiner: SKIP (0.000s)
[482.152173] [094/133] (541s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[482.243053] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[482.246633] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[482.315841] [095/133] (541s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[482.416342] Starting subtest: y-tiled-8bpp-rotate-180
[482.420014] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[482.543969] [096/133] (541s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[482.645851] Starting subtest: psr-rgb565-draw-blt
[489.640161] Subtest psr-rgb565-draw-blt: SUCCESS (6.994s)
[489.755076] [097/133] (534s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[489.855634] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[496.504174] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.651s)
[496.632356] [098/133] (527s left) gen3_render_mixed_blits
[496.753308] [099/133] (527s left) kms_vblank (wait-forked-hang)
[496.834342] Starting subtest: wait-forked-hang
[496.836575] Starting dynamic subtest: pipe-A-eDP-1
[523.273045] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.433s)
[523.288378] Starting dynamic subtest: pipe-D-eDP-1
[538.317858] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[538.320216] Subtest wait-forked-hang: SUCCESS (41.479s)
[539.122044] [100/133] (485s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[539.203176] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[539.205357] Starting dynamic subtest: pipe-A
[539.224133] Dynamic subtest pipe-A: SKIP (0.016s)
[539.234247] Starting dynamic subtest: pipe-B
[539.258640] Dynamic subtest pipe-B: SKIP (0.034s)
[539.269023] Starting dynamic subtest: pipe-C
[539.296046] Dynamic subtest pipe-C: SKIP (0.037s)
[539.306198] Starting dynamic subtest: pipe-D
[539.330840] Dynamic subtest pipe-D: SKIP (0.033s)
[539.335188] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.124s)
[539.433038] [101/133] (484s left) perf_pmu (all-busy-check-all)
[539.479463] Starting subtest: all-busy-check-all
[541.515547] Subtest all-busy-check-all: SUCCESS (2.035s)
[541.648353] [102/133] (482s left) syncobj_timeline (host-signal-points)
[541.720226] Starting subtest: host-signal-points
[541.725248] Subtest host-signal-points: SUCCESS (0.004s)
[541.824629] [103/133] (482s left) kms_fbcon_fbt (fbc-suspend)
[541.881445] Starting subtest: fbc-suspend
[591.416491] Subtest fbc-suspend: SUCCESS (19.310s)
[592.736044] [104/133] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[592.852030] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[599.819561] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.000s)
[599.943094] [105/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[600.034458] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[600.039479] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[600.139152] [106/133] (424s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[600.237726] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[600.243252] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[600.331575] [107/133] (424s left) kms_flip (flip-vs-fences-interruptible)
[600.425760] Starting subtest: flip-vs-fences-interruptible
[600.430373] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[600.523511] [108/133] (424s left) kms_plane (plane-position-hole)
[600.614225] Starting subtest: plane-position-hole
[601.144965] Starting dynamic subtest: pipe-A-plane-1
[602.411615] Dynamic subtest pipe-A-plane-1: SUCCESS (1.271s)
[602.424358] Starting dynamic subtest: pipe-A-plane-2
[603.656150] Dynamic subtest pipe-A-plane-2: SUCCESS (1.244s)
[603.667905] Starting dynamic subtest: pipe-A-plane-3
[604.957928] Dynamic subtest pipe-A-plane-3: SUCCESS (1.305s)
[604.969491] Starting dynamic subtest: pipe-A-plane-4
[606.202512] Dynamic subtest pipe-A-plane-4: SUCCESS (1.246s)
[606.213565] Starting dynamic subtest: pipe-A-plane-5
[606.231256] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[607.384144] Starting dynamic subtest: pipe-B-plane-1
[608.643616] Dynamic subtest pipe-B-plane-1: SUCCESS (1.271s)
[608.656979] Starting dynamic subtest: pipe-B-plane-2
[609.947127] Dynamic subtest pipe-B-plane-2: SUCCESS (1.304s)
[609.957662] Starting dynamic subtest: pipe-B-plane-3
[611.201596] Dynamic subtest pipe-B-plane-3: SUCCESS (1.254s)
[611.213087] Starting dynamic subtest: pipe-B-plane-4
[612.531517] Dynamic subtest pipe-B-plane-4: SUCCESS (1.330s)
[612.543510] Starting dynamic subtest: pipe-B-plane-5
[612.556985] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[612.559598] Subtest plane-position-hole: SUCCESS (11.961s)
[613.334447] [109/133] (411s left) i915_pm_rpm (gem-evict-pwrite)
[615.062621] Starting subtest: gem-evict-pwrite
[615.067540] Subtest gem-evict-pwrite: SKIP (0.000s)
[615.598656] [110/133] (409s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[615.658267] Starting subtest: etime-multi-wait-all-available-unsubmitted
[615.759416] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[615.851999] [111/133] (408s left) gem_exec_schedule (u-semaphore-resolve)
[615.920601] Starting subtest: u-semaphore-resolve
[615.953944] Subtest u-semaphore-resolve: SUCCESS (0.042s)
[616.296769] [112/133] (408s left) syncobj_timeline (signal-array)
[616.347507] Starting subtest: signal-array
[616.350403] Subtest signal-array: SUCCESS (0.000s)
[616.440159] [113/133] (408s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[616.531994] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[616.536888] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[616.627026] [114/133] (408s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[616.716515] Starting subtest: yf-tiled-16bpp-rotate-0
[616.722535] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[616.826075] [115/133] (408s left) i915_selftest (perf)
[619.351592] Starting subtest: perf
[619.354513] Starting dynamic subtest: engine_cs
[623.011864] Dynamic subtest engine_cs: SUCCESS (3.659s)
[623.021583] Starting dynamic subtest: request
[629.173100] Dynamic subtest request: SUCCESS (6.160s)
[629.183177] Starting dynamic subtest: migrate
[634.380882] Dynamic subtest migrate: SUCCESS (5.206s)
[634.390739] Starting dynamic subtest: region
[641.558958] Dynamic subtest region: SUCCESS (7.178s)
[641.561712] Subtest perf: SUCCESS (22.208s)
[641.594464] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[641.595249] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[641.598805] [116/133] (383s left) kms_panel_fitting (legacy)
[644.029034] Starting subtest: legacy
[644.031752] Starting dynamic subtest: pipe-A-eDP-1
[644.614691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[644.643619] Starting dynamic subtest: pipe-B-eDP-1
[646.228012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s)
[646.254529] Starting dynamic subtest: pipe-C-eDP-1
[647.812491] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s)
[647.838447] Starting dynamic subtest: pipe-D-eDP-1
[649.321014] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.491s)
[649.323479] Subtest legacy: SUCCESS (5.297s)
[650.527569] [FACT kms_panel_fitting (legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[650.528884] [FACT kms_panel_fitting (legacy)] new: kernel.kmod_is_loaded.i915: true
[650.533466] [117/133] (374s left) gem_ctx_persistence (legacy-engines-mixed)
[650.607053] Starting subtest: legacy-engines-mixed
[650.609639] Starting dynamic subtest: render
[650.690885] Dynamic subtest render: SUCCESS (0.083s)
[650.702922] Starting dynamic subtest: bsd1
[650.748781] Dynamic subtest bsd1: SUCCESS (0.056s)
[650.759881] Starting dynamic subtest: bsd2
[650.808974] Dynamic subtest bsd2: SUCCESS (0.058s)
[650.820246] Starting dynamic subtest: blt
[650.858767] Dynamic subtest blt: SUCCESS (0.047s)
[650.868726] Starting dynamic subtest: vebox
[650.925082] Dynamic subtest vebox: SUCCESS (0.064s)
[650.927952] Subtest legacy-engines-mixed: SUCCESS (0.319s)
[651.017096] [118/133] (373s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[651.132265] Starting subtest: 4-tiled-8bpp-rotate-270
[651.158626] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[651.286488] [119/133] (373s left) kms_busy (extended-modeset-hang-newfb)
[651.388352] Starting subtest: extended-modeset-hang-newfb
[651.390751] Starting dynamic subtest: pipe-A
[673.782738] Dynamic subtest pipe-A: SUCCESS (22.400s)
[673.792558] Starting dynamic subtest: pipe-D
[696.765738] Dynamic subtest pipe-D: SUCCESS (22.976s)
[696.768506] Subtest extended-modeset-hang-newfb: SUCCESS (45.381s)
[697.558074] [120/133] (327s left) kms_mmap_write_crc (main)
[697.675617] Starting subtest: main
[697.678484] Starting dynamic subtest: pipe-A-eDP-1
[701.101579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[701.104373] Subtest main: SUCCESS (3.428s)
[701.914771] [121/133] (323s left) syncobj_wait (multi-wait-submitted-signaled)
[701.970600] Starting subtest: multi-wait-submitted-signaled
[701.973664] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[702.065305] [122/133] (323s left) i915_hangman (engine-engine-error)
[702.123402] Starting subtest: engine-engine-error
[702.125574] Starting dynamic subtest: rcs0
[703.811772] Dynamic subtest rcs0: SUCCESS (1.688s)
[703.823760] Starting dynamic subtest: bcs0
[705.795162] Dynamic subtest bcs0: SUCCESS (1.980s)
[705.808393] Starting dynamic subtest: vcs0
[707.843056] Dynamic subtest vcs0: SUCCESS (2.045s)
[707.856323] Starting dynamic subtest: vcs1
[709.827079] Dynamic subtest vcs1: SUCCESS (1.981s)
[709.843478] Starting dynamic subtest: vecs0
[711.875860] Dynamic subtest vecs0: SUCCESS (2.046s)
[711.889554] Starting dynamic subtest: ccs0
[713.858094] Dynamic subtest ccs0: SUCCESS (1.979s)
[713.861105] Subtest engine-engine-error: SUCCESS (11.736s)
[713.942600] [123/133] (311s left) gem_readwrite (read-bad-handle)
[713.998454] Subtest read-bad-handle: SKIP (0.000s)
[714.062189] [124/133] (311s left) gem_mmap_gtt (fault-concurrent-x)
[714.120459] Subtest fault-concurrent-X: SKIP (0.000s)
[714.186544] [125/133] (311s left) kms_prime (basic-modeset-hybrid)
[714.275977] Subtest basic-modeset-hybrid: SKIP (0.000s)
[714.393512] [126/133] (310s left) gem_lmem_swapping (massive-random)
[714.432666] Subtest massive-random: SKIP (0.000s)
[714.482974] [127/133] (310s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[714.881521] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[715.708605] [128/133] (309s left) kms_pm_backlight (fade-with-suspend)
[715.803558] Starting subtest: fade-with-suspend
[732.253892] Starting dynamic subtest: eDP-1
[735.291680] Dynamic subtest eDP-1: SUCCESS (3.032s)
[735.294187] Subtest fade-with-suspend: SUCCESS (4.990s)
[736.100126] [129/133] (289s left) kms_async_flips (async-flip-suspend-resume)
[736.200165] Starting subtest: async-flip-suspend-resume
[736.589890] Starting dynamic subtest: pipe-A-eDP-1
[754.255099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.929s)
[754.644148] Starting dynamic subtest: pipe-B-eDP-1
[772.262995] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s)
[772.636555] Starting dynamic subtest: pipe-C-eDP-1
[790.290440] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.892s)
[790.656693] Starting dynamic subtest: pipe-D-eDP-1
[808.275024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s)
[808.277471] Subtest async-flip-suspend-resume: SUCCESS (13.070s)
[809.459021] [130/133] (216s left) kms_sequence (get-idle)
[809.553008] Starting subtest: get-idle
[809.555471] Starting dynamic subtest: pipe-A-eDP-1
[811.348638] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.790s)
[811.360392] Starting dynamic subtest: pipe-B-eDP-1
[813.837292] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.481s)
[813.847527] Starting dynamic subtest: pipe-C-eDP-1
[816.269224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[816.280433] Starting dynamic subtest: pipe-D-eDP-1
[818.702594] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[818.705534] Subtest get-idle: SUCCESS (9.130s)
[819.516464] [131/133] (206s left) kms_psr (psr2-cursor-plane-move)
[819.613100] Starting subtest: psr2-cursor-plane-move
[819.615430] Starting dynamic subtest: eDP-1
[821.312488] Dynamic subtest eDP-1: SUCCESS (1.698s)
[821.315502] Subtest psr2-cursor-plane-move: SUCCESS (1.700s)
[822.205309] [132/133] (203s left) kms_dsc (dsc-with-output-formats-with-bpc)
[822.291962] Starting subtest: dsc-with-output-formats-with-bpc
[822.362144] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[822.407356] [133/133] (203s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[822.456778] Starting subtest: y-tiled-to-vebox-yf-tiled
[822.462607] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[822.641280] 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.