[58.707985] Initializing watchdogs
[58.708060]   /dev/watchdog0
[58.722287] [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]
[58.726540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.728574] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.730377] [001/131] (960s left) fbdev (unaligned-read)
[58.769029] Starting subtest: unaligned-read
[58.784702] Subtest unaligned-read: SUCCESS (0.016s)
[58.856566] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[58.920312] Starting subtest: dirty-switch
[58.921310] Starting dynamic subtest: rcs0
[59.187417] Dynamic subtest rcs0: SUCCESS (0.268s)
[59.196540] Starting dynamic subtest: bcs0
[59.480064] Dynamic subtest bcs0: SUCCESS (0.293s)
[59.488756] Starting dynamic subtest: vcs0
[59.727062] Dynamic subtest vcs0: SUCCESS (0.247s)
[59.735454] Starting dynamic subtest: vcs1
[61.119104] Dynamic subtest vcs1: SUCCESS (1.396s)
[61.127622] Starting dynamic subtest: vecs0
[63.168258] Dynamic subtest vecs0: SUCCESS (2.054s)
[63.174232] Starting dynamic subtest: ccs0
[65.162907] Dynamic subtest ccs0: SUCCESS (1.998s)
[65.164111] Subtest dirty-switch: SUCCESS (6.260s)
[65.442386] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[65.550583] Starting subtest: psr-modesetfrombusy
[71.732119] Subtest psr-modesetfrombusy: SUCCESS (6.189s)
[71.885527] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[71.986254] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[71.987212] Starting dynamic subtest: pipe-A-default-mode
[74.681674] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[74.682563] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.697s)
[75.583154] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[75.641349] Starting subtest: sol-reset-invalid
[75.645375] Subtest sol-reset-invalid: SUCCESS (0.004s)
[76.999467] [006/131] (942s left) gem_spin_batch (resubmit-new)
[77.057783] Starting subtest: resubmit-new
[77.058927] Starting dynamic subtest: rcs0
[77.064793] Dynamic subtest rcs0: SUCCESS (0.007s)
[77.071469] Starting dynamic subtest: bcs0
[77.072395] Dynamic subtest bcs0: SUCCESS (0.004s)
[77.079852] Starting dynamic subtest: vcs0
[77.080760] Dynamic subtest vcs0: SUCCESS (0.004s)
[77.086476] Starting dynamic subtest: vcs1
[77.087395] Dynamic subtest vcs1: SUCCESS (0.004s)
[77.093333] Starting dynamic subtest: vecs0
[77.094187] Dynamic subtest vecs0: SUCCESS (0.004s)
[77.100609] Starting dynamic subtest: ccs0
[77.101511] Dynamic subtest ccs0: SUCCESS (0.003s)
[77.102379] Subtest resubmit-new: SUCCESS (0.028s)
[78.995134] [007/131] (940s left) gem_exec_schedule (preempt-user)
[79.067195] Starting subtest: preempt-user
[79.068191] Starting dynamic subtest: rcs0
[79.103112] Dynamic subtest rcs0: SUCCESS (0.036s)
[79.110257] Starting dynamic subtest: bcs0
[79.132388] Dynamic subtest bcs0: SUCCESS (0.029s)
[79.138942] Starting dynamic subtest: vcs0
[79.157085] Dynamic subtest vcs0: SUCCESS (0.024s)
[79.163139] Starting dynamic subtest: vcs1
[79.185628] Dynamic subtest vcs1: SUCCESS (0.028s)
[79.191568] Starting dynamic subtest: vecs0
[79.207499] Dynamic subtest vecs0: SUCCESS (0.022s)
[79.213458] Starting dynamic subtest: ccs0
[79.238379] Dynamic subtest ccs0: SUCCESS (0.030s)
[79.239299] Subtest preempt-user: SUCCESS (0.171s)
[81.031324] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[81.090989] Starting subtest: nopreempt
[81.092033] Starting dynamic subtest: vecs0
[90.928344] Dynamic subtest vecs0: SUCCESS (9.837s)
[90.938431] Starting dynamic subtest: ccs0
[95.005557] Dynamic subtest ccs0: SUCCESS (4.076s)
[95.014384] Starting dynamic subtest: vcs0
[104.937165] Dynamic subtest vcs0: SUCCESS (9.928s)
[104.946607] Starting dynamic subtest: bcs0
[108.871255] Dynamic subtest bcs0: SUCCESS (3.936s)
[108.879189] Starting dynamic subtest: rcs0
[112.936535] Dynamic subtest rcs0: SUCCESS (4.065s)
[112.945799] Starting dynamic subtest: vcs1
[122.935329] Dynamic subtest vcs1: SUCCESS (9.994s)
[122.936815] Subtest nopreempt: SUCCESS (41.841s)
[123.024325] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[123.113901] Starting subtest: zero-hdisplay
[123.114802] Starting dynamic subtest: pipe-A-eDP-1
[123.396150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[123.403209] Starting dynamic subtest: pipe-B-eDP-1
[123.404053] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[123.409911] Starting dynamic subtest: pipe-C-eDP-1
[123.410850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[123.416825] Starting dynamic subtest: pipe-D-eDP-1
[123.417875] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[123.418825] Subtest zero-hdisplay: SUCCESS (0.287s)
[124.205322] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[124.308082] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[124.309842] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[124.425376] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[124.520194] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[125.378804] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s)
[125.577249] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[125.669587] Starting subtest: getfb-handle-zero
[125.670872] Subtest getfb-handle-zero: SUCCESS (0.000s)
[125.791628] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[125.839849] Starting subtest: yf-tiled-ccs-to-yf-tiled
[125.841973] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[126.039408] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[126.131299] Starting subtest: multiplane-rotation-cropping-bottom
[133.356791] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.226s)
[133.509688] [015/131] (886s left) gem_eio (wait-1us)
[133.742185] Starting subtest: wait-1us
[134.099193] Subtest wait-1us: SUCCESS (0.358s)
[134.263939] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[134.318564] Starting subtest: multi-wait-for-submit-signaled
[134.319702] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[134.450704] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[134.550613] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[134.552207] Starting dynamic subtest: pipe-A-default-mode
[134.844946] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[134.846681] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.295s)
[135.736092] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[135.824664] Starting subtest: alpha-7efc
[136.111102] Starting dynamic subtest: pipe-A-eDP-1
[136.707160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[136.733939] Starting dynamic subtest: pipe-D-eDP-1
[138.029188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[138.030120] Subtest alpha-7efc: SUCCESS (2.205s)
[138.897454] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[139.010341] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[139.012100] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[139.131639] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[139.211639] Starting subtest: fbc-psr2-primary-mmap-cpu
[139.212601] Starting dynamic subtest: eDP-1
[139.214366] Dynamic subtest eDP-1: SKIP (0.000s)
[139.216040] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[139.302149] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[139.396274] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[139.406942] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[139.504923] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[139.568315] Starting subtest: basic-normal-all
[141.726991] Subtest basic-normal-all: SUCCESS (2.159s)
[141.924284] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[142.033697] Starting subtest: linear-16bpp-rotate-180
[143.323481] Subtest linear-16bpp-rotate-180: SUCCESS (1.290s)
[143.495310] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[143.591149] Starting subtest: psr-slowdraw
[168.747221] Subtest psr-slowdraw: SUCCESS (25.154s)
[168.910822] [025/131] (851s left) vgem_basic (dmabuf-fence)
[169.001931] Starting subtest: dmabuf-fence
[169.002822] Subtest dmabuf-fence: SUCCESS (0.001s)
[169.074790] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[169.076542] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[169.131416] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[169.132312] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[169.236269] [027/131] (850s left) kms_psr (pr-primary-render)
[169.323223] Starting subtest: pr-primary-render
[169.325024] Subtest pr-primary-render: SKIP (0.000s)
[169.411769] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[169.496555] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[169.497572] Starting dynamic subtest: pipe-A-eDP-1
[169.507198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.514532] Starting dynamic subtest: pipe-B-eDP-1
[169.523914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.530941] Starting dynamic subtest: pipe-C-eDP-1
[169.539890] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.546558] Starting dynamic subtest: pipe-D-eDP-1
[169.555413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.557102] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[171.686103] [029/131] (848s left) core_auth (getclient-master-drop)
[171.718210] Starting subtest: getclient-master-drop
[171.747467] Subtest getclient-master-drop: SUCCESS (0.030s)
[171.880054] [030/131] (848s left) kms_plane_scaling (planes-downscale-factor-0-5)
[171.983481] Starting subtest: planes-downscale-factor-0-5
[171.984523] Starting dynamic subtest: pipe-A
[171.999651] Dynamic subtest pipe-A: SKIP (0.016s)
[172.009710] Starting dynamic subtest: pipe-B
[172.032282] Dynamic subtest pipe-B: SKIP (0.032s)
[172.043055] Starting dynamic subtest: pipe-C
[172.063957] Dynamic subtest pipe-C: SKIP (0.031s)
[172.072918] Starting dynamic subtest: pipe-D
[172.094974] Dynamic subtest pipe-D: SKIP (0.030s)
[172.097232] Subtest planes-downscale-factor-0-5: SKIP (0.111s)
[172.226771] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[172.310296] Starting subtest: fb-8bpc-vs-panel-8bpc
[172.311297] Starting dynamic subtest: pipe-A-eDP-1
[173.657393] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.347s)
[173.658422] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.348s)
[174.475822] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[174.529840] Subtest reads-snoop: SKIP (0.000s)
[174.591434] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[174.822418] Starting subtest: in-flight-contexts-immediate
[188.915845] Subtest in-flight-contexts-immediate: SUCCESS (14.092s)
[189.114576] [034/131] (831s left) gen3_render_mixed_blits
[189.240520] [035/131] (831s left) kms_pm_rpm (pm-tiling)
[191.056979] Starting subtest: pm-tiling
[191.059722] Subtest pm-tiling: SKIP (0.000s)
[191.515164] [036/131] (828s left) i915_module_load (reload-no-display)
[191.552329] Starting subtest: reload-no-display
[196.056838] Subtest reload-no-display: SUCCESS (4.503s)
[196.075925] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[196.076626] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[196.078202] [037/131] (824s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[197.638509] Starting subtest: plane-upscale-20x20-with-rotation
[197.639630] Starting dynamic subtest: pipe-A
[197.883507] Dynamic subtest pipe-A: SUCCESS (0.246s)
[197.889286] Starting dynamic subtest: pipe-B
[199.204208] Dynamic subtest pipe-B: SUCCESS (1.320s)
[199.212355] Starting dynamic subtest: pipe-C
[200.538979] Dynamic subtest pipe-C: SUCCESS (1.334s)
[200.545485] Starting dynamic subtest: pipe-D
[201.869150] Dynamic subtest pipe-D: SUCCESS (1.329s)
[201.869973] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.232s)
[203.018775] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[203.020125] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[203.022335] [038/131] (817s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[203.137787] Starting subtest: 4-tiled-8bpp-rotate-180
[204.312684] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.175s)
[204.486987] [039/131] (815s left) kms_rotation_crc (primary-rotation-90)
[204.584350] Starting subtest: primary-rotation-90
[204.586119] Subtest primary-rotation-90: SKIP (0.001s)
[204.674031] [040/131] (815s left) kms_cursor_crc (cursor-onscreen-32x10)
[204.831143] Starting subtest: cursor-onscreen-32x10
[204.874515] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[205.179465] [041/131] (815s left) kms_vblank (wait-idle)
[205.281561] Starting subtest: wait-idle
[205.284098] Starting dynamic subtest: pipe-A-eDP-1
[207.059268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.773s)
[207.070615] Starting dynamic subtest: pipe-D-eDP-1
[209.492267] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s)
[209.493392] Subtest wait-idle: SUCCESS (4.209s)
[210.327539] [042/131] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[210.415404] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[210.417055] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[210.528666] [043/131] (810s left) kms_flip (2x-flip-vs-dpms)
[210.628785] Starting subtest: 2x-flip-vs-dpms
[210.640539] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[210.784148] [044/131] (809s left) gem_exec_fence (syncobj-channel)
[211.213804] Starting subtest: syncobj-channel
[212.232857] Subtest syncobj-channel: SUCCESS (1.016s)
[213.013843] [045/131] (807s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[213.107522] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[213.108422] Starting dynamic subtest: pipe-A-eDP-1
[213.111714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.118300] Starting dynamic subtest: pipe-B-eDP-1
[213.121550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.128432] Starting dynamic subtest: pipe-C-eDP-1
[213.131783] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.138330] Starting dynamic subtest: pipe-D-eDP-1
[213.141656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.143380] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[215.383301] [046/131] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[215.480320] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[222.762476] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.283s)
[222.931980] [047/131] (797s left) kms_flip (busy-flip)
[223.045985] Starting subtest: busy-flip
[223.048560] Starting dynamic subtest: A-eDP1
[224.697728] Dynamic subtest A-eDP1: SUCCESS (1.649s)
[224.706240] Starting dynamic subtest: B-eDP1
[226.348123] Dynamic subtest B-eDP1: SUCCESS (1.649s)
[226.357980] Starting dynamic subtest: C-eDP1
[228.061052] Dynamic subtest C-eDP1: SUCCESS (1.711s)
[228.069824] Starting dynamic subtest: D-eDP1
[229.704137] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[229.707452] Subtest busy-flip: SUCCESS (6.662s)
[230.880322] [048/131] (789s left) prime_mmap (test_aperture_limit)
[230.942730] Starting subtest: test_aperture_limit
[230.943740] Starting dynamic subtest: test_aperture_limit-smem
[230.952224] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[230.954127] Subtest test_aperture_limit: SKIP (0.009s)
[231.040153] [049/131] (789s left) i915_pm_rpm (sysfs-read)
[233.063783] Starting subtest: sysfs-read
[234.219883] Subtest sysfs-read: SUCCESS (1.154s)
[234.605401] [050/131] (786s left) kms_big_fb (yf-tiled-addfb)
[234.707391] Starting subtest: yf-tiled-addfb
[234.709316] Subtest yf-tiled-addfb: SKIP (0.000s)
[234.840164] [051/131] (785s left) sriov_basic (enable-vfs-autoprobe-on)
[234.903904] Starting subtest: enable-vfs-autoprobe-on
[234.904980] Starting dynamic subtest: numvfs-1
[234.939066] Dynamic subtest numvfs-1: FAIL (0.015s)
[234.947659] Starting dynamic subtest: numvfs-2
[234.975192] Dynamic subtest numvfs-2: FAIL (0.004s)
[234.981830] Starting dynamic subtest: numvfs-3
[235.008987] Dynamic subtest numvfs-3: FAIL (0.003s)
[235.015415] Starting dynamic subtest: numvfs-4
[235.042096] Dynamic subtest numvfs-4: FAIL (0.004s)
[235.048143] Starting dynamic subtest: numvfs-5
[235.075677] Dynamic subtest numvfs-5: FAIL (0.004s)
[235.081825] Starting dynamic subtest: numvfs-6
[235.110474] Dynamic subtest numvfs-6: FAIL (0.004s)
[235.116589] Starting dynamic subtest: numvfs-7
[235.146641] Dynamic subtest numvfs-7: FAIL (0.004s)
[235.153093] Starting dynamic subtest: numvfs-random
[235.182269] Dynamic subtest numvfs-random: FAIL (0.004s)
[235.188578] Starting dynamic subtest: numvfs-all
[235.220623] Dynamic subtest numvfs-all: FAIL (0.003s)
[235.221478] Subtest enable-vfs-autoprobe-on: FAIL (0.050s)
[235.251224] [052/131] (785s left) gem_exec_whisper (basic-queues)
[235.319410] Starting subtest: basic-queues
[240.887839] Subtest basic-queues: SUCCESS (5.566s)
[241.084094] [053/131] (779s left) kms_flip (2x-dpms-vs-vblank-race)
[241.194896] Starting subtest: 2x-dpms-vs-vblank-race
[241.213320] Subtest 2x-dpms-vs-vblank-race: SKIP (0.018s)
[241.308990] [054/131] (779s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[241.405306] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[241.787891] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.563838] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[244.573797] Starting dynamic subtest: pipe-A-eDP-1-4
[246.738909] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[246.748061] Starting dynamic subtest: pipe-A-eDP-1-4
[248.748895] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.758502] Starting dynamic subtest: pipe-A-eDP-1-x
[250.927843] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[251.290665] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[254.093746] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[254.103380] Starting dynamic subtest: pipe-B-eDP-1-4
[256.357645] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.263s)
[256.367196] Starting dynamic subtest: pipe-B-eDP-1-4
[258.368398] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[258.377789] Starting dynamic subtest: pipe-B-eDP-1-x
[260.558238] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[260.937754] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.720839] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[263.730990] Starting dynamic subtest: pipe-C-eDP-1-4
[265.896491] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[265.908479] Starting dynamic subtest: pipe-C-eDP-1-4
[267.906720] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[267.917668] Starting dynamic subtest: pipe-C-eDP-1-x
[270.085429] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[270.444713] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[273.258447] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[273.267332] Starting dynamic subtest: pipe-D-eDP-1-4
[275.433719] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[275.443333] Starting dynamic subtest: pipe-D-eDP-1-4
[277.489016] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[277.496517] Starting dynamic subtest: pipe-D-eDP-1-x
[279.633583] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[279.635080] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.225s)
[280.853915] [055/131] (740s left) gem_mmap_gtt (basic-write-read-distinct)
[280.919281] Subtest basic-write-read-distinct: SKIP (0.000s)
[280.987905] [056/131] (739s left) gem_mmap_offset (oob-read)
[281.041852] Starting subtest: oob-read
[281.042832] Subtest oob-read: SUCCESS (0.000s)
[281.168775] [057/131] (739s left) kms_atomic (atomic-plane-damage)
[281.264439] Starting subtest: atomic-plane-damage
[281.315757] Starting dynamic subtest: pipe-A-eDP-1
[281.844279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[281.845118] Subtest atomic-plane-damage: SUCCESS (0.580s)
[282.681992] [058/131] (738s left) kms_atomic_transition (plane-all-transition-nonblocking)
[282.775356] Starting subtest: plane-all-transition-nonblocking
[282.776212] Starting dynamic subtest: pipe-A-eDP-1
[285.268864] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[285.578491] Starting dynamic subtest: pipe-B-eDP-1
[288.806160] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s)
[289.099950] Subtest plane-all-transition-nonblocking: SUCCESS (6.324s)
[289.953602] [059/131] (731s left) gem_exec_parallel (contexts)
[290.023959] Starting subtest: contexts
[290.024898] Starting dynamic subtest: rcs0
[293.208036] Dynamic subtest rcs0: SUCCESS (3.183s)
[293.217557] Starting dynamic subtest: bcs0
[296.981129] Dynamic subtest bcs0: SUCCESS (3.772s)
[296.995592] Starting dynamic subtest: vcs0
[301.315746] Dynamic subtest vcs0: SUCCESS (4.332s)
[301.324282] Starting dynamic subtest: vcs1
[305.317197] Dynamic subtest vcs1: SUCCESS (3.998s)
[305.326953] Starting dynamic subtest: vecs0
[309.355446] Dynamic subtest vecs0: SUCCESS (4.035s)
[309.368060] Starting dynamic subtest: ccs0
[312.970873] Dynamic subtest ccs0: SUCCESS (3.614s)
[312.972246] Subtest contexts: SUCCESS (22.949s)
[313.179305] [060/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[313.284072] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[319.936787] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.653s)
[320.114853] [061/131] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[320.205491] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[320.207321] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.325376] [062/131] (700s left) kms_atomic_interruptible (legacy-pageflip)
[320.420365] Starting subtest: legacy-pageflip
[320.421147] Starting dynamic subtest: pipe-A-eDP-1
[327.852631] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.432s)
[327.853655] Subtest legacy-pageflip: SUCCESS (7.433s)
[328.733787] [063/131] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[328.816930] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[328.818665] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[328.941733] [064/131] (692s left) kms_psr (psr2-sprite-mmap-cpu)
[329.030365] Starting subtest: psr2-sprite-mmap-cpu
[329.031279] Starting dynamic subtest: eDP-1
[330.698196] Dynamic subtest eDP-1: SUCCESS (1.668s)
[330.699070] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.669s)
[331.589341] [065/131] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[331.691153] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[338.747065] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.056s)
[338.930445] [066/131] (682s left) gem_exec_schedule (fairslice-all)
[338.983761] Starting subtest: fairslice-all
[341.053553] Subtest fairslice-all: SUCCESS (2.070s)
[342.992565] [067/131] (678s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[347.989864] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[347.990778] Starting dynamic subtest: pipe-A-eDP-1
[348.778228] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[348.786996] Starting dynamic subtest: pipe-B-eDP-1
[349.899535] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[349.901342] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.910s)
[351.117794] [068/131] (670s left) api_intel_allocator (two-level-inception)
[351.170191] Starting subtest: two-level-inception
[356.573517] Subtest two-level-inception: SUCCESS (5.403s)
[356.710326] [069/131] (664s left) i915_suspend (debugfs-reader)
[356.771362] Starting subtest: debugfs-reader
[375.516152] Subtest debugfs-reader: SUCCESS (8.501s)
[381.653180] [070/131] (645s left) kms_flip (plain-flip-fb-recreate-interruptible)
[381.771476] Starting subtest: plain-flip-fb-recreate-interruptible
[381.773773] Starting dynamic subtest: A-eDP1
[402.300420] Dynamic subtest A-eDP1: SUCCESS (20.682s)
[402.310554] Starting dynamic subtest: B-eDP1
[411.111667] Dynamic subtest B-eDP1: SUCCESS (8.816s)
[411.121983] Starting dynamic subtest: C-eDP1
[419.934249] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[419.944200] Starting dynamic subtest: D-eDP1
[428.762837] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[428.765399] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (47.161s)
[429.945195] [071/131] (597s left) gem_vm_create (invalid-destroy)
[430.007547] Starting subtest: invalid-destroy
[430.011382] Subtest invalid-destroy: SUCCESS (0.004s)
[430.147641] [072/131] (597s left) gem_ccs (ctrl-surf-copy-new-ctx)
[430.193353] Starting subtest: ctrl-surf-copy-new-ctx
[430.195159] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[430.311539] [073/131] (597s left) syncobj_basic (bad-destroy-pad)
[430.359981] Starting subtest: bad-destroy-pad
[430.360845] Subtest bad-destroy-pad: SUCCESS (0.000s)
[430.481421] [074/131] (597s left) kms_plane_multiple (2x-tiling-y)
[430.558435] Starting subtest: 2x-tiling-y
[430.560450] Subtest 2x-tiling-y: SKIP (0.000s)
[430.650219] [075/131] (597s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[430.738292] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[430.739320] Starting dynamic subtest: pipe-A-eDP-1
[430.747536] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[430.757139] Starting dynamic subtest: pipe-B-eDP-1
[430.765408] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.773485] Starting dynamic subtest: pipe-C-eDP-1
[430.781308] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.788920] Starting dynamic subtest: pipe-D-eDP-1
[430.797182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.798793] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[432.927976] [076/131] (594s left) kms_pm_rpm (modeset-lpsp)
[434.469070] Starting subtest: modeset-lpsp
[435.918974] Subtest modeset-lpsp: SUCCESS (1.455s)
[436.027953] [077/131] (591s left) kms_setmode (basic)
[436.079029] Starting subtest: basic
[436.407051] Starting dynamic subtest: pipe-A-eDP-1
[438.484599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[438.827890] Starting dynamic subtest: pipe-B-eDP-1
[440.910470] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s)
[441.214886] Subtest basic: SUCCESS (5.138s)
[442.082174] [078/131] (585s left) kms_psr (fbc-psr-suspend)
[442.180966] Starting subtest: fbc-psr-suspend
[442.181890] Starting dynamic subtest: eDP-1
[442.183565] Dynamic subtest eDP-1: SKIP (0.000s)
[442.185325] Subtest fbc-psr-suspend: SKIP (0.001s)
[442.273795] [079/131] (585s left) gem_ringfill (engines-basic)
[448.157241] Starting subtest: engines-basic
[448.158386] Starting dynamic subtest: rcs0
[448.226956] Dynamic subtest rcs0: SUCCESS (0.069s)
[448.238415] Starting dynamic subtest: bcs0
[448.272377] Dynamic subtest bcs0: SUCCESS (0.043s)
[448.283518] Starting dynamic subtest: vcs0
[448.317349] Dynamic subtest vcs0: SUCCESS (0.043s)
[448.327314] Starting dynamic subtest: vcs1
[448.360553] Dynamic subtest vcs1: SUCCESS (0.041s)
[448.372180] Starting dynamic subtest: vecs0
[448.404314] Dynamic subtest vecs0: SUCCESS (0.042s)
[448.415286] Starting dynamic subtest: ccs0
[448.451278] Dynamic subtest ccs0: SUCCESS (0.045s)
[448.452500] Subtest engines-basic: SUCCESS (0.295s)
[448.547982] [080/131] (579s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[448.608506] Starting subtest: invalid-bsd2-flag-on-vebox
[448.609499] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[448.740390] [081/131] (579s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[448.846494] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[448.847409] Starting dynamic subtest: pipe-A-eDP-1
[448.867170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[448.876453] Starting dynamic subtest: pipe-B-eDP-1
[448.888485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[448.897567] Starting dynamic subtest: pipe-C-eDP-1
[448.909493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[448.918378] Starting dynamic subtest: pipe-D-eDP-1
[448.931642] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[448.932596] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[451.259156] [082/131] (576s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[451.350655] Starting subtest: extended-pageflip-modeset-hang-oldfb
[451.351502] Starting dynamic subtest: pipe-A
[459.251226] Dynamic subtest pipe-A: SUCCESS (7.902s)
[459.260253] Starting dynamic subtest: pipe-D
[467.849365] Dynamic subtest pipe-D: SUCCESS (8.599s)
[467.850438] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.506s)
[468.711397] [083/131] (559s left) gem_ppgtt (shrink-vs-evict-any)
[468.769903] Starting subtest: shrink-vs-evict-any
[474.116243] Subtest shrink-vs-evict-any: SUCCESS (5.343s)
[474.216322] [084/131] (553s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[474.266296] Starting subtest: etime-single-wait-for-submit-unsubmitted
[474.376483] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[474.473932] [085/131] (553s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[474.522014] Starting subtest: multi-wait-all-for-submit-signaled
[474.523038] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[474.638924] [086/131] (553s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[474.692458] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[474.800315] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[474.897382] [087/131] (553s left) gem_exec_schedule (implicit-write-read)
[474.979709] Starting subtest: implicit-write-read
[474.980812] Starting dynamic subtest: rcs0
[475.175308] Dynamic subtest rcs0: SUCCESS (0.193s)
[475.185815] Starting dynamic subtest: vcs0
[475.312146] Dynamic subtest vcs0: SUCCESS (0.138s)
[475.321413] Starting dynamic subtest: vcs1
[475.417989] Dynamic subtest vcs1: SUCCESS (0.105s)
[475.428784] Starting dynamic subtest: vecs0
[475.521615] Dynamic subtest vecs0: SUCCESS (0.102s)
[475.532349] Starting dynamic subtest: ccs0
[475.653790] Dynamic subtest ccs0: SUCCESS (0.131s)
[475.655504] Subtest implicit-write-read: SUCCESS (0.673s)
[476.254924] [088/131] (551s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[476.370373] Starting subtest: fbcpsr-rgb565-draw-blt
[483.375080] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.003s)
[483.549010] [089/131] (544s left) gem_ctx_persistence (processes)
[483.610661] Starting subtest: processes
[485.176315] Subtest processes: SUCCESS (1.564s)
[485.281774] [090/131] (542s left) kms_cursor_crc (cursor-sliding-32x10)
[485.434737] Starting subtest: cursor-sliding-32x10
[485.474342] Subtest cursor-sliding-32x10: SKIP (0.038s)
[485.771702] [091/131] (542s left) kms_psr (fbc-pr-primary-render)
[485.880051] Starting subtest: fbc-pr-primary-render
[485.881980] Subtest fbc-pr-primary-render: SKIP (0.000s)
[485.968358] [092/131] (542s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[486.027804] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[486.107953] [093/131] (542s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[486.164022] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[486.165007] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[486.299941] [094/131] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[486.404327] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[486.406017] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.540969] [095/131] (541s left) gem_exec_async (concurrent-writes)
[486.602295] Starting subtest: concurrent-writes
[486.603246] Starting dynamic subtest: rcs0
[486.615194] Dynamic subtest rcs0: SUCCESS (0.014s)
[486.625295] Starting dynamic subtest: bcs0
[486.626264] Dynamic subtest bcs0: SUCCESS (0.005s)
[486.634270] Starting dynamic subtest: vcs0
[486.635382] Dynamic subtest vcs0: SUCCESS (0.006s)
[486.647267] Starting dynamic subtest: vcs1
[486.648222] Dynamic subtest vcs1: SUCCESS (0.006s)
[486.656237] Starting dynamic subtest: vecs0
[486.657142] Dynamic subtest vecs0: SUCCESS (0.006s)
[486.664918] Starting dynamic subtest: ccs0
[486.665757] Dynamic subtest ccs0: SUCCESS (0.007s)
[486.666577] Subtest concurrent-writes: SUCCESS (0.048s)
[486.892721] [096/131] (541s left) gem_mmap_gtt (basic-small-bo-tiledx)
[486.947479] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[487.000913] [097/131] (541s left) dmabuf_sync_file (import-basic)
[487.038498] Starting subtest: import-basic
[487.039450] Subtest import-basic: SUCCESS (0.001s)
[487.115487] [098/131] (541s left) kms_feature_discovery (display)
[487.211117] Starting subtest: display
[487.212085] Subtest display: SUCCESS (0.000s)
[487.304185] [099/131] (541s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[487.395683] Starting subtest: x-tiled-64bpp-rotate-90
[487.417007] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[487.573847] [100/131] (540s left) perf_pmu (busy-no-semaphores)
[487.609507] Starting subtest: busy-no-semaphores
[487.610557] Starting dynamic subtest: rcs0
[488.202035] Dynamic subtest rcs0: SUCCESS (0.589s)
[488.213609] Starting dynamic subtest: bcs0
[488.751639] Dynamic subtest bcs0: SUCCESS (0.546s)
[488.763513] Starting dynamic subtest: vcs0
[489.301828] Dynamic subtest vcs0: SUCCESS (0.547s)
[489.311661] Starting dynamic subtest: vcs1
[490.654290] Dynamic subtest vcs1: SUCCESS (1.349s)
[490.663834] Starting dynamic subtest: vecs0
[492.639861] Dynamic subtest vecs0: SUCCESS (1.982s)
[492.649930] Starting dynamic subtest: ccs0
[494.686552] Dynamic subtest ccs0: SUCCESS (2.043s)
[494.688107] Subtest busy-no-semaphores: SUCCESS (7.075s)
[494.827335] [101/131] (533s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[494.937884] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[494.939646] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[495.063863] [102/131] (533s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[495.176636] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[495.178318] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[495.344020] [103/131] (533s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[495.727312] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[496.525296] [104/131] (532s left) kms_getfb (getfb-reject-nv12)
[496.623871] Starting subtest: getfb-reject-nv12
[496.624693] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[496.781948] [105/131] (531s left) i915_drm_fdinfo (context-close-stress)
[496.817683] Starting subtest: context-close-stress
[507.565258] Subtest context-close-stress: SUCCESS (10.746s)
[507.656231] [106/131] (521s left) perf_pmu (module-unload)
[507.939826] Starting subtest: module-unload
[515.884655] Subtest module-unload: FAIL (7.907s)
[515.905371] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.906317] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[515.908110] [107/131] (512s left) kms_chamelium_edid (dp-edid-read)
[517.609405] Subtest dp-edid-read: SKIP (0.000s)
[518.451504] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[518.452815] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[518.455103] [108/131] (510s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[523.524411] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[523.525643] Starting dynamic subtest: pipe-A-eDP-1
[524.340555] Dynamic subtest pipe-A-eDP-1: SKIP (0.815s)
[524.349335] Starting dynamic subtest: pipe-B-eDP-1
[525.476546] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[525.478395] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.953s)
[526.899966] [109/131] (501s left) kms_vblank (query-busy)
[527.003264] Starting subtest: query-busy
[527.004294] Starting dynamic subtest: pipe-A-eDP-1
[528.897914] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[528.915857] Starting dynamic subtest: pipe-D-eDP-1
[531.445124] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[531.446056] Subtest query-busy: SUCCESS (4.443s)
[532.263411] [110/131] (496s left) syncobj_timeline (wait-for-submit-complex)
[532.326620] Starting subtest: wait-for-submit-complex
[532.388233] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[532.483667] [111/131] (496s left) perf (invalid-create-userspace-config)
[532.619712] Starting subtest: invalid-create-userspace-config
[532.622110] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[532.655678] [112/131] (496s left) gem_exec_basic (basic)
[532.716533] Starting subtest: basic
[532.717613] Starting dynamic subtest: rcs0-smem
[532.720516] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[532.728786] Starting dynamic subtest: bcs0-smem
[532.729650] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[532.737040] Starting dynamic subtest: vcs0-smem
[532.737945] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[532.744946] Starting dynamic subtest: vcs1-smem
[532.745836] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[532.752734] Starting dynamic subtest: vecs0-smem
[532.753642] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[532.760631] Starting dynamic subtest: ccs0-smem
[532.761502] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[532.762350] Subtest basic: SUCCESS (0.015s)
[534.165965] [113/131] (494s left) kms_chamelium_color (ctm-0-25)
[534.274644] Subtest ctm-0-25: SKIP (0.000s)
[534.314870] [114/131] (494s left) gem_userptr_blits (process-exit-busy)
[534.386915] Starting subtest: process-exit-busy
[534.400817] Subtest process-exit-busy: SUCCESS (0.014s)
[534.535619] [115/131] (494s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[534.602321] Starting subtest: y-tiled-ccs-to-y-tiled
[534.604822] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[534.807376] [116/131] (494s left) gen7_exec_parse (bitmasks)
[534.863130] Subtest bitmasks: SKIP (0.000s)
[534.937261] [117/131] (494s left) gem_eio (wait-wedge-10ms)
[535.134400] Starting subtest: wait-wedge-10ms
[536.203942] Subtest wait-wedge-10ms: SUCCESS (1.070s)
[536.383101] [118/131] (492s left) kms_content_protection (atomic)
[536.516942] Starting subtest: atomic
[536.518698] Subtest atomic: SKIP (0.000s)
[536.651247] [119/131] (492s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[536.739937] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[536.740806] Starting dynamic subtest: pipe-A-default-mode
[537.026117] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[537.027726] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[537.886272] [120/131] (491s left) gem_exec_params (invalid-flag)
[537.949902] Starting subtest: invalid-flag
[537.950856] Subtest invalid-flag: SUCCESS (0.000s)
[538.119003] [121/131] (491s left) kms_getfb (getfb-addfb-different-handles)
[538.214228] Starting subtest: getfb-addfb-different-handles
[538.215169] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[538.336805] [122/131] (490s left) gem_exec_flush (basic-uc-ro-default)
[538.397876] Starting subtest: basic-uc-ro-default
[543.853037] Subtest basic-uc-ro-default: SUCCESS (5.456s)
[544.055252] [123/131] (485s left) gem_sync (basic-each)
[544.125563] Starting subtest: basic-each
[546.507056] Subtest basic-each: SUCCESS (2.383s)
[546.710170] [124/131] (482s left) gem_exec_balancer (full)
[546.784084] Starting subtest: full
[551.053526] Subtest full: SUCCESS (4.270s)
[551.415050] [125/131] (477s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[551.516328] Starting subtest: y-tiled-8bpp-rotate-180
[551.518307] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[551.625739] [126/131] (477s left) sw_sync (sync_merge_invalid)
[551.652007] Starting subtest: sync_merge_invalid
[551.679688] Subtest sync_merge_invalid: SUCCESS (0.028s)
[551.761415] [127/131] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[551.868912] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[556.320546] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.453s)
[557.494454] [128/131] (471s left) gem_lmem_swapping (parallel-random-verify-ccs)
[557.538299] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[557.574749] [129/131] (471s left) kms_lease (lease-unleased-connector)
[557.665049] Starting subtest: lease-unleased-connector
[557.665902] Starting dynamic subtest: pipe-A-eDP-1
[557.673518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[557.683845] Starting dynamic subtest: pipe-B-eDP-1
[557.684676] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[557.693393] Starting dynamic subtest: pipe-C-eDP-1
[557.694273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[557.702384] Starting dynamic subtest: pipe-D-eDP-1
[557.703269] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[557.704159] Subtest lease-unleased-connector: SUCCESS (0.036s)
[557.822144] [130/131] (471s left) perf (enable-disable)
[557.925691] Starting subtest: enable-disable
[557.926742] Starting dynamic subtest: 0-rcs0
[560.192976] Dynamic subtest 0-rcs0: SUCCESS (2.265s)
[560.201150] Starting dynamic subtest: 1-vcs0
[564.673108] Dynamic subtest 1-vcs0: SUCCESS (4.480s)
[564.674441] Subtest enable-disable: SUCCESS (6.747s)
[564.715321] [131/131] (464s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[564.853609] Starting subtest: cursor-rapid-movement-32x32
[564.893997] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[565.225549] 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.