[57.669868] Initializing watchdogs
[57.669916]   /dev/watchdog0
[57.685074] [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.689471] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.691964] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.695217] [001/131] (960s left) fbdev (unaligned-read)
[57.765630] Starting subtest: unaligned-read
[57.780046] Subtest unaligned-read: SUCCESS (0.015s)
[57.858563] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[57.935314] Starting subtest: dirty-switch
[57.937851] Starting dynamic subtest: rcs0
[58.192121] Dynamic subtest rcs0: SUCCESS (0.254s)
[58.202580] Starting dynamic subtest: bcs0
[58.483597] Dynamic subtest bcs0: SUCCESS (0.288s)
[58.491753] Starting dynamic subtest: vcs0
[58.749616] Dynamic subtest vcs0: SUCCESS (0.264s)
[58.759189] Starting dynamic subtest: vcs1
[60.160251] Dynamic subtest vcs1: SUCCESS (1.396s)
[60.170105] Starting dynamic subtest: vecs0
[62.138621] Dynamic subtest vecs0: SUCCESS (1.964s)
[62.148621] Starting dynamic subtest: ccs0
[64.141062] Dynamic subtest ccs0: SUCCESS (1.991s)
[64.143663] Subtest dirty-switch: SUCCESS (6.158s)
[64.430136] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.538084] Starting subtest: psr-modesetfrombusy
[70.737319] Subtest psr-modesetfrombusy: SUCCESS (6.185s)
[70.930575] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[71.031461] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[71.033527] Starting dynamic subtest: pipe-A-default-mode
[73.768680] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[73.771037] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.734s)
[74.657874] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[74.720036] Starting subtest: sol-reset-invalid
[74.722424] Subtest sol-reset-invalid: SUCCESS (0.002s)
[76.027028] [006/131] (942s left) gem_spin_batch (resubmit-new)
[76.100337] Starting subtest: resubmit-new
[76.102748] Starting dynamic subtest: rcs0
[76.107567] Dynamic subtest rcs0: SUCCESS (0.007s)
[76.115826] Starting dynamic subtest: bcs0
[76.118105] Dynamic subtest bcs0: SUCCESS (0.004s)
[76.125482] Starting dynamic subtest: vcs0
[76.127811] Dynamic subtest vcs0: SUCCESS (0.005s)
[76.135791] Starting dynamic subtest: vcs1
[76.137667] Dynamic subtest vcs1: SUCCESS (0.004s)
[76.144714] Starting dynamic subtest: vecs0
[76.146667] Dynamic subtest vecs0: SUCCESS (0.004s)
[76.153686] Starting dynamic subtest: ccs0
[76.155682] Dynamic subtest ccs0: SUCCESS (0.003s)
[76.157606] Subtest resubmit-new: SUCCESS (0.029s)
[77.976181] [007/131] (940s left) gem_exec_schedule (preempt-user)
[78.052048] Starting subtest: preempt-user
[78.054123] Starting dynamic subtest: rcs0
[78.078306] Dynamic subtest rcs0: SUCCESS (0.033s)
[78.088522] Starting dynamic subtest: bcs0
[78.108904] Dynamic subtest bcs0: SUCCESS (0.031s)
[78.116735] Starting dynamic subtest: vcs0
[78.132761] Dynamic subtest vcs0: SUCCESS (0.023s)
[78.140305] Starting dynamic subtest: vcs1
[78.160348] Dynamic subtest vcs1: SUCCESS (0.027s)
[78.168406] Starting dynamic subtest: vecs0
[78.184343] Dynamic subtest vecs0: SUCCESS (0.023s)
[78.191903] Starting dynamic subtest: ccs0
[78.214600] Dynamic subtest ccs0: SUCCESS (0.030s)
[78.217064] Subtest preempt-user: SUCCESS (0.169s)
[80.025787] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[80.093999] Starting subtest: nopreempt
[80.096704] Starting dynamic subtest: vecs0
[89.903134] Dynamic subtest vecs0: SUCCESS (9.798s)
[89.912882] Starting dynamic subtest: ccs0
[94.000727] Dynamic subtest ccs0: SUCCESS (4.097s)
[94.011149] Starting dynamic subtest: vcs0
[103.915334] Dynamic subtest vcs0: SUCCESS (9.906s)
[103.926793] Starting dynamic subtest: bcs0
[108.037785] Dynamic subtest bcs0: SUCCESS (4.122s)
[108.046895] Starting dynamic subtest: rcs0
[112.132677] Dynamic subtest rcs0: SUCCESS (4.093s)
[112.142900] Starting dynamic subtest: vcs1
[121.883216] Dynamic subtest vcs1: SUCCESS (9.748s)
[121.885783] Subtest nopreempt: SUCCESS (41.770s)
[121.987441] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[122.087425] Starting subtest: zero-hdisplay
[122.089997] Starting dynamic subtest: pipe-A-eDP-1
[122.377317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[122.388492] Starting dynamic subtest: pipe-B-eDP-1
[122.390391] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[122.397741] Starting dynamic subtest: pipe-C-eDP-1
[122.400047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[122.407290] Starting dynamic subtest: pipe-D-eDP-1
[122.409456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[122.411633] Subtest zero-hdisplay: SUCCESS (0.295s)
[123.210266] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[123.315020] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[123.319658] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[123.432351] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[123.552856] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[124.421749] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s)
[124.634442] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[124.742936] Starting subtest: getfb-handle-zero
[124.745240] Subtest getfb-handle-zero: SUCCESS (0.000s)
[124.874955] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[124.941402] Starting subtest: yf-tiled-ccs-to-yf-tiled
[124.945926] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[125.141776] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[125.232900] Starting subtest: multiplane-rotation-cropping-bottom
[132.470866] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.238s)
[132.647979] [015/131] (886s left) gem_eio (wait-1us)
[132.889616] Starting subtest: wait-1us
[133.242406] Subtest wait-1us: SUCCESS (0.354s)
[133.429269] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[133.488116] Starting subtest: multi-wait-for-submit-signaled
[133.489953] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[133.619286] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[133.716384] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[133.718183] Starting dynamic subtest: pipe-A-default-mode
[134.004382] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[134.008805] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s)
[134.830205] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[134.927132] Starting subtest: alpha-7efc
[135.225669] Starting dynamic subtest: pipe-A-eDP-1
[135.833940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[135.866305] Starting dynamic subtest: pipe-D-eDP-1
[137.129929] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[137.132332] Subtest alpha-7efc: SUCCESS (2.203s)
[137.989260] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[138.103416] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[138.107744] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[138.251730] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[138.342068] Starting subtest: fbc-psr2-primary-mmap-cpu
[138.344330] Starting dynamic subtest: eDP-1
[138.348320] Dynamic subtest eDP-1: SKIP (0.000s)
[138.352690] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[138.437953] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[138.536384] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[138.545135] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[138.644763] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[138.705965] Starting subtest: basic-normal-all
[141.149247] Subtest basic-normal-all: SUCCESS (2.441s)
[141.353255] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[141.464826] Starting subtest: linear-16bpp-rotate-180
[142.829334] Subtest linear-16bpp-rotate-180: SUCCESS (1.367s)
[142.999193] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[143.100319] Starting subtest: psr-slowdraw
[168.272115] Subtest psr-slowdraw: SUCCESS (25.174s)
[168.384916] [025/131] (850s left) vgem_basic (dmabuf-fence)
[168.493879] Starting subtest: dmabuf-fence
[168.495895] Subtest dmabuf-fence: SUCCESS (0.001s)
[168.568308] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[168.571316] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[168.630361] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[168.632533] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[168.741331] [027/131] (850s left) kms_psr (pr-primary-render)
[168.844932] Starting subtest: pr-primary-render
[168.849194] Subtest pr-primary-render: SKIP (0.000s)
[168.974220] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[169.067371] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[169.069227] Starting dynamic subtest: pipe-A-eDP-1
[169.088614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.098621] Starting dynamic subtest: pipe-B-eDP-1
[169.116354] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.124956] Starting dynamic subtest: pipe-C-eDP-1
[169.143812] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.153367] Starting dynamic subtest: pipe-D-eDP-1
[169.171586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.174907] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[171.347174] [029/131] (848s left) core_auth (getclient-master-drop)
[171.386325] Starting subtest: getclient-master-drop
[171.408878] Subtest getclient-master-drop: SUCCESS (0.024s)
[171.545823] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[171.653893] Starting subtest: planes-downscale-factor-0-5
[171.656105] Starting dynamic subtest: pipe-A
[171.677579] Dynamic subtest pipe-A: SKIP (0.019s)
[171.688581] Starting dynamic subtest: pipe-B
[171.715178] Dynamic subtest pipe-B: SKIP (0.037s)
[171.724180] Starting dynamic subtest: pipe-C
[171.751731] Dynamic subtest pipe-C: SKIP (0.037s)
[171.760296] Starting dynamic subtest: pipe-D
[171.784932] Dynamic subtest pipe-D: SKIP (0.033s)
[171.789139] Subtest planes-downscale-factor-0-5: SKIP (0.127s)
[171.914162] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[172.017640] Starting subtest: fb-8bpc-vs-panel-8bpc
[172.019836] Starting dynamic subtest: pipe-A-eDP-1
[173.409822] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.391s)
[173.411684] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.392s)
[174.305670] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[174.375395] Subtest reads-snoop: SKIP (0.000s)
[174.465733] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[174.708430] Starting subtest: in-flight-contexts-immediate
[185.904703] Subtest in-flight-contexts-immediate: SUCCESS (11.194s)
[186.121723] [034/131] (833s left) gen3_render_mixed_blits
[186.258825] [035/131] (833s left) kms_pm_rpm (pm-tiling)
[188.093245] Starting subtest: pm-tiling
[188.098243] Subtest pm-tiling: SKIP (0.000s)
[188.537407] [036/131] (831s left) i915_module_load (reload-no-display)
[188.576930] Starting subtest: reload-no-display
[193.205679] Subtest reload-no-display: SUCCESS (4.631s)
[193.237019] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[193.237806] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[193.240928] [037/131] (826s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[194.884422] Starting subtest: plane-upscale-20x20-with-rotation
[194.886799] Starting dynamic subtest: pipe-A
[195.137050] Dynamic subtest pipe-A: SUCCESS (0.254s)
[195.145453] Starting dynamic subtest: pipe-B
[196.476550] Dynamic subtest pipe-B: SUCCESS (1.337s)
[196.485107] Starting dynamic subtest: pipe-C
[197.803091] Dynamic subtest pipe-C: SUCCESS (1.326s)
[197.811795] Starting dynamic subtest: pipe-D
[199.141120] Dynamic subtest pipe-D: SUCCESS (1.337s)
[199.143634] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.259s)
[200.294834] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[200.296062] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[200.299854] [038/131] (819s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[200.412459] Starting subtest: 4-tiled-8bpp-rotate-180
[201.628571] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.216s)
[201.784754] [039/131] (817s left) kms_rotation_crc (primary-rotation-90)
[201.882491] Starting subtest: primary-rotation-90
[201.886201] Subtest primary-rotation-90: SKIP (0.001s)
[201.979696] [040/131] (817s left) kms_cursor_crc (cursor-onscreen-32x10)
[202.140045] Starting subtest: cursor-onscreen-32x10
[202.188159] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[202.473827] [041/131] (817s left) kms_vblank (wait-idle)
[202.572107] Starting subtest: wait-idle
[202.573882] Starting dynamic subtest: pipe-A-eDP-1
[204.338763] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[204.352971] Starting dynamic subtest: pipe-D-eDP-1
[206.764589] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[206.767054] Subtest wait-idle: SUCCESS (4.192s)
[207.612755] [042/131] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[207.723865] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[207.728185] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[207.863194] [043/131] (812s left) kms_flip (2x-flip-vs-dpms)
[207.966153] Starting subtest: 2x-flip-vs-dpms
[207.978343] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[208.085070] [044/131] (811s left) gem_exec_fence (syncobj-channel)
[208.512631] Starting subtest: syncobj-channel
[209.530913] Subtest syncobj-channel: SUCCESS (1.015s)
[210.059149] [045/131] (809s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[210.166060] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[210.168210] Starting dynamic subtest: pipe-A-eDP-1
[210.176792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.185834] Starting dynamic subtest: pipe-B-eDP-1
[210.194258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.203039] Starting dynamic subtest: pipe-C-eDP-1
[210.211156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.219085] Starting dynamic subtest: pipe-D-eDP-1
[210.227157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.231065] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[212.460403] [046/131] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[212.563652] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[219.879946] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.319s)
[220.051863] [047/131] (800s left) kms_flip (busy-flip)
[220.144272] Starting subtest: busy-flip
[220.146440] Starting dynamic subtest: A-eDP1
[221.882707] Dynamic subtest A-eDP1: SUCCESS (1.737s)
[221.893746] Starting dynamic subtest: B-eDP1
[223.610745] Dynamic subtest B-eDP1: SUCCESS (1.726s)
[223.621793] Starting dynamic subtest: C-eDP1
[225.326768] Dynamic subtest C-eDP1: SUCCESS (1.714s)
[225.338045] Starting dynamic subtest: D-eDP1
[226.968246] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[226.970825] Subtest busy-flip: SUCCESS (6.826s)
[228.166706] [048/131] (791s left) prime_mmap (test_aperture_limit)
[228.231701] Starting subtest: test_aperture_limit
[228.233894] Starting dynamic subtest: test_aperture_limit-smem
[228.243400] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[228.247654] Subtest test_aperture_limit: SKIP (0.011s)
[228.390841] [049/131] (791s left) i915_pm_rpm (sysfs-read)
[230.020527] Starting subtest: sysfs-read
[231.195785] Subtest sysfs-read: SUCCESS (1.169s)
[231.581682] [050/131] (788s left) kms_big_fb (yf-tiled-addfb)
[231.684024] Starting subtest: yf-tiled-addfb
[231.688678] Subtest yf-tiled-addfb: SKIP (0.000s)
[231.828662] [051/131] (788s left) sriov_basic (enable-vfs-autoprobe-on)
[231.897915] Starting subtest: enable-vfs-autoprobe-on
[231.900390] Starting dynamic subtest: numvfs-1
[231.982161] Dynamic subtest numvfs-1: FAIL (0.029s)
[231.992344] Starting dynamic subtest: numvfs-2
[232.066091] Dynamic subtest numvfs-2: FAIL (0.004s)
[232.077213] Starting dynamic subtest: numvfs-3
[232.153199] Dynamic subtest numvfs-3: FAIL (0.003s)
[232.163193] Starting dynamic subtest: numvfs-4
[232.237795] Dynamic subtest numvfs-4: FAIL (0.004s)
[232.247356] Starting dynamic subtest: numvfs-5
[232.318853] Dynamic subtest numvfs-5: FAIL (0.004s)
[232.329474] Starting dynamic subtest: numvfs-6
[232.401966] Dynamic subtest numvfs-6: FAIL (0.004s)
[232.411309] Starting dynamic subtest: numvfs-7
[232.485363] Dynamic subtest numvfs-7: FAIL (0.003s)
[232.495345] Starting dynamic subtest: numvfs-random
[232.555759] Dynamic subtest numvfs-random: FAIL (0.004s)
[232.565076] Starting dynamic subtest: numvfs-all
[232.626280] Dynamic subtest numvfs-all: FAIL (0.515s)
[232.628180] Subtest enable-vfs-autoprobe-on: FAIL (0.576s)
[232.665479] [052/131] (787s left) gem_exec_whisper (basic-queues)
[232.740320] Starting subtest: basic-queues
[238.422193] Subtest basic-queues: SUCCESS (5.678s)
[238.632375] [053/131] (781s left) kms_flip (2x-dpms-vs-vblank-race)
[238.741240] Starting subtest: 2x-dpms-vs-vblank-race
[238.751091] Subtest 2x-dpms-vs-vblank-race: SKIP (0.012s)
[238.854281] [054/131] (781s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[238.961814] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[239.335182] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[242.116750] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[242.128373] Starting dynamic subtest: pipe-A-eDP-1-4
[244.291598] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[244.303059] Starting dynamic subtest: pipe-A-eDP-1-4
[246.301743] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[246.312856] Starting dynamic subtest: pipe-A-eDP-1-x
[248.491825] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[248.856628] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[251.641610] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[251.653285] Starting dynamic subtest: pipe-B-eDP-1-4
[253.817431] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[253.828954] Starting dynamic subtest: pipe-B-eDP-1-4
[255.826778] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[255.838342] Starting dynamic subtest: pipe-B-eDP-1-x
[258.028668] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[258.392815] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[261.169581] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[261.179301] Starting dynamic subtest: pipe-C-eDP-1-4
[263.345408] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[263.356908] Starting dynamic subtest: pipe-C-eDP-1-4
[265.355695] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[265.367475] Starting dynamic subtest: pipe-C-eDP-1-x
[267.535044] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[267.904294] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[270.703205] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[270.714473] Starting dynamic subtest: pipe-D-eDP-1-4
[272.878455] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[272.890373] Starting dynamic subtest: pipe-D-eDP-1-4
[274.889229] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[274.904691] Starting dynamic subtest: pipe-D-eDP-1-x
[277.067327] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[277.069849] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.104s)
[278.311868] [055/131] (742s left) gem_mmap_gtt (basic-write-read-distinct)
[278.388175] Subtest basic-write-read-distinct: SKIP (0.000s)
[278.451593] [056/131] (742s left) gem_mmap_offset (oob-read)
[278.493766] Starting subtest: oob-read
[278.496158] Subtest oob-read: SUCCESS (0.000s)
[278.611815] [057/131] (741s left) kms_atomic (atomic-plane-damage)
[278.714340] Starting subtest: atomic-plane-damage
[278.764145] Starting dynamic subtest: pipe-A-eDP-1
[279.290186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[279.292925] Subtest atomic-plane-damage: SUCCESS (0.578s)
[280.141525] [058/131] (740s left) kms_atomic_transition (plane-all-transition-nonblocking)
[280.245198] Starting subtest: plane-all-transition-nonblocking
[280.247324] Starting dynamic subtest: pipe-A-eDP-1
[282.739065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[283.053044] Starting dynamic subtest: pipe-B-eDP-1
[286.249032] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.205s)
[286.546858] Subtest plane-all-transition-nonblocking: SUCCESS (6.301s)
[287.399189] [059/131] (733s left) gem_exec_parallel (contexts)
[287.462682] Starting subtest: contexts
[287.465243] Starting dynamic subtest: rcs0
[290.346378] Dynamic subtest rcs0: SUCCESS (2.881s)
[290.361352] Starting dynamic subtest: bcs0
[293.916700] Dynamic subtest bcs0: SUCCESS (3.567s)
[293.928073] Starting dynamic subtest: vcs0
[298.332415] Dynamic subtest vcs0: SUCCESS (4.412s)
[298.344223] Starting dynamic subtest: vcs1
[302.349563] Dynamic subtest vcs1: SUCCESS (4.014s)
[302.364813] Starting dynamic subtest: vecs0
[306.345873] Dynamic subtest vecs0: SUCCESS (3.994s)
[306.359754] Starting dynamic subtest: ccs0
[309.666864] Dynamic subtest ccs0: SUCCESS (3.317s)
[309.669702] Subtest contexts: SUCCESS (22.204s)
[309.881056] [060/131] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[309.987115] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[316.747367] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.761s)
[316.940187] [061/131] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[317.051097] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[317.055154] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[317.214024] [062/131] (703s left) kms_atomic_interruptible (legacy-pageflip)
[317.313765] Starting subtest: legacy-pageflip
[317.315852] Starting dynamic subtest: pipe-A-eDP-1
[324.702697] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.385s)
[324.704966] Subtest legacy-pageflip: SUCCESS (7.388s)
[325.565251] [063/131] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[325.667867] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[325.672035] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[325.806916] [064/131] (695s left) kms_psr (psr2-sprite-mmap-cpu)
[325.895038] Starting subtest: psr2-sprite-mmap-cpu
[325.897115] Starting dynamic subtest: eDP-1
[327.634211] Dynamic subtest eDP-1: SUCCESS (1.739s)
[327.636479] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.740s)
[328.522142] [065/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[328.627137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[335.744396] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.118s)
[335.947921] [066/131] (684s left) gem_exec_schedule (fairslice-all)
[336.028715] Starting subtest: fairslice-all
[338.083993] Subtest fairslice-all: SUCCESS (2.061s)
[339.982668] [067/131] (680s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[345.011140] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[345.013300] Starting dynamic subtest: pipe-A-eDP-1
[345.792517] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[345.802903] Starting dynamic subtest: pipe-B-eDP-1
[346.927036] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[346.931649] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.914s)
[348.139883] [068/131] (672s left) api_intel_allocator (two-level-inception)
[348.204815] Starting subtest: two-level-inception
[353.603101] Subtest two-level-inception: SUCCESS (5.398s)
[353.766375] [069/131] (667s left) i915_suspend (debugfs-reader)
[353.828797] Starting subtest: debugfs-reader
[371.995273] Subtest debugfs-reader: SUCCESS (8.531s)
[372.061108] [070/131] (649s left) kms_flip (plain-flip-fb-recreate-interruptible)
[372.195410] Starting subtest: plain-flip-fb-recreate-interruptible
[372.198044] Starting dynamic subtest: A-eDP1
[392.918385] Dynamic subtest A-eDP1: SUCCESS (20.399s)
[392.928912] Starting dynamic subtest: B-eDP1
[401.788202] Dynamic subtest B-eDP1: SUCCESS (8.849s)
[401.799416] Starting dynamic subtest: C-eDP1
[410.622245] Dynamic subtest C-eDP1: SUCCESS (8.827s)
[410.633287] Starting dynamic subtest: D-eDP1
[419.459234] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[419.463511] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (46.915s)
[420.670424] [071/131] (600s left) gem_vm_create (invalid-destroy)
[420.736383] Starting subtest: invalid-destroy
[420.738798] Subtest invalid-destroy: SUCCESS (0.002s)
[420.880065] [072/131] (600s left) gem_ccs (ctrl-surf-copy-new-ctx)
[420.946704] Starting subtest: ctrl-surf-copy-new-ctx
[420.951390] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[421.086034] [073/131] (600s left) syncobj_basic (bad-destroy-pad)
[421.147322] Starting subtest: bad-destroy-pad
[421.149239] Subtest bad-destroy-pad: SUCCESS (0.000s)
[421.281827] [074/131] (599s left) kms_plane_multiple (2x-tiling-y)
[421.384597] Starting subtest: 2x-tiling-y
[421.388814] Subtest 2x-tiling-y: SKIP (0.000s)
[421.479079] [075/131] (599s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[421.574755] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[421.577017] Starting dynamic subtest: pipe-A-eDP-1
[421.597022] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[421.608611] Starting dynamic subtest: pipe-B-eDP-1
[421.626038] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[421.635358] Starting dynamic subtest: pipe-C-eDP-1
[421.652779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[421.662233] Starting dynamic subtest: pipe-D-eDP-1
[421.679770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[421.683263] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[423.723024] [076/131] (597s left) kms_pm_rpm (modeset-lpsp)
[425.655557] Starting subtest: modeset-lpsp
[427.122642] Subtest modeset-lpsp: SUCCESS (1.469s)
[427.233993] [077/131] (594s left) kms_setmode (basic)
[427.298755] Starting subtest: basic
[427.631529] Starting dynamic subtest: pipe-A-eDP-1
[431.177853] Dynamic subtest pipe-A-eDP-1: FAIL (3.414s)
[431.387553] Starting dynamic subtest: pipe-B-eDP-1
[434.782634] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.398s)
[435.093973] Subtest basic: FAIL (7.789s)
[435.911890] [078/131] (585s left) kms_psr (fbc-psr-suspend)
[436.013410] Starting subtest: fbc-psr-suspend
[436.015697] Starting dynamic subtest: eDP-1
[436.019907] Dynamic subtest eDP-1: SKIP (0.000s)
[436.024172] Subtest fbc-psr-suspend: SKIP (0.001s)
[436.114054] [079/131] (585s left) gem_ringfill (engines-basic)
[441.504074] Starting subtest: engines-basic
[441.506985] Starting dynamic subtest: rcs0
[441.567501] Dynamic subtest rcs0: SUCCESS (0.063s)
[441.579877] Starting dynamic subtest: bcs0
[441.612444] Dynamic subtest bcs0: SUCCESS (0.043s)
[441.623521] Starting dynamic subtest: vcs0
[441.655671] Dynamic subtest vcs0: SUCCESS (0.041s)
[441.665993] Starting dynamic subtest: vcs1
[441.699519] Dynamic subtest vcs1: SUCCESS (0.042s)
[441.709994] Starting dynamic subtest: vecs0
[441.742704] Dynamic subtest vecs0: SUCCESS (0.041s)
[441.753298] Starting dynamic subtest: ccs0
[441.788520] Dynamic subtest ccs0: SUCCESS (0.044s)
[441.790909] Subtest engines-basic: SUCCESS (0.286s)
[441.893627] [080/131] (579s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[441.967294] Starting subtest: invalid-bsd2-flag-on-vebox
[441.969473] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[442.108757] [081/131] (579s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[442.211572] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[442.213717] Starting dynamic subtest: pipe-A-eDP-1
[442.234898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[442.245003] Starting dynamic subtest: pipe-B-eDP-1
[442.264264] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[442.274367] Starting dynamic subtest: pipe-C-eDP-1
[442.293852] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[442.303746] Starting dynamic subtest: pipe-D-eDP-1
[442.322913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[442.325002] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.089s)
[444.476744] [082/131] (577s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[444.587094] Starting subtest: extended-pageflip-modeset-hang-oldfb
[444.589434] Starting dynamic subtest: pipe-A
[452.493723] Dynamic subtest pipe-A: SUCCESS (7.898s)
[452.504769] Starting dynamic subtest: pipe-D
[461.069285] Dynamic subtest pipe-D: SUCCESS (8.570s)
[461.071553] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.473s)
[461.989090] [083/131] (559s left) gem_ppgtt (shrink-vs-evict-any)
[462.058767] Starting subtest: shrink-vs-evict-any
[467.523818] Subtest shrink-vs-evict-any: SUCCESS (5.463s)
[467.651283] [084/131] (554s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[467.715734] Starting subtest: etime-single-wait-for-submit-unsubmitted
[467.826103] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[467.930465] [085/131] (553s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[467.984197] Starting subtest: multi-wait-all-for-submit-signaled
[467.986221] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[468.128294] [086/131] (553s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[468.188398] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[468.298102] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[468.407848] [087/131] (553s left) gem_exec_schedule (implicit-write-read)
[468.476867] Starting subtest: implicit-write-read
[468.478744] Starting dynamic subtest: rcs0
[468.666296] Dynamic subtest rcs0: SUCCESS (0.194s)
[468.681583] Starting dynamic subtest: vcs0
[468.794510] Dynamic subtest vcs0: SUCCESS (0.129s)
[468.807454] Starting dynamic subtest: vcs1
[468.899576] Dynamic subtest vcs1: SUCCESS (0.104s)
[468.913860] Starting dynamic subtest: vecs0
[468.996591] Dynamic subtest vecs0: SUCCESS (0.097s)
[469.009889] Starting dynamic subtest: ccs0
[469.115487] Dynamic subtest ccs0: SUCCESS (0.118s)
[469.118333] Subtest implicit-write-read: SUCCESS (0.646s)
[470.632588] [088/131] (551s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[470.732701] Starting subtest: fbcpsr-rgb565-draw-blt
[477.756906] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.029s)
[477.928626] [089/131] (544s left) gem_ctx_persistence (processes)
[477.981921] Starting subtest: processes
[479.513223] Subtest processes: SUCCESS (1.519s)
[479.607069] [090/131] (542s left) kms_cursor_crc (cursor-sliding-32x10)
[479.765358] Starting subtest: cursor-sliding-32x10
[479.811323] Subtest cursor-sliding-32x10: SKIP (0.043s)
[480.111800] [091/131] (541s left) kms_psr (fbc-pr-primary-render)
[480.211998] Starting subtest: fbc-pr-primary-render
[480.216242] Subtest fbc-pr-primary-render: SKIP (0.000s)
[480.312042] [092/131] (541s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[480.372463] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[480.455596] [093/131] (541s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[480.517277] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[480.519633] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[480.649080] [094/131] (541s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[480.746469] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[480.750170] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.862396] [095/131] (541s left) gem_exec_async (concurrent-writes)
[480.917276] Starting subtest: concurrent-writes
[480.919387] Starting dynamic subtest: rcs0
[480.931579] Dynamic subtest rcs0: SUCCESS (0.014s)
[480.943885] Starting dynamic subtest: bcs0
[480.946146] Dynamic subtest bcs0: SUCCESS (0.007s)
[480.956167] Starting dynamic subtest: vcs0
[480.957899] Dynamic subtest vcs0: SUCCESS (0.006s)
[480.967789] Starting dynamic subtest: vcs1
[480.969686] Dynamic subtest vcs1: SUCCESS (0.006s)
[480.979355] Starting dynamic subtest: vecs0
[480.981319] Dynamic subtest vecs0: SUCCESS (0.005s)
[480.991200] Starting dynamic subtest: ccs0
[480.993166] Dynamic subtest ccs0: SUCCESS (0.006s)
[480.995145] Subtest concurrent-writes: SUCCESS (0.047s)
[481.239537] [096/131] (541s left) gem_mmap_gtt (basic-small-bo-tiledx)
[481.300597] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[481.370372] [097/131] (540s left) dmabuf_sync_file (import-basic)
[481.409807] Starting subtest: import-basic
[481.411716] Subtest import-basic: SUCCESS (0.001s)
[481.489319] [098/131] (540s left) kms_feature_discovery (display)
[481.588175] Starting subtest: display
[481.590188] Subtest display: SUCCESS (0.000s)
[481.707787] [099/131] (540s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[481.800761] Starting subtest: x-tiled-64bpp-rotate-90
[481.820488] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[481.980402] [100/131] (540s left) perf_pmu (busy-no-semaphores)
[482.018102] Starting subtest: busy-no-semaphores
[482.019897] Starting dynamic subtest: rcs0
[482.611999] Dynamic subtest rcs0: SUCCESS (0.593s)
[482.625409] Starting dynamic subtest: bcs0
[483.163031] Dynamic subtest bcs0: SUCCESS (0.548s)
[483.175955] Starting dynamic subtest: vcs0
[483.715032] Dynamic subtest vcs0: SUCCESS (0.548s)
[483.728355] Starting dynamic subtest: vcs1
[485.023541] Dynamic subtest vcs1: SUCCESS (1.306s)
[485.036685] Starting dynamic subtest: vecs0
[487.008725] Dynamic subtest vecs0: SUCCESS (1.983s)
[487.022273] Starting dynamic subtest: ccs0
[489.055871] Dynamic subtest ccs0: SUCCESS (2.044s)
[489.058712] Subtest busy-no-semaphores: SUCCESS (7.040s)
[489.219664] [101/131] (533s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[489.326869] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[489.330953] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[489.465364] [102/131] (533s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[489.590279] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[489.594615] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[489.760855] [103/131] (532s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[490.145396] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[490.959211] [104/131] (531s left) kms_getfb (getfb-reject-nv12)
[491.059637] Starting subtest: getfb-reject-nv12
[491.061811] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[491.209522] [105/131] (531s left) i915_drm_fdinfo (context-close-stress)
[491.248738] Starting subtest: context-close-stress
[501.994722] Subtest context-close-stress: SUCCESS (10.745s)
[502.096487] [106/131] (520s left) perf_pmu (module-unload)
[502.359354] Starting subtest: module-unload
[510.904701] Subtest module-unload: FAIL (8.438s)
[510.935126] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[510.935857] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[510.938993] [107/131] (511s left) kms_chamelium_edid (dp-edid-read)
[513.498538] Subtest dp-edid-read: SKIP (0.000s)
[513.808400] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[513.809619] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[513.813224] [108/131] (508s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[518.828293] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[518.830271] Starting dynamic subtest: pipe-A-eDP-1
[519.607792] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[519.617767] Starting dynamic subtest: pipe-B-eDP-1
[520.734711] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[520.739087] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.906s)
[521.940414] [109/131] (500s left) kms_vblank (query-busy)
[522.044034] Starting subtest: query-busy
[522.046304] Starting dynamic subtest: pipe-A-eDP-1
[523.957079] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.908s)
[523.971795] Starting dynamic subtest: pipe-D-eDP-1
[526.482524] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[526.484866] Subtest query-busy: SUCCESS (4.437s)
[527.312349] [110/131] (495s left) syncobj_timeline (wait-for-submit-complex)
[527.380719] Starting subtest: wait-for-submit-complex
[527.442663] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[527.545052] [111/131] (495s left) perf (invalid-create-userspace-config)
[527.707993] Starting subtest: invalid-create-userspace-config
[527.710289] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[527.754849] [112/131] (495s left) gem_exec_basic (basic)
[527.820967] Starting subtest: basic
[527.823409] Starting dynamic subtest: rcs0-smem
[527.825728] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[527.837240] Starting dynamic subtest: bcs0-smem
[527.839432] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[527.848122] Starting dynamic subtest: vcs0-smem
[527.850274] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[527.858870] Starting dynamic subtest: vcs1-smem
[527.861007] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[527.869679] Starting dynamic subtest: vecs0-smem
[527.871834] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[527.880667] Starting dynamic subtest: ccs0-smem
[527.882957] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[527.885140] Subtest basic: SUCCESS (0.014s)
[529.563737] [113/131] (493s left) kms_chamelium_color (ctm-0-25)
[529.668415] Subtest ctm-0-25: SKIP (0.000s)
[529.715833] [114/131] (493s left) gem_userptr_blits (process-exit-busy)
[529.786695] Starting subtest: process-exit-busy
[529.801884] Subtest process-exit-busy: SUCCESS (0.015s)
[529.957623] [115/131] (493s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[530.010514] Starting subtest: y-tiled-ccs-to-y-tiled
[530.015074] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[530.219395] [116/131] (492s left) gen7_exec_parse (bitmasks)
[530.283967] Subtest bitmasks: SKIP (0.000s)
[530.366807] [117/131] (492s left) gem_eio (wait-wedge-10ms)
[530.555489] Starting subtest: wait-wedge-10ms
[531.529860] Subtest wait-wedge-10ms: SUCCESS (0.977s)
[531.687015] [118/131] (491s left) kms_content_protection (atomic)
[531.831555] Starting subtest: atomic
[531.835783] Subtest atomic: SKIP (0.000s)
[532.010261] [119/131] (491s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[532.115476] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[532.117710] Starting dynamic subtest: pipe-A-default-mode
[532.416961] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[532.421342] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.301s)
[533.259200] [120/131] (490s left) gem_exec_params (invalid-flag)
[533.326561] Starting subtest: invalid-flag
[533.329080] Subtest invalid-flag: SUCCESS (0.000s)
[533.473016] [121/131] (489s left) kms_getfb (getfb-addfb-different-handles)
[533.574766] Starting subtest: getfb-addfb-different-handles
[533.577051] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[533.709128] [122/131] (489s left) gem_exec_flush (basic-uc-ro-default)
[533.789251] Starting subtest: basic-uc-ro-default
[539.252451] Subtest basic-uc-ro-default: SUCCESS (5.463s)
[539.467062] [123/131] (483s left) gem_sync (basic-each)
[539.565707] Starting subtest: basic-each
[542.321822] Subtest basic-each: SUCCESS (2.763s)
[542.536322] [124/131] (480s left) gem_exec_balancer (full)
[542.605427] Starting subtest: full
[547.407368] Subtest full: SUCCESS (4.800s)
[547.756400] [125/131] (475s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[547.860981] Starting subtest: y-tiled-8bpp-rotate-180
[547.864927] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[547.983843] [126/131] (475s left) sw_sync (sync_merge_invalid)
[548.023191] Starting subtest: sync_merge_invalid
[548.039587] Subtest sync_merge_invalid: SUCCESS (0.019s)
[548.131755] [127/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[548.243983] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[552.713490] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.478s)
[553.873407] [128/131] (469s left) gem_lmem_swapping (parallel-random-verify-ccs)
[553.917040] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[553.965750] [129/131] (469s left) kms_lease (lease-unleased-connector)
[554.063972] Starting subtest: lease-unleased-connector
[554.066317] Starting dynamic subtest: pipe-A-eDP-1
[554.071578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[554.082129] Starting dynamic subtest: pipe-B-eDP-1
[554.084396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[554.094400] Starting dynamic subtest: pipe-C-eDP-1
[554.096667] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[554.106345] Starting dynamic subtest: pipe-D-eDP-1
[554.108228] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[554.110115] Subtest lease-unleased-connector: SUCCESS (0.037s)
[554.246407] [130/131] (469s left) perf (enable-disable)
[554.357952] Starting subtest: enable-disable
[554.360258] Starting dynamic subtest: 0-rcs0
[556.624682] Dynamic subtest 0-rcs0: SUCCESS (2.265s)
[556.635514] Starting dynamic subtest: 1-vecs0
[561.108344] Dynamic subtest 1-vecs0: SUCCESS (4.480s)
[561.110667] Subtest enable-disable: SUCCESS (6.747s)
[561.158756] [131/131] (462s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[561.312343] Starting subtest: cursor-rapid-movement-32x32
[561.358074] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[561.704217] 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.