[57.826957] Initializing watchdogs
[57.827020]   /dev/watchdog0
[57.841982] [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]
[57.846549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.848957] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.852323] [001/131] (960s left) fbdev (unaligned-read)
[57.916358] Starting subtest: unaligned-read
[57.931410] Subtest unaligned-read: SUCCESS (0.015s)
[58.009460] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[58.078813] Starting subtest: dirty-switch
[58.081120] Starting dynamic subtest: rcs0
[58.338596] Dynamic subtest rcs0: SUCCESS (0.261s)
[58.348722] Starting dynamic subtest: bcs0
[58.609474] Dynamic subtest bcs0: SUCCESS (0.272s)
[58.619553] Starting dynamic subtest: vcs0
[58.880554] Dynamic subtest vcs0: SUCCESS (0.273s)
[58.889727] Starting dynamic subtest: vcs1
[60.155237] Dynamic subtest vcs1: SUCCESS (1.280s)
[60.164452] Starting dynamic subtest: vecs0
[62.118548] Dynamic subtest vecs0: SUCCESS (1.970s)
[62.128459] Starting dynamic subtest: ccs0
[64.123199] Dynamic subtest ccs0: SUCCESS (2.010s)
[64.125676] Subtest dirty-switch: SUCCESS (6.068s)
[64.396888] [003/131] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.503031] Starting subtest: psr-modesetfrombusy
[71.011103] Subtest psr-modesetfrombusy: SUCCESS (6.525s)
[71.168327] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[71.267337] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[71.269247] Starting dynamic subtest: pipe-A-default-mode
[74.035544] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[74.038037] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.772s)
[74.910301] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[74.985337] Starting subtest: sol-reset-invalid
[74.988060] Subtest sol-reset-invalid: SUCCESS (0.002s)
[76.976837] [006/131] (941s left) gem_spin_batch (resubmit-new)
[77.041130] Starting subtest: resubmit-new
[77.043621] Starting dynamic subtest: rcs0
[77.049471] Dynamic subtest rcs0: SUCCESS (0.008s)
[77.059220] Starting dynamic subtest: bcs0
[77.061576] Dynamic subtest bcs0: SUCCESS (0.004s)
[77.068850] Starting dynamic subtest: vcs0
[77.071238] Dynamic subtest vcs0: SUCCESS (0.004s)
[77.078030] Starting dynamic subtest: vcs1
[77.079979] Dynamic subtest vcs1: SUCCESS (0.004s)
[77.086907] Starting dynamic subtest: vecs0
[77.088864] Dynamic subtest vecs0: SUCCESS (0.003s)
[77.095798] Starting dynamic subtest: ccs0
[77.097799] Dynamic subtest ccs0: SUCCESS (0.004s)
[77.099739] Subtest resubmit-new: SUCCESS (0.029s)
[78.994792] [007/131] (939s left) gem_exec_schedule (preempt-user)
[79.073630] Starting subtest: preempt-user
[79.075967] Starting dynamic subtest: rcs0
[79.102622] Dynamic subtest rcs0: SUCCESS (0.036s)
[79.111308] Starting dynamic subtest: bcs0
[79.132680] Dynamic subtest bcs0: SUCCESS (0.030s)
[79.140106] Starting dynamic subtest: vcs0
[79.159509] Dynamic subtest vcs0: SUCCESS (0.027s)
[79.171027] Starting dynamic subtest: vcs1
[79.188229] Dynamic subtest vcs1: SUCCESS (0.028s)
[79.196727] Starting dynamic subtest: vecs0
[79.208853] Dynamic subtest vecs0: SUCCESS (0.020s)
[79.218707] Starting dynamic subtest: ccs0
[79.241083] Dynamic subtest ccs0: SUCCESS (0.032s)
[79.243272] Subtest preempt-user: SUCCESS (0.175s)
[81.031038] [008/131] (937s left) sysfs_heartbeat_interval (nopreempt)
[81.095348] Starting subtest: nopreempt
[81.097717] Starting dynamic subtest: vecs0
[90.912235] Dynamic subtest vecs0: SUCCESS (9.813s)
[90.922949] Starting dynamic subtest: ccs0
[95.030388] Dynamic subtest ccs0: SUCCESS (4.120s)
[95.043543] Starting dynamic subtest: vcs0
[104.919180] Dynamic subtest vcs0: SUCCESS (9.888s)
[104.929754] Starting dynamic subtest: bcs0
[108.953292] Dynamic subtest bcs0: SUCCESS (4.033s)
[108.966434] Starting dynamic subtest: rcs0
[113.076950] Dynamic subtest rcs0: SUCCESS (4.123s)
[113.087913] Starting dynamic subtest: vcs1
[122.902414] Dynamic subtest vcs1: SUCCESS (9.824s)
[122.904956] Subtest nopreempt: SUCCESS (41.806s)
[123.003158] [009/131] (895s left) kms_invalid_mode (zero-hdisplay)
[123.097173] Starting subtest: zero-hdisplay
[123.099431] Starting dynamic subtest: pipe-A-eDP-1
[123.378679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[123.388212] Starting dynamic subtest: pipe-B-eDP-1
[123.390088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[123.397807] Starting dynamic subtest: pipe-C-eDP-1
[123.399818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[123.409709] Starting dynamic subtest: pipe-D-eDP-1
[123.411895] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[123.414068] Subtest zero-hdisplay: SUCCESS (0.292s)
[124.226227] [010/131] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[124.340669] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[124.344765] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[124.456432] [011/131] (894s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[124.551712] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[125.397799] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[125.584658] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[125.677266] Starting subtest: getfb-handle-zero
[125.679580] Subtest getfb-handle-zero: SUCCESS (0.000s)
[125.819750] [013/131] (892s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[125.888569] Starting subtest: yf-tiled-ccs-to-yf-tiled
[125.892975] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[126.092780] [014/131] (892s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[126.191803] Starting subtest: multiplane-rotation-cropping-bottom
[133.416384] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.227s)
[133.555658] [015/131] (885s left) gem_eio (wait-1us)
[133.790723] Starting subtest: wait-1us
[134.133639] Subtest wait-1us: SUCCESS (0.344s)
[134.318832] [016/131] (884s left) syncobj_wait (multi-wait-for-submit-signaled)
[134.379478] Starting subtest: multi-wait-for-submit-signaled
[134.381578] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[134.511097] [017/131] (884s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[134.605908] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[134.608015] Starting dynamic subtest: pipe-A-default-mode
[134.890086] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[134.894836] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s)
[135.758065] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[135.852290] Starting subtest: alpha-7efc
[136.164587] Starting dynamic subtest: pipe-A-eDP-1
[136.769191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[136.805231] Starting dynamic subtest: pipe-D-eDP-1
[138.051530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[138.053752] Subtest alpha-7efc: SUCCESS (2.201s)
[138.909612] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[139.023690] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[139.028218] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[139.157487] [020/131] (879s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[139.255313] Starting subtest: fbc-psr2-primary-mmap-cpu
[139.257501] Starting dynamic subtest: eDP-1
[139.261876] Dynamic subtest eDP-1: SKIP (0.000s)
[139.266270] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[139.348726] [021/131] (879s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[139.452600] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[139.463810] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[139.591432] [022/131] (879s left) gem_exec_whisper (basic-normal-all)
[139.664098] Starting subtest: basic-normal-all
[142.140331] Subtest basic-normal-all: SUCCESS (2.473s)
[142.351577] [023/131] (876s left) kms_big_fb (linear-16bpp-rotate-180)
[142.459834] Starting subtest: linear-16bpp-rotate-180
[143.906605] Subtest linear-16bpp-rotate-180: SUCCESS (1.447s)
[144.051755] [024/131] (875s left) kms_frontbuffer_tracking (psr-slowdraw)
[144.149841] Starting subtest: psr-slowdraw
[169.361299] Subtest psr-slowdraw: SUCCESS (25.210s)
[169.528546] [025/131] (849s left) vgem_basic (dmabuf-fence)
[169.648782] Starting subtest: dmabuf-fence
[169.651067] Subtest dmabuf-fence: SUCCESS (0.001s)
[169.726441] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[169.729753] [026/131] (849s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[169.804637] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[169.807104] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[169.952904] [027/131] (849s left) kms_psr (pr-primary-render)
[170.046151] Starting subtest: pr-primary-render
[170.050452] Subtest pr-primary-render: SKIP (0.000s)
[170.147375] [028/131] (849s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[170.243040] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[170.244916] Starting dynamic subtest: pipe-A-eDP-1
[170.263317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.273014] Starting dynamic subtest: pipe-B-eDP-1
[170.289046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.296768] Starting dynamic subtest: pipe-C-eDP-1
[170.313939] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.321757] Starting dynamic subtest: pipe-D-eDP-1
[170.339304] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.342780] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[172.514191] [029/131] (846s left) core_auth (getclient-master-drop)
[172.551773] Starting subtest: getclient-master-drop
[172.578046] Subtest getclient-master-drop: SUCCESS (0.024s)
[172.714904] [030/131] (846s left) kms_plane_scaling (planes-downscale-factor-0-5)
[172.814223] Starting subtest: planes-downscale-factor-0-5
[172.816517] Starting dynamic subtest: pipe-A
[172.837074] Dynamic subtest pipe-A: SKIP (0.018s)
[172.845655] Starting dynamic subtest: pipe-B
[172.873084] Dynamic subtest pipe-B: SKIP (0.036s)
[172.881713] Starting dynamic subtest: pipe-C
[172.908145] Dynamic subtest pipe-C: SKIP (0.036s)
[172.916625] Starting dynamic subtest: pipe-D
[172.941178] Dynamic subtest pipe-D: SKIP (0.032s)
[172.945343] Subtest planes-downscale-factor-0-5: SKIP (0.124s)
[173.076990] [031/131] (846s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[173.169736] Starting subtest: fb-8bpc-vs-panel-8bpc
[173.171964] Starting dynamic subtest: pipe-A-eDP-1
[174.598527] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.427s)
[174.600549] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.428s)
[175.482685] [032/131] (844s left) gem_partial_pwrite_pread (reads-snoop)
[175.549660] Subtest reads-snoop: SKIP (0.000s)
[175.634316] [033/131] (843s left) gem_eio (in-flight-contexts-immediate)
[175.873650] Starting subtest: in-flight-contexts-immediate
[189.921036] Subtest in-flight-contexts-immediate: SUCCESS (14.047s)
[190.134160] [034/131] (829s left) gen3_render_mixed_blits
[190.274266] [035/131] (829s left) kms_pm_rpm (pm-tiling)
[192.006673] Starting subtest: pm-tiling
[192.011420] Subtest pm-tiling: SKIP (0.000s)
[192.522894] [036/131] (827s left) i915_module_load (reload-no-display)
[192.561476] Starting subtest: reload-no-display
[198.871061] Subtest reload-no-display: SUCCESS (6.312s)
[198.927015] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[198.927725] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[198.930830] [037/131] (820s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[200.584903] Starting subtest: plane-upscale-20x20-with-rotation
[200.587200] Starting dynamic subtest: pipe-A
[200.838065] Dynamic subtest pipe-A: SUCCESS (0.254s)
[200.846546] Starting dynamic subtest: pipe-B
[202.144201] Dynamic subtest pipe-B: SUCCESS (1.305s)
[202.155095] Starting dynamic subtest: pipe-C
[203.481552] Dynamic subtest pipe-C: SUCCESS (1.336s)
[203.489850] Starting dynamic subtest: pipe-D
[204.829412] Dynamic subtest pipe-D: SUCCESS (1.345s)
[204.831947] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.247s)
[205.974489] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[205.975760] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[205.979754] [038/131] (813s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[206.097743] Starting subtest: 4-tiled-8bpp-rotate-180
[207.306584] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.209s)
[207.477272] [039/131] (812s left) kms_rotation_crc (primary-rotation-90)
[207.584638] Starting subtest: primary-rotation-90
[207.588394] Subtest primary-rotation-90: SKIP (0.001s)
[207.684251] [040/131] (812s left) kms_cursor_crc (cursor-onscreen-32x10)
[207.838035] Starting subtest: cursor-onscreen-32x10
[207.884101] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[208.176408] [041/131] (811s left) kms_vblank (wait-idle)
[208.281649] Starting subtest: wait-idle
[208.283492] Starting dynamic subtest: pipe-A-eDP-1
[210.037226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[210.049255] Starting dynamic subtest: pipe-D-eDP-1
[212.442563] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.405s)
[212.444894] Subtest wait-idle: SUCCESS (4.163s)
[213.285105] [042/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[213.393388] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[213.397608] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[213.531113] [043/131] (806s left) kms_flip (2x-flip-vs-dpms)
[213.625204] Starting subtest: 2x-flip-vs-dpms
[213.636964] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[213.741580] [044/131] (806s left) gem_exec_fence (syncobj-channel)
[214.165712] Starting subtest: syncobj-channel
[215.186075] Subtest syncobj-channel: SUCCESS (1.017s)
[216.006399] [045/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[216.098357] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[216.100568] Starting dynamic subtest: pipe-A-eDP-1
[216.109364] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.118296] Starting dynamic subtest: pipe-B-eDP-1
[216.127059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.135357] Starting dynamic subtest: pipe-C-eDP-1
[216.143671] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.150930] Starting dynamic subtest: pipe-D-eDP-1
[216.159116] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.163054] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[218.378119] [046/131] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[218.478402] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[225.941926] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.465s)
[226.117927] [047/131] (794s left) kms_flip (busy-flip)
[226.222398] Starting subtest: busy-flip
[226.224699] Starting dynamic subtest: A-eDP1
[227.893334] Dynamic subtest A-eDP1: SUCCESS (1.670s)
[227.902194] Starting dynamic subtest: B-eDP1
[229.529326] Dynamic subtest B-eDP1: SUCCESS (1.635s)
[229.539651] Starting dynamic subtest: C-eDP1
[231.152632] Dynamic subtest C-eDP1: SUCCESS (1.622s)
[231.162171] Starting dynamic subtest: D-eDP1
[232.783047] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[232.785524] Subtest busy-flip: SUCCESS (6.564s)
[234.072593] [048/131] (786s left) prime_mmap (test_aperture_limit)
[234.137381] Starting subtest: test_aperture_limit
[234.139623] Starting dynamic subtest: test_aperture_limit-smem
[234.147047] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[234.151447] Subtest test_aperture_limit: SKIP (0.008s)
[234.280438] [049/131] (785s left) i915_pm_rpm (sysfs-read)
[236.117880] Starting subtest: sysfs-read
[237.277078] Subtest sysfs-read: SUCCESS (1.156s)
[237.650673] [050/131] (782s left) kms_big_fb (yf-tiled-addfb)
[237.746978] Starting subtest: yf-tiled-addfb
[237.751553] Subtest yf-tiled-addfb: SKIP (0.000s)
[237.859656] [051/131] (782s left) sriov_basic (enable-vfs-autoprobe-on)
[237.928613] Starting subtest: enable-vfs-autoprobe-on
[237.930787] Starting dynamic subtest: numvfs-1
[238.003342] Dynamic subtest numvfs-1: FAIL (0.014s)
[238.013376] Starting dynamic subtest: numvfs-2
[238.086809] Dynamic subtest numvfs-2: FAIL (0.004s)
[238.096636] Starting dynamic subtest: numvfs-3
[238.170093] Dynamic subtest numvfs-3: FAIL (0.004s)
[238.179350] Starting dynamic subtest: numvfs-4
[238.252122] Dynamic subtest numvfs-4: FAIL (0.004s)
[238.262701] Starting dynamic subtest: numvfs-5
[238.338596] Dynamic subtest numvfs-5: FAIL (0.004s)
[238.347640] Starting dynamic subtest: numvfs-6
[238.422420] Dynamic subtest numvfs-6: FAIL (0.004s)
[238.433621] Starting dynamic subtest: numvfs-7
[238.507973] Dynamic subtest numvfs-7: FAIL (0.004s)
[238.517281] Starting dynamic subtest: numvfs-random
[238.586552] Dynamic subtest numvfs-random: FAIL (0.004s)
[238.601654] Starting dynamic subtest: numvfs-all
[238.667099] Dynamic subtest numvfs-all: FAIL (0.516s)
[238.669048] Subtest enable-vfs-autoprobe-on: FAIL (0.565s)
[238.755505] [052/131] (781s left) gem_exec_whisper (basic-queues)
[238.837689] Starting subtest: basic-queues
[244.521387] Subtest basic-queues: SUCCESS (5.682s)
[244.726400] [053/131] (775s left) kms_flip (2x-dpms-vs-vblank-race)
[244.832367] Starting subtest: 2x-dpms-vs-vblank-race
[244.844272] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[244.994293] [054/131] (775s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[245.094669] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[245.474217] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[248.203802] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.728s)
[248.215216] Starting dynamic subtest: pipe-A-eDP-1-4
[250.401075] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[250.412074] Starting dynamic subtest: pipe-A-eDP-1-4
[252.410992] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[252.421992] Starting dynamic subtest: pipe-A-eDP-1-x
[254.589396] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[254.955527] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[257.733685] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[257.742303] Starting dynamic subtest: pipe-B-eDP-1-4
[259.919820] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[259.928584] Starting dynamic subtest: pipe-B-eDP-1-4
[261.930568] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[261.942293] Starting dynamic subtest: pipe-B-eDP-1-x
[264.131564] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[264.493245] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[267.259321] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[267.271239] Starting dynamic subtest: pipe-C-eDP-1-4
[269.420910] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.161s)
[269.431774] Starting dynamic subtest: pipe-C-eDP-1-4
[271.431526] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[271.442336] Starting dynamic subtest: pipe-C-eDP-1-x
[273.610348] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[273.978078] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[276.780491] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[276.789531] Starting dynamic subtest: pipe-D-eDP-1-4
[278.966641] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[278.977576] Starting dynamic subtest: pipe-D-eDP-1-4
[280.977208] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[280.988800] Starting dynamic subtest: pipe-D-eDP-1-x
[283.156545] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[283.159341] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.061s)
[284.380380] [055/131] (736s left) gem_mmap_gtt (basic-write-read-distinct)
[284.446308] Subtest basic-write-read-distinct: SKIP (0.000s)
[284.507418] [056/131] (736s left) gem_mmap_offset (oob-read)
[284.564255] Starting subtest: oob-read
[284.566366] Subtest oob-read: SUCCESS (0.000s)
[284.696542] [057/131] (735s left) kms_atomic (atomic-plane-damage)
[284.802285] Starting subtest: atomic-plane-damage
[284.850461] Starting dynamic subtest: pipe-A-eDP-1
[285.455050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[285.457439] Subtest atomic-plane-damage: SUCCESS (0.655s)
[286.310847] [058/131] (734s left) kms_atomic_transition (plane-all-transition-nonblocking)
[286.406581] Starting subtest: plane-all-transition-nonblocking
[286.409058] Starting dynamic subtest: pipe-A-eDP-1
[288.899655] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[289.207935] Starting dynamic subtest: pipe-B-eDP-1
[292.423890] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.223s)
[292.721670] Subtest plane-all-transition-nonblocking: SUCCESS (6.315s)
[293.571541] [059/131] (727s left) gem_exec_parallel (contexts)
[293.633455] Starting subtest: contexts
[293.635818] Starting dynamic subtest: rcs0
[296.339789] Dynamic subtest rcs0: SUCCESS (2.708s)
[296.349382] Starting dynamic subtest: bcs0
[299.695768] Dynamic subtest bcs0: SUCCESS (3.353s)
[299.704827] Starting dynamic subtest: vcs0
[303.424496] Dynamic subtest vcs0: SUCCESS (3.726s)
[303.435950] Starting dynamic subtest: vcs1
[307.344394] Dynamic subtest vcs1: SUCCESS (3.917s)
[307.353914] Starting dynamic subtest: vecs0
[311.402970] Dynamic subtest vecs0: SUCCESS (4.055s)
[311.413908] Starting dynamic subtest: ccs0
[314.885878] Dynamic subtest ccs0: SUCCESS (3.480s)
[314.888481] Subtest contexts: SUCCESS (21.255s)
[315.096997] [060/131] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[315.211884] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[321.953449] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.745s)
[322.113189] [061/131] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[322.218429] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[322.222694] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[322.335651] [062/131] (698s left) kms_atomic_interruptible (legacy-pageflip)
[322.432834] Starting subtest: legacy-pageflip
[322.434992] Starting dynamic subtest: pipe-A-eDP-1
[329.835132] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[329.837436] Subtest legacy-pageflip: SUCCESS (7.402s)
[330.699090] [063/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[330.795629] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[330.799657] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[330.931162] [064/131] (689s left) kms_psr (psr2-sprite-mmap-cpu)
[331.016942] Starting subtest: psr2-sprite-mmap-cpu
[331.019152] Starting dynamic subtest: eDP-1
[332.761209] Dynamic subtest eDP-1: SUCCESS (1.743s)
[332.763416] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.744s)
[333.653444] [065/131] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[333.766107] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[340.882675] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.118s)
[341.077746] [066/131] (679s left) gem_exec_schedule (fairslice-all)
[341.155700] Starting subtest: fairslice-all
[343.209735] Subtest fairslice-all: SUCCESS (2.057s)
[344.934371] [067/131] (676s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[349.934068] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[349.936317] Starting dynamic subtest: pipe-A-eDP-1
[350.727676] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[350.737693] Starting dynamic subtest: pipe-B-eDP-1
[351.857400] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[351.862109] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.923s)
[353.058718] [068/131] (668s left) api_intel_allocator (two-level-inception)
[353.125586] Starting subtest: two-level-inception
[358.524763] Subtest two-level-inception: SUCCESS (5.400s)
[358.688585] [069/131] (662s left) i915_suspend (debugfs-reader)
[358.756318] Starting subtest: debugfs-reader
[377.017466] Subtest debugfs-reader: SUCCESS (8.048s)
[377.234115] [070/131] (644s left) kms_flip (plain-flip-fb-recreate-interruptible)
[377.342787] Starting subtest: plain-flip-fb-recreate-interruptible
[377.345095] Starting dynamic subtest: A-eDP1
[397.963757] Dynamic subtest A-eDP1: SUCCESS (20.801s)
[397.974658] Starting dynamic subtest: B-eDP1
[406.774907] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[406.785386] Starting dynamic subtest: C-eDP1
[415.576639] Dynamic subtest C-eDP1: SUCCESS (8.797s)
[415.592966] Starting dynamic subtest: D-eDP1
[424.411341] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[424.415369] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (47.263s)
[425.609508] [071/131] (595s left) gem_vm_create (invalid-destroy)
[425.681111] Starting subtest: invalid-destroy
[425.683402] Subtest invalid-destroy: SUCCESS (0.002s)
[425.831918] [072/131] (595s left) gem_ccs (ctrl-surf-copy-new-ctx)
[425.904011] Starting subtest: ctrl-surf-copy-new-ctx
[425.908549] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[426.020479] [073/131] (595s left) syncobj_basic (bad-destroy-pad)
[426.072258] Starting subtest: bad-destroy-pad
[426.074406] Subtest bad-destroy-pad: SUCCESS (0.000s)
[426.191724] [074/131] (595s left) kms_plane_multiple (2x-tiling-y)
[426.291721] Starting subtest: 2x-tiling-y
[426.295857] Subtest 2x-tiling-y: SKIP (0.000s)
[426.386913] [075/131] (595s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[426.473615] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[426.475946] Starting dynamic subtest: pipe-A-eDP-1
[426.498337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.509831] Starting dynamic subtest: pipe-B-eDP-1
[426.528461] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.537686] Starting dynamic subtest: pipe-C-eDP-1
[426.555400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.564360] Starting dynamic subtest: pipe-D-eDP-1
[426.582953] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.586594] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[428.671489] [076/131] (592s left) kms_pm_rpm (modeset-lpsp)
[430.305642] Starting subtest: modeset-lpsp
[431.776385] Subtest modeset-lpsp: SUCCESS (1.474s)
[431.885829] [077/131] (589s left) kms_setmode (basic)
[431.951311] Starting subtest: basic
[432.271941] Starting dynamic subtest: pipe-A-eDP-1
[434.349555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[434.693179] Starting dynamic subtest: pipe-B-eDP-1
[436.781560] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s)
[437.088611] Subtest basic: SUCCESS (5.137s)
[437.952068] [078/131] (583s left) kms_psr (fbc-psr-suspend)
[438.051689] Starting subtest: fbc-psr-suspend
[438.053855] Starting dynamic subtest: eDP-1
[438.057859] Dynamic subtest eDP-1: SKIP (0.000s)
[438.061802] Subtest fbc-psr-suspend: SKIP (0.001s)
[438.148832] [079/131] (583s left) gem_ringfill (engines-basic)
[444.109123] Starting subtest: engines-basic
[444.111980] Starting dynamic subtest: rcs0
[444.181633] Dynamic subtest rcs0: SUCCESS (0.072s)
[444.194470] Starting dynamic subtest: bcs0
[444.226589] Dynamic subtest bcs0: SUCCESS (0.043s)
[444.238663] Starting dynamic subtest: vcs0
[444.267545] Dynamic subtest vcs0: SUCCESS (0.039s)
[444.279237] Starting dynamic subtest: vcs1
[444.309504] Dynamic subtest vcs1: SUCCESS (0.040s)
[444.320153] Starting dynamic subtest: vecs0
[444.352621] Dynamic subtest vecs0: SUCCESS (0.041s)
[444.363248] Starting dynamic subtest: ccs0
[444.397786] Dynamic subtest ccs0: SUCCESS (0.043s)
[444.400389] Subtest engines-basic: SUCCESS (0.291s)
[444.511053] [080/131] (577s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[444.571857] Starting subtest: invalid-bsd2-flag-on-vebox
[444.574146] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[444.712224] [081/131] (577s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[444.808365] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[444.810223] Starting dynamic subtest: pipe-A-eDP-1
[444.830258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[444.841242] Starting dynamic subtest: pipe-B-eDP-1
[444.859408] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[444.868998] Starting dynamic subtest: pipe-C-eDP-1
[444.888355] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[444.897834] Starting dynamic subtest: pipe-D-eDP-1
[444.916981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[444.919147] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[447.125599] [082/131] (574s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[447.229790] Starting subtest: extended-pageflip-modeset-hang-oldfb
[447.232093] Starting dynamic subtest: pipe-A
[455.157141] Dynamic subtest pipe-A: SUCCESS (7.928s)
[455.168371] Starting dynamic subtest: pipe-D
[463.816326] Dynamic subtest pipe-D: SUCCESS (8.659s)
[463.818666] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.593s)
[464.700655] [083/131] (557s left) gem_ppgtt (shrink-vs-evict-any)
[464.770365] Starting subtest: shrink-vs-evict-any
[470.120269] Subtest shrink-vs-evict-any: SUCCESS (5.350s)
[470.228846] [084/131] (551s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[470.285264] Starting subtest: etime-single-wait-for-submit-unsubmitted
[470.389590] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[470.501464] [085/131] (551s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[470.561258] Starting subtest: multi-wait-all-for-submit-signaled
[470.563594] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[470.699096] [086/131] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[470.750119] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[470.853213] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[470.956914] [087/131] (551s left) gem_exec_schedule (implicit-write-read)
[471.027337] Starting subtest: implicit-write-read
[471.029589] Starting dynamic subtest: rcs0
[471.214970] Dynamic subtest rcs0: SUCCESS (0.196s)
[471.230244] Starting dynamic subtest: vcs0
[471.351170] Dynamic subtest vcs0: SUCCESS (0.136s)
[471.360791] Starting dynamic subtest: vcs1
[471.461409] Dynamic subtest vcs1: SUCCESS (0.109s)
[471.474657] Starting dynamic subtest: vecs0
[471.569886] Dynamic subtest vecs0: SUCCESS (0.107s)
[471.581534] Starting dynamic subtest: ccs0
[471.705920] Dynamic subtest ccs0: SUCCESS (0.133s)
[471.708652] Subtest implicit-write-read: SUCCESS (0.688s)
[472.281854] [088/131] (549s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[472.382251] Starting subtest: fbcpsr-rgb565-draw-blt
[479.445575] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.062s)
[479.630408] [089/131] (542s left) gem_ctx_persistence (processes)
[479.693757] Starting subtest: processes
[481.165133] Subtest processes: SUCCESS (1.471s)
[481.269085] [090/131] (540s left) kms_cursor_crc (cursor-sliding-32x10)
[481.433485] Starting subtest: cursor-sliding-32x10
[481.480096] Subtest cursor-sliding-32x10: SKIP (0.044s)
[481.806934] [091/131] (540s left) kms_psr (fbc-pr-primary-render)
[481.898765] Starting subtest: fbc-pr-primary-render
[481.902845] Subtest fbc-pr-primary-render: SKIP (0.000s)
[481.995221] [092/131] (540s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[482.055441] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[482.136769] [093/131] (540s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[482.190678] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[482.192363] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[482.321829] [094/131] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[482.417788] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[482.421259] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.560614] [095/131] (539s left) gem_exec_async (concurrent-writes)
[482.629731] Starting subtest: concurrent-writes
[482.631619] Starting dynamic subtest: rcs0
[482.644347] Dynamic subtest rcs0: SUCCESS (0.015s)
[482.657228] Starting dynamic subtest: bcs0
[482.659051] Dynamic subtest bcs0: SUCCESS (0.007s)
[482.669181] Starting dynamic subtest: vcs0
[482.671048] Dynamic subtest vcs0: SUCCESS (0.005s)
[482.680977] Starting dynamic subtest: vcs1
[482.682671] Dynamic subtest vcs1: SUCCESS (0.005s)
[482.692355] Starting dynamic subtest: vecs0
[482.694160] Dynamic subtest vecs0: SUCCESS (0.005s)
[482.703389] Starting dynamic subtest: ccs0
[482.705197] Dynamic subtest ccs0: SUCCESS (0.005s)
[482.706992] Subtest concurrent-writes: SUCCESS (0.046s)
[482.926397] [096/131] (539s left) gem_mmap_gtt (basic-small-bo-tiledx)
[482.983588] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[483.053745] [097/131] (539s left) dmabuf_sync_file (import-basic)
[483.089748] Starting subtest: import-basic
[483.091540] Subtest import-basic: SUCCESS (0.001s)
[483.170783] [098/131] (539s left) kms_feature_discovery (display)
[483.268249] Starting subtest: display
[483.270147] Subtest display: SUCCESS (0.000s)
[483.367732] [099/131] (539s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[483.456935] Starting subtest: x-tiled-64bpp-rotate-90
[483.476826] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[483.637683] [100/131] (538s left) perf_pmu (busy-no-semaphores)
[483.680706] Starting subtest: busy-no-semaphores
[483.682681] Starting dynamic subtest: rcs0
[484.254803] Dynamic subtest rcs0: SUCCESS (0.571s)
[484.267993] Starting dynamic subtest: bcs0
[484.806555] Dynamic subtest bcs0: SUCCESS (0.549s)
[484.819479] Starting dynamic subtest: vcs0
[485.357091] Dynamic subtest vcs0: SUCCESS (0.547s)
[485.370649] Starting dynamic subtest: vcs1
[486.667329] Dynamic subtest vcs1: SUCCESS (1.307s)
[486.680730] Starting dynamic subtest: vecs0
[488.653082] Dynamic subtest vecs0: SUCCESS (1.982s)
[488.666461] Starting dynamic subtest: ccs0
[490.638082] Dynamic subtest ccs0: SUCCESS (1.981s)
[490.640926] Subtest busy-no-semaphores: SUCCESS (6.955s)
[490.804814] [101/131] (531s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[490.913023] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[490.917329] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[491.054408] [102/131] (531s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[491.173499] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[491.178717] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[491.342849] [103/131] (531s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[491.733121] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[492.527724] [104/131] (530s left) kms_getfb (getfb-reject-nv12)
[492.618022] Starting subtest: getfb-reject-nv12
[492.620278] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[492.762131] [105/131] (530s left) i915_drm_fdinfo (context-close-stress)
[492.798143] Starting subtest: context-close-stress
[503.542424] Subtest context-close-stress: SUCCESS (10.743s)
[503.646930] [106/131] (519s left) perf_pmu (module-unload)
[503.816393] Starting subtest: module-unload
[512.475747] Subtest module-unload: FAIL (8.554s)
[512.530912] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[512.532778] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[512.537000] [107/131] (510s left) kms_chamelium_edid (dp-edid-read)
[514.329408] Subtest dp-edid-read: SKIP (0.000s)
[515.163585] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.164820] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[515.168383] [108/131] (507s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[520.162269] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[520.164156] Starting dynamic subtest: pipe-A-eDP-1
[520.956709] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[520.966645] Starting dynamic subtest: pipe-B-eDP-1
[522.089234] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[522.093790] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.928s)
[523.307700] [109/131] (499s left) kms_vblank (query-busy)
[523.410882] Starting subtest: query-busy
[523.413026] Starting dynamic subtest: pipe-A-eDP-1
[525.298991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[525.313110] Starting dynamic subtest: pipe-D-eDP-1
[527.855565] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[527.857923] Subtest query-busy: SUCCESS (4.446s)
[528.681793] [110/131] (494s left) syncobj_timeline (wait-for-submit-complex)
[528.752229] Starting subtest: wait-for-submit-complex
[528.813037] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[528.911467] [111/131] (494s left) perf (invalid-create-userspace-config)
[529.055486] Starting subtest: invalid-create-userspace-config
[529.057616] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[529.099382] [112/131] (494s left) gem_exec_basic (basic)
[529.182767] Starting subtest: basic
[529.185171] Starting dynamic subtest: rcs0-smem
[529.187469] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[529.199700] Starting dynamic subtest: bcs0-smem
[529.202002] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[529.214400] Starting dynamic subtest: vcs0-smem
[529.216682] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[529.228899] Starting dynamic subtest: vcs1-smem
[529.231316] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[529.242164] Starting dynamic subtest: vecs0-smem
[529.244409] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[529.252680] Starting dynamic subtest: ccs0-smem
[529.254893] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[529.257080] Subtest basic: SUCCESS (0.015s)
[531.210630] [113/131] (491s left) kms_chamelium_color (ctm-0-25)
[531.313916] Subtest ctm-0-25: SKIP (0.000s)
[531.357645] [114/131] (491s left) gem_userptr_blits (process-exit-busy)
[531.426899] Starting subtest: process-exit-busy
[531.441413] Subtest process-exit-busy: SUCCESS (0.015s)
[531.606307] [115/131] (491s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[531.665674] Starting subtest: y-tiled-ccs-to-y-tiled
[531.670018] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[531.871475] [116/131] (491s left) gen7_exec_parse (bitmasks)
[531.929751] Subtest bitmasks: SKIP (0.000s)
[532.010049] [117/131] (491s left) gem_eio (wait-wedge-10ms)
[532.201486] Starting subtest: wait-wedge-10ms
[534.210714] Subtest wait-wedge-10ms: SUCCESS (2.011s)
[534.354324] [118/131] (489s left) kms_content_protection (atomic)
[534.491425] Starting subtest: atomic
[534.496235] Subtest atomic: SKIP (0.000s)
[534.630276] [119/131] (488s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[534.725314] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[534.727785] Starting dynamic subtest: pipe-A-default-mode
[535.015365] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[535.020144] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.289s)
[535.906044] [120/131] (487s left) gem_exec_params (invalid-flag)
[535.975400] Starting subtest: invalid-flag
[535.977749] Subtest invalid-flag: SUCCESS (0.000s)
[536.116131] [121/131] (487s left) kms_getfb (getfb-addfb-different-handles)
[536.224742] Starting subtest: getfb-addfb-different-handles
[536.226980] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[536.367205] [122/131] (487s left) gem_exec_flush (basic-uc-ro-default)
[536.431014] Starting subtest: basic-uc-ro-default
[541.889537] Subtest basic-uc-ro-default: SUCCESS (5.460s)
[542.100048] [123/131] (481s left) gem_sync (basic-each)
[542.181030] Starting subtest: basic-each
[544.687228] Subtest basic-each: SUCCESS (2.517s)
[544.895495] [124/131] (478s left) gem_exec_balancer (full)
[544.953458] Starting subtest: full
[550.012782] Subtest full: SUCCESS (5.060s)
[550.316955] [125/131] (473s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[550.411166] Starting subtest: y-tiled-8bpp-rotate-180
[550.415438] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[550.542469] [126/131] (473s left) sw_sync (sync_merge_invalid)
[550.579721] Starting subtest: sync_merge_invalid
[550.606924] Subtest sync_merge_invalid: SUCCESS (0.029s)
[550.692378] [127/131] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[550.798046] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[555.263590] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.470s)
[556.499958] [128/131] (467s left) gem_lmem_swapping (parallel-random-verify-ccs)
[556.544337] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[556.593082] [129/131] (467s left) kms_lease (lease-unleased-connector)
[556.689068] Starting subtest: lease-unleased-connector
[556.691334] Starting dynamic subtest: pipe-A-eDP-1
[556.698923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[556.709181] Starting dynamic subtest: pipe-B-eDP-1
[556.711379] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[556.721329] Starting dynamic subtest: pipe-C-eDP-1
[556.723490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[556.733107] Starting dynamic subtest: pipe-D-eDP-1
[556.735271] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[556.737423] Subtest lease-unleased-connector: SUCCESS (0.040s)
[556.871672] [130/131] (467s left) perf (enable-disable)
[556.981854] Starting subtest: enable-disable
[556.984185] Starting dynamic subtest: 0-rcs0
[559.246103] Dynamic subtest 0-rcs0: SUCCESS (2.263s)
[559.256752] Starting dynamic subtest: 1-vcs1
[563.731448] Dynamic subtest 1-vcs1: SUCCESS (4.486s)
[563.734285] Subtest enable-disable: SUCCESS (6.751s)
[563.782326] [131/131] (460s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[563.917322] Starting subtest: cursor-rapid-movement-32x32
[563.971138] Subtest cursor-rapid-movement-32x32: SKIP (0.047s)
[564.289286] Closing watchdogs
results: parsing output: 0/ for test: fbdev
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_plane_alpha_blend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: core_auth
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_dither
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gen3_render_mixed_blits
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_atomic_interruptible
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: i915_suspend
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_async
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: kms_feature_discovery
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_basic
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_cursor_crc
Done.