[59.078402] Initializing watchdogs
[59.078452]   /dev/watchdog0
[59.093427] [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.098140] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.100621] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.104199] [001/131] (960s left) fbdev (unaligned-read)
[59.173586] Starting subtest: unaligned-read
[59.188777] Subtest unaligned-read: SUCCESS (0.015s)
[59.269674] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[59.335289] Starting subtest: dirty-switch
[59.337740] Starting dynamic subtest: rcs0
[59.591957] Dynamic subtest rcs0: SUCCESS (0.255s)
[59.600990] Starting dynamic subtest: bcs0
[59.866067] Dynamic subtest bcs0: SUCCESS (0.272s)
[59.875340] Starting dynamic subtest: vcs0
[60.075487] Dynamic subtest vcs0: SUCCESS (0.208s)
[60.085541] Starting dynamic subtest: vcs1
[62.120810] Dynamic subtest vcs1: SUCCESS (2.033s)
[62.130493] Starting dynamic subtest: vecs0
[64.106899] Dynamic subtest vecs0: SUCCESS (1.977s)
[64.116968] Starting dynamic subtest: ccs0
[66.173643] Dynamic subtest ccs0: SUCCESS (2.059s)
[66.176069] Subtest dirty-switch: SUCCESS (6.806s)
[66.442948] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[66.546609] Starting subtest: psr-modesetfrombusy
[72.700087] Subtest psr-modesetfrombusy: SUCCESS (6.144s)
[72.875118] [004/131] (946s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[72.968830] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[72.970665] Starting dynamic subtest: pipe-A-default-mode
[75.704789] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[75.707288] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.734s)
[76.600536] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[76.679267] Starting subtest: sol-reset-invalid
[76.683806] Subtest sol-reset-invalid: SUCCESS (0.002s)
[78.024546] [006/131] (941s left) gem_spin_batch (resubmit-new)
[78.095503] Starting subtest: resubmit-new
[78.097875] Starting dynamic subtest: rcs0
[78.103031] Dynamic subtest rcs0: SUCCESS (0.008s)
[78.112629] Starting dynamic subtest: bcs0
[78.114824] Dynamic subtest bcs0: SUCCESS (0.004s)
[78.122915] Starting dynamic subtest: vcs0
[78.125360] Dynamic subtest vcs0: SUCCESS (0.004s)
[78.132997] Starting dynamic subtest: vcs1
[78.135164] Dynamic subtest vcs1: SUCCESS (0.004s)
[78.142791] Starting dynamic subtest: vecs0
[78.145138] Dynamic subtest vecs0: SUCCESS (0.004s)
[78.152580] Starting dynamic subtest: ccs0
[78.154853] Dynamic subtest ccs0: SUCCESS (0.004s)
[78.157144] Subtest resubmit-new: SUCCESS (0.029s)
[79.954201] [007/131] (939s left) gem_exec_schedule (preempt-user)
[80.033152] Starting subtest: preempt-user
[80.035136] Starting dynamic subtest: rcs0
[80.069654] Dynamic subtest rcs0: SUCCESS (0.039s)
[80.080192] Starting dynamic subtest: bcs0
[80.100095] Dynamic subtest bcs0: SUCCESS (0.030s)
[80.107338] Starting dynamic subtest: vcs0
[80.132382] Dynamic subtest vcs0: SUCCESS (0.032s)
[80.140057] Starting dynamic subtest: vcs1
[80.156723] Dynamic subtest vcs1: SUCCESS (0.024s)
[80.164187] Starting dynamic subtest: vecs0
[80.178736] Dynamic subtest vecs0: SUCCESS (0.022s)
[80.191814] Starting dynamic subtest: ccs0
[80.211607] Dynamic subtest ccs0: SUCCESS (0.032s)
[80.213963] Subtest preempt-user: SUCCESS (0.181s)
[81.990067] [008/131] (937s left) sysfs_heartbeat_interval (nopreempt)
[82.054581] Starting subtest: nopreempt
[82.056957] Starting dynamic subtest: vecs0
[91.950356] Dynamic subtest vecs0: SUCCESS (9.887s)
[91.961105] Starting dynamic subtest: ccs0
[96.048212] Dynamic subtest ccs0: SUCCESS (4.096s)
[96.058704] Starting dynamic subtest: vcs0
[105.896570] Dynamic subtest vcs0: SUCCESS (9.846s)
[105.907360] Starting dynamic subtest: bcs0
[109.895367] Dynamic subtest bcs0: SUCCESS (3.995s)
[109.907280] Starting dynamic subtest: rcs0
[114.007450] Dynamic subtest rcs0: SUCCESS (4.111s)
[114.018038] Starting dynamic subtest: vcs1
[122.926878] Dynamic subtest vcs1: SUCCESS (8.916s)
[122.929449] Subtest nopreempt: SUCCESS (40.858s)
[123.030211] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[123.134210] Starting subtest: zero-hdisplay
[123.136620] Starting dynamic subtest: pipe-A-eDP-1
[123.416268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[123.426078] Starting dynamic subtest: pipe-B-eDP-1
[123.428318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[123.436583] Starting dynamic subtest: pipe-C-eDP-1
[123.438651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[123.448408] Starting dynamic subtest: pipe-D-eDP-1
[123.450385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[123.452287] Subtest zero-hdisplay: SUCCESS (0.288s)
[124.246863] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[124.344876] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[124.349052] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[124.454908] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[124.561424] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[125.430282] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s)
[125.648242] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[125.743823] Starting subtest: getfb-handle-zero
[125.746114] Subtest getfb-handle-zero: SUCCESS (0.000s)
[125.875697] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[125.932066] Starting subtest: yf-tiled-ccs-to-yf-tiled
[125.936312] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[126.135602] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[126.232412] Starting subtest: multiplane-rotation-cropping-bottom
[133.525219] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.293s)
[133.686746] [015/131] (886s left) gem_eio (wait-1us)
[133.921521] Starting subtest: wait-1us
[134.270335] Subtest wait-1us: SUCCESS (0.349s)
[134.442730] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[134.502545] Starting subtest: multi-wait-for-submit-signaled
[134.504447] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[134.628064] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[134.725177] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[134.726806] Starting dynamic subtest: pipe-A-default-mode
[135.023403] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[135.027795] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.296s)
[135.878305] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[135.983663] Starting subtest: alpha-7efc
[136.270734] Starting dynamic subtest: pipe-A-eDP-1
[136.871105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[136.916024] Starting dynamic subtest: pipe-D-eDP-1
[138.183461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[138.185700] Subtest alpha-7efc: SUCCESS (2.200s)
[139.052884] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[139.155023] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[139.159346] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[139.280250] [020/131] (881s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[139.380823] Starting subtest: fbc-psr2-primary-mmap-cpu
[139.383072] Starting dynamic subtest: eDP-1
[139.387515] Dynamic subtest eDP-1: SKIP (0.000s)
[139.391984] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[139.475503] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[139.563601] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[139.573623] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[139.675352] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[139.752388] Starting subtest: basic-normal-all
[142.284426] Subtest basic-normal-all: SUCCESS (2.530s)
[142.488978] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[142.617172] Starting subtest: linear-16bpp-rotate-180
[143.982989] Subtest linear-16bpp-rotate-180: SUCCESS (1.368s)
[144.140298] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[144.246054] Starting subtest: psr-slowdraw
[169.447867] Subtest psr-slowdraw: SUCCESS (25.206s)
[169.629790] [025/131] (850s left) vgem_basic (dmabuf-fence)
[169.725590] Starting subtest: dmabuf-fence
[169.727843] Subtest dmabuf-fence: SUCCESS (0.002s)
[169.806279] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[169.809412] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[169.869994] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[169.872220] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[170.011494] [027/131] (850s left) kms_psr (pr-primary-render)
[170.104448] Starting subtest: pr-primary-render
[170.108970] Subtest pr-primary-render: SKIP (0.000s)
[170.200125] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[170.304465] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[170.306480] Starting dynamic subtest: pipe-A-eDP-1
[170.326537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.337743] Starting dynamic subtest: pipe-B-eDP-1
[170.355570] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.363966] Starting dynamic subtest: pipe-C-eDP-1
[170.381668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.389960] Starting dynamic subtest: pipe-D-eDP-1
[170.407365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.410787] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[172.609041] [029/131] (848s left) core_auth (getclient-master-drop)
[172.648444] Starting subtest: getclient-master-drop
[172.677350] Subtest getclient-master-drop: SUCCESS (0.033s)
[172.821235] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[172.931182] Starting subtest: planes-downscale-factor-0-5
[172.933479] Starting dynamic subtest: pipe-A
[172.953489] Dynamic subtest pipe-A: SKIP (0.018s)
[172.963069] Starting dynamic subtest: pipe-B
[172.990065] Dynamic subtest pipe-B: SKIP (0.037s)
[173.001611] Starting dynamic subtest: pipe-C
[173.028200] Dynamic subtest pipe-C: SKIP (0.036s)
[173.037063] Starting dynamic subtest: pipe-D
[173.060589] Dynamic subtest pipe-D: SKIP (0.032s)
[173.064404] Subtest planes-downscale-factor-0-5: SKIP (0.126s)
[173.193408] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[173.295029] Starting subtest: fb-8bpc-vs-panel-8bpc
[173.297377] Starting dynamic subtest: pipe-A-eDP-1
[174.682769] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.388s)
[174.685066] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.389s)
[175.577139] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[175.636366] Subtest reads-snoop: SKIP (0.000s)
[175.714988] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[175.955891] Starting subtest: in-flight-contexts-immediate
[189.924626] Subtest in-flight-contexts-immediate: SUCCESS (13.967s)
[190.131816] [034/131] (830s left) gen3_render_mixed_blits
[190.279115] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[192.005596] Starting subtest: pm-tiling
[192.010233] Subtest pm-tiling: SKIP (0.000s)
[192.599062] [036/131] (828s left) i915_module_load (reload-no-display)
[192.642887] Starting subtest: reload-no-display
[198.880729] Subtest reload-no-display: SUCCESS (6.238s)
[198.910322] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[198.911066] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[198.914159] [037/131] (822s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[200.558101] Starting subtest: plane-upscale-20x20-with-rotation
[200.560340] Starting dynamic subtest: pipe-A
[200.796817] Dynamic subtest pipe-A: SUCCESS (0.241s)
[200.804642] Starting dynamic subtest: pipe-B
[202.133996] Dynamic subtest pipe-B: SUCCESS (1.335s)
[202.142392] Starting dynamic subtest: pipe-C
[203.464590] Dynamic subtest pipe-C: SUCCESS (1.330s)
[203.472939] Starting dynamic subtest: pipe-D
[204.796298] Dynamic subtest pipe-D: SUCCESS (1.331s)
[204.798498] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.242s)
[205.961790] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[205.963066] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[205.966669] [038/131] (815s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[206.085067] Starting subtest: 4-tiled-8bpp-rotate-180
[207.289727] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.206s)
[207.423721] [039/131] (813s left) kms_rotation_crc (primary-rotation-90)
[207.512163] Starting subtest: primary-rotation-90
[207.515721] Subtest primary-rotation-90: SKIP (0.001s)
[207.606379] [040/131] (813s left) kms_cursor_crc (cursor-onscreen-32x10)
[207.761664] Starting subtest: cursor-onscreen-32x10
[207.809059] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[208.094082] [041/131] (813s left) kms_vblank (wait-idle)
[208.192246] Starting subtest: wait-idle
[208.193978] Starting dynamic subtest: pipe-A-eDP-1
[209.961876] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[209.974833] Starting dynamic subtest: pipe-D-eDP-1
[212.437084] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.473s)
[212.439209] Subtest wait-idle: SUCCESS (4.245s)
[213.286023] [042/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[213.398288] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[213.402475] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[213.547130] [043/131] (807s left) kms_flip (2x-flip-vs-dpms)
[213.649166] Starting subtest: 2x-flip-vs-dpms
[213.661343] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[213.765358] [044/131] (807s left) gem_exec_fence (syncobj-channel)
[214.194744] Starting subtest: syncobj-channel
[215.221037] Subtest syncobj-channel: SUCCESS (1.026s)
[215.983174] [045/131] (805s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[216.071060] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[216.073391] Starting dynamic subtest: pipe-A-eDP-1
[216.082524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.092938] Starting dynamic subtest: pipe-B-eDP-1
[216.102380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.113024] Starting dynamic subtest: pipe-C-eDP-1
[216.121913] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.130473] Starting dynamic subtest: pipe-D-eDP-1
[216.139308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.143647] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[218.253913] [046/131] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[218.367237] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[225.619309] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.256s)
[225.770405] [047/131] (795s left) kms_flip (busy-flip)
[225.881068] Starting subtest: busy-flip
[225.883362] Starting dynamic subtest: A-eDP1
[227.565319] Dynamic subtest A-eDP1: SUCCESS (1.686s)
[227.576509] Starting dynamic subtest: B-eDP1
[229.208930] Dynamic subtest B-eDP1: SUCCESS (1.642s)
[229.228375] Starting dynamic subtest: C-eDP1
[230.931794] Dynamic subtest C-eDP1: SUCCESS (1.720s)
[230.946018] Starting dynamic subtest: D-eDP1
[232.563673] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[232.568822] Subtest busy-flip: SUCCESS (6.691s)
[233.775265] [048/131] (787s left) prime_mmap (test_aperture_limit)
[233.833930] Starting subtest: test_aperture_limit
[233.836056] Starting dynamic subtest: test_aperture_limit-smem
[233.842732] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[233.846720] Subtest test_aperture_limit: SKIP (0.009s)
[233.973518] [049/131] (787s left) i915_pm_rpm (sysfs-read)
[236.117376] Starting subtest: sysfs-read
[237.283043] Subtest sysfs-read: SUCCESS (1.167s)
[237.685171] [050/131] (783s left) kms_big_fb (yf-tiled-addfb)
[237.795590] Starting subtest: yf-tiled-addfb
[237.800067] Subtest yf-tiled-addfb: SKIP (0.000s)
[237.915702] [051/131] (783s left) sriov_basic (enable-vfs-autoprobe-on)
[237.975586] Starting subtest: enable-vfs-autoprobe-on
[237.977814] Starting dynamic subtest: numvfs-1
[238.056420] Dynamic subtest numvfs-1: FAIL (0.031s)
[238.066196] Starting dynamic subtest: numvfs-2
[238.135948] Dynamic subtest numvfs-2: FAIL (0.010s)
[238.145093] Starting dynamic subtest: numvfs-3
[238.213641] Dynamic subtest numvfs-3: FAIL (0.009s)
[238.222068] Starting dynamic subtest: numvfs-4
[238.290321] Dynamic subtest numvfs-4: FAIL (0.009s)
[238.298666] Starting dynamic subtest: numvfs-5
[238.367106] Dynamic subtest numvfs-5: FAIL (0.009s)
[238.375127] Starting dynamic subtest: numvfs-6
[238.443809] Dynamic subtest numvfs-6: FAIL (0.009s)
[238.453507] Starting dynamic subtest: numvfs-7
[238.524170] Dynamic subtest numvfs-7: FAIL (0.009s)
[238.534217] Starting dynamic subtest: numvfs-random
[238.602983] Dynamic subtest numvfs-random: FAIL (0.009s)
[238.613429] Starting dynamic subtest: numvfs-all
[238.673144] Dynamic subtest numvfs-all: FAIL (0.009s)
[238.674833] Subtest enable-vfs-autoprobe-on: FAIL (0.125s)
[238.710016] [052/131] (782s left) gem_exec_whisper (basic-queues)
[238.774984] Starting subtest: basic-queues
[245.879597] Subtest basic-queues: SUCCESS (7.099s)
[246.084543] [053/131] (775s left) kms_flip (2x-dpms-vs-vblank-race)
[246.201119] Starting subtest: 2x-dpms-vs-vblank-race
[246.218729] Subtest 2x-dpms-vs-vblank-race: SKIP (0.018s)
[246.324995] [054/131] (775s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[246.428143] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[246.805978] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[249.542360] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.734s)
[249.552340] Starting dynamic subtest: pipe-A-eDP-1-4
[251.783756] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.240s)
[251.795068] Starting dynamic subtest: pipe-A-eDP-1-4
[253.794833] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[253.806633] Starting dynamic subtest: pipe-A-eDP-1-x
[255.983428] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[256.358869] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[259.167052] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[259.176723] Starting dynamic subtest: pipe-B-eDP-1-4
[261.353849] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[261.365612] Starting dynamic subtest: pipe-B-eDP-1-4
[263.363620] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[263.373353] Starting dynamic subtest: pipe-B-eDP-1-x
[265.553984] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[265.929024] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[268.698705] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[268.711296] Starting dynamic subtest: pipe-C-eDP-1-4
[270.873780] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[270.883088] Starting dynamic subtest: pipe-C-eDP-1-4
[272.884015] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[272.892889] Starting dynamic subtest: pipe-C-eDP-1-x
[275.062963] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[275.424692] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[278.225709] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[278.237887] Starting dynamic subtest: pipe-D-eDP-1-4
[280.401461] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[280.413083] Starting dynamic subtest: pipe-D-eDP-1-4
[282.411211] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[282.423075] Starting dynamic subtest: pipe-D-eDP-1-x
[284.589692] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[284.592623] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.161s)
[285.834509] [055/131] (735s left) gem_mmap_gtt (basic-write-read-distinct)
[285.891842] Subtest basic-write-read-distinct: SKIP (0.000s)
[285.955281] [056/131] (735s left) gem_mmap_offset (oob-read)
[286.022320] Starting subtest: oob-read
[286.024671] Subtest oob-read: SUCCESS (0.000s)
[286.143139] [057/131] (735s left) kms_atomic (atomic-plane-damage)
[286.232076] Starting subtest: atomic-plane-damage
[286.281123] Starting dynamic subtest: pipe-A-eDP-1
[286.821861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[286.824199] Subtest atomic-plane-damage: SUCCESS (0.591s)
[287.669101] [058/131] (734s left) kms_atomic_transition (plane-all-transition-nonblocking)
[287.774653] Starting subtest: plane-all-transition-nonblocking
[287.776774] Starting dynamic subtest: pipe-A-eDP-1
[290.269777] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[290.587882] Starting dynamic subtest: pipe-B-eDP-1
[293.773458] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.194s)
[294.085463] Subtest plane-all-transition-nonblocking: SUCCESS (6.310s)
[294.930562] [059/131] (727s left) gem_exec_parallel (contexts)
[294.998644] Starting subtest: contexts
[295.000905] Starting dynamic subtest: rcs0
[297.820767] Dynamic subtest rcs0: SUCCESS (2.823s)
[297.833353] Starting dynamic subtest: bcs0
[301.257038] Dynamic subtest bcs0: SUCCESS (3.434s)
[301.269220] Starting dynamic subtest: vcs0
[305.376115] Dynamic subtest vcs0: SUCCESS (4.119s)
[305.385891] Starting dynamic subtest: vcs1
[309.349481] Dynamic subtest vcs1: SUCCESS (3.970s)
[309.361202] Starting dynamic subtest: vecs0
[313.436101] Dynamic subtest vecs0: SUCCESS (4.084s)
[313.447807] Starting dynamic subtest: ccs0
[317.056661] Dynamic subtest ccs0: SUCCESS (3.617s)
[317.059034] Subtest contexts: SUCCESS (22.061s)
[317.273179] [060/131] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[317.382614] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[324.202291] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.824s)
[324.391790] [061/131] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[324.505657] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[324.510198] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.618520] [062/131] (697s left) kms_atomic_interruptible (legacy-pageflip)
[324.718666] Starting subtest: legacy-pageflip
[324.720804] Starting dynamic subtest: pipe-A-eDP-1
[332.160692] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.438s)
[332.162755] Subtest legacy-pageflip: SUCCESS (7.440s)
[333.010892] [063/131] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[333.108062] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[333.112677] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[333.249487] [064/131] (688s left) kms_psr (psr2-sprite-mmap-cpu)
[333.341296] Starting subtest: psr2-sprite-mmap-cpu
[333.343581] Starting dynamic subtest: eDP-1
[335.070823] Dynamic subtest eDP-1: SUCCESS (1.731s)
[335.073198] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.732s)
[335.982535] [065/131] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[336.082410] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[343.196081] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.116s)
[343.391706] [066/131] (678s left) gem_exec_schedule (fairslice-all)
[343.471247] Starting subtest: fairslice-all
[345.522593] Subtest fairslice-all: SUCCESS (2.058s)
[346.965586] [067/131] (675s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[351.966515] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[351.968831] Starting dynamic subtest: pipe-A-eDP-1
[352.763863] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[352.773513] Starting dynamic subtest: pipe-B-eDP-1
[353.893096] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[353.897114] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.926s)
[355.100530] [068/131] (667s left) api_intel_allocator (two-level-inception)
[355.165590] Starting subtest: two-level-inception
[360.565239] Subtest two-level-inception: SUCCESS (5.401s)
[360.727899] [069/131] (661s left) i915_suspend (debugfs-reader)
[360.801170] Starting subtest: debugfs-reader
[378.323999] Subtest debugfs-reader: SUCCESS (7.495s)
[378.533007] [070/131] (644s left) kms_flip (plain-flip-fb-recreate-interruptible)
[378.651764] Starting subtest: plain-flip-fb-recreate-interruptible
[378.654136] Starting dynamic subtest: A-eDP1
[399.401912] Dynamic subtest A-eDP1: SUCCESS (20.476s)
[399.413205] Starting dynamic subtest: B-eDP1
[408.275172] Dynamic subtest B-eDP1: SUCCESS (8.855s)
[408.287352] Starting dynamic subtest: C-eDP1
[417.119417] Dynamic subtest C-eDP1: SUCCESS (8.839s)
[417.132600] Starting dynamic subtest: D-eDP1
[425.949467] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[425.953637] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (47.007s)
[427.146016] [071/131] (595s left) gem_vm_create (invalid-destroy)
[427.221619] Starting subtest: invalid-destroy
[427.223998] Subtest invalid-destroy: SUCCESS (0.002s)
[427.369036] [072/131] (595s left) gem_ccs (ctrl-surf-copy-new-ctx)
[427.439452] Starting subtest: ctrl-surf-copy-new-ctx
[427.443760] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[427.580764] [073/131] (595s left) syncobj_basic (bad-destroy-pad)
[427.639576] Starting subtest: bad-destroy-pad
[427.641798] Subtest bad-destroy-pad: SUCCESS (0.000s)
[427.779834] [074/131] (594s left) kms_plane_multiple (2x-tiling-y)
[427.887188] Starting subtest: 2x-tiling-y
[427.891643] Subtest 2x-tiling-y: SKIP (0.000s)
[428.008586] [075/131] (594s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[428.109465] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[428.111319] Starting dynamic subtest: pipe-A-eDP-1
[428.129868] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.141415] Starting dynamic subtest: pipe-B-eDP-1
[428.157138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.166681] Starting dynamic subtest: pipe-C-eDP-1
[428.182344] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.191804] Starting dynamic subtest: pipe-D-eDP-1
[428.209970] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.213501] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[430.319458] [076/131] (592s left) kms_pm_rpm (modeset-lpsp)
[432.044517] Starting subtest: modeset-lpsp
[433.518404] Subtest modeset-lpsp: SUCCESS (1.472s)
[433.618534] [077/131] (589s left) kms_setmode (basic)
[433.688230] Starting subtest: basic
[434.009155] Starting dynamic subtest: pipe-A-eDP-1
[436.091574] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s)
[436.434572] Starting dynamic subtest: pipe-B-eDP-1
[438.520207] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[438.828096] Subtest basic: SUCCESS (5.136s)
[439.698289] [078/131] (583s left) kms_psr (fbc-psr-suspend)
[439.795351] Starting subtest: fbc-psr-suspend
[439.797692] Starting dynamic subtest: eDP-1
[439.802007] Dynamic subtest eDP-1: SKIP (0.000s)
[439.806523] Subtest fbc-psr-suspend: SKIP (0.001s)
[439.899756] [079/131] (583s left) gem_ringfill (engines-basic)
[445.936068] Starting subtest: engines-basic
[445.938772] Starting dynamic subtest: rcs0
[446.009856] Dynamic subtest rcs0: SUCCESS (0.074s)
[446.022795] Starting dynamic subtest: bcs0
[446.053299] Dynamic subtest bcs0: SUCCESS (0.042s)
[446.064289] Starting dynamic subtest: vcs0
[446.097156] Dynamic subtest vcs0: SUCCESS (0.041s)
[446.109027] Starting dynamic subtest: vcs1
[446.138390] Dynamic subtest vcs1: SUCCESS (0.040s)
[446.150619] Starting dynamic subtest: vecs0
[446.181445] Dynamic subtest vecs0: SUCCESS (0.041s)
[446.192183] Starting dynamic subtest: ccs0
[446.226074] Dynamic subtest ccs0: SUCCESS (0.043s)
[446.228438] Subtest engines-basic: SUCCESS (0.293s)
[446.328885] [080/131] (576s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[446.391654] Starting subtest: invalid-bsd2-flag-on-vebox
[446.393935] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[446.530492] [081/131] (576s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[446.626319] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[446.628235] Starting dynamic subtest: pipe-A-eDP-1
[446.648505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[446.660039] Starting dynamic subtest: pipe-B-eDP-1
[446.679925] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[446.689781] Starting dynamic subtest: pipe-C-eDP-1
[446.709257] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[446.718967] Starting dynamic subtest: pipe-D-eDP-1
[446.739946] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[446.741876] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[448.958985] [082/131] (574s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[449.066013] Starting subtest: extended-pageflip-modeset-hang-oldfb
[449.068483] Starting dynamic subtest: pipe-A
[456.955205] Dynamic subtest pipe-A: SUCCESS (7.885s)
[456.965724] Starting dynamic subtest: pipe-D
[465.569858] Dynamic subtest pipe-D: SUCCESS (8.610s)
[465.572277] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.500s)
[466.434993] [083/131] (556s left) gem_ppgtt (shrink-vs-evict-any)
[466.495005] Starting subtest: shrink-vs-evict-any
[471.881399] Subtest shrink-vs-evict-any: SUCCESS (5.382s)
[471.967520] [084/131] (551s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[472.041179] Starting subtest: etime-single-wait-for-submit-unsubmitted
[472.143393] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[472.246289] [085/131] (550s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[472.314380] Starting subtest: multi-wait-all-for-submit-signaled
[472.316780] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[472.457956] [086/131] (550s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[472.514784] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[472.614934] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[472.723571] [087/131] (550s left) gem_exec_schedule (implicit-write-read)
[472.804748] Starting subtest: implicit-write-read
[472.807049] Starting dynamic subtest: rcs0
[472.976564] Dynamic subtest rcs0: SUCCESS (0.180s)
[472.991927] Starting dynamic subtest: vcs0
[473.084560] Dynamic subtest vcs0: SUCCESS (0.107s)
[473.098306] Starting dynamic subtest: vcs1
[473.182962] Dynamic subtest vcs1: SUCCESS (0.098s)
[473.195947] Starting dynamic subtest: vecs0
[473.312074] Dynamic subtest vecs0: SUCCESS (0.128s)
[473.324882] Starting dynamic subtest: ccs0
[473.441973] Dynamic subtest ccs0: SUCCESS (0.128s)
[473.443971] Subtest implicit-write-read: SUCCESS (0.648s)
[474.029153] [088/131] (549s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[474.136687] Starting subtest: fbcpsr-rgb565-draw-blt
[481.143736] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.011s)
[481.337925] [089/131] (542s left) gem_ctx_persistence (processes)
[481.394318] Starting subtest: processes
[482.875153] Subtest processes: SUCCESS (1.481s)
[482.977804] [090/131] (540s left) kms_cursor_crc (cursor-sliding-32x10)
[483.164317] Starting subtest: cursor-sliding-32x10
[483.209496] Subtest cursor-sliding-32x10: SKIP (0.042s)
[483.508998] [091/131] (539s left) kms_psr (fbc-pr-primary-render)
[483.595963] Starting subtest: fbc-pr-primary-render
[483.600401] Subtest fbc-pr-primary-render: SKIP (0.000s)
[483.694712] [092/131] (539s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[483.756435] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[483.837963] [093/131] (539s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[483.881752] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[483.883560] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[484.013323] [094/131] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[484.107543] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[484.110922] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[484.243209] [095/131] (539s left) gem_exec_async (concurrent-writes)
[484.311998] Starting subtest: concurrent-writes
[484.313592] Starting dynamic subtest: rcs0
[484.324818] Dynamic subtest rcs0: SUCCESS (0.015s)
[484.336716] Starting dynamic subtest: bcs0
[484.338476] Dynamic subtest bcs0: SUCCESS (0.006s)
[484.348613] Starting dynamic subtest: vcs0
[484.350377] Dynamic subtest vcs0: SUCCESS (0.004s)
[484.360909] Starting dynamic subtest: vcs1
[484.362596] Dynamic subtest vcs1: SUCCESS (0.005s)
[484.372334] Starting dynamic subtest: vecs0
[484.374045] Dynamic subtest vecs0: SUCCESS (0.005s)
[484.383715] Starting dynamic subtest: ccs0
[484.385467] Dynamic subtest ccs0: SUCCESS (0.004s)
[484.387155] Subtest concurrent-writes: SUCCESS (0.044s)
[484.630997] [096/131] (539s left) gem_mmap_gtt (basic-small-bo-tiledx)
[484.692233] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[484.755583] [097/131] (539s left) dmabuf_sync_file (import-basic)
[484.800262] Starting subtest: import-basic
[484.801962] Subtest import-basic: SUCCESS (0.001s)
[484.881915] [098/131] (538s left) kms_feature_discovery (display)
[484.978868] Starting subtest: display
[484.980663] Subtest display: SUCCESS (0.000s)
[485.075940] [099/131] (538s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[485.177890] Starting subtest: x-tiled-64bpp-rotate-90
[485.198656] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[485.361797] [100/131] (538s left) perf_pmu (busy-no-semaphores)
[485.408708] Starting subtest: busy-no-semaphores
[485.410269] Starting dynamic subtest: rcs0
[485.986885] Dynamic subtest rcs0: SUCCESS (0.577s)
[486.000760] Starting dynamic subtest: bcs0
[486.537907] Dynamic subtest bcs0: SUCCESS (0.548s)
[486.551630] Starting dynamic subtest: vcs0
[487.087900] Dynamic subtest vcs0: SUCCESS (0.547s)
[487.101627] Starting dynamic subtest: vcs1
[488.431481] Dynamic subtest vcs1: SUCCESS (1.342s)
[488.445357] Starting dynamic subtest: vecs0
[490.417366] Dynamic subtest vecs0: SUCCESS (1.983s)
[490.431311] Starting dynamic subtest: ccs0
[492.463925] Dynamic subtest ccs0: SUCCESS (2.044s)
[492.466663] Subtest busy-no-semaphores: SUCCESS (7.058s)
[492.606998] [101/131] (531s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[492.724606] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[492.728504] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[492.864724] [102/131] (531s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[492.978941] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[492.983566] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[493.146601] [103/131] (530s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[493.541638] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[494.335248] [104/131] (529s left) kms_getfb (getfb-reject-nv12)
[494.436999] Starting subtest: getfb-reject-nv12
[494.439215] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[494.574414] [105/131] (529s left) i915_drm_fdinfo (context-close-stress)
[494.616992] Starting subtest: context-close-stress
[505.362298] Subtest context-close-stress: SUCCESS (10.745s)
[505.462266] [106/131] (518s left) perf_pmu (module-unload)
[505.772022] Starting subtest: module-unload
[514.237875] Subtest module-unload: FAIL (8.357s)
[514.271933] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[514.272645] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[514.275679] [107/131] (509s left) kms_chamelium_edid (dp-edid-read)
[516.087983] Subtest dp-edid-read: SKIP (0.000s)
[516.917939] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[516.919299] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[516.922855] [108/131] (507s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[522.056241] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[522.058624] Starting dynamic subtest: pipe-A-eDP-1
[522.811455] Dynamic subtest pipe-A-eDP-1: SKIP (0.751s)
[522.821508] Starting dynamic subtest: pipe-B-eDP-1
[523.936502] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[523.940772] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.879s)
[525.148600] [109/131] (499s left) kms_vblank (query-busy)
[525.256027] Starting subtest: query-busy
[525.258166] Starting dynamic subtest: pipe-A-eDP-1
[527.131308] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[527.147251] Starting dynamic subtest: pipe-D-eDP-1
[529.675876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[529.678094] Subtest query-busy: SUCCESS (4.419s)
[530.495939] [110/131] (493s left) syncobj_timeline (wait-for-submit-complex)
[530.559115] Starting subtest: wait-for-submit-complex
[530.619467] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[530.740092] [111/131] (493s left) perf (invalid-create-userspace-config)
[530.883755] Starting subtest: invalid-create-userspace-config
[530.885948] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[530.922737] [112/131] (493s left) gem_exec_basic (basic)
[530.991045] Starting subtest: basic
[530.993371] Starting dynamic subtest: rcs0-smem
[530.995687] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[531.006283] Starting dynamic subtest: bcs0-smem
[531.008119] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[531.016713] Starting dynamic subtest: vcs0-smem
[531.018520] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[531.027044] Starting dynamic subtest: vcs1-smem
[531.028879] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[531.037535] Starting dynamic subtest: vecs0-smem
[531.039461] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[531.049034] Starting dynamic subtest: ccs0-smem
[531.050889] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[531.052712] Subtest basic: SUCCESS (0.014s)
[532.974353] [113/131] (491s left) kms_chamelium_color (ctm-0-25)
[533.070155] Subtest ctm-0-25: SKIP (0.000s)
[533.116150] [114/131] (491s left) gem_userptr_blits (process-exit-busy)
[533.182842] Starting subtest: process-exit-busy
[533.193497] Subtest process-exit-busy: SUCCESS (0.013s)
[533.359087] [115/131] (491s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[533.411770] Starting subtest: y-tiled-ccs-to-y-tiled
[533.416393] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[533.620713] [116/131] (490s left) gen7_exec_parse (bitmasks)
[533.678656] Subtest bitmasks: SKIP (0.000s)
[533.750473] [117/131] (490s left) gem_eio (wait-wedge-10ms)
[533.929906] Starting subtest: wait-wedge-10ms
[534.934725] Subtest wait-wedge-10ms: SUCCESS (1.004s)
[535.119964] [118/131] (489s left) kms_content_protection (atomic)
[535.280011] Starting subtest: atomic
[535.284234] Subtest atomic: SKIP (0.000s)
[535.438988] [119/131] (489s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[535.533242] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[535.535447] Starting dynamic subtest: pipe-A-default-mode
[535.822809] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[535.827363] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.288s)
[536.645460] [120/131] (488s left) gem_exec_params (invalid-flag)
[536.713239] Starting subtest: invalid-flag
[536.715633] Subtest invalid-flag: SUCCESS (0.000s)
[536.853847] [121/131] (487s left) kms_getfb (getfb-addfb-different-handles)
[536.950388] Starting subtest: getfb-addfb-different-handles
[536.952758] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[537.086274] [122/131] (487s left) gem_exec_flush (basic-uc-ro-default)
[537.145763] Starting subtest: basic-uc-ro-default
[542.612132] Subtest basic-uc-ro-default: SUCCESS (5.465s)
[542.825846] [123/131] (482s left) gem_sync (basic-each)
[542.906091] Starting subtest: basic-each
[545.476545] Subtest basic-each: SUCCESS (2.581s)
[545.694078] [124/131] (479s left) gem_exec_balancer (full)
[545.760381] Starting subtest: full
[550.845086] Subtest full: SUCCESS (5.083s)
[551.219611] [125/131] (473s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[551.331640] Starting subtest: y-tiled-8bpp-rotate-180
[551.336173] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[551.452761] [126/131] (473s left) sw_sync (sync_merge_invalid)
[551.487668] Starting subtest: sync_merge_invalid
[551.508958] Subtest sync_merge_invalid: SUCCESS (0.022s)
[551.591581] [127/131] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[551.698756] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[556.207488] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.512s)
[557.364611] [128/131] (467s left) gem_lmem_swapping (parallel-random-verify-ccs)
[557.406044] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[557.448018] [129/131] (467s left) kms_lease (lease-unleased-connector)
[557.551943] Starting subtest: lease-unleased-connector
[557.554108] Starting dynamic subtest: pipe-A-eDP-1
[557.559017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[557.569296] Starting dynamic subtest: pipe-B-eDP-1
[557.571395] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[557.581610] Starting dynamic subtest: pipe-C-eDP-1
[557.583690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[557.593566] Starting dynamic subtest: pipe-D-eDP-1
[557.595679] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[557.597775] Subtest lease-unleased-connector: SUCCESS (0.039s)
[557.725601] [130/131] (467s left) perf (enable-disable)
[557.835935] Starting subtest: enable-disable
[557.838258] Starting dynamic subtest: 0-rcs0
[560.098501] Dynamic subtest 0-rcs0: SUCCESS (2.260s)
[560.109417] Starting dynamic subtest: 1-vcs0
[564.576815] Dynamic subtest 1-vcs0: SUCCESS (4.477s)
[564.579477] Subtest enable-disable: SUCCESS (6.739s)
[564.626566] [131/131] (460s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[564.762925] Starting subtest: cursor-rapid-movement-32x32
[564.811288] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[565.132470] 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.