[59.653085] Initializing watchdogs
[59.653138]   /dev/watchdog0
[59.668154] [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]
[59.672588] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.674896] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.678320] [001/131] (960s left) fbdev (unaligned-read)
[59.754250] Starting subtest: unaligned-read
[59.768196] Subtest unaligned-read: SUCCESS (0.014s)
[59.851407] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[59.930072] Starting subtest: dirty-switch
[59.932440] Starting dynamic subtest: rcs0
[60.168956] Dynamic subtest rcs0: SUCCESS (0.236s)
[60.179002] Starting dynamic subtest: bcs0
[60.398808] Dynamic subtest bcs0: SUCCESS (0.228s)
[60.408112] Starting dynamic subtest: vcs0
[60.653986] Dynamic subtest vcs0: SUCCESS (0.253s)
[60.660820] Starting dynamic subtest: vcs1
[62.092405] Dynamic subtest vcs1: SUCCESS (1.429s)
[62.100135] Starting dynamic subtest: vecs0
[64.084964] Dynamic subtest vecs0: SUCCESS (1.981s)
[64.094092] Starting dynamic subtest: ccs0
[66.123081] Dynamic subtest ccs0: SUCCESS (2.029s)
[66.125526] Subtest dirty-switch: SUCCESS (6.161s)
[66.393779] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[66.492397] Starting subtest: psr-modesetfrombusy
[72.682430] Subtest psr-modesetfrombusy: SUCCESS (6.180s)
[72.860391] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[72.971211] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[72.973262] Starting dynamic subtest: pipe-A-default-mode
[75.713319] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[75.715745] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.742s)
[76.596121] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[76.652262] Starting subtest: sol-reset-invalid
[76.654729] Subtest sol-reset-invalid: SUCCESS (0.002s)
[78.023345] [006/131] (942s left) gem_spin_batch (resubmit-new)
[78.082814] Starting subtest: resubmit-new
[78.085189] Starting dynamic subtest: rcs0
[78.091852] Dynamic subtest rcs0: SUCCESS (0.009s)
[78.099246] Starting dynamic subtest: bcs0
[78.101720] Dynamic subtest bcs0: SUCCESS (0.004s)
[78.108853] Starting dynamic subtest: vcs0
[78.111261] Dynamic subtest vcs0: SUCCESS (0.004s)
[78.118843] Starting dynamic subtest: vcs1
[78.121185] Dynamic subtest vcs1: SUCCESS (0.004s)
[78.128064] Starting dynamic subtest: vecs0
[78.130363] Dynamic subtest vecs0: SUCCESS (0.004s)
[78.137280] Starting dynamic subtest: ccs0
[78.139589] Dynamic subtest ccs0: SUCCESS (0.004s)
[78.141883] Subtest resubmit-new: SUCCESS (0.030s)
[79.955943] [007/131] (940s left) gem_exec_schedule (preempt-user)
[80.035160] Starting subtest: preempt-user
[80.037146] Starting dynamic subtest: rcs0
[80.065321] Dynamic subtest rcs0: SUCCESS (0.033s)
[80.076387] Starting dynamic subtest: bcs0
[80.097692] Dynamic subtest bcs0: SUCCESS (0.032s)
[80.107361] Starting dynamic subtest: vcs0
[80.121379] Dynamic subtest vcs0: SUCCESS (0.024s)
[80.128321] Starting dynamic subtest: vcs1
[80.146243] Dynamic subtest vcs1: SUCCESS (0.025s)
[80.153296] Starting dynamic subtest: vecs0
[80.170026] Dynamic subtest vecs0: SUCCESS (0.023s)
[80.177042] Starting dynamic subtest: ccs0
[80.197909] Dynamic subtest ccs0: SUCCESS (0.028s)
[80.200279] Subtest preempt-user: SUCCESS (0.166s)
[82.063917] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[82.132720] Starting subtest: nopreempt
[82.135029] Starting dynamic subtest: vecs0
[91.950396] Dynamic subtest vecs0: SUCCESS (9.811s)
[91.962622] Starting dynamic subtest: ccs0
[95.937637] Dynamic subtest ccs0: SUCCESS (3.983s)
[95.948450] Starting dynamic subtest: vcs0
[105.965952] Dynamic subtest vcs0: SUCCESS (10.021s)
[105.976572] Starting dynamic subtest: bcs0
[109.982885] Dynamic subtest bcs0: SUCCESS (4.016s)
[109.993699] Starting dynamic subtest: rcs0
[114.057453] Dynamic subtest rcs0: SUCCESS (4.073s)
[114.067517] Starting dynamic subtest: vcs1
[123.953149] Dynamic subtest vcs1: SUCCESS (9.890s)
[123.955816] Subtest nopreempt: SUCCESS (41.800s)
[124.044786] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[124.147062] Starting subtest: zero-hdisplay
[124.149366] Starting dynamic subtest: pipe-A-eDP-1
[124.432549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[124.442057] Starting dynamic subtest: pipe-B-eDP-1
[124.444222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[124.454258] Starting dynamic subtest: pipe-C-eDP-1
[124.456469] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[124.463835] Starting dynamic subtest: pipe-D-eDP-1
[124.466354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[124.468705] Subtest zero-hdisplay: SUCCESS (0.290s)
[125.240706] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[125.327494] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[125.332091] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[125.450745] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[125.552127] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[126.421219] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.871s)
[126.636794] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[126.730727] Starting subtest: getfb-handle-zero
[126.733027] Subtest getfb-handle-zero: SUCCESS (0.000s)
[126.865275] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[126.925974] Starting subtest: yf-tiled-ccs-to-yf-tiled
[126.930418] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[127.131072] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[127.219940] Starting subtest: multiplane-rotation-cropping-bottom
[134.500218] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.281s)
[134.663162] [015/131] (886s left) gem_eio (wait-1us)
[134.898182] Starting subtest: wait-1us
[135.227128] Subtest wait-1us: SUCCESS (0.329s)
[135.414513] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[135.486507] Starting subtest: multi-wait-for-submit-signaled
[135.488270] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[135.620986] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[135.723305] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[135.725285] Starting dynamic subtest: pipe-A-default-mode
[136.009052] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[136.013428] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.285s)
[136.873387] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[136.977233] Starting subtest: alpha-7efc
[137.256548] Starting dynamic subtest: pipe-A-eDP-1
[137.870624] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[137.901444] Starting dynamic subtest: pipe-D-eDP-1
[139.181463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[139.183916] Subtest alpha-7efc: SUCCESS (2.206s)
[140.044321] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[140.159478] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[140.163959] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[140.265114] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[140.368304] Starting subtest: fbc-psr2-primary-mmap-cpu
[140.370429] Starting dynamic subtest: eDP-1
[140.374683] Dynamic subtest eDP-1: SKIP (0.000s)
[140.378948] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[140.460713] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[140.557403] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[140.570398] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[140.695711] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[140.771047] Starting subtest: basic-normal-all
[143.270330] Subtest basic-normal-all: SUCCESS (2.498s)
[143.476051] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[143.597495] Starting subtest: linear-16bpp-rotate-180
[145.043478] Subtest linear-16bpp-rotate-180: SUCCESS (1.448s)
[145.207265] [024/131] (875s left) kms_frontbuffer_tracking (psr-slowdraw)
[145.313646] Starting subtest: psr-slowdraw
[170.431242] Subtest psr-slowdraw: SUCCESS (25.119s)
[170.610572] [025/131] (850s left) vgem_basic (dmabuf-fence)
[170.707552] Starting subtest: dmabuf-fence
[170.709763] Subtest dmabuf-fence: SUCCESS (0.001s)
[170.781046] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[170.784100] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[170.838237] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[170.840553] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[170.975074] [027/131] (850s left) kms_psr (pr-primary-render)
[171.070116] Starting subtest: pr-primary-render
[171.074620] Subtest pr-primary-render: SKIP (0.000s)
[171.173706] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[171.270888] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[171.272890] Starting dynamic subtest: pipe-A-eDP-1
[171.292557] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[171.307053] Starting dynamic subtest: pipe-B-eDP-1
[171.326177] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.335731] Starting dynamic subtest: pipe-C-eDP-1
[171.354595] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.363881] Starting dynamic subtest: pipe-D-eDP-1
[171.382346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.386037] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[173.468055] [029/131] (847s left) core_auth (getclient-master-drop)
[173.517065] Starting subtest: getclient-master-drop
[173.540855] Subtest getclient-master-drop: SUCCESS (0.024s)
[173.672034] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[173.765722] Starting subtest: planes-downscale-factor-0-5
[173.768056] Starting dynamic subtest: pipe-A
[173.792574] Dynamic subtest pipe-A: SKIP (0.022s)
[173.801595] Starting dynamic subtest: pipe-B
[173.826358] Dynamic subtest pipe-B: SKIP (0.033s)
[173.834910] Starting dynamic subtest: pipe-C
[173.859130] Dynamic subtest pipe-C: SKIP (0.033s)
[173.867606] Starting dynamic subtest: pipe-D
[173.889304] Dynamic subtest pipe-D: SKIP (0.030s)
[173.893375] Subtest planes-downscale-factor-0-5: SKIP (0.121s)
[174.029941] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[174.131849] Starting subtest: fb-8bpc-vs-panel-8bpc
[174.134490] Starting dynamic subtest: pipe-A-eDP-1
[175.525086] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.394s)
[175.527531] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.396s)
[176.415855] [032/131] (844s left) gem_partial_pwrite_pread (reads-snoop)
[176.481075] Subtest reads-snoop: SKIP (0.000s)
[176.563664] [033/131] (844s left) gem_eio (in-flight-contexts-immediate)
[176.806341] Starting subtest: in-flight-contexts-immediate
[190.944958] Subtest in-flight-contexts-immediate: SUCCESS (14.136s)
[191.141637] [034/131] (830s left) gen3_render_mixed_blits
[191.267369] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[193.089386] Starting subtest: pm-tiling
[193.094871] Subtest pm-tiling: SKIP (0.000s)
[193.528881] [036/131] (828s left) i915_module_load (reload-no-display)
[193.572628] Starting subtest: reload-no-display
[199.829703] Subtest reload-no-display: SUCCESS (6.260s)
[199.856293] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[199.856980] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[199.860935] [037/131] (821s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[201.468125] Starting subtest: plane-upscale-20x20-with-rotation
[201.470330] Starting dynamic subtest: pipe-A
[201.707866] Dynamic subtest pipe-A: SUCCESS (0.242s)
[201.716066] Starting dynamic subtest: pipe-B
[203.032546] Dynamic subtest pipe-B: SUCCESS (1.323s)
[203.039957] Starting dynamic subtest: pipe-C
[204.363857] Dynamic subtest pipe-C: SUCCESS (1.330s)
[204.371193] Starting dynamic subtest: pipe-D
[205.688626] Dynamic subtest pipe-D: SUCCESS (1.324s)
[205.691113] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.223s)
[206.837204] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[206.838385] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[206.842386] [038/131] (814s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[206.958996] Starting subtest: 4-tiled-8bpp-rotate-180
[208.129154] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.172s)
[208.300319] [039/131] (813s left) kms_rotation_crc (primary-rotation-90)
[208.387482] Starting subtest: primary-rotation-90
[208.391207] Subtest primary-rotation-90: SKIP (0.001s)
[208.485888] [040/131] (813s left) kms_cursor_crc (cursor-onscreen-32x10)
[208.634366] Starting subtest: cursor-onscreen-32x10
[208.676788] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[208.944540] [041/131] (812s left) kms_vblank (wait-idle)
[209.032156] Starting subtest: wait-idle
[209.033720] Starting dynamic subtest: pipe-A-eDP-1
[210.785917] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[210.798896] Starting dynamic subtest: pipe-D-eDP-1
[213.203069] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.414s)
[213.204971] Subtest wait-idle: SUCCESS (4.169s)
[214.045141] [042/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[214.150512] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[214.154594] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[214.288834] [043/131] (807s left) kms_flip (2x-flip-vs-dpms)
[214.380618] Starting subtest: 2x-flip-vs-dpms
[214.389343] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[214.516646] [044/131] (807s left) gem_exec_fence (syncobj-channel)
[214.940883] Starting subtest: syncobj-channel
[215.959151] Subtest syncobj-channel: SUCCESS (1.015s)
[217.043029] [045/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[217.156333] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[217.158696] Starting dynamic subtest: pipe-A-eDP-1
[217.167769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[217.179991] Starting dynamic subtest: pipe-B-eDP-1
[217.189108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[217.200853] Starting dynamic subtest: pipe-C-eDP-1
[217.209638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[217.221196] Starting dynamic subtest: pipe-D-eDP-1
[217.230624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[217.235136] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[219.348659] [046/131] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[219.456275] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[226.644371] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.191s)
[226.804087] [047/131] (795s left) kms_flip (busy-flip)
[226.909065] Starting subtest: busy-flip
[226.911302] Starting dynamic subtest: A-eDP1
[228.632757] Dynamic subtest A-eDP1: SUCCESS (1.722s)
[228.643469] Starting dynamic subtest: B-eDP1
[230.280738] Dynamic subtest B-eDP1: SUCCESS (1.647s)
[230.291635] Starting dynamic subtest: C-eDP1
[231.905870] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[231.915066] Starting dynamic subtest: D-eDP1
[233.534338] Dynamic subtest D-eDP1: SUCCESS (1.627s)
[233.536613] Subtest busy-flip: SUCCESS (6.628s)
[234.817664] [048/131] (787s left) prime_mmap (test_aperture_limit)
[234.875930] Starting subtest: test_aperture_limit
[234.877871] Starting dynamic subtest: test_aperture_limit-smem
[234.885222] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[234.889647] Subtest test_aperture_limit: SKIP (0.008s)
[235.007832] [049/131] (787s left) i915_pm_rpm (sysfs-read)
[237.039356] Starting subtest: sysfs-read
[238.193675] Subtest sysfs-read: SUCCESS (1.155s)
[238.587956] [050/131] (783s left) kms_big_fb (yf-tiled-addfb)
[238.691600] Starting subtest: yf-tiled-addfb
[238.696090] Subtest yf-tiled-addfb: SKIP (0.000s)
[238.808641] [051/131] (783s left) sriov_basic (enable-vfs-autoprobe-on)
[238.858730] Starting subtest: enable-vfs-autoprobe-on
[238.861061] Starting dynamic subtest: numvfs-1
[238.940649] Dynamic subtest numvfs-1: FAIL (0.029s)
[238.950644] Starting dynamic subtest: numvfs-2
[239.025923] Dynamic subtest numvfs-2: FAIL (0.003s)
[239.035640] Starting dynamic subtest: numvfs-3
[239.108053] Dynamic subtest numvfs-3: FAIL (0.003s)
[239.117479] Starting dynamic subtest: numvfs-4
[239.190437] Dynamic subtest numvfs-4: FAIL (0.003s)
[239.200112] Starting dynamic subtest: numvfs-5
[239.272415] Dynamic subtest numvfs-5: FAIL (0.003s)
[239.281377] Starting dynamic subtest: numvfs-6
[239.353682] Dynamic subtest numvfs-6: FAIL (0.004s)
[239.363145] Starting dynamic subtest: numvfs-7
[239.436071] Dynamic subtest numvfs-7: FAIL (0.003s)
[239.443808] Starting dynamic subtest: numvfs-random
[239.512213] Dynamic subtest numvfs-random: FAIL (0.003s)
[239.521391] Starting dynamic subtest: numvfs-all
[239.581619] Dynamic subtest numvfs-all: FAIL (0.509s)
[239.583318] Subtest enable-vfs-autoprobe-on: FAIL (0.569s)
[239.619298] [052/131] (782s left) gem_exec_whisper (basic-queues)
[239.692110] Starting subtest: basic-queues
[246.906238] Subtest basic-queues: SUCCESS (7.211s)
[247.113403] [053/131] (775s left) kms_flip (2x-dpms-vs-vblank-race)
[247.226598] Starting subtest: 2x-dpms-vs-vblank-race
[247.237674] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[247.341779] [054/131] (774s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[247.438766] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[247.821967] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[250.634743] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[250.643262] Starting dynamic subtest: pipe-A-eDP-1-4
[252.810325] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[252.821276] Starting dynamic subtest: pipe-A-eDP-1-4
[254.828659] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[254.837568] Starting dynamic subtest: pipe-A-eDP-1-x
[257.044704] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.223s)
[257.422790] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[260.163658] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.745s)
[260.176209] Starting dynamic subtest: pipe-B-eDP-1-4
[262.361591] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[262.373058] Starting dynamic subtest: pipe-B-eDP-1-4
[264.371496] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[264.382686] Starting dynamic subtest: pipe-B-eDP-1-x
[266.562579] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[266.935511] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[269.704551] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[269.716092] Starting dynamic subtest: pipe-C-eDP-1-4
[271.879591] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[271.890372] Starting dynamic subtest: pipe-C-eDP-1-4
[273.889437] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[273.900909] Starting dynamic subtest: pipe-C-eDP-1-x
[276.067309] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[276.430550] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[279.235560] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[279.247623] Starting dynamic subtest: pipe-D-eDP-1-4
[281.410591] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[281.421994] Starting dynamic subtest: pipe-D-eDP-1-4
[283.421178] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[283.432645] Starting dynamic subtest: pipe-D-eDP-1-x
[285.599791] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[285.602793] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.160s)
[286.842920] [055/131] (735s left) gem_mmap_gtt (basic-write-read-distinct)
[286.917870] Subtest basic-write-read-distinct: SKIP (0.000s)
[286.981186] [056/131] (735s left) gem_mmap_offset (oob-read)
[287.043757] Starting subtest: oob-read
[287.045785] Subtest oob-read: SUCCESS (0.000s)
[287.178162] [057/131] (735s left) kms_atomic (atomic-plane-damage)
[287.272737] Starting subtest: atomic-plane-damage
[287.320375] Starting dynamic subtest: pipe-A-eDP-1
[287.851637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[287.854090] Subtest atomic-plane-damage: SUCCESS (0.580s)
[288.676413] [058/131] (733s left) kms_atomic_transition (plane-all-transition-nonblocking)
[288.768089] Starting subtest: plane-all-transition-nonblocking
[288.770536] Starting dynamic subtest: pipe-A-eDP-1
[291.260406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[291.573833] Starting dynamic subtest: pipe-B-eDP-1
[294.774828] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[295.093025] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s)
[295.932220] [059/131] (726s left) gem_exec_parallel (contexts)
[295.993447] Starting subtest: contexts
[295.995763] Starting dynamic subtest: rcs0
[298.726571] Dynamic subtest rcs0: SUCCESS (2.731s)
[298.737968] Starting dynamic subtest: bcs0
[302.554724] Dynamic subtest bcs0: SUCCESS (3.824s)
[302.564476] Starting dynamic subtest: vcs0
[306.382836] Dynamic subtest vcs0: SUCCESS (3.825s)
[306.391419] Starting dynamic subtest: vcs1
[310.375837] Dynamic subtest vcs1: SUCCESS (3.990s)
[310.385541] Starting dynamic subtest: vecs0
[314.312915] Dynamic subtest vecs0: SUCCESS (3.934s)
[314.323288] Starting dynamic subtest: ccs0
[317.557791] Dynamic subtest ccs0: SUCCESS (3.242s)
[317.560681] Subtest contexts: SUCCESS (21.564s)
[317.773583] [060/131] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[317.884498] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[324.639466] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.757s)
[324.812388] [061/131] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[324.930163] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[324.934538] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.067372] [062/131] (697s left) kms_atomic_interruptible (legacy-pageflip)
[325.165291] Starting subtest: legacy-pageflip
[325.167592] Starting dynamic subtest: pipe-A-eDP-1
[332.545984] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s)
[332.548366] Subtest legacy-pageflip: SUCCESS (7.381s)
[333.405038] [063/131] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[333.502594] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[333.506997] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[333.623430] [064/131] (689s left) kms_psr (psr2-sprite-mmap-cpu)
[333.721596] Starting subtest: psr2-sprite-mmap-cpu
[333.723938] Starting dynamic subtest: eDP-1
[335.470746] Dynamic subtest eDP-1: SUCCESS (1.750s)
[335.473116] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.751s)
[336.353492] [065/131] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[336.461110] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[343.525377] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.065s)
[343.709609] [066/131] (679s left) gem_exec_schedule (fairslice-all)
[343.777766] Starting subtest: fairslice-all
[345.829175] Subtest fairslice-all: SUCCESS (2.059s)
[347.060730] [067/131] (675s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[352.049193] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[352.051657] Starting dynamic subtest: pipe-A-eDP-1
[352.838337] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[352.848291] Starting dynamic subtest: pipe-B-eDP-1
[353.964415] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[353.969050] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.914s)
[355.175260] [068/131] (667s left) api_intel_allocator (two-level-inception)
[355.229455] Starting subtest: two-level-inception
[360.626762] Subtest two-level-inception: SUCCESS (5.398s)
[360.783112] [069/131] (662s left) i915_suspend (debugfs-reader)
[360.851577] Starting subtest: debugfs-reader
[378.082477] Subtest debugfs-reader: SUCCESS (7.302s)
[378.179664] [070/131] (644s left) kms_flip (plain-flip-fb-recreate-interruptible)
[378.279996] Starting subtest: plain-flip-fb-recreate-interruptible
[378.282315] Starting dynamic subtest: A-eDP1
[387.136151] Dynamic subtest A-eDP1: SUCCESS (8.855s)
[387.146493] Starting dynamic subtest: B-eDP1
[408.282517] Dynamic subtest B-eDP1: FAIL (20.353s)
[408.293162] Starting dynamic subtest: C-eDP1
[416.660701] Dynamic subtest C-eDP1: SUCCESS (8.792s)
[416.671482] Starting dynamic subtest: D-eDP1
[425.516884] Dynamic subtest D-eDP1: SUCCESS (8.847s)
[425.521390] Subtest plain-flip-fb-recreate-interruptible: FAIL (46.858s)
[426.727991] [071/131] (596s left) gem_vm_create (invalid-destroy)
[426.797069] Starting subtest: invalid-destroy
[426.799431] Subtest invalid-destroy: SUCCESS (0.002s)
[426.942157] [072/131] (596s left) gem_ccs (ctrl-surf-copy-new-ctx)
[427.017659] Starting subtest: ctrl-surf-copy-new-ctx
[427.021752] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[427.168881] [073/131] (595s left) syncobj_basic (bad-destroy-pad)
[427.239577] Starting subtest: bad-destroy-pad
[427.241933] Subtest bad-destroy-pad: SUCCESS (0.000s)
[427.361425] [074/131] (595s left) kms_plane_multiple (2x-tiling-y)
[427.464998] Starting subtest: 2x-tiling-y
[427.469307] Subtest 2x-tiling-y: SKIP (0.000s)
[427.564746] [075/131] (595s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[427.664271] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[427.666138] Starting dynamic subtest: pipe-A-eDP-1
[427.685006] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.695828] Starting dynamic subtest: pipe-B-eDP-1
[427.713592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.722526] Starting dynamic subtest: pipe-C-eDP-1
[427.741127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.751270] Starting dynamic subtest: pipe-D-eDP-1
[427.769420] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.772909] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[429.921834] [076/131] (593s left) kms_pm_rpm (modeset-lpsp)
[432.057175] Starting subtest: modeset-lpsp
[433.517034] Subtest modeset-lpsp: SUCCESS (1.462s)
[433.635143] [077/131] (589s left) kms_setmode (basic)
[433.702725] Starting subtest: basic
[434.026486] Starting dynamic subtest: pipe-A-eDP-1
[436.084805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.052s)
[436.423616] Starting dynamic subtest: pipe-B-eDP-1
[438.511078] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[438.822222] Subtest basic: SUCCESS (5.114s)
[439.677365] [078/131] (583s left) kms_psr (fbc-psr-suspend)
[439.772955] Starting subtest: fbc-psr-suspend
[439.775160] Starting dynamic subtest: eDP-1
[439.779217] Dynamic subtest eDP-1: SKIP (0.000s)
[439.783391] Subtest fbc-psr-suspend: SKIP (0.001s)
[439.872338] [079/131] (583s left) gem_ringfill (engines-basic)
[445.858025] Starting subtest: engines-basic
[445.860665] Starting dynamic subtest: rcs0
[445.943186] Dynamic subtest rcs0: SUCCESS (0.085s)
[445.955637] Starting dynamic subtest: bcs0
[445.988135] Dynamic subtest bcs0: SUCCESS (0.043s)
[445.999015] Starting dynamic subtest: vcs0
[446.031487] Dynamic subtest vcs0: SUCCESS (0.041s)
[446.044141] Starting dynamic subtest: vcs1
[446.073227] Dynamic subtest vcs1: SUCCESS (0.040s)
[446.083820] Starting dynamic subtest: vecs0
[446.119137] Dynamic subtest vecs0: SUCCESS (0.044s)
[446.130875] Starting dynamic subtest: ccs0
[446.163882] Dynamic subtest ccs0: SUCCESS (0.043s)
[446.166336] Subtest engines-basic: SUCCESS (0.308s)
[446.269473] [080/131] (577s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[446.346725] Starting subtest: invalid-bsd2-flag-on-vebox
[446.349141] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[446.492461] [081/131] (576s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[446.592008] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[446.594280] Starting dynamic subtest: pipe-A-eDP-1
[446.614530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[446.626017] Starting dynamic subtest: pipe-B-eDP-1
[446.646211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[446.655956] Starting dynamic subtest: pipe-C-eDP-1
[446.675682] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[446.685266] Starting dynamic subtest: pipe-D-eDP-1
[446.705582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[446.707806] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[448.983878] [082/131] (574s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[449.097207] Starting subtest: extended-pageflip-modeset-hang-oldfb
[449.099142] Starting dynamic subtest: pipe-A
[457.001454] Dynamic subtest pipe-A: SUCCESS (7.899s)
[457.012530] Starting dynamic subtest: pipe-D
[465.628808] Dynamic subtest pipe-D: SUCCESS (8.623s)
[465.631298] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.526s)
[466.519592] [083/131] (557s left) gem_ppgtt (shrink-vs-evict-any)
[466.588176] Starting subtest: shrink-vs-evict-any
[471.803741] Subtest shrink-vs-evict-any: SUCCESS (5.210s)
[471.926195] [084/131] (551s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[471.986882] Starting subtest: etime-single-wait-for-submit-unsubmitted
[472.091038] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[472.226594] [085/131] (551s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[472.298261] Starting subtest: multi-wait-all-for-submit-signaled
[472.300469] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[472.443113] [086/131] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[472.506734] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[472.610642] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[472.717538] [087/131] (551s left) gem_exec_schedule (implicit-write-read)
[472.796802] Starting subtest: implicit-write-read
[472.799148] Starting dynamic subtest: rcs0
[472.960543] Dynamic subtest rcs0: SUCCESS (0.173s)
[472.974043] Starting dynamic subtest: vcs0
[473.099644] Dynamic subtest vcs0: SUCCESS (0.138s)
[473.115293] Starting dynamic subtest: vcs1
[473.205135] Dynamic subtest vcs1: SUCCESS (0.106s)
[473.217688] Starting dynamic subtest: vecs0
[473.304249] Dynamic subtest vecs0: SUCCESS (0.098s)
[473.317853] Starting dynamic subtest: ccs0
[473.431120] Dynamic subtest ccs0: SUCCESS (0.125s)
[473.434083] Subtest implicit-write-read: SUCCESS (0.643s)
[474.994391] [088/131] (548s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[475.092572] Starting subtest: fbcpsr-rgb565-draw-blt
[482.227562] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.135s)
[482.387647] [089/131] (541s left) gem_ctx_persistence (processes)
[482.464349] Starting subtest: processes
[483.828883] Subtest processes: SUCCESS (1.367s)
[483.933855] [090/131] (539s left) kms_cursor_crc (cursor-sliding-32x10)
[484.111755] Starting subtest: cursor-sliding-32x10
[484.157640] Subtest cursor-sliding-32x10: SKIP (0.040s)
[484.456329] [091/131] (539s left) kms_psr (fbc-pr-primary-render)
[484.554797] Starting subtest: fbc-pr-primary-render
[484.559048] Subtest fbc-pr-primary-render: SKIP (0.000s)
[484.670986] [092/131] (539s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[484.734843] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[484.828894] [093/131] (539s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[484.881158] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[484.882834] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[484.997879] [094/131] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[485.083187] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[485.086603] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[485.218126] [095/131] (538s left) gem_exec_async (concurrent-writes)
[485.282352] Starting subtest: concurrent-writes
[485.284276] Starting dynamic subtest: rcs0
[485.297638] Dynamic subtest rcs0: SUCCESS (0.015s)
[485.313672] Starting dynamic subtest: bcs0
[485.315688] Dynamic subtest bcs0: SUCCESS (0.006s)
[485.325388] Starting dynamic subtest: vcs0
[485.326922] Dynamic subtest vcs0: SUCCESS (0.004s)
[485.336354] Starting dynamic subtest: vcs1
[485.338058] Dynamic subtest vcs1: SUCCESS (0.006s)
[485.347494] Starting dynamic subtest: vecs0
[485.349254] Dynamic subtest vecs0: SUCCESS (0.005s)
[485.358195] Starting dynamic subtest: ccs0
[485.359929] Dynamic subtest ccs0: SUCCESS (0.005s)
[485.361654] Subtest concurrent-writes: SUCCESS (0.046s)
[485.608221] [096/131] (538s left) gem_mmap_gtt (basic-small-bo-tiledx)
[485.672837] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[485.737180] [097/131] (538s left) dmabuf_sync_file (import-basic)
[485.782412] Starting subtest: import-basic
[485.784618] Subtest import-basic: SUCCESS (0.001s)
[485.862220] [098/131] (538s left) kms_feature_discovery (display)
[485.957739] Starting subtest: display
[485.959679] Subtest display: SUCCESS (0.000s)
[486.056396] [099/131] (538s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[486.153304] Starting subtest: x-tiled-64bpp-rotate-90
[486.173008] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[486.324213] [100/131] (537s left) perf_pmu (busy-no-semaphores)
[486.367005] Starting subtest: busy-no-semaphores
[486.368584] Starting dynamic subtest: rcs0
[486.929163] Dynamic subtest rcs0: SUCCESS (0.561s)
[486.942757] Starting dynamic subtest: bcs0
[487.480821] Dynamic subtest bcs0: SUCCESS (0.548s)
[487.494174] Starting dynamic subtest: vcs0
[488.032163] Dynamic subtest vcs0: SUCCESS (0.549s)
[488.045865] Starting dynamic subtest: vcs1
[489.378571] Dynamic subtest vcs1: SUCCESS (1.344s)
[489.391759] Starting dynamic subtest: vecs0
[491.362624] Dynamic subtest vecs0: SUCCESS (1.981s)
[491.375933] Starting dynamic subtest: ccs0
[493.346420] Dynamic subtest ccs0: SUCCESS (1.982s)
[493.349202] Subtest busy-no-semaphores: SUCCESS (6.983s)
[493.492167] [101/131] (530s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[493.602147] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[493.606421] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[493.742804] [102/131] (530s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[493.863723] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[493.868300] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[494.032271] [103/131] (530s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[494.407293] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[495.235224] [104/131] (529s left) kms_getfb (getfb-reject-nv12)
[495.332180] Starting subtest: getfb-reject-nv12
[495.334555] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[495.473848] [105/131] (529s left) i915_drm_fdinfo (context-close-stress)
[495.519992] Starting subtest: context-close-stress
[506.264583] Subtest context-close-stress: SUCCESS (10.747s)
[506.364146] [106/131] (518s left) perf_pmu (module-unload)
[506.616126] Starting subtest: module-unload
[515.218217] Subtest module-unload: FAIL (8.498s)
[515.248959] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.249736] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[515.252569] [107/131] (509s left) kms_chamelium_edid (dp-edid-read)
[517.014703] Subtest dp-edid-read: SKIP (0.000s)
[517.850281] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[517.851498] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[517.855416] [108/131] (506s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[522.840173] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[522.842456] Starting dynamic subtest: pipe-A-eDP-1
[523.645389] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[523.654924] Starting dynamic subtest: pipe-B-eDP-1
[524.770671] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[524.775328] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.931s)
[526.195175] [109/131] (498s left) kms_vblank (query-busy)
[526.283156] Starting subtest: query-busy
[526.285015] Starting dynamic subtest: pipe-A-eDP-1
[528.157246] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[528.172150] Starting dynamic subtest: pipe-D-eDP-1
[530.728308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[530.730166] Subtest query-busy: SUCCESS (4.444s)
[531.559973] [110/131] (493s left) syncobj_timeline (wait-for-submit-complex)
[531.618408] Starting subtest: wait-for-submit-complex
[531.678176] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[531.775662] [111/131] (492s left) perf (invalid-create-userspace-config)
[531.910512] Starting subtest: invalid-create-userspace-config
[531.912718] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[531.955873] [112/131] (492s left) gem_exec_basic (basic)
[532.022445] Starting subtest: basic
[532.024800] Starting dynamic subtest: rcs0-smem
[532.027067] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[532.035644] Starting dynamic subtest: bcs0-smem
[532.037775] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[532.045402] Starting dynamic subtest: vcs0-smem
[532.047232] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[532.054875] Starting dynamic subtest: vcs1-smem
[532.056695] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[532.064309] Starting dynamic subtest: vecs0-smem
[532.066154] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[532.073644] Starting dynamic subtest: ccs0-smem
[532.075533] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[532.077426] Subtest basic: SUCCESS (0.014s)
[533.916704] [113/131] (490s left) kms_chamelium_color (ctm-0-25)
[534.010403] Subtest ctm-0-25: SKIP (0.000s)
[534.058661] [114/131] (490s left) gem_userptr_blits (process-exit-busy)
[534.119334] Starting subtest: process-exit-busy
[534.130583] Subtest process-exit-busy: SUCCESS (0.014s)
[534.288108] [115/131] (490s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[534.343809] Starting subtest: y-tiled-ccs-to-y-tiled
[534.348303] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[534.551231] [116/131] (490s left) gen7_exec_parse (bitmasks)
[534.612067] Subtest bitmasks: SKIP (0.000s)
[534.668128] [117/131] (490s left) gem_eio (wait-wedge-10ms)
[534.858448] Starting subtest: wait-wedge-10ms
[535.883755] Subtest wait-wedge-10ms: SUCCESS (1.024s)
[536.040091] [118/131] (489s left) kms_content_protection (atomic)
[536.182950] Starting subtest: atomic
[536.187511] Subtest atomic: SKIP (0.000s)
[536.358312] [119/131] (488s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[536.462272] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[536.464611] Starting dynamic subtest: pipe-A-default-mode
[536.756182] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[536.760988] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.291s)
[537.583656] [120/131] (487s left) gem_exec_params (invalid-flag)
[537.640833] Starting subtest: invalid-flag
[537.643279] Subtest invalid-flag: SUCCESS (0.000s)
[537.780200] [121/131] (487s left) kms_getfb (getfb-addfb-different-handles)
[537.879754] Starting subtest: getfb-addfb-different-handles
[537.881925] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[538.020978] [122/131] (487s left) gem_exec_flush (basic-uc-ro-default)
[538.100672] Starting subtest: basic-uc-ro-default
[543.562427] Subtest basic-uc-ro-default: SUCCESS (5.461s)
[543.776255] [123/131] (481s left) gem_sync (basic-each)
[543.855188] Starting subtest: basic-each
[546.403900] Subtest basic-each: SUCCESS (2.559s)
[546.619893] [124/131] (478s left) gem_exec_balancer (full)
[546.686392] Starting subtest: full
[551.643812] Subtest full: SUCCESS (4.956s)
[552.004672] [125/131] (473s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[552.111056] Starting subtest: y-tiled-8bpp-rotate-180
[552.115524] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[552.249631] [126/131] (473s left) sw_sync (sync_merge_invalid)
[552.287026] Starting subtest: sync_merge_invalid
[552.310291] Subtest sync_merge_invalid: SUCCESS (0.024s)
[552.393307] [127/131] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[552.501081] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[556.910296] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.413s)
[558.109671] [128/131] (467s left) gem_lmem_swapping (parallel-random-verify-ccs)
[558.159217] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[558.203636] [129/131] (467s left) kms_lease (lease-unleased-connector)
[558.297521] Starting subtest: lease-unleased-connector
[558.299630] Starting dynamic subtest: pipe-A-eDP-1
[558.304414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[558.314430] Starting dynamic subtest: pipe-B-eDP-1
[558.316563] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[558.326333] Starting dynamic subtest: pipe-C-eDP-1
[558.328446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[558.337979] Starting dynamic subtest: pipe-D-eDP-1
[558.340179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[558.342381] Subtest lease-unleased-connector: SUCCESS (0.036s)
[558.468429] [130/131] (467s left) perf (enable-disable)
[558.569723] Starting subtest: enable-disable
[558.572156] Starting dynamic subtest: 0-rcs0
[560.819652] Dynamic subtest 0-rcs0: SUCCESS (2.247s)
[560.830674] Starting dynamic subtest: 1-vecs0
[565.279926] Dynamic subtest 1-vecs0: SUCCESS (4.457s)
[565.282374] Subtest enable-disable: SUCCESS (6.707s)
[565.328195] [131/131] (460s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[565.504962] Starting subtest: cursor-rapid-movement-32x32
[565.562285] Subtest cursor-rapid-movement-32x32: SKIP (0.052s)
[565.897046] 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.