[56.464039] Initializing watchdogs
[56.464084]   /dev/watchdog0
[56.479075] [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.483502] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.486191] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.489398] [001/133] (960s left) gem_exec_fence (syncobj-timeline-export)
[57.076771] Starting subtest: syncobj-timeline-export
[57.088628] Subtest syncobj-timeline-export: SUCCESS (0.014s)
[58.384310] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[58.387967] [002/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[58.493638] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[58.497761] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[58.598835] [003/133] (958s left) kms_cursor_crc (cursor-random-max-size)
[58.899473] Starting subtest: cursor-random-max-size
[58.905596] Subtest cursor-random-max-size: SKIP (0.000s)
[59.033127] [004/133] (958s left) kms_plane_multiple (2x-tiling-x)
[59.119868] Starting subtest: 2x-tiling-x
[59.124060] Subtest 2x-tiling-x: SKIP (0.000s)
[59.204820] [005/133] (957s left) gem_mmap_offset (bad-flags)
[59.267738] Starting subtest: bad-flags
[59.269633] Subtest bad-flags: SUCCESS (0.000s)
[59.366575] [006/133] (957s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[59.419795] Starting subtest: y-tiled-ccs-to-x-tiled
[59.424041] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[59.600398] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[59.698972] Starting subtest: psr2-overlay-plane-move-continuous-sf
[59.701335] Starting dynamic subtest: pipe-A-eDP-1
[65.659070] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.021s)
[65.668304] Starting dynamic subtest: pipe-B-eDP-1
[72.368797] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.733s)
[72.370889] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.756s)
[73.237166] [008/133] (944s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[73.539013] Starting subtest: cursorA-vs-flipB-varying-size
[73.543612] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[73.682844] [009/133] (943s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[73.779034] Starting subtest: plane-use-after-nonblocking-unbind
[73.781373] Starting dynamic subtest: pipe-A-eDP-1
[73.840455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[74.142874] Starting dynamic subtest: pipe-B-eDP-1
[74.922387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s)
[75.223610] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.448s)
[76.086810] [010/133] (941s left) kms_psr (fbc-pr-primary-mmap-gtt)
[76.187985] Starting subtest: fbc-pr-primary-mmap-gtt
[76.192668] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[76.257146] [011/133] (941s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[76.345862] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[76.348317] Starting dynamic subtest: pipe-A-eDP-1
[76.371589] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[76.381630] Starting dynamic subtest: pipe-B-eDP-1
[76.403432] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[76.411323] Starting dynamic subtest: pipe-C-eDP-1
[76.432966] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[76.440714] Starting dynamic subtest: pipe-D-eDP-1
[76.462686] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[76.466744] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[78.638054] [012/133] (938s left) gem_exec_params (invalid-ring2)
[78.692390] Starting subtest: invalid-ring2
[78.694744] Subtest invalid-ring2: SUCCESS (0.000s)
[78.790450] [013/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[78.887694] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[78.891873] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[78.985401] [014/133] (938s left) kms_hdr (invalid-hdr)
[79.079920] Starting subtest: invalid-hdr
[81.148472] Starting dynamic subtest: pipe-A-eDP-1
[83.812070] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.667s)
[83.814636] Subtest invalid-hdr: SUCCESS (4.738s)
[83.905179] [015/133] (933s left) kms_atomic (atomic-invalid-params)
[83.991391] Starting subtest: atomic-invalid-params
[83.993611] Starting dynamic subtest: pipe-A-eDP-1
[85.490267] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.496s)
[85.492792] Subtest atomic-invalid-params: SUCCESS (1.498s)
[86.330899] [016/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[86.443794] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[86.448254] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[86.536241] [017/133] (931s left) gem_pwrite (basic-exhaustion)
[86.598666] Subtest basic-exhaustion: SKIP (0.000s)
[86.660834] [018/133] (931s left) gem_exec_flush (basic-uc-rw-default)
[86.726314] Starting subtest: basic-uc-rw-default
[92.217057] Subtest basic-uc-rw-default: SUCCESS (5.459s)
[92.378730] [019/133] (925s left) kms_atomic_interruptible (legacy-cursor)
[92.481854] Starting subtest: legacy-cursor
[92.484300] Starting dynamic subtest: pipe-A-eDP-1
[99.877526] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[99.879953] Subtest legacy-cursor: SUCCESS (7.396s)
[100.710193] [020/133] (917s left) kms_flip (flip-vs-suspend-interruptible)
[100.833563] Starting subtest: flip-vs-suspend-interruptible
[100.835980] Starting dynamic subtest: A-eDP1
[246.830992] Dynamic subtest A-eDP1: SUCCESS (11.479s)
[246.834393] Subtest flip-vs-suspend-interruptible: SUCCESS (11.481s)
[247.003013] [021/133] (770s left) gem_pipe_control_store_loop (reused-buffer)
[247.077747] Starting subtest: reused-buffer
[249.153986] Subtest reused-buffer: SUCCESS (2.153s)
[249.271006] [022/133] (768s left) prime_self_import (basic-llseek-size)
[249.321524] Starting subtest: basic-llseek-size
[249.333923] Subtest basic-llseek-size: SUCCESS (0.014s)
[249.441672] [023/133] (768s left) sysfs_timeslice_duration (invalid)
[249.497573] Starting subtest: invalid
[249.499930] Starting dynamic subtest: vecs0
[249.502661] Dynamic subtest vecs0: SUCCESS (0.000s)
[249.511965] Starting dynamic subtest: ccs0
[249.514709] Dynamic subtest ccs0: SUCCESS (0.000s)
[249.523769] Starting dynamic subtest: vcs0
[249.526514] Dynamic subtest vcs0: SUCCESS (0.000s)
[249.535962] Starting dynamic subtest: bcs0
[249.538239] Dynamic subtest bcs0: SUCCESS (0.000s)
[249.546977] Starting dynamic subtest: rcs0
[249.549704] Dynamic subtest rcs0: SUCCESS (0.000s)
[249.558399] Starting dynamic subtest: vcs1
[249.560992] Dynamic subtest vcs1: SUCCESS (0.000s)
[249.563755] Subtest invalid: SUCCESS (0.004s)
[249.604414] [024/133] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[249.697714] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[256.317993] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.769s)
[256.429562] [025/133] (761s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[256.528763] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[260.707534] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.225s)
[261.937256] [026/133] (756s left) gem_exec_whisper (basic-contexts-all)
[262.002133] Starting subtest: basic-contexts-all
[271.924601] Subtest basic-contexts-all: SUCCESS (9.959s)
[272.112343] [027/133] (745s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[272.183217] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[272.185927] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[272.295144] [028/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[272.399930] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[272.404780] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[272.499463] [029/133] (745s left) kms_addfb_basic (bad-pitch-128)
[272.553015] Starting subtest: bad-pitch-128
[272.555872] Subtest bad-pitch-128: SUCCESS (0.000s)
[272.688452] [030/133] (745s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[272.802780] Starting subtest: 2x-cursor-vs-flip-atomic
[272.810919] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.004s)
[272.982739] [031/133] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[273.096388] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[280.391629] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.302s)
[280.505175] [032/133] (737s left) gem_exec_balancer (bonded-pair)
[280.581990] Starting subtest: bonded-pair
[280.587834] Subtest bonded-pair: SKIP (0.000s)
[280.871828] [033/133] (737s left) gem_close_race (multigpu-basic-process)
[280.931466] Starting subtest: multigpu-basic-process
[280.936860] Subtest multigpu-basic-process: SKIP (0.000s)
[281.160716] [034/133] (737s left) kms_fbcon_fbt (fbc)
[281.224834] Starting subtest: fbc
[287.585204] Subtest fbc: SUCCESS (6.357s)
[288.674427] [035/133] (729s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[288.766771] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[288.769206] Starting dynamic subtest: pipe-A-eDP-1
[288.912826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[288.924492] Starting dynamic subtest: pipe-B-eDP-1
[288.946212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[288.956469] Starting dynamic subtest: pipe-C-eDP-1
[288.978727] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[288.989768] Starting dynamic subtest: pipe-D-eDP-1
[289.013763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[289.016324] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[291.147174] [036/133] (727s left) gen7_exec_parse (bitmasks)
[291.210398] Subtest bitmasks: SKIP (0.000s)
[291.285875] [037/133] (727s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[291.346014] Starting subtest: invalid-single-wait-unsubmitted
[291.348820] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[291.445909] [038/133] (727s left) kms_display_modes (extended-mode-basic)
[291.534619] Starting subtest: extended-mode-basic
[291.539258] Subtest extended-mode-basic: SKIP (0.000s)
[291.583711] [039/133] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[291.680687] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[291.685638] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[291.767066] [040/133] (726s left) gem_exec_schedule (preempt-other)
[291.845211] Starting subtest: preempt-other
[291.847437] Starting dynamic subtest: rcs0
[291.915597] Dynamic subtest rcs0: SUCCESS (0.080s)
[291.925882] Starting dynamic subtest: bcs0
[291.987856] Dynamic subtest bcs0: SUCCESS (0.072s)
[292.001081] Starting dynamic subtest: vcs0
[292.051624] Dynamic subtest vcs0: SUCCESS (0.062s)
[292.066508] Starting dynamic subtest: vcs1
[292.122018] Dynamic subtest vcs1: SUCCESS (0.071s)
[292.135966] Starting dynamic subtest: vecs0
[292.189566] Dynamic subtest vecs0: SUCCESS (0.067s)
[292.200803] Starting dynamic subtest: ccs0
[292.255458] Dynamic subtest ccs0: SUCCESS (0.066s)
[292.257396] Subtest preempt-other: SUCCESS (0.421s)
[293.886686] [041/133] (724s left) dumb_buffer (map-invalid-size)
[293.955307] Starting subtest: map-invalid-size
[293.957982] Subtest map-invalid-size: SUCCESS (0.000s)
[294.067112] [042/133] (724s left) kms_cursor_crc (cursor-sliding-512x170)
[294.369591] Starting subtest: cursor-sliding-512x170
[294.374916] Subtest cursor-sliding-512x170: SKIP (0.001s)
[294.514226] [043/133] (724s left) sw_sync (sync_busy_fork_unixsocket)
[294.557728] Starting subtest: sync_busy_fork_unixsocket
[294.560670] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[294.635538] [044/133] (724s left) perf (non-zero-reason)
[294.760703] Starting subtest: non-zero-reason
[294.762972] Starting dynamic subtest: 0-rcs0
[300.230311] Dynamic subtest 0-rcs0: SUCCESS (5.417s)
[300.242111] Starting dynamic subtest: 1-vcs0
[304.110385] Dynamic subtest 1-vcs0: SUCCESS (3.933s)
[304.113456] Subtest non-zero-reason: SUCCESS (9.351s)
[304.158894] [045/133] (714s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[304.261982] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[304.264659] Starting dynamic subtest: pipe-A-eDP-1
[304.292702] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[304.304983] Starting dynamic subtest: pipe-B-eDP-1
[304.330880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[304.340762] Starting dynamic subtest: pipe-C-eDP-1
[304.366210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[304.375886] Starting dynamic subtest: pipe-D-eDP-1
[304.404497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[304.409500] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[306.494477] [046/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[306.597790] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[306.602979] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[306.689490] [047/133] (712s left) gem_render_copy_redux (flink)
[306.744759] Starting subtest: flink
[307.557541] Subtest flink: SUCCESS (0.813s)
[307.664966] [048/133] (711s left) sriov_basic (enable-vfs-bind-unbind-each)
[307.718656] Starting subtest: enable-vfs-bind-unbind-each
[307.721117] Starting dynamic subtest: numvfs-1
[307.796604] Dynamic subtest numvfs-1: FAIL (0.028s)
[307.807092] Starting dynamic subtest: numvfs-2
[307.877626] Dynamic subtest numvfs-2: FAIL (0.004s)
[307.887310] Starting dynamic subtest: numvfs-3
[307.959503] Dynamic subtest numvfs-3: FAIL (0.003s)
[307.969742] Starting dynamic subtest: numvfs-4
[308.042433] Dynamic subtest numvfs-4: FAIL (0.003s)
[308.052006] Starting dynamic subtest: numvfs-5
[308.122262] Dynamic subtest numvfs-5: FAIL (0.004s)
[308.131978] Starting dynamic subtest: numvfs-6
[308.203770] Dynamic subtest numvfs-6: FAIL (0.003s)
[308.213776] Starting dynamic subtest: numvfs-7
[308.287004] Dynamic subtest numvfs-7: FAIL (0.003s)
[308.296762] Starting dynamic subtest: numvfs-random
[308.368705] Dynamic subtest numvfs-random: FAIL (0.004s)
[308.370639] Subtest enable-vfs-bind-unbind-each: FAIL (0.057s)
[308.410969] [049/133] (710s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[308.522574] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[309.335893] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[309.509884] [050/133] (709s left) kms_addfb_basic (bad-pitch-256)
[309.569646] Starting subtest: bad-pitch-256
[309.572022] Subtest bad-pitch-256: SUCCESS (0.000s)
[309.689431] [051/133] (709s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[309.780580] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[309.783004] Starting dynamic subtest: pipe-A-eDP-1
[310.242777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[310.254005] Starting dynamic subtest: pipe-B-eDP-1
[311.686895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[311.698030] Starting dynamic subtest: pipe-C-eDP-1
[313.103703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s)
[313.114653] Starting dynamic subtest: pipe-D-eDP-1
[314.452588] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[314.454883] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.642s)
[315.618107] [052/133] (703s left) gem_userptr_blits (sync-unmap-after-close)
[315.694974] Starting subtest: sync-unmap-after-close
[315.707340] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[315.832631] [053/133] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[315.924969] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[315.929828] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[316.022225] [054/133] (703s left) gem_exec_async (forked-writes)
[316.089065] Starting subtest: forked-writes
[316.091704] Starting dynamic subtest: rcs0
[316.115636] Dynamic subtest rcs0: SUCCESS (0.026s)
[316.127860] Starting dynamic subtest: bcs0
[316.140605] Dynamic subtest bcs0: SUCCESS (0.023s)
[316.151127] Starting dynamic subtest: vcs0
[316.162320] Dynamic subtest vcs0: SUCCESS (0.021s)
[316.177809] Starting dynamic subtest: vcs1
[316.193597] Dynamic subtest vcs1: SUCCESS (0.029s)
[316.203788] Starting dynamic subtest: vecs0
[316.215978] Dynamic subtest vecs0: SUCCESS (0.021s)
[316.227267] Starting dynamic subtest: ccs0
[316.236011] Dynamic subtest ccs0: SUCCESS (0.020s)
[316.238816] Subtest forked-writes: SUCCESS (0.147s)
[316.467268] [055/133] (702s left) gem_userptr_blits (process-exit-busy)
[316.533483] Starting subtest: process-exit-busy
[316.544305] Subtest process-exit-busy: SUCCESS (0.013s)
[316.701348] [056/133] (702s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[316.765660] Subtest no-spare-fences-busy: SKIP (0.000s)
[316.833361] [057/133] (702s left) kms_flip (busy-flip)
[316.939759] Starting subtest: busy-flip
[316.942257] Starting dynamic subtest: A-eDP1
[318.635246] Dynamic subtest A-eDP1: SUCCESS (1.698s)
[318.647056] Starting dynamic subtest: B-eDP1
[320.279692] Dynamic subtest B-eDP1: SUCCESS (1.643s)
[320.291594] Starting dynamic subtest: C-eDP1
[321.937554] Dynamic subtest C-eDP1: SUCCESS (1.634s)
[321.947516] Starting dynamic subtest: D-eDP1
[323.557387] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[323.559863] Subtest busy-flip: SUCCESS (6.627s)
[324.724462] [058/133] (694s left) vgem_basic (sysfs)
[324.783012] Starting subtest: sysfs
[324.785496] Subtest sysfs: SUCCESS (0.000s)
[324.841550] [059/133] (694s left) gem_exec_balancer (parallel-contexts)
[325.103336] Starting subtest: parallel-contexts
[327.836725] Subtest parallel-contexts: SUCCESS (2.735s)
[328.814189] [060/133] (690s left) api_intel_allocator (fork-simple-stress)
[328.884316] Starting subtest: fork-simple-stress
[334.330999] Subtest fork-simple-stress: SUCCESS (5.397s)
[334.383862] [061/133] (685s left) gem_vm_create (execbuf)
[334.450979] Starting subtest: execbuf
[334.465633] Subtest execbuf: SUCCESS (0.015s)
[334.592641] [062/133] (684s left) gem_ctx_isolation (dirty-create)
[334.650846] Starting subtest: dirty-create
[334.653701] Starting dynamic subtest: rcs0
[334.931632] Dynamic subtest rcs0: SUCCESS (0.281s)
[334.943720] Starting dynamic subtest: bcs0
[335.208306] Dynamic subtest bcs0: SUCCESS (0.276s)
[335.220007] Starting dynamic subtest: vcs0
[335.456888] Dynamic subtest vcs0: SUCCESS (0.248s)
[335.467859] Starting dynamic subtest: vcs1
[337.048387] Dynamic subtest vcs1: SUCCESS (1.590s)
[337.061482] Starting dynamic subtest: vecs0
[339.007990] Dynamic subtest vecs0: SUCCESS (1.958s)
[339.018030] Starting dynamic subtest: ccs0
[341.000851] Dynamic subtest ccs0: SUCCESS (1.993s)
[341.003832] Subtest dirty-create: SUCCESS (6.353s)
[341.239473] [063/133] (678s left) api_intel_bb (intel-bb-blit-none)
[341.292900] Starting subtest: intel-bb-blit-none
[345.420705] Subtest intel-bb-blit-none: SUCCESS (4.127s)
[345.532635] [064/133] (674s left) kms_psr (pr-sprite-render)
[345.631719] Starting subtest: pr-sprite-render
[345.636843] Subtest pr-sprite-render: SKIP (0.000s)
[345.708372] [065/133] (674s left) gem_userptr_blits (sync-unmap-cycles)
[345.769615] Starting subtest: sync-unmap-cycles
[351.136573] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[351.269005] [066/133] (668s left) gem_pxp (reject-modify-context-protection-off-3)
[351.388825] Starting subtest: reject-modify-context-protection-off-3
[351.391556] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[351.514245] [067/133] (668s left) gem_render_copy_redux (interruptible)
[351.569374] Starting subtest: interruptible
[351.998295] Subtest interruptible: SUCCESS (0.431s)
[352.117884] [068/133] (667s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[352.231705] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[352.235712] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[352.321433] [069/133] (667s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[352.421417] Starting subtest: fbc-psr2-sprite-mmap-gtt
[352.423631] Starting dynamic subtest: eDP-1
[352.427740] Dynamic subtest eDP-1: SKIP (0.000s)
[352.432273] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[352.497320] [070/133] (667s left) kms_content_protection (dp-mst-type-1)
[352.648781] Starting subtest: dp-mst-type-1
[352.652672] Subtest dp-mst-type-1: SKIP (0.000s)
[352.779791] [071/133] (667s left) gem_workarounds (reset-fd)
[352.844374] Starting subtest: reset-fd
[353.027196] Subtest reset-fd: SUCCESS (0.182s)
[353.136958] [072/133] (666s left) fbdev (write)
[353.176636] Starting subtest: write
[353.667389] Subtest write: SUCCESS (0.491s)
[353.737807] [073/133] (666s left) kms_chamelium_frames (dp-crc-multiple)
[354.142112] Subtest dp-crc-multiple: SKIP (0.000s)
[354.932684] [074/133] (665s left) kms_lease (lease-invalid-crtc)
[355.020656] Starting subtest: lease-invalid-crtc
[355.023372] Starting dynamic subtest: pipe-A-eDP-1
[355.025997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[355.036904] Starting dynamic subtest: pipe-B-eDP-1
[355.039668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[355.051887] Starting dynamic subtest: pipe-C-eDP-1
[355.054353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[355.064612] Starting dynamic subtest: pipe-D-eDP-1
[355.066997] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[355.069500] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[355.110549] [075/133] (665s left) kms_properties (crtc-properties-atomic)
[355.206018] Starting subtest: crtc-properties-atomic
[355.208259] Starting dynamic subtest: pipe-A-eDP-1
[355.656157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[355.667624] Starting dynamic subtest: pipe-B-eDP-1
[356.823869] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[356.835783] Starting dynamic subtest: pipe-C-eDP-1
[357.943255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[357.955014] Starting dynamic subtest: pipe-D-eDP-1
[359.070979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[359.073757] Subtest crtc-properties-atomic: SUCCESS (3.865s)
[359.882935] [076/133] (660s left) kms_chamelium_color (ctm-0-75)
[359.976348] Subtest ctm-0-75: SKIP (0.000s)
[360.022369] [077/133] (660s left) gem_exec_parallel (userptr)
[360.086928] Starting subtest: userptr
[360.089821] Starting dynamic subtest: rcs0
[361.792485] Dynamic subtest rcs0: SUCCESS (1.704s)
[361.805109] Starting dynamic subtest: bcs0
[363.504573] Dynamic subtest bcs0: SUCCESS (1.711s)
[363.515177] Starting dynamic subtest: vcs0
[366.769289] Dynamic subtest vcs0: SUCCESS (3.261s)
[366.782042] Starting dynamic subtest: vcs1
[368.752673] Dynamic subtest vcs1: SUCCESS (1.980s)
[368.766174] Starting dynamic subtest: vecs0
[370.736919] Dynamic subtest vecs0: SUCCESS (1.982s)
[370.748136] Starting dynamic subtest: ccs0
[372.568584] Dynamic subtest ccs0: SUCCESS (1.829s)
[372.572132] Subtest userptr: SUCCESS (12.481s)
[372.784302] [078/133] (647s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[372.885953] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[372.911288] Starting dynamic subtest: pipe-A-plane-0
[373.377386] Dynamic subtest pipe-A-plane-0: SUCCESS (0.466s)
[373.387635] Starting dynamic subtest: pipe-A-plane-3
[373.632733] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[373.643166] Starting dynamic subtest: pipe-A-plane-5
[373.650542] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[374.767164] Starting dynamic subtest: pipe-B-plane-0
[375.203432] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[375.213977] Starting dynamic subtest: pipe-B-plane-3
[375.458976] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[375.468987] Starting dynamic subtest: pipe-B-plane-5
[375.473320] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[375.771887] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.886s)
[376.640802] [079/133] (643s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[376.749590] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[376.754604] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[376.819044] [080/133] (643s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[376.918255] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[378.052888] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.134s)
[378.164501] [081/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[378.259886] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[378.264364] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[378.351958] [082/133] (642s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[378.447821] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[378.452241] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[378.540470] [083/133] (642s left) kms_color (ctm-max)
[378.655068] Starting subtest: ctm-max
[378.657213] Starting dynamic subtest: pipe-A-eDP-1
[379.385856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[379.397872] Starting dynamic subtest: pipe-B-eDP-1
[380.775111] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[380.786320] Starting dynamic subtest: pipe-C-eDP-1
[382.150116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[382.160997] Starting dynamic subtest: pipe-D-eDP-1
[383.480446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[383.482741] Subtest ctm-max: SUCCESS (4.825s)
[384.284208] [084/133] (636s left) kms_cursor_crc (cursor-onscreen-128x128)
[384.501618] Starting subtest: cursor-onscreen-128x128
[384.504455] Starting dynamic subtest: pipe-A-eDP-1
[386.633668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[386.668806] Starting dynamic subtest: pipe-D-eDP-1
[389.533917] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s)
[389.536834] Subtest cursor-onscreen-128x128: SUCCESS (5.032s)
[390.357907] [085/133] (630s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[390.473616] Starting subtest: multiplane-rotation-cropping-bottom
[408.115912] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.649s)
[408.237903] [086/133] (612s left) gem_exec_params (sol-reset-invalid)
[408.299961] Starting subtest: sol-reset-invalid
[408.305300] Subtest sol-reset-invalid: SUCCESS (0.003s)
[409.893875] [087/133] (610s left) gem_eio (reset-stress)
[410.122507] Starting subtest: reset-stress
[410.124960] Starting dynamic subtest: render
[415.275917] Dynamic subtest render: SUCCESS (5.152s)
[415.287681] Starting dynamic subtest: bsd1
[433.330306] Dynamic subtest bsd1: SUCCESS (18.057s)
[433.348036] Starting dynamic subtest: bsd2
[451.348929] Dynamic subtest bsd2: SUCCESS (18.021s)
[451.362056] Starting dynamic subtest: blt
[451.371047] Dynamic subtest blt: SKIP (0.000s)
[451.382586] Starting dynamic subtest: vebox
[469.399620] Dynamic subtest vebox: SUCCESS (18.051s)
[469.401844] Subtest reset-stress: SUCCESS (59.290s)
[470.815138] [088/133] (549s left) gem_softpin (reverse)
[470.892905] Starting subtest: reverse
[470.898383] Subtest reverse: SUCCESS (0.005s)
[471.008713] [089/133] (549s left) perf_pmu (multi-client)
[471.057018] Starting subtest: multi-client
[471.059582] Starting dynamic subtest: rcs0
[472.116933] Dynamic subtest rcs0: SUCCESS (1.058s)
[472.129072] Starting dynamic subtest: bcs0
[473.171836] Dynamic subtest bcs0: SUCCESS (1.051s)
[473.183999] Starting dynamic subtest: vcs0
[474.226173] Dynamic subtest vcs0: SUCCESS (1.051s)
[474.239826] Starting dynamic subtest: vcs1
[475.819193] Dynamic subtest vcs1: SUCCESS (1.589s)
[475.832877] Starting dynamic subtest: vecs0
[477.799205] Dynamic subtest vecs0: SUCCESS (1.977s)
[477.813171] Starting dynamic subtest: ccs0
[479.784861] Dynamic subtest ccs0: SUCCESS (1.982s)
[479.788009] Subtest multi-client: SUCCESS (8.726s)
[479.906161] [090/133] (540s left) gem_mmap (bad-object)
[479.956825] Subtest bad-object: SKIP (0.000s)
[480.015874] [091/133] (540s left) i915_drm_fdinfo (memory-info-purgeable)
[480.061070] Starting subtest: memory-info-purgeable
[480.063981] Starting dynamic subtest: smem0
[482.627635] Dynamic subtest smem0: SUCCESS (2.569s)
[482.630209] Subtest memory-info-purgeable: SUCCESS (2.570s)
[482.703935] [092/133] (538s left) gem_tiled_partial_pwrite_pread (writes)
[482.772255] Subtest writes: SKIP (0.000s)
[482.848810] [093/133] (538s left) kms_joiner (basic-force-big-joiner)
[482.955126] Starting subtest: basic-force-big-joiner
[482.958632] Subtest basic-force-big-joiner: SKIP (0.000s)
[483.026380] [094/133] (537s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[483.114680] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[483.118859] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[483.192572] [095/133] (537s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[483.294698] Starting subtest: y-tiled-8bpp-rotate-180
[483.298808] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[483.402800] [096/133] (537s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[483.498688] Starting subtest: psr-rgb565-draw-blt
[490.610903] Subtest psr-rgb565-draw-blt: SUCCESS (7.113s)
[490.705007] [097/133] (530s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[490.805032] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[497.470066] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.666s)
[497.622375] [098/133] (523s left) gen3_render_mixed_blits
[497.741271] [099/133] (523s left) kms_vblank (wait-forked-hang)
[497.834046] Starting subtest: wait-forked-hang
[497.836446] Starting dynamic subtest: pipe-A-eDP-1
[524.591327] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.754s)
[524.608897] Starting dynamic subtest: pipe-D-eDP-1
[549.553749] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s)
[549.556821] Subtest wait-forked-hang: SUCCESS (51.717s)
[550.360423] [100/133] (470s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[550.449685] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[550.452362] Starting dynamic subtest: pipe-A
[550.473538] Dynamic subtest pipe-A: SKIP (0.019s)
[550.485145] Starting dynamic subtest: pipe-B
[550.506915] Dynamic subtest pipe-B: SKIP (0.031s)
[550.517994] Starting dynamic subtest: pipe-C
[550.536847] Dynamic subtest pipe-C: SKIP (0.030s)
[550.547879] Starting dynamic subtest: pipe-D
[550.566976] Dynamic subtest pipe-D: SKIP (0.030s)
[550.572406] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.113s)
[550.661189] [101/133] (470s left) perf_pmu (all-busy-check-all)
[550.710692] Starting subtest: all-busy-check-all
[551.793189] Subtest all-busy-check-all: SUCCESS (1.081s)
[551.914754] [102/133] (469s left) syncobj_timeline (host-signal-points)
[551.976775] Starting subtest: host-signal-points
[551.979817] Subtest host-signal-points: SUCCESS (0.004s)
[552.107540] [103/133] (469s left) kms_fbcon_fbt (fbc-suspend)
[552.169279] Starting subtest: fbc-suspend
[601.889932] Subtest fbc-suspend: SUCCESS (19.430s)
[603.215797] [104/133] (418s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[603.345613] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[610.205364] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.948s)
[610.341762] [105/133] (411s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[610.436281] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[610.440954] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[610.528497] [106/133] (411s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[610.630738] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[610.635819] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[610.725426] [107/133] (410s left) kms_flip (flip-vs-fences-interruptible)
[610.818371] Starting subtest: flip-vs-fences-interruptible
[610.822942] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[610.918512] [108/133] (410s left) kms_plane (plane-position-hole)
[611.005618] Starting subtest: plane-position-hole
[611.535070] Starting dynamic subtest: pipe-A-plane-1
[612.833685] Dynamic subtest pipe-A-plane-1: SUCCESS (1.305s)
[612.845510] Starting dynamic subtest: pipe-A-plane-2
[614.160636] Dynamic subtest pipe-A-plane-2: SUCCESS (1.335s)
[614.172530] Starting dynamic subtest: pipe-A-plane-3
[615.384868] Dynamic subtest pipe-A-plane-3: SUCCESS (1.228s)
[615.400696] Starting dynamic subtest: pipe-A-plane-4
[616.656004] Dynamic subtest pipe-A-plane-4: SUCCESS (1.277s)
[616.668286] Starting dynamic subtest: pipe-A-plane-5
[616.684817] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[617.873719] Starting dynamic subtest: pipe-B-plane-1
[619.120203] Dynamic subtest pipe-B-plane-1: SUCCESS (1.259s)
[619.132271] Starting dynamic subtest: pipe-B-plane-2
[620.459227] Dynamic subtest pipe-B-plane-2: SUCCESS (1.344s)
[620.471883] Starting dynamic subtest: pipe-B-plane-3
[621.764844] Dynamic subtest pipe-B-plane-3: SUCCESS (1.307s)
[621.777611] Starting dynamic subtest: pipe-B-plane-4
[623.074921] Dynamic subtest pipe-B-plane-4: SUCCESS (1.313s)
[623.086787] Starting dynamic subtest: pipe-B-plane-5
[623.109459] Dynamic subtest pipe-B-plane-5: SUCCESS (0.031s)
[623.111942] Subtest plane-position-hole: SUCCESS (12.150s)
[623.892714] [109/133] (397s left) i915_pm_rpm (gem-evict-pwrite)
[625.624609] Starting subtest: gem-evict-pwrite
[625.629574] Subtest gem-evict-pwrite: SKIP (0.000s)
[626.118504] [110/133] (395s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[626.172841] Starting subtest: etime-multi-wait-all-available-unsubmitted
[626.277028] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[626.356138] [111/133] (395s left) gem_exec_schedule (u-semaphore-resolve)
[626.425566] Starting subtest: u-semaphore-resolve
[626.458119] Subtest u-semaphore-resolve: SUCCESS (0.040s)
[626.792325] [112/133] (395s left) syncobj_timeline (signal-array)
[626.851868] Starting subtest: signal-array
[626.854381] Subtest signal-array: SUCCESS (0.000s)
[626.947319] [113/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[627.046727] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[627.052660] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[627.138353] [114/133] (394s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[627.232860] Starting subtest: yf-tiled-16bpp-rotate-0
[627.237731] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[627.338625] [115/133] (394s left) i915_selftest (perf)
[629.084739] Starting subtest: perf
[629.087154] Starting dynamic subtest: engine_cs
[632.706548] Dynamic subtest engine_cs: SUCCESS (3.620s)
[632.716939] Starting dynamic subtest: request
[640.859961] Dynamic subtest request: SUCCESS (8.147s)
[640.875597] Starting dynamic subtest: migrate
[644.604197] Dynamic subtest migrate: SUCCESS (3.742s)
[644.613386] Starting dynamic subtest: region
[649.714796] Dynamic subtest region: SUCCESS (5.108s)
[649.717923] Subtest perf: SUCCESS (20.622s)
[649.748614] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[649.749459] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[649.753628] [116/133] (372s left) kms_panel_fitting (legacy)
[652.222298] Starting subtest: legacy
[652.225074] Starting dynamic subtest: pipe-A-eDP-1
[652.816982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[652.845178] Starting dynamic subtest: pipe-B-eDP-1
[654.428205] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[654.454642] Starting dynamic subtest: pipe-C-eDP-1
[656.034662] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.587s)
[656.059953] Starting dynamic subtest: pipe-D-eDP-1
[657.694364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.639s)
[657.696626] Subtest legacy: SUCCESS (5.474s)
[658.847220] [FACT kms_panel_fitting (legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[658.848558] [FACT kms_panel_fitting (legacy)] new: kernel.kmod_is_loaded.i915: true
[658.852716] [117/133] (363s left) gem_ctx_persistence (legacy-engines-mixed)
[658.912020] Starting subtest: legacy-engines-mixed
[658.914913] Starting dynamic subtest: render
[658.985835] Dynamic subtest render: SUCCESS (0.069s)
[658.997977] Starting dynamic subtest: bsd1
[659.026977] Dynamic subtest bsd1: SUCCESS (0.042s)
[659.036821] Starting dynamic subtest: bsd2
[659.078678] Dynamic subtest bsd2: SUCCESS (0.050s)
[659.094966] Starting dynamic subtest: blt
[659.131189] Dynamic subtest blt: SUCCESS (0.049s)
[659.142937] Starting dynamic subtest: vebox
[659.181159] Dynamic subtest vebox: SUCCESS (0.048s)
[659.183874] Subtest legacy-engines-mixed: SUCCESS (0.270s)
[659.272940] [118/133] (362s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[659.367259] Starting subtest: 4-tiled-8bpp-rotate-270
[659.391111] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[659.513352] [119/133] (362s left) kms_busy (extended-modeset-hang-newfb)
[659.609400] Starting subtest: extended-modeset-hang-newfb
[659.611942] Starting dynamic subtest: pipe-A
[694.435725] Dynamic subtest pipe-A: SUCCESS (34.836s)
[694.446916] Starting dynamic subtest: pipe-D
[717.395884] Dynamic subtest pipe-D: SUCCESS (22.949s)
[717.398454] Subtest extended-modeset-hang-newfb: SUCCESS (57.790s)
[718.198354] [120/133] (304s left) kms_mmap_write_crc (main)
[718.296738] Starting subtest: main
[718.299390] Starting dynamic subtest: pipe-A-eDP-1
[721.801251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[721.803642] Subtest main: SUCCESS (3.505s)
[722.638616] [121/133] (299s left) syncobj_wait (multi-wait-submitted-signaled)
[722.686697] Starting subtest: multi-wait-submitted-signaled
[722.689403] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[722.772272] [122/133] (299s left) i915_hangman (engine-engine-error)
[722.832458] Starting subtest: engine-engine-error
[722.834724] Starting dynamic subtest: rcs0
[724.474728] Dynamic subtest rcs0: SUCCESS (1.642s)
[724.489431] Starting dynamic subtest: bcs0
[726.455279] Dynamic subtest bcs0: SUCCESS (1.977s)
[726.468956] Starting dynamic subtest: vcs0
[728.438749] Dynamic subtest vcs0: SUCCESS (1.981s)
[728.451972] Starting dynamic subtest: vcs1
[730.487982] Dynamic subtest vcs1: SUCCESS (2.046s)
[730.501725] Starting dynamic subtest: vecs0
[732.470864] Dynamic subtest vecs0: SUCCESS (1.980s)
[732.490998] Starting dynamic subtest: ccs0
[734.454264] Dynamic subtest ccs0: SUCCESS (1.980s)
[734.457425] Subtest engine-engine-error: SUCCESS (11.624s)
[734.580030] [123/133] (287s left) gem_readwrite (read-bad-handle)
[734.640786] Subtest read-bad-handle: SKIP (0.000s)
[734.702834] [124/133] (287s left) gem_mmap_gtt (fault-concurrent-x)
[734.764798] Subtest fault-concurrent-X: SKIP (0.000s)
[734.832955] [125/133] (287s left) kms_prime (basic-modeset-hybrid)
[734.944945] Subtest basic-modeset-hybrid: SKIP (0.000s)
[735.056707] [126/133] (287s left) gem_lmem_swapping (massive-random)
[735.111720] Subtest massive-random: SKIP (0.000s)
[735.159258] [127/133] (287s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[735.539491] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[736.352482] [128/133] (286s left) kms_pm_backlight (fade-with-suspend)
[736.446490] Starting subtest: fade-with-suspend
[752.811017] Starting dynamic subtest: eDP-1
[755.842857] Dynamic subtest eDP-1: SUCCESS (3.027s)
[755.845646] Subtest fade-with-suspend: SUCCESS (4.996s)
[756.650467] [129/133] (265s left) kms_async_flips (async-flip-suspend-resume)
[756.745462] Starting subtest: async-flip-suspend-resume
[757.132362] Starting dynamic subtest: pipe-A-eDP-1
[774.820766] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.713s)
[775.305834] Starting dynamic subtest: pipe-B-eDP-1
[792.831096] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.037s)
[793.247160] Starting dynamic subtest: pipe-C-eDP-1
[810.824380] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.859s)
[811.183451] Starting dynamic subtest: pipe-D-eDP-1
[828.842599] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.934s)
[828.845255] Subtest async-flip-suspend-resume: SUCCESS (14.169s)
[830.027758] [130/133] (192s left) kms_sequence (get-idle)
[830.133909] Starting subtest: get-idle
[830.136387] Starting dynamic subtest: pipe-A-eDP-1
[831.948577] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[831.959120] Starting dynamic subtest: pipe-B-eDP-1
[834.403869] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.447s)
[834.416079] Starting dynamic subtest: pipe-C-eDP-1
[836.823098] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[836.834037] Starting dynamic subtest: pipe-D-eDP-1
[839.275002] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[839.277318] Subtest get-idle: SUCCESS (9.121s)
[840.075864] [131/133] (182s left) kms_psr (psr2-cursor-plane-move)
[840.164432] Starting subtest: psr2-cursor-plane-move
[840.166765] Starting dynamic subtest: eDP-1
[841.855643] Dynamic subtest eDP-1: SUCCESS (1.688s)
[841.858140] Subtest psr2-cursor-plane-move: SUCCESS (1.689s)
[842.751644] [132/133] (179s left) kms_dsc (dsc-with-output-formats-with-bpc)
[842.851909] Starting subtest: dsc-with-output-formats-with-bpc
[842.912242] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s)
[842.953416] [133/133] (179s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[843.008620] Starting subtest: y-tiled-to-vebox-yf-tiled
[843.014213] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[843.192071] 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.