[56.451244] Initializing watchdogs
[56.451293]   /dev/watchdog0
[56.465197] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.469271] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.471380] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.474731] [001/131] (960s left) fbdev (unaligned-read)
[56.538290] Starting subtest: unaligned-read
[56.555538] Subtest unaligned-read: SUCCESS (0.017s)
[56.627950] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[56.685770] Starting subtest: dirty-switch
[56.688432] Starting dynamic subtest: rcs0
[56.931623] Dynamic subtest rcs0: SUCCESS (0.245s)
[56.939864] Starting dynamic subtest: bcs0
[57.207455] Dynamic subtest bcs0: SUCCESS (0.276s)
[57.216865] Starting dynamic subtest: vcs0
[57.462084] Dynamic subtest vcs0: SUCCESS (0.255s)
[57.471138] Starting dynamic subtest: vcs1
[59.122995] Dynamic subtest vcs1: SUCCESS (1.660s)
[59.132682] Starting dynamic subtest: vecs0
[61.110055] Dynamic subtest vecs0: SUCCESS (1.988s)
[61.119333] Starting dynamic subtest: ccs0
[63.162763] Dynamic subtest ccs0: SUCCESS (2.052s)
[63.165285] Subtest dirty-switch: SUCCESS (6.477s)
[63.438577] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[63.534439] Starting subtest: psr-modesetfrombusy
[69.764361] Subtest psr-modesetfrombusy: SUCCESS (6.234s)
[69.946519] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.049057] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.051045] Starting dynamic subtest: pipe-A-default-mode
[72.750823] Dynamic subtest pipe-A-default-mode: SUCCESS (2.701s)
[72.753325] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.702s)
[73.644992] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[73.724832] Starting subtest: sol-reset-invalid
[73.727165] Subtest sol-reset-invalid: SUCCESS (0.002s)
[75.012485] [006/131] (942s left) gem_spin_batch (resubmit-new)
[75.077365] Starting subtest: resubmit-new
[75.079672] Starting dynamic subtest: rcs0
[75.084478] Dynamic subtest rcs0: SUCCESS (0.010s)
[75.093969] Starting dynamic subtest: bcs0
[75.095892] Dynamic subtest bcs0: SUCCESS (0.004s)
[75.103217] Starting dynamic subtest: vcs0
[75.105491] Dynamic subtest vcs0: SUCCESS (0.003s)
[75.112822] Starting dynamic subtest: vcs1
[75.114954] Dynamic subtest vcs1: SUCCESS (0.004s)
[75.122083] Starting dynamic subtest: vecs0
[75.124261] Dynamic subtest vecs0: SUCCESS (0.004s)
[75.131402] Starting dynamic subtest: ccs0
[75.133703] Dynamic subtest ccs0: SUCCESS (0.003s)
[75.135931] Subtest resubmit-new: SUCCESS (0.031s)
[76.946755] [007/131] (940s left) gem_exec_schedule (preempt-user)
[77.023826] Starting subtest: preempt-user
[77.026074] Starting dynamic subtest: rcs0
[77.055028] Dynamic subtest rcs0: SUCCESS (0.035s)
[77.064741] Starting dynamic subtest: bcs0
[77.085437] Dynamic subtest bcs0: SUCCESS (0.030s)
[77.092665] Starting dynamic subtest: vcs0
[77.109595] Dynamic subtest vcs0: SUCCESS (0.024s)
[77.116756] Starting dynamic subtest: vcs1
[77.132206] Dynamic subtest vcs1: SUCCESS (0.022s)
[77.139296] Starting dynamic subtest: vecs0
[77.165698] Dynamic subtest vecs0: SUCCESS (0.033s)
[77.173935] Starting dynamic subtest: ccs0
[77.193809] Dynamic subtest ccs0: SUCCESS (0.028s)
[77.196165] Subtest preempt-user: SUCCESS (0.174s)
[79.056378] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[79.123038] Starting subtest: nopreempt
[79.125283] Starting dynamic subtest: vecs0
[87.885724] Dynamic subtest vecs0: SUCCESS (8.761s)
[87.897768] Starting dynamic subtest: ccs0
[91.849226] Dynamic subtest ccs0: SUCCESS (3.963s)
[91.859945] Starting dynamic subtest: vcs0
[100.891769] Dynamic subtest vcs0: SUCCESS (9.043s)
[100.902302] Starting dynamic subtest: bcs0
[106.643094] Dynamic subtest bcs0: SUCCESS (5.750s)
[106.654603] Starting dynamic subtest: rcs0
[110.754639] Dynamic subtest rcs0: SUCCESS (4.110s)
[110.765148] Starting dynamic subtest: vcs1
[119.920073] Dynamic subtest vcs1: SUCCESS (9.165s)
[119.922665] Subtest nopreempt: SUCCESS (40.800s)
[120.021125] [009/131] (897s left) kms_invalid_mode (zero-hdisplay)
[120.116691] Starting subtest: zero-hdisplay
[120.119116] Starting dynamic subtest: pipe-A-eDP-1
[120.398763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[120.408471] Starting dynamic subtest: pipe-B-eDP-1
[120.410780] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[120.418596] Starting dynamic subtest: pipe-C-eDP-1
[120.420881] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[120.428189] Starting dynamic subtest: pipe-D-eDP-1
[120.430094] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[120.432079] Subtest zero-hdisplay: SUCCESS (0.290s)
[121.264902] [010/131] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[121.380611] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[121.384991] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[121.511584] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[121.617386] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[122.486030] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s)
[122.713392] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[122.802642] Starting subtest: getfb-handle-zero
[122.804942] Subtest getfb-handle-zero: SUCCESS (0.000s)
[122.939272] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[123.000999] Starting subtest: yf-tiled-ccs-to-yf-tiled
[123.005659] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[123.210208] [014/131] (894s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[123.299782] Starting subtest: multiplane-rotation-cropping-bottom
[130.535566] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.237s)
[130.684671] [015/131] (886s left) gem_eio (wait-1us)
[130.913720] Starting subtest: wait-1us
[131.394544] Subtest wait-1us: SUCCESS (0.482s)
[131.570176] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[131.630279] Starting subtest: multi-wait-for-submit-signaled
[131.632742] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[131.753787] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[131.852275] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[131.854603] Starting dynamic subtest: pipe-A-default-mode
[132.157486] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[132.162152] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.302s)
[133.009580] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[133.087281] Starting subtest: alpha-7efc
[133.372862] Starting dynamic subtest: pipe-A-eDP-1
[134.003355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[134.031402] Starting dynamic subtest: pipe-D-eDP-1
[135.288197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[135.290549] Subtest alpha-7efc: SUCCESS (2.200s)
[136.158114] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[136.264572] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[136.268930] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[136.400206] [020/131] (881s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[136.497804] Starting subtest: fbc-psr2-primary-mmap-cpu
[136.500042] Starting dynamic subtest: eDP-1
[136.504063] Dynamic subtest eDP-1: SKIP (0.000s)
[136.508097] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[136.593113] [021/131] (881s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[136.694273] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[136.706257] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[136.806904] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[136.871899] Starting subtest: basic-normal-all
[139.347296] Subtest basic-normal-all: SUCCESS (2.476s)
[139.551140] [023/131] (878s left) kms_big_fb (linear-16bpp-rotate-180)
[139.663319] Starting subtest: linear-16bpp-rotate-180
[140.954976] Subtest linear-16bpp-rotate-180: SUCCESS (1.291s)
[141.131362] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[141.241258] Starting subtest: psr-slowdraw
[166.445230] Subtest psr-slowdraw: SUCCESS (25.205s)
[166.605987] [025/131] (851s left) vgem_basic (dmabuf-fence)
[166.710873] Starting subtest: dmabuf-fence
[166.713287] Subtest dmabuf-fence: SUCCESS (0.001s)
[166.790318] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[166.793514] [026/131] (851s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[166.847967] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[166.850327] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[166.980677] [027/131] (850s left) kms_psr (pr-primary-render)
[167.083936] Starting subtest: pr-primary-render
[167.088379] Subtest pr-primary-render: SKIP (0.000s)
[167.179090] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[167.279465] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[167.281425] Starting dynamic subtest: pipe-A-eDP-1
[167.300376] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.309059] Starting dynamic subtest: pipe-B-eDP-1
[167.326443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.333838] Starting dynamic subtest: pipe-C-eDP-1
[167.351841] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.359143] Starting dynamic subtest: pipe-D-eDP-1
[167.379080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.383023] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[169.543071] [029/131] (848s left) core_auth (getclient-master-drop)
[169.587754] Starting subtest: getclient-master-drop
[169.616309] Subtest getclient-master-drop: SUCCESS (0.030s)
[169.756666] [030/131] (848s left) kms_plane_scaling (planes-downscale-factor-0-5)
[169.866753] Starting subtest: planes-downscale-factor-0-5
[169.869421] Starting dynamic subtest: pipe-A
[169.906917] Dynamic subtest pipe-A: SKIP (0.036s)
[169.915926] Starting dynamic subtest: pipe-B
[169.965800] Dynamic subtest pipe-B: SKIP (0.057s)
[169.974192] Starting dynamic subtest: pipe-C
[170.002323] Dynamic subtest pipe-C: SKIP (0.036s)
[170.011069] Starting dynamic subtest: pipe-D
[170.036462] Dynamic subtest pipe-D: SKIP (0.032s)
[170.040856] Subtest planes-downscale-factor-0-5: SKIP (0.165s)
[170.169333] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[170.260360] Starting subtest: fb-8bpc-vs-panel-8bpc
[170.262739] Starting dynamic subtest: pipe-A-eDP-1
[171.635775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.374s)
[171.638274] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.375s)
[172.532491] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[172.606146] Subtest reads-snoop: SKIP (0.000s)
[172.684732] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[172.917426] Starting subtest: in-flight-contexts-immediate
[186.935056] Subtest in-flight-contexts-immediate: SUCCESS (14.018s)
[187.077907] [034/131] (831s left) gen3_render_mixed_blits
[187.198448] [035/131] (831s left) kms_pm_rpm (pm-tiling)
[189.018507] Starting subtest: pm-tiling
[189.023285] Subtest pm-tiling: SKIP (0.000s)
[189.479987] [036/131] (828s left) i915_module_load (reload-no-display)
[189.517894] Starting subtest: reload-no-display
[195.753562] Subtest reload-no-display: SUCCESS (6.235s)
[195.782592] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[195.783332] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[195.786529] [037/131] (822s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[197.349195] Starting subtest: plane-upscale-20x20-with-rotation
[197.351482] Starting dynamic subtest: pipe-A
[197.589511] Dynamic subtest pipe-A: SUCCESS (0.243s)
[197.597053] Starting dynamic subtest: pipe-B
[198.860290] Dynamic subtest pipe-B: SUCCESS (1.269s)
[198.868076] Starting dynamic subtest: pipe-C
[200.198067] Dynamic subtest pipe-C: SUCCESS (1.336s)
[200.206576] Starting dynamic subtest: pipe-D
[201.537106] Dynamic subtest pipe-D: SUCCESS (1.338s)
[201.539505] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.192s)
[202.709623] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[202.710962] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[202.714523] [038/131] (815s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[202.818350] Starting subtest: 4-tiled-8bpp-rotate-180
[204.028738] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.209s)
[204.181868] [039/131] (814s left) kms_rotation_crc (primary-rotation-90)
[204.281061] Starting subtest: primary-rotation-90
[204.284832] Subtest primary-rotation-90: SKIP (0.001s)
[204.380259] [040/131] (814s left) kms_cursor_crc (cursor-onscreen-32x10)
[204.540663] Starting subtest: cursor-onscreen-32x10
[204.592407] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[204.874564] [041/131] (813s left) kms_vblank (wait-idle)
[204.966323] Starting subtest: wait-idle
[204.967939] Starting dynamic subtest: pipe-A-eDP-1
[206.721673] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[206.734625] Starting dynamic subtest: pipe-D-eDP-1
[209.171870] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[209.174667] Subtest wait-idle: SUCCESS (4.206s)
[210.009816] [042/131] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[210.114544] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[210.118973] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[210.240330] [043/131] (808s left) kms_flip (2x-flip-vs-dpms)
[210.329714] Starting subtest: 2x-flip-vs-dpms
[210.341204] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[210.449261] [044/131] (808s left) gem_exec_fence (syncobj-channel)
[210.864907] Starting subtest: syncobj-channel
[211.883897] Subtest syncobj-channel: SUCCESS (1.015s)
[212.197643] [045/131] (806s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[212.295984] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[212.298314] Starting dynamic subtest: pipe-A-eDP-1
[212.307393] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.315486] Starting dynamic subtest: pipe-B-eDP-1
[212.324485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.332219] Starting dynamic subtest: pipe-C-eDP-1
[212.341018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.348504] Starting dynamic subtest: pipe-D-eDP-1
[212.356758] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.360980] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[214.566718] [046/131] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[214.663656] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[221.947545] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.288s)
[222.087225] [047/131] (796s left) kms_flip (busy-flip)
[222.192819] Starting subtest: busy-flip
[222.194608] Starting dynamic subtest: A-eDP1
[223.888960] Dynamic subtest A-eDP1: SUCCESS (1.697s)
[223.901898] Starting dynamic subtest: B-eDP1
[225.616040] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[225.626325] Starting dynamic subtest: C-eDP1
[227.256063] Dynamic subtest C-eDP1: SUCCESS (1.639s)
[227.265493] Starting dynamic subtest: D-eDP1
[228.896924] Dynamic subtest D-eDP1: SUCCESS (1.639s)
[228.903594] Subtest busy-flip: SUCCESS (6.712s)
[230.171353] [048/131] (788s left) prime_mmap (test_aperture_limit)
[230.228936] Starting subtest: test_aperture_limit
[230.231292] Starting dynamic subtest: test_aperture_limit-smem
[230.239022] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[230.243469] Subtest test_aperture_limit: SKIP (0.008s)
[230.363684] [049/131] (788s left) i915_pm_rpm (sysfs-read)
[232.103684] Starting subtest: sysfs-read
[233.270102] Subtest sysfs-read: SUCCESS (1.168s)
[233.676623] [050/131] (785s left) kms_big_fb (yf-tiled-addfb)
[233.777226] Starting subtest: yf-tiled-addfb
[233.781183] Subtest yf-tiled-addfb: SKIP (0.000s)
[233.923356] [051/131] (785s left) sriov_basic (enable-vfs-autoprobe-on)
[233.988303] Starting subtest: enable-vfs-autoprobe-on
[233.990545] Starting dynamic subtest: numvfs-1
[234.068393] Dynamic subtest numvfs-1: FAIL (0.030s)
[234.078556] Starting dynamic subtest: numvfs-2
[234.151076] Dynamic subtest numvfs-2: FAIL (0.003s)
[234.160806] Starting dynamic subtest: numvfs-3
[234.234316] Dynamic subtest numvfs-3: FAIL (0.003s)
[234.243846] Starting dynamic subtest: numvfs-4
[234.315386] Dynamic subtest numvfs-4: FAIL (0.003s)
[234.324791] Starting dynamic subtest: numvfs-5
[234.397502] Dynamic subtest numvfs-5: FAIL (0.003s)
[234.407571] Starting dynamic subtest: numvfs-6
[234.479723] Dynamic subtest numvfs-6: FAIL (0.003s)
[234.489340] Starting dynamic subtest: numvfs-7
[234.562140] Dynamic subtest numvfs-7: FAIL (0.004s)
[234.571289] Starting dynamic subtest: numvfs-random
[234.629919] Dynamic subtest numvfs-random: FAIL (0.003s)
[234.639109] Starting dynamic subtest: numvfs-all
[234.697636] Dynamic subtest numvfs-all: FAIL (0.505s)
[234.699355] Subtest enable-vfs-autoprobe-on: FAIL (0.568s)
[234.735665] [052/131] (784s left) gem_exec_whisper (basic-queues)
[234.804862] Starting subtest: basic-queues
[240.500183] Subtest basic-queues: SUCCESS (5.694s)
[240.706882] [053/131] (778s left) kms_flip (2x-dpms-vs-vblank-race)
[240.796019] Starting subtest: 2x-dpms-vs-vblank-race
[240.807290] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[240.927587] [054/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[241.024393] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[241.397327] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.221413] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.822s)
[244.232623] Starting dynamic subtest: pipe-A-eDP-1-4
[246.397675] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[246.408992] Starting dynamic subtest: pipe-A-eDP-1-4
[248.405398] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.415751] Starting dynamic subtest: pipe-A-eDP-1-x
[250.595792] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[250.980275] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[253.754659] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[253.766240] Starting dynamic subtest: pipe-B-eDP-1-4
[255.928771] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[255.939910] Starting dynamic subtest: pipe-B-eDP-1-4
[257.937931] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[257.946174] Starting dynamic subtest: pipe-B-eDP-1-x
[260.141234] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[260.520586] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.341240] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[263.353097] Starting dynamic subtest: pipe-C-eDP-1-4
[265.454780] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[265.466266] Starting dynamic subtest: pipe-C-eDP-1-4
[267.463452] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[267.475241] Starting dynamic subtest: pipe-C-eDP-1-x
[269.643992] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[270.012080] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[272.746441] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[272.755257] Starting dynamic subtest: pipe-D-eDP-1-4
[274.922671] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[274.933767] Starting dynamic subtest: pipe-D-eDP-1-4
[276.932089] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[276.943324] Starting dynamic subtest: pipe-D-eDP-1-x
[279.110925] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[279.113748] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.084s)
[280.357393] [055/131] (738s left) gem_mmap_gtt (basic-write-read-distinct)
[280.414319] Subtest basic-write-read-distinct: SKIP (0.000s)
[280.482594] [056/131] (738s left) gem_mmap_offset (oob-read)
[280.544311] Starting subtest: oob-read
[280.546710] Subtest oob-read: SUCCESS (0.001s)
[280.679957] [057/131] (738s left) kms_atomic (atomic-plane-damage)
[280.780334] Starting subtest: atomic-plane-damage
[280.826842] Starting dynamic subtest: pipe-A-eDP-1
[281.347841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s)
[281.350132] Subtest atomic-plane-damage: SUCCESS (0.570s)
[282.196408] [058/131] (737s left) kms_atomic_transition (plane-all-transition-nonblocking)
[282.299100] Starting subtest: plane-all-transition-nonblocking
[282.301350] Starting dynamic subtest: pipe-A-eDP-1
[284.793790] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[285.099463] Starting dynamic subtest: pipe-B-eDP-1
[288.299225] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[288.604791] Subtest plane-all-transition-nonblocking: SUCCESS (6.306s)
[289.454859] [059/131] (729s left) gem_exec_parallel (contexts)
[289.515657] Starting subtest: contexts
[289.518101] Starting dynamic subtest: rcs0
[292.250732] Dynamic subtest rcs0: SUCCESS (2.732s)
[292.259375] Starting dynamic subtest: bcs0
[295.634082] Dynamic subtest bcs0: SUCCESS (3.383s)
[295.643059] Starting dynamic subtest: vcs0
[299.397407] Dynamic subtest vcs0: SUCCESS (3.760s)
[299.408984] Starting dynamic subtest: vcs1
[303.399086] Dynamic subtest vcs1: SUCCESS (3.998s)
[303.408050] Starting dynamic subtest: vecs0
[307.460224] Dynamic subtest vecs0: SUCCESS (4.058s)
[307.471651] Starting dynamic subtest: ccs0
[311.114312] Dynamic subtest ccs0: SUCCESS (3.653s)
[311.116925] Subtest contexts: SUCCESS (21.598s)
[311.328863] [060/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[311.433320] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[318.176401] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.745s)
[318.334950] [061/131] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[318.448185] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[318.452152] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.576384] [062/131] (700s left) kms_atomic_interruptible (legacy-pageflip)
[318.681075] Starting subtest: legacy-pageflip
[318.683321] Starting dynamic subtest: pipe-A-eDP-1
[326.070065] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[326.071927] Subtest legacy-pageflip: SUCCESS (7.388s)
[326.923656] [063/131] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[327.018090] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[327.022058] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[327.147131] [064/131] (692s left) kms_psr (psr2-sprite-mmap-cpu)
[327.243748] Starting subtest: psr2-sprite-mmap-cpu
[327.245992] Starting dynamic subtest: eDP-1
[329.043450] Dynamic subtest eDP-1: SUCCESS (1.800s)
[329.045795] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.801s)
[329.902782] [065/131] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[329.993316] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[337.077259] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.087s)
[337.259822] [066/131] (682s left) gem_exec_schedule (fairslice-all)
[337.339107] Starting subtest: fairslice-all
[339.443462] Subtest fairslice-all: SUCCESS (2.053s)
[340.966862] [067/131] (678s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[346.001504] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[346.003829] Starting dynamic subtest: pipe-A-eDP-1
[346.786943] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[346.797090] Starting dynamic subtest: pipe-B-eDP-1
[347.921533] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[347.926025] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.918s)
[349.135998] [068/131] (670s left) api_intel_allocator (two-level-inception)
[349.194675] Starting subtest: two-level-inception
[354.642353] Subtest two-level-inception: SUCCESS (5.398s)
[354.746998] [069/131] (664s left) i915_suspend (debugfs-reader)
[354.810562] Starting subtest: debugfs-reader
[373.013255] Subtest debugfs-reader: SUCCESS (8.216s)
[373.169835] [070/131] (646s left) kms_flip (plain-flip-fb-recreate-interruptible)
[373.285586] Starting subtest: plain-flip-fb-recreate-interruptible
[373.287968] Starting dynamic subtest: A-eDP1
[382.170097] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[382.180945] Starting dynamic subtest: B-eDP1
[390.993873] Dynamic subtest B-eDP1: SUCCESS (8.820s)
[391.020739] Starting dynamic subtest: C-eDP1
[399.907742] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[399.918202] Starting dynamic subtest: D-eDP1
[408.751858] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[408.757276] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.465s)
[410.060893] [071/131] (609s left) gem_vm_create (invalid-destroy)
[410.127808] Starting subtest: invalid-destroy
[410.130127] Subtest invalid-destroy: SUCCESS (0.002s)
[410.264270] [072/131] (609s left) gem_ccs (ctrl-surf-copy-new-ctx)
[410.322796] Starting subtest: ctrl-surf-copy-new-ctx
[410.327180] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[410.446420] [073/131] (609s left) syncobj_basic (bad-destroy-pad)
[410.509685] Starting subtest: bad-destroy-pad
[410.511625] Subtest bad-destroy-pad: SUCCESS (0.000s)
[410.628360] [074/131] (609s left) kms_plane_multiple (2x-tiling-y)
[410.718248] Starting subtest: 2x-tiling-y
[410.722583] Subtest 2x-tiling-y: SKIP (0.000s)
[410.818936] [075/131] (609s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[410.918060] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[410.920303] Starting dynamic subtest: pipe-A-eDP-1
[410.942433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.954407] Starting dynamic subtest: pipe-B-eDP-1
[410.971530] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.980336] Starting dynamic subtest: pipe-C-eDP-1
[410.997495] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.006070] Starting dynamic subtest: pipe-D-eDP-1
[411.023202] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.026597] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[413.201871] [076/131] (606s left) kms_pm_rpm (modeset-lpsp)
[415.027411] Starting subtest: modeset-lpsp
[416.472098] Subtest modeset-lpsp: SUCCESS (1.445s)
[416.584687] [077/131] (603s left) kms_setmode (basic)
[416.644782] Starting subtest: basic
[416.966424] Starting dynamic subtest: pipe-A-eDP-1
[419.034561] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.064s)
[419.382412] Starting dynamic subtest: pipe-B-eDP-1
[421.463557] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[421.771615] Subtest basic: SUCCESS (5.124s)
[422.632574] [078/131] (597s left) kms_psr (fbc-psr-suspend)
[422.735085] Starting subtest: fbc-psr-suspend
[422.737407] Starting dynamic subtest: eDP-1
[422.741797] Dynamic subtest eDP-1: SKIP (0.000s)
[422.746254] Subtest fbc-psr-suspend: SKIP (0.001s)
[422.834157] [079/131] (597s left) gem_ringfill (engines-basic)
[428.893627] Starting subtest: engines-basic
[428.896113] Starting dynamic subtest: rcs0
[428.963342] Dynamic subtest rcs0: SUCCESS (0.069s)
[428.975796] Starting dynamic subtest: bcs0
[429.008351] Dynamic subtest bcs0: SUCCESS (0.043s)
[429.019530] Starting dynamic subtest: vcs0
[429.049994] Dynamic subtest vcs0: SUCCESS (0.041s)
[429.060178] Starting dynamic subtest: vcs1
[429.096041] Dynamic subtest vcs1: SUCCESS (0.044s)
[429.107092] Starting dynamic subtest: vecs0
[429.139985] Dynamic subtest vecs0: SUCCESS (0.042s)
[429.151690] Starting dynamic subtest: ccs0
[429.184699] Dynamic subtest ccs0: SUCCESS (0.043s)
[429.187186] Subtest engines-basic: SUCCESS (0.293s)
[429.288289] [080/131] (590s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[429.343231] Starting subtest: invalid-bsd2-flag-on-vebox
[429.345664] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[429.500379] [081/131] (590s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[429.604165] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[429.606417] Starting dynamic subtest: pipe-A-eDP-1
[429.625569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[429.635853] Starting dynamic subtest: pipe-B-eDP-1
[429.656450] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[429.668328] Starting dynamic subtest: pipe-C-eDP-1
[429.689036] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[429.698685] Starting dynamic subtest: pipe-D-eDP-1
[429.718682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[429.721058] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[431.913566] [082/131] (588s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[432.019953] Starting subtest: extended-pageflip-modeset-hang-oldfb
[432.021761] Starting dynamic subtest: pipe-A
[439.930081] Dynamic subtest pipe-A: SUCCESS (7.908s)
[439.940862] Starting dynamic subtest: pipe-D
[448.542918] Dynamic subtest pipe-D: SUCCESS (8.610s)
[448.545211] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.523s)
[449.377483] [083/131] (571s left) gem_ppgtt (shrink-vs-evict-any)
[449.447810] Starting subtest: shrink-vs-evict-any
[454.960289] Subtest shrink-vs-evict-any: SUCCESS (5.459s)
[454.999607] [084/131] (565s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[455.062176] Starting subtest: etime-single-wait-for-submit-unsubmitted
[455.166060] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[455.273681] [085/131] (565s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[455.326593] Starting subtest: multi-wait-all-for-submit-signaled
[455.328932] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[455.467495] [086/131] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[455.521815] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[455.629663] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[455.732272] [087/131] (564s left) gem_exec_schedule (implicit-write-read)
[455.793797] Starting subtest: implicit-write-read
[455.796562] Starting dynamic subtest: rcs0
[455.968834] Dynamic subtest rcs0: SUCCESS (0.184s)
[455.981831] Starting dynamic subtest: vcs0
[456.087572] Dynamic subtest vcs0: SUCCESS (0.118s)
[456.100152] Starting dynamic subtest: vcs1
[456.193428] Dynamic subtest vcs1: SUCCESS (0.105s)
[456.206245] Starting dynamic subtest: vecs0
[456.291955] Dynamic subtest vecs0: SUCCESS (0.098s)
[456.301929] Starting dynamic subtest: ccs0
[456.411588] Dynamic subtest ccs0: SUCCESS (0.119s)
[456.414704] Subtest implicit-write-read: SUCCESS (0.627s)
[457.054725] [088/131] (563s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[457.155219] Starting subtest: fbcpsr-rgb565-draw-blt
[464.205443] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.053s)
[464.354453] [089/131] (556s left) gem_ctx_persistence (processes)
[464.422994] Starting subtest: processes
[465.905630] Subtest processes: SUCCESS (1.482s)
[466.008760] [090/131] (554s left) kms_cursor_crc (cursor-sliding-32x10)
[466.179725] Starting subtest: cursor-sliding-32x10
[466.224480] Subtest cursor-sliding-32x10: SKIP (0.042s)
[466.521888] [091/131] (554s left) kms_psr (fbc-pr-primary-render)
[466.622243] Starting subtest: fbc-pr-primary-render
[466.626292] Subtest fbc-pr-primary-render: SKIP (0.000s)
[466.747735] [092/131] (554s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[466.817365] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[466.885985] [093/131] (553s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[466.944369] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[466.946069] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[467.073614] [094/131] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[467.173684] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[467.176908] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[467.299109] [095/131] (553s left) gem_exec_async (concurrent-writes)
[467.368028] Starting subtest: concurrent-writes
[467.370281] Starting dynamic subtest: rcs0
[467.384514] Dynamic subtest rcs0: SUCCESS (0.016s)
[467.395601] Starting dynamic subtest: bcs0
[467.397670] Dynamic subtest bcs0: SUCCESS (0.005s)
[467.407166] Starting dynamic subtest: vcs0
[467.408718] Dynamic subtest vcs0: SUCCESS (0.005s)
[467.417943] Starting dynamic subtest: vcs1
[467.419796] Dynamic subtest vcs1: SUCCESS (0.007s)
[467.428803] Starting dynamic subtest: vecs0
[467.430691] Dynamic subtest vecs0: SUCCESS (0.006s)
[467.439781] Starting dynamic subtest: ccs0
[467.441677] Dynamic subtest ccs0: SUCCESS (0.005s)
[467.443551] Subtest concurrent-writes: SUCCESS (0.049s)
[467.672398] [096/131] (553s left) gem_mmap_gtt (basic-small-bo-tiledx)
[467.730586] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[467.802176] [097/131] (553s left) dmabuf_sync_file (import-basic)
[467.842388] Starting subtest: import-basic
[467.844450] Subtest import-basic: SUCCESS (0.001s)
[467.923014] [098/131] (553s left) kms_feature_discovery (display)
[468.011953] Starting subtest: display
[468.013910] Subtest display: SUCCESS (0.000s)
[468.109521] [099/131] (552s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[468.205481] Starting subtest: x-tiled-64bpp-rotate-90
[468.224988] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[468.377072] [100/131] (552s left) perf_pmu (busy-no-semaphores)
[468.418371] Starting subtest: busy-no-semaphores
[468.420155] Starting dynamic subtest: rcs0
[468.992453] Dynamic subtest rcs0: SUCCESS (0.573s)
[469.005191] Starting dynamic subtest: bcs0
[469.542959] Dynamic subtest bcs0: SUCCESS (0.547s)
[469.555832] Starting dynamic subtest: vcs0
[470.093977] Dynamic subtest vcs0: SUCCESS (0.548s)
[470.107130] Starting dynamic subtest: vcs1
[471.387329] Dynamic subtest vcs1: SUCCESS (1.289s)
[471.400517] Starting dynamic subtest: vecs0
[473.437732] Dynamic subtest vecs0: SUCCESS (2.047s)
[473.450625] Starting dynamic subtest: ccs0
[475.422807] Dynamic subtest ccs0: SUCCESS (1.982s)
[475.425580] Subtest busy-no-semaphores: SUCCESS (7.007s)
[475.590068] [101/131] (545s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[475.697594] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[475.701834] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[475.826534] [102/131] (545s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[475.950029] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[475.954447] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[476.144671] [103/131] (545s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[476.521621] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[477.302023] [104/131] (544s left) kms_getfb (getfb-reject-nv12)
[477.424626] Starting subtest: getfb-reject-nv12
[477.426947] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[477.566542] [105/131] (543s left) i915_drm_fdinfo (context-close-stress)
[477.607491] Starting subtest: context-close-stress
[488.405182] Subtest context-close-stress: SUCCESS (10.745s)
[488.455058] [106/131] (532s left) perf_pmu (module-unload)
[488.705805] Starting subtest: module-unload
[495.712725] Subtest module-unload: FAIL (6.901s)
[495.744584] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[495.745281] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[495.748344] [107/131] (525s left) kms_chamelium_edid (dp-edid-read)
[497.507808] Subtest dp-edid-read: SKIP (0.000s)
[498.340464] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[498.341681] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[498.345350] [108/131] (523s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[503.346417] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[503.348685] Starting dynamic subtest: pipe-A-eDP-1
[504.121327] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s)
[504.131119] Starting dynamic subtest: pipe-B-eDP-1
[505.250535] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[505.254644] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.904s)
[506.462041] [109/131] (515s left) kms_vblank (query-busy)
[506.557277] Starting subtest: query-busy
[506.559434] Starting dynamic subtest: pipe-A-eDP-1
[508.432622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[508.447387] Starting dynamic subtest: pipe-D-eDP-1
[510.994406] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[510.996335] Subtest query-busy: SUCCESS (4.435s)
[511.822180] [110/131] (509s left) syncobj_timeline (wait-for-submit-complex)
[511.885663] Starting subtest: wait-for-submit-complex
[511.946052] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[512.048071] [111/131] (509s left) perf (invalid-create-userspace-config)
[512.189435] Starting subtest: invalid-create-userspace-config
[512.191568] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[512.232307] [112/131] (509s left) gem_exec_basic (basic)
[512.296052] Starting subtest: basic
[512.298615] Starting dynamic subtest: rcs0-smem
[512.300965] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[512.311259] Starting dynamic subtest: bcs0-smem
[512.313075] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[512.321033] Starting dynamic subtest: vcs0-smem
[512.322870] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[512.330620] Starting dynamic subtest: vcs1-smem
[512.332470] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[512.340226] Starting dynamic subtest: vecs0-smem
[512.342057] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[512.349820] Starting dynamic subtest: ccs0-smem
[512.351754] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[512.353628] Subtest basic: SUCCESS (0.013s)
[513.942625] [113/131] (507s left) kms_chamelium_color (ctm-0-25)
[514.040419] Subtest ctm-0-25: SKIP (0.000s)
[514.088254] [114/131] (507s left) gem_userptr_blits (process-exit-busy)
[514.154486] Starting subtest: process-exit-busy
[514.169222] Subtest process-exit-busy: SUCCESS (0.016s)
[514.342266] [115/131] (507s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[514.412446] Starting subtest: y-tiled-ccs-to-y-tiled
[514.416914] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[514.622954] [116/131] (507s left) gen7_exec_parse (bitmasks)
[514.684727] Subtest bitmasks: SKIP (0.000s)
[514.765361] [117/131] (507s left) gem_eio (wait-wedge-10ms)
[514.940889] Starting subtest: wait-wedge-10ms
[515.906844] Subtest wait-wedge-10ms: SUCCESS (0.964s)
[516.071585] [118/131] (505s left) kms_content_protection (atomic)
[516.209601] Starting subtest: atomic
[516.214058] Subtest atomic: SKIP (0.000s)
[516.383232] [119/131] (505s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[516.484971] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[516.487296] Starting dynamic subtest: pipe-A-default-mode
[516.773670] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[516.778245] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.288s)
[517.667631] [120/131] (504s left) gem_exec_params (invalid-flag)
[517.733020] Starting subtest: invalid-flag
[517.735418] Subtest invalid-flag: SUCCESS (0.000s)
[517.863091] [121/131] (504s left) kms_getfb (getfb-addfb-different-handles)
[517.961775] Starting subtest: getfb-addfb-different-handles
[517.964107] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[518.100476] [122/131] (503s left) gem_exec_flush (basic-uc-ro-default)
[518.161901] Starting subtest: basic-uc-ro-default
[523.650763] Subtest basic-uc-ro-default: SUCCESS (5.449s)
[523.834210] [123/131] (498s left) gem_sync (basic-each)
[523.914812] Starting subtest: basic-each
[526.450252] Subtest basic-each: SUCCESS (2.541s)
[526.678020] [124/131] (495s left) gem_exec_balancer (full)
[526.756050] Starting subtest: full
[531.758150] Subtest full: SUCCESS (5.000s)
[532.121274] [125/131] (490s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[532.231546] Starting subtest: y-tiled-8bpp-rotate-180
[532.235869] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[532.336250] [126/131] (489s left) sw_sync (sync_merge_invalid)
[532.370850] Starting subtest: sync_merge_invalid
[532.395387] Subtest sync_merge_invalid: SUCCESS (0.024s)
[532.467407] [127/131] (489s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[532.573308] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[537.007109] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.437s)
[538.154811] [128/131] (484s left) gem_lmem_swapping (parallel-random-verify-ccs)
[538.207720] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[538.250073] [129/131] (484s left) kms_lease (lease-unleased-connector)
[538.342062] Starting subtest: lease-unleased-connector
[538.344307] Starting dynamic subtest: pipe-A-eDP-1
[538.348895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[538.359264] Starting dynamic subtest: pipe-B-eDP-1
[538.361452] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[538.370996] Starting dynamic subtest: pipe-C-eDP-1
[538.373251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[538.382317] Starting dynamic subtest: pipe-D-eDP-1
[538.384110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[538.385956] Subtest lease-unleased-connector: SUCCESS (0.037s)
[538.504344] [130/131] (483s left) perf (enable-disable)
[538.604766] Starting subtest: enable-disable
[538.607036] Starting dynamic subtest: 0-rcs0
[540.881059] Dynamic subtest 0-rcs0: SUCCESS (2.277s)
[540.891181] Starting dynamic subtest: 1-vcs1
[545.360161] Dynamic subtest 1-vcs1: SUCCESS (4.434s)
[545.362203] Subtest enable-disable: SUCCESS (6.713s)
[545.403102] [131/131] (477s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[545.569375] Starting subtest: cursor-rapid-movement-32x32
[545.613009] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[545.914479] 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.