[59.185496] Initializing watchdogs
[59.185540]   /dev/watchdog0
[59.199525] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.203859] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.205987] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.209919] [001/133] (960s left) kms_addfb_basic (bad-pitch-32)
[59.286887] Starting subtest: bad-pitch-32
[59.289112] Subtest bad-pitch-32: SUCCESS (0.000s)
[59.409471] [002/133] (960s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[59.494212] Starting subtest: psr2-cursor-plane-move-continuous-sf
[59.496471] Starting dynamic subtest: pipe-A-eDP-1
[69.869428] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.422s)
[69.882145] Starting dynamic subtest: pipe-B-eDP-1
[80.911325] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.049s)
[80.913709] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.473s)
[81.705712] [003/133] (938s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[81.792386] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[81.797445] Starting dynamic subtest: pipe-A-eDP-1
[81.826789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[81.834804] Starting dynamic subtest: pipe-B-eDP-1
[81.853281] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[81.859841] Starting dynamic subtest: pipe-C-eDP-1
[81.879321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[81.885979] Starting dynamic subtest: pipe-D-eDP-1
[81.906161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[81.908296] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[84.056837] [004/133] (935s left) gem_sync (basic-all)
[84.139228] Starting subtest: basic-all
[87.296319] Subtest basic-all: SUCCESS (3.166s)
[87.493623] [005/133] (932s left) gem_ctx_create (basic-files)
[87.552459] Starting subtest: basic-files
[89.562321] Subtest basic-files: SUCCESS (2.009s)
[89.994873] [006/133] (929s left) kms_plane (pixel-format-4-tiled-modifier)
[90.078798] Starting subtest: pixel-format-4-tiled-modifier
[90.105478] Starting dynamic subtest: pipe-A-plane-0
[90.685563] Dynamic subtest pipe-A-plane-0: SUCCESS (0.578s)
[90.694875] Starting dynamic subtest: pipe-A-plane-3
[91.116154] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[91.122903] Starting dynamic subtest: pipe-A-plane-5
[91.126450] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[92.246690] Starting dynamic subtest: pipe-B-plane-0
[92.859364] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[92.869412] Starting dynamic subtest: pipe-B-plane-3
[93.292528] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[93.301057] Starting dynamic subtest: pipe-B-plane-5
[93.304799] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[93.601257] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.522s)
[94.409730] [007/133] (925s left) kms_dirtyfb (default-dirtyfb-ioctl)
[94.481072] Starting subtest: default-dirtyfb-ioctl
[94.483575] Starting dynamic subtest: A-eDP-1
[96.078735] Dynamic subtest A-eDP-1: SUCCESS (1.598s)
[96.081047] Subtest default-dirtyfb-ioctl: SUCCESS (1.599s)
[96.949411] [008/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[97.045565] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[100.621509] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.582s)
[101.755562] [009/133] (918s left) gem_ppgtt (shrink-vs-evict-pinned)
[101.814837] Starting subtest: shrink-vs-evict-pinned
[107.824444] Subtest shrink-vs-evict-pinned: SUCCESS (6.009s)
[107.904918] [010/133] (912s left) gem_exec_balancer (bonded-false-hang)
[108.159219] Starting subtest: bonded-false-hang
[108.163645] Subtest bonded-false-hang: SKIP (0.000s)
[108.251339] [011/133] (911s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[108.328626] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[108.331185] Starting dynamic subtest: pipe-A
[108.390461] Dynamic subtest pipe-A: SUCCESS (0.066s)
[108.399662] Starting dynamic subtest: pipe-B
[109.575874] Dynamic subtest pipe-B: SUCCESS (1.185s)
[109.590344] Starting dynamic subtest: pipe-C
[110.685583] Dynamic subtest pipe-C: SUCCESS (1.108s)
[110.694979] Starting dynamic subtest: pipe-D
[111.818328] Dynamic subtest pipe-D: SUCCESS (1.133s)
[111.820466] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.494s)
[112.983106] [012/133] (907s left) api_intel_allocator (alloc-simple)
[113.044827] Starting subtest: alloc-simple
[113.047179] Subtest alloc-simple: SUCCESS (0.004s)
[113.159216] [013/133] (906s left) gem_exec_store (dword)
[113.223431] Starting subtest: dword
[113.225846] Starting dynamic subtest: rcs0
[113.294821] Dynamic subtest rcs0: SUCCESS (0.073s)
[113.305476] Starting dynamic subtest: bcs0
[113.337713] Dynamic subtest bcs0: SUCCESS (0.042s)
[113.346798] Starting dynamic subtest: vcs0
[113.379889] Dynamic subtest vcs0: SUCCESS (0.041s)
[113.389223] Starting dynamic subtest: vcs1
[113.423552] Dynamic subtest vcs1: SUCCESS (0.043s)
[113.433232] Starting dynamic subtest: vecs0
[113.466432] Dynamic subtest vecs0: SUCCESS (0.042s)
[113.475627] Starting dynamic subtest: ccs0
[113.509719] Dynamic subtest ccs0: SUCCESS (0.042s)
[113.512521] Subtest dword: SUCCESS (0.289s)
[113.706862] [014/133] (906s left) gem_softpin (allocator-evict)
[113.767608] Starting subtest: allocator-evict
[113.769941] Starting dynamic subtest: rcs0
[137.053639] Dynamic subtest rcs0: SUCCESS (23.284s)
[137.063349] Starting dynamic subtest: bcs0
[161.163084] Dynamic subtest bcs0: SUCCESS (24.107s)
[161.171455] Starting dynamic subtest: vcs0
[184.996844] Dynamic subtest vcs0: SUCCESS (23.831s)
[185.005611] Starting dynamic subtest: vcs1
[208.662754] Dynamic subtest vcs1: SUCCESS (23.665s)
[208.671295] Starting dynamic subtest: vecs0
[232.521479] Dynamic subtest vecs0: SUCCESS (23.857s)
[232.534022] Starting dynamic subtest: ccs0
[256.432074] Dynamic subtest ccs0: SUCCESS (23.909s)
[256.434378] Subtest allocator-evict: SUCCESS (142.657s)
[256.508272] [015/133] (763s left) gem_exec_flush (basic-wb-prw-default)
[256.605403] Starting subtest: basic-wb-prw-default
[262.059199] Subtest basic-wb-prw-default: SUCCESS (5.453s)
[262.244265] [016/133] (758s left) kms_flip (flip-vs-suspend)
[262.336282] Starting subtest: flip-vs-suspend
[262.338253] Starting dynamic subtest: A-eDP1
[312.135065] Dynamic subtest A-eDP1: SUCCESS (4.820s)
[312.149421] Starting dynamic subtest: B-eDP1
[361.122011] Dynamic subtest B-eDP1: SUCCESS (4.614s)
[361.130492] Starting dynamic subtest: C-eDP1
[410.118179] Dynamic subtest C-eDP1: SUCCESS (4.561s)
[410.126883] Starting dynamic subtest: D-eDP1
[459.164145] Dynamic subtest D-eDP1: SUCCESS (4.714s)
[459.170184] Subtest flip-vs-suspend: SUCCESS (18.717s)
[460.318633] [017/133] (559s left) kms_psr (psr-primary-mmap-gtt)
[460.410926] Starting subtest: psr-primary-mmap-gtt
[460.413264] Starting dynamic subtest: eDP-1
[461.808873] Dynamic subtest eDP-1: SKIP (1.406s)
[461.814354] Subtest psr-primary-mmap-gtt: SKIP (1.408s)
[461.963169] [018/133] (558s left) kms_atomic (atomic-plane-damage)
[462.036070] Starting subtest: atomic-plane-damage
[462.087446] Starting dynamic subtest: pipe-A-eDP-1
[462.654042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[462.656706] Subtest atomic-plane-damage: SUCCESS (0.621s)
[463.471492] [019/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[463.556800] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[463.561648] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[463.645428] [020/133] (556s left) syncobj_timeline (multi-wait-available-signaled)
[463.719009] Starting subtest: multi-wait-available-signaled
[463.721683] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[463.805103] [021/133] (556s left) kms_rmfb (close-fd)
[463.877253] Starting subtest: close-fd
[463.879425] Starting dynamic subtest: pipe-A-eDP-1
[463.986430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[463.996217] Starting dynamic subtest: pipe-B-eDP-1
[465.137290] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[465.147322] Starting dynamic subtest: pipe-C-eDP-1
[466.346217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[466.355890] Starting dynamic subtest: pipe-D-eDP-1
[467.705150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.365s)
[467.707456] Subtest close-fd: SUCCESS (3.847s)
[468.909831] [022/133] (551s left) kms_vblank (wait-forked)
[468.989354] Starting subtest: wait-forked
[468.992042] Starting dynamic subtest: pipe-A-eDP-1
[470.810161] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[470.825185] Starting dynamic subtest: pipe-D-eDP-1
[473.302969] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.498s)
[473.305404] Subtest wait-forked: SUCCESS (4.326s)
[474.150700] [023/133] (546s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[474.225775] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[474.228111] Starting dynamic subtest: pipe-A-eDP-1
[474.255268] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[474.264656] Starting dynamic subtest: pipe-B-eDP-1
[474.288840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[474.297717] Starting dynamic subtest: pipe-C-eDP-1
[474.325200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[474.334268] Starting dynamic subtest: pipe-D-eDP-1
[474.363190] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[474.368270] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[476.411310] [024/133] (544s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[476.478264] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[476.538014] [025/133] (544s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[476.597241] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[476.664000] [026/133] (544s left) i915_pm_rc6_residency (rc6-accuracy)
[476.716269] Starting subtest: rc6-accuracy
[476.719196] Starting dynamic subtest: gt0
[479.886590] Dynamic subtest gt0: SUCCESS (3.172s)
[479.897454] Starting dynamic subtest: gt1
[483.057092] Dynamic subtest gt1: SUCCESS (3.171s)
[483.060251] Subtest rc6-accuracy: SUCCESS (6.348s)
[483.140072] [027/133] (537s left) gem_exec_params (no-bsd)
[483.194799] Starting subtest: no-bsd
[483.201232] Subtest no-bsd: SUCCESS (0.005s)
[485.309930] [028/133] (535s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[485.367594] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[485.373063] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[485.574610] [029/133] (535s left) kms_chamelium_hpd (dp-hpd)
[485.938328] Subtest dp-hpd: SKIP (0.000s)
[486.711272] [030/133] (534s left) gem_ctx_persistence (engines-hostile-preempt)
[486.770589] Starting subtest: engines-hostile-preempt
[486.772971] Starting dynamic subtest: rcs0
[486.855436] Dynamic subtest rcs0: SUCCESS (0.086s)
[486.867214] Starting dynamic subtest: bcs0
[486.900421] Dynamic subtest bcs0: SUCCESS (0.043s)
[486.910863] Starting dynamic subtest: vcs0
[488.264877] Dynamic subtest vcs0: SUCCESS (1.363s)
[488.276930] Starting dynamic subtest: vcs1
[490.228461] Dynamic subtest vcs1: SUCCESS (1.962s)
[490.239365] Starting dynamic subtest: vecs0
[492.231141] Dynamic subtest vecs0: SUCCESS (2.002s)
[492.243117] Starting dynamic subtest: ccs0
[492.294668] Dynamic subtest ccs0: SUCCESS (0.063s)
[492.297412] Subtest engines-hostile-preempt: SUCCESS (5.530s)
[492.387888] [031/133] (528s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[492.478206] Starting subtest: 4-tiled-64bpp-rotate-90
[492.497585] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[492.608829] [032/133] (528s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[492.674416] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[492.733134] [033/133] (528s left) kms_color (ctm-blue-to-red)
[492.803949] Starting subtest: ctm-blue-to-red
[492.806258] Starting dynamic subtest: pipe-A-eDP-1
[493.497371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[493.506993] Starting dynamic subtest: pipe-B-eDP-1
[494.925405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[494.934449] Starting dynamic subtest: pipe-C-eDP-1
[496.272818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[496.282056] Starting dynamic subtest: pipe-D-eDP-1
[497.628500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[497.631472] Subtest ctm-blue-to-red: SUCCESS (4.829s)
[498.437220] [034/133] (522s left) kms_flip (2x-absolute-wf_vblank)
[498.507400] Starting subtest: 2x-absolute-wf_vblank
[498.517000] Subtest 2x-absolute-wf_vblank: SKIP (0.007s)
[498.595334] [035/133] (522s left) i915_getparams_basic (basic-eu-total)
[498.654326] Starting subtest: basic-eu-total
[498.660064] Subtest basic-eu-total: SUCCESS (0.000s)
[498.734247] [036/133] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[498.818364] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[498.823443] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[498.902187] [037/133] (522s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[499.217074] Starting subtest: cursor-rapid-movement-max-size
[499.224225] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[499.331757] [038/133] (521s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[499.416232] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[499.420683] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[499.507869] [039/133] (521s left) api_intel_bb (delta-check)
[499.565040] Starting subtest: delta-check
[499.568731] Subtest delta-check: SUCCESS (0.006s)
[499.689921] [040/133] (521s left) gem_ctx_persistence (userptr)
[499.743227] Starting subtest: userptr
[499.912434] Subtest userptr: SUCCESS (0.169s)
[500.022890] [041/133] (521s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[500.111146] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[500.115213] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[500.222758] [042/133] (521s left) kms_vblank (invalid)
[500.292299] Starting subtest: invalid
[500.294614] Starting dynamic subtest: pipe-A-eDP-1
[500.701795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[500.704579] Subtest invalid: SUCCESS (0.412s)
[501.586125] [043/133] (519s left) drm_read (short-buffer-block)
[501.709122] Starting subtest: short-buffer-block
[501.712262] Subtest short-buffer-block: SUCCESS (0.000s)
[501.833509] [044/133] (519s left) gem_exec_balancer (persistence)
[502.132445] Starting subtest: persistence
[502.973023] Subtest persistence: SUCCESS (0.870s)
[503.098218] [045/133] (518s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[503.187096] Starting subtest: extended-modeset-hang-newfb-with-reset
[503.189613] Starting dynamic subtest: pipe-A
[518.360733] Dynamic subtest pipe-A: SUCCESS (15.182s)
[518.371732] Starting dynamic subtest: pipe-D
[533.860398] Dynamic subtest pipe-D: SUCCESS (15.505s)
[533.862513] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.691s)
[534.657238] [046/133] (486s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[534.742429] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[534.744794] Starting dynamic subtest: pipe-A-eDP-1
[534.770070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.779408] Starting dynamic subtest: pipe-B-eDP-1
[534.803891] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.812176] Starting dynamic subtest: pipe-C-eDP-1
[534.837077] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.845248] Starting dynamic subtest: pipe-D-eDP-1
[534.870320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.874834] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[537.011305] [047/133] (484s left) i915_drm_fdinfo (memory-info-purgeable)
[537.054463] Starting subtest: memory-info-purgeable
[537.057217] Starting dynamic subtest: smem0
[539.757752] Dynamic subtest smem0: SUCCESS (2.708s)
[539.759721] Subtest memory-info-purgeable: SUCCESS (2.709s)
[539.828838] [048/133] (481s left) kms_properties (plane-properties-legacy)
[539.904945] Starting subtest: plane-properties-legacy
[539.907326] Starting dynamic subtest: pipe-A-eDP-1
[540.452429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[540.463440] Starting dynamic subtest: pipe-B-eDP-1
[541.688826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[541.698155] Starting dynamic subtest: pipe-C-eDP-1
[542.924985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[542.935454] Starting dynamic subtest: pipe-D-eDP-1
[544.160322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[544.162942] Subtest plane-properties-legacy: SUCCESS (4.257s)
[544.970691] [049/133] (476s left) gem_mmap_gtt (basic-small-copy-xy)
[545.037839] Subtest basic-small-copy-XY: SKIP (0.000s)
[545.097583] [050/133] (476s left) kms_psr (pr-primary-mmap-cpu)
[545.173867] Starting subtest: pr-primary-mmap-cpu
[545.179206] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[545.244934] [051/133] (476s left) perf_pmu (invalid-open)
[545.287046] Starting subtest: invalid-open
[545.290053] Subtest invalid-open: SUCCESS (0.000s)
[545.395942] [052/133] (476s left) kms_pm_rpm (modeset-non-lpsp)
[547.398792] Starting subtest: modeset-non-lpsp
[548.544962] Subtest modeset-non-lpsp: SKIP (1.144s)
[548.901805] [053/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[549.004619] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[549.010329] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[549.110321] [054/133] (472s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[549.189994] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[549.198033] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.008s)
[549.288883] [055/133] (472s left) gem_exec_schedule (semaphore-noskip)
[549.366719] Starting subtest: semaphore-noskip
[549.824286] Subtest semaphore-noskip: SUCCESS (0.463s)
[551.284519] [056/133] (470s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[551.355951] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[551.358232] Starting dynamic subtest: pipe-A-eDP-1
[551.367091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[551.375924] Starting dynamic subtest: pipe-B-eDP-1
[551.384994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[551.393591] Starting dynamic subtest: pipe-C-eDP-1
[551.401296] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[551.409543] Starting dynamic subtest: pipe-D-eDP-1
[551.419059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[551.423973] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[553.664941] [057/133] (468s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[553.717254] Starting subtest: invalid-multi-wait-unsubmitted
[553.720239] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[553.815090] [058/133] (468s left) gem_mmap (basic)
[553.868240] Subtest basic: SKIP (0.000s)
[553.930776] [059/133] (468s left) kms_getfb (getfb-handle-valid)
[554.007365] Starting subtest: getfb-handle-valid
[554.010251] Subtest getfb-handle-valid: SUCCESS (0.000s)
[554.115287] [060/133] (467s left) gem_exec_await (wide-contexts)
[554.364361] Starting subtest: wide-contexts
[577.936414] Subtest wide-contexts: SUCCESS (23.586s)
[578.127333] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[578.133347] [061/133] (443s left) gem_mmap_gtt (zero-extend)
[578.234319] Subtest zero-extend: SKIP (0.000s)
[578.293753] [062/133] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[578.382585] Starting subtest: fbcpsr-2p-rte
[578.386790] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[578.470841] [063/133] (443s left) syncobj_basic (bad-destroy-pad)
[578.533425] Starting subtest: bad-destroy-pad
[578.536007] Subtest bad-destroy-pad: SUCCESS (0.000s)
[578.634733] [064/133] (443s left) gem_userptr_blits (coherency-unsync)
[578.706905] Subtest coherency-unsync: SKIP (0.000s)
[578.834340] [065/133] (443s left) kms_flip (2x-flip-vs-dpms)
[578.911419] Starting subtest: 2x-flip-vs-dpms
[578.919108] Subtest 2x-flip-vs-dpms: SKIP (0.007s)
[579.004875] [066/133] (443s left) kms_pipe_crc_basic (nonblocking-crc)
[579.078126] Starting subtest: nonblocking-crc
[579.080081] Starting dynamic subtest: pipe-A-eDP-1
[579.833449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[579.845669] Starting dynamic subtest: pipe-B-eDP-1
[581.262393] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[581.273277] Starting dynamic subtest: pipe-C-eDP-1
[582.652036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[582.663185] Starting dynamic subtest: pipe-D-eDP-1
[584.004263] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.355s)
[584.007244] Subtest nonblocking-crc: SUCCESS (4.931s)
[584.879801] [067/133] (437s left) gem_lmem_swapping (heavy-verify-multi)
[584.946222] Subtest heavy-verify-multi: SKIP (0.000s)
[584.990529] [068/133] (437s left) kms_cursor_crc (cursor-onscreen-128x128)
[585.181435] Starting subtest: cursor-onscreen-128x128
[585.186415] Starting dynamic subtest: pipe-A-eDP-1
[587.317492] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[587.353406] Starting dynamic subtest: pipe-D-eDP-1
[590.050909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s)
[590.053288] Subtest cursor-onscreen-128x128: SUCCESS (4.870s)
[590.844433] [069/133] (431s left) gem_exec_params (cliprects_ptr-dirt)
[590.900460] Starting subtest: cliprects_ptr-dirt
[590.903193] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[591.007273] [070/133] (431s left) syncobj_basic (illegal-fd-to-handle)
[591.052234] Starting subtest: illegal-fd-to-handle
[591.054972] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[591.141401] [071/133] (431s left) gem_mmap_gtt (bad-object)
[591.203262] Subtest bad-object: SKIP (0.000s)
[591.265176] [072/133] (431s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[591.334054] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[591.338715] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[591.408775] [073/133] (431s left) gem_ctx_engines (independent)
[591.468924] Starting subtest: independent
[591.470969] Starting dynamic subtest: rcs0
[591.620652] Dynamic subtest rcs0: SUCCESS (0.153s)
[591.632948] Starting dynamic subtest: bcs0
[591.762542] Dynamic subtest bcs0: SUCCESS (0.141s)
[591.773864] Starting dynamic subtest: vcs0
[591.888105] Dynamic subtest vcs0: SUCCESS (0.125s)
[591.897643] Starting dynamic subtest: vcs1
[592.027360] Dynamic subtest vcs1: SUCCESS (0.138s)
[592.036780] Starting dynamic subtest: vecs0
[592.166288] Dynamic subtest vecs0: SUCCESS (0.137s)
[592.176408] Starting dynamic subtest: ccs0
[592.313803] Dynamic subtest ccs0: SUCCESS (0.146s)
[592.328680] Starting dynamic subtest: all-engines
[592.937686] Dynamic subtest all-engines: SUCCESS (0.623s)
[592.940409] Subtest independent: SUCCESS (1.473s)
[593.435412] [074/133] (429s left) kms_hdr (static-toggle)
[593.518761] Starting subtest: static-toggle
[593.526214] Subtest static-toggle: SKIP (0.000s)
[593.589677] [075/133] (429s left) dumb_buffer (map-invalid-size)
[593.658814] Starting subtest: map-invalid-size
[593.661415] Subtest map-invalid-size: SUCCESS (0.000s)
[593.741822] [076/133] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[593.823045] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[593.828033] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[593.918193] [077/133] (428s left) gem_exec_parallel (basic)
[593.972181] Starting subtest: basic
[593.975172] Starting dynamic subtest: rcs0
[596.415167] Dynamic subtest rcs0: SUCCESS (2.444s)
[596.424579] Starting dynamic subtest: bcs0
[598.209224] Dynamic subtest bcs0: SUCCESS (1.793s)
[598.220326] Starting dynamic subtest: vcs0
[600.269750] Dynamic subtest vcs0: SUCCESS (2.059s)
[600.282843] Starting dynamic subtest: vcs1
[602.252795] Dynamic subtest vcs1: SUCCESS (1.981s)
[602.265331] Starting dynamic subtest: vecs0
[604.237038] Dynamic subtest vecs0: SUCCESS (1.982s)
[604.249002] Starting dynamic subtest: ccs0
[606.047567] Dynamic subtest ccs0: SUCCESS (1.810s)
[606.050416] Subtest basic: SUCCESS (12.082s)
[606.240919] [078/133] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[606.323470] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[606.328480] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[606.414996] [079/133] (416s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[606.470620] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[606.473229] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[606.569713] [080/133] (416s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[606.642361] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[606.645406] Starting dynamic subtest: pipe-A-eDP-1
[607.505421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[607.516018] Starting dynamic subtest: pipe-B-eDP-1
[609.072407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.566s)
[609.083145] Starting dynamic subtest: pipe-C-eDP-1
[610.606270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[610.616840] Starting dynamic subtest: pipe-D-eDP-1
[612.113138] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.507s)
[612.115897] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.466s)
[613.281322] [081/133] (409s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[613.372206] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[613.374899] Starting dynamic subtest: pipe-A
[613.732458] Dynamic subtest pipe-A: SUCCESS (0.362s)
[613.742457] Starting dynamic subtest: pipe-B
[615.181169] Dynamic subtest pipe-B: SUCCESS (1.448s)
[615.190872] Starting dynamic subtest: pipe-C
[616.620584] Dynamic subtest pipe-C: SUCCESS (1.440s)
[616.634060] Starting dynamic subtest: pipe-D
[618.063126] Dynamic subtest pipe-D: SUCCESS (1.439s)
[618.065655] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.695s)
[619.208661] [082/133] (403s left) sriov_basic (enable-vfs-autoprobe-off)
[619.267595] Starting subtest: enable-vfs-autoprobe-off
[619.270086] Starting dynamic subtest: numvfs-1
[619.355334] Dynamic subtest numvfs-1: FAIL (0.026s)
[619.364266] Starting dynamic subtest: numvfs-2
[619.447967] Dynamic subtest numvfs-2: FAIL (0.003s)
[619.457959] Starting dynamic subtest: numvfs-3
[619.540731] Dynamic subtest numvfs-3: FAIL (0.003s)
[619.551794] Starting dynamic subtest: numvfs-4
[619.640230] Dynamic subtest numvfs-4: FAIL (0.004s)
[619.651856] Starting dynamic subtest: numvfs-5
[619.739061] Dynamic subtest numvfs-5: FAIL (0.004s)
[619.748984] Starting dynamic subtest: numvfs-6
[619.833714] Dynamic subtest numvfs-6: FAIL (0.004s)
[619.844674] Starting dynamic subtest: numvfs-7
[619.924348] Dynamic subtest numvfs-7: FAIL (0.004s)
[619.933253] Starting dynamic subtest: numvfs-random
[620.007126] Dynamic subtest numvfs-random: FAIL (0.003s)
[620.015751] Starting dynamic subtest: numvfs-all
[620.089499] Dynamic subtest numvfs-all: FAIL (0.598s)
[620.091809] Subtest enable-vfs-autoprobe-off: FAIL (0.657s)
[620.129525] [083/133] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[620.203328] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[627.222221] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.099s)
[627.346133] [084/133] (395s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[627.429152] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[627.433946] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[627.505845] [085/133] (395s left) kms_lease (lease-get)
[627.581878] Starting subtest: lease-get
[627.584419] Starting dynamic subtest: pipe-A-eDP-1
[627.587127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[627.599588] Starting dynamic subtest: pipe-B-eDP-1
[627.601793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[627.610458] Starting dynamic subtest: pipe-C-eDP-1
[627.612690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[627.621403] Starting dynamic subtest: pipe-D-eDP-1
[627.623717] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[627.626445] Subtest lease-get: SUCCESS (0.009s)
[627.683618] [086/133] (395s left) gem_readwrite (read-write)
[627.728567] Subtest read-write: SKIP (0.000s)
[627.781117] [087/133] (395s left) kms_psr (psr2-cursor-plane-move)
[627.859284] Starting subtest: psr2-cursor-plane-move
[627.861835] Starting dynamic subtest: eDP-1
[629.532317] Dynamic subtest eDP-1: SUCCESS (1.682s)
[629.535248] Subtest psr2-cursor-plane-move: SUCCESS (1.684s)
[630.404625] [088/133] (392s left) perf (non-zero-reason)
[630.562006] Starting subtest: non-zero-reason
[630.564268] Starting dynamic subtest: 0-rcs0
[635.867122] Dynamic subtest 0-rcs0: SUCCESS (5.324s)
[635.880575] Starting dynamic subtest: 1-vcs1
[639.726333] Dynamic subtest 1-vcs1: SUCCESS (3.866s)
[639.729234] Subtest non-zero-reason: SUCCESS (9.192s)
[639.778053] [089/133] (383s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[639.864181] Starting subtest: x-tiled-16bpp-rotate-0
[641.266185] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.404s)
[641.388692] [090/133] (381s left) kms_big_fb (linear-32bpp-rotate-270)
[641.465961] Starting subtest: linear-32bpp-rotate-270
[641.486353] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[641.597839] [091/133] (381s left) gem_exec_schedule (in-order)
[641.677253] Starting subtest: in-order
[641.679867] Starting dynamic subtest: rcs0
[641.789308] Dynamic subtest rcs0: SUCCESS (0.120s)
[641.801205] Starting dynamic subtest: vcs0
[641.876410] Dynamic subtest vcs0: SUCCESS (0.087s)
[641.888449] Starting dynamic subtest: vcs1
[641.959224] Dynamic subtest vcs1: SUCCESS (0.082s)
[641.969861] Starting dynamic subtest: vecs0
[642.038437] Dynamic subtest vecs0: SUCCESS (0.078s)
[642.050083] Starting dynamic subtest: ccs0
[642.122215] Dynamic subtest ccs0: SUCCESS (0.083s)
[642.125100] Subtest in-order: SUCCESS (0.454s)
[643.367068] [092/133] (379s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[645.398856] Starting subtest: dpms-mode-unset-non-lpsp
[646.555396] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s)
[646.920567] [093/133] (376s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[646.975351] Starting subtest: single-wait-all-for-submit-available-submitted
[646.978292] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[647.087422] [094/133] (376s left) kms_chamelium_edid (dp-edid-read)
[647.443050] Subtest dp-edid-read: SKIP (0.000s)
[648.226075] [095/133] (375s left) prime_mmap (test_forked_cpu_write)
[648.281866] Starting subtest: test_forked_cpu_write
[648.284369] Starting dynamic subtest: test_forked_cpu_write-smem
[648.290230] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[648.292630] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[648.388806] [096/133] (375s left) kms_feature_discovery (chamelium)
[648.469127] Starting subtest: chamelium
[648.474426] Subtest chamelium: SKIP (0.000s)
[648.541519] [097/133] (374s left) intel_hwmon (hwmon-write)
[648.593087] Subtest hwmon-write: SKIP (0.000s)
[648.658071] [098/133] (374s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[648.742980] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[658.124207] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.383s)
[658.239615] [099/133] (365s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[658.294258] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[658.401432] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[658.478911] [100/133] (365s left) fbdev (write)
[658.530447] Starting subtest: write
[658.884186] Subtest write: SUCCESS (0.352s)
[658.939228] [101/133] (364s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[659.022152] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[659.024261] Starting dynamic subtest: pipe-A-eDP-1
[665.579369] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.558s)
[665.589429] Starting dynamic subtest: pipe-B-eDP-1
[672.340909] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.762s)
[672.343347] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.323s)
[673.205810] [102/133] (350s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[673.317383] Starting subtest: fbcpsr-tiling-y
[673.322169] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[673.415459] [103/133] (350s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[673.467910] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[673.567953] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[673.646494] [104/133] (350s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[673.718706] Starting subtest: fbc-psr-sprite-mmap-gtt
[673.721170] Starting dynamic subtest: eDP-1
[673.726083] Dynamic subtest eDP-1: SKIP (0.000s)
[673.731222] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[673.790729] [105/133] (350s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[673.852241] Starting subtest: yf-tiled-ccs-to-x-tiled
[673.857236] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[674.039673] [106/133] (349s left) syncobj_timeline (invalid-transfer-bad-pad)
[674.110303] Starting subtest: invalid-transfer-bad-pad
[674.113103] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[674.220601] [107/133] (349s left) kms_psr (fbc-psr2-cursor-blt)
[674.294179] Starting subtest: fbc-psr2-cursor-blt
[674.296804] Starting dynamic subtest: eDP-1
[674.301649] Dynamic subtest eDP-1: SKIP (0.000s)
[674.306839] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[674.393384] [108/133] (349s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[674.516045] Starting subtest: dp-mst-type-0-suspend-resume
[674.521251] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[674.639120] [109/133] (349s left) syncobj_wait (wait-all-for-submit-complex)
[674.694407] Starting subtest: wait-all-for-submit-complex
[674.910294] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[674.998502] [110/133] (349s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[675.075288] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[675.083189] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.007s)
[675.172011] [111/133] (348s left) perf (invalid-remove-userspace-config)
[675.271332] Starting subtest: invalid-remove-userspace-config
[675.285372] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[675.327617] [112/133] (348s left) gem_exec_params (readonly)
[675.374802] Starting subtest: readonly
[675.380290] Subtest readonly: SUCCESS (0.003s)
[675.489022] [113/133] (348s left) sysfs_timeslice_duration (idempotent)
[675.543257] Starting subtest: idempotent
[675.545843] Starting dynamic subtest: vecs0
[675.548224] Dynamic subtest vecs0: SUCCESS (0.000s)
[675.559682] Starting dynamic subtest: ccs0
[675.561708] Dynamic subtest ccs0: SUCCESS (0.000s)
[675.571063] Starting dynamic subtest: vcs0
[675.573214] Dynamic subtest vcs0: SUCCESS (0.000s)
[675.582682] Starting dynamic subtest: bcs0
[675.585440] Dynamic subtest bcs0: SUCCESS (0.000s)
[675.595172] Starting dynamic subtest: rcs0
[675.597922] Dynamic subtest rcs0: SUCCESS (0.000s)
[675.607412] Starting dynamic subtest: vcs1
[675.609692] Dynamic subtest vcs1: SUCCESS (0.000s)
[675.612038] Subtest idempotent: SUCCESS (0.006s)
[675.652140] [114/133] (348s left) kms_prop_blob (invalid-get-prop-any)
[675.714802] Starting subtest: invalid-get-prop-any
[675.717303] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[675.804819] [115/133] (348s left) vgem_basic (create)
[675.858485] Starting subtest: create
[675.860767] Subtest create: SUCCESS (0.000s)
[675.914884] [116/133] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[675.997216] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[676.001235] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[676.108996] [117/133] (348s left) i915_query (engine-info-invalid)
[676.166310] Starting subtest: engine-info-invalid
[676.168452] Subtest engine-info-invalid: SUCCESS (0.000s)
[676.265674] [118/133] (348s left) gem_userptr_blits (huge-split)
[676.327750] Starting subtest: huge-split
[676.335655] Subtest huge-split: SUCCESS (0.008s)
[676.460735] [119/133] (347s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[676.540098] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[676.544218] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[676.624801] [120/133] (347s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[676.696969] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[676.701261] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[676.768850] [121/133] (347s left) gem_exec_fence (invalid-timeline-fence-array)
[677.349618] Starting subtest: invalid-timeline-fence-array
[677.355323] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[678.384914] [122/133] (346s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[678.472717] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[679.465219] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.991s)
[679.631147] [123/133] (344s left) gem_eio (kms)
[679.885363] Starting subtest: kms
[699.561001] Subtest kms: SUCCESS (19.679s)
[699.681887] [124/133] (324s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[699.774361] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[699.779397] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[699.860357] [125/133] (324s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[699.943826] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[699.948872] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[700.037912] [126/133] (324s left) kms_atomic_transition (plane-all-transition-nonblocking)
[700.110176] Starting subtest: plane-all-transition-nonblocking
[700.112529] Starting dynamic subtest: pipe-A-eDP-1
[702.602207] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[702.912685] Starting dynamic subtest: pipe-B-eDP-1
[706.128706] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[706.435343] Subtest plane-all-transition-nonblocking: SUCCESS (6.327s)
[707.244447] [127/133] (317s left) gem_pwrite_snooped
[707.381049] [128/133] (317s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[707.458859] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[714.837724] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.386s)
[714.977597] [129/133] (309s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[715.076841] Starting subtest: cursor-tearing-framebuffer-change
[715.079131] Starting dynamic subtest: pipe-A-eDP-1
[715.642628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[715.653407] Starting dynamic subtest: pipe-D-eDP-1
[716.907312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[716.910188] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.831s)
[717.746713] [130/133] (307s left) gem_flink_basic (bad-open)
[717.795712] Starting subtest: bad-open
[717.798134] Subtest bad-open: SUCCESS (0.000s)
[717.886589] [131/133] (307s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[717.982342] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[717.988040] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[718.065322] [132/133] (306s left) perf (rc6-disable)
[718.157853] Starting subtest: rc6-disable
[718.327797] Subtest rc6-disable: SUCCESS (0.170s)
[718.373276] [133/133] (306s left) gen9_exec_parse (allowed-single)
[718.425288] Subtest allowed-single: SKIP (0.000s)
[718.488002] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_sync
results: parsing output: 4/ for test: gem_ctx_create
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_dirtyfb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ppgtt
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: gem_exec_store
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_atomic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_rmfb
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_pipe_b_c_ivb
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: i915_pm_rc6_residency
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: kms_color
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_getparams_basic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: drm_read
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_properties
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_mmap
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: gem_exec_await
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_pipe_crc_basic
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: gem_ctx_engines
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: dumb_buffer
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_parallel
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: gem_readwrite
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_feature_discovery
results: parsing output: 96/ for test: intel_hwmon
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: fbdev
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: sysfs_timeslice_duration
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: vgem_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: gem_pwrite_snooped
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_flink_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: gen9_exec_parse
Done.