[57.662146] Initializing watchdogs
[57.662191]   /dev/watchdog0
[57.676872] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.681132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.683308] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.686703] [001/131] (960s left) fbdev (unaligned-read)
[57.747741] Starting subtest: unaligned-read
[57.760512] Subtest unaligned-read: SUCCESS (0.015s)
[57.837467] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[57.901945] Starting subtest: dirty-switch
[57.904366] Starting dynamic subtest: rcs0
[58.141220] Dynamic subtest rcs0: SUCCESS (0.240s)
[58.148701] Starting dynamic subtest: bcs0
[58.432619] Dynamic subtest bcs0: SUCCESS (0.292s)
[58.439955] Starting dynamic subtest: vcs0
[58.687276] Dynamic subtest vcs0: SUCCESS (0.256s)
[58.693964] Starting dynamic subtest: vcs1
[60.159080] Dynamic subtest vcs1: SUCCESS (1.475s)
[60.166285] Starting dynamic subtest: vecs0
[62.130745] Dynamic subtest vecs0: SUCCESS (1.975s)
[62.138050] Starting dynamic subtest: ccs0
[64.122090] Dynamic subtest ccs0: SUCCESS (1.995s)
[64.124553] Subtest dirty-switch: SUCCESS (6.235s)
[64.380855] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.491814] Starting subtest: psr-modesetfrombusy
[70.628050] Subtest psr-modesetfrombusy: SUCCESS (6.147s)
[70.798887] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.902402] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.904497] Starting dynamic subtest: pipe-A-default-mode
[73.638642] Dynamic subtest pipe-A-default-mode: SUCCESS (2.735s)
[73.641027] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.736s)
[74.527109] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[74.591512] Starting subtest: sol-reset-invalid
[74.593927] Subtest sol-reset-invalid: SUCCESS (0.003s)
[76.049052] [006/131] (942s left) gem_spin_batch (resubmit-new)
[76.109404] Starting subtest: resubmit-new
[76.111874] Starting dynamic subtest: rcs0
[76.117319] Dynamic subtest rcs0: SUCCESS (0.008s)
[76.126400] Starting dynamic subtest: bcs0
[76.128328] Dynamic subtest bcs0: SUCCESS (0.007s)
[76.135754] Starting dynamic subtest: vcs0
[76.138068] Dynamic subtest vcs0: SUCCESS (0.006s)
[76.145336] Starting dynamic subtest: vcs1
[76.147804] Dynamic subtest vcs1: SUCCESS (0.006s)
[76.155319] Starting dynamic subtest: vecs0
[76.157428] Dynamic subtest vecs0: SUCCESS (0.004s)
[76.164557] Starting dynamic subtest: ccs0
[76.166720] Dynamic subtest ccs0: SUCCESS (0.004s)
[76.168920] Subtest resubmit-new: SUCCESS (0.038s)
[77.970138] [007/131] (940s left) gem_exec_schedule (preempt-user)
[78.045849] Starting subtest: preempt-user
[78.048121] Starting dynamic subtest: rcs0
[78.079528] Dynamic subtest rcs0: SUCCESS (0.038s)
[78.089762] Starting dynamic subtest: bcs0
[78.109865] Dynamic subtest bcs0: SUCCESS (0.030s)
[78.117610] Starting dynamic subtest: vcs0
[78.132992] Dynamic subtest vcs0: SUCCESS (0.023s)
[78.140376] Starting dynamic subtest: vcs1
[78.157439] Dynamic subtest vcs1: SUCCESS (0.024s)
[78.164871] Starting dynamic subtest: vecs0
[78.179969] Dynamic subtest vecs0: SUCCESS (0.022s)
[78.187313] Starting dynamic subtest: ccs0
[78.210471] Dynamic subtest ccs0: SUCCESS (0.030s)
[78.213164] Subtest preempt-user: SUCCESS (0.169s)
[80.023976] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[80.086729] Starting subtest: nopreempt
[80.089047] Starting dynamic subtest: vecs0
[89.955235] Dynamic subtest vecs0: SUCCESS (9.867s)
[89.966310] Starting dynamic subtest: ccs0
[94.080855] Dynamic subtest ccs0: SUCCESS (4.124s)
[94.091695] Starting dynamic subtest: vcs0
[103.904126] Dynamic subtest vcs0: SUCCESS (9.822s)
[103.915443] Starting dynamic subtest: bcs0
[107.889503] Dynamic subtest bcs0: SUCCESS (3.983s)
[107.900011] Starting dynamic subtest: rcs0
[111.901612] Dynamic subtest rcs0: SUCCESS (4.011s)
[111.912056] Starting dynamic subtest: vcs1
[121.905039] Dynamic subtest vcs1: SUCCESS (10.001s)
[121.907500] Subtest nopreempt: SUCCESS (41.815s)
[121.998710] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[122.112065] Starting subtest: zero-hdisplay
[122.114239] Starting dynamic subtest: pipe-A-eDP-1
[122.404170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[122.413264] Starting dynamic subtest: pipe-B-eDP-1
[122.415097] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[122.422204] Starting dynamic subtest: pipe-C-eDP-1
[122.424058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[122.431510] Starting dynamic subtest: pipe-D-eDP-1
[122.433690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.435902] Subtest zero-hdisplay: SUCCESS (0.300s)
[123.256424] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[123.358148] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[123.362376] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[123.496986] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[123.605096] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[124.484661] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.881s)
[124.699619] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[124.793046] Starting subtest: getfb-handle-zero
[124.795348] Subtest getfb-handle-zero: SUCCESS (0.000s)
[124.927241] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[124.998018] Starting subtest: yf-tiled-ccs-to-yf-tiled
[125.002428] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[125.200860] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[125.294742] Starting subtest: multiplane-rotation-cropping-bottom
[132.676296] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.383s)
[132.835295] [015/131] (885s left) gem_eio (wait-1us)
[133.066373] Starting subtest: wait-1us
[133.405277] Subtest wait-1us: SUCCESS (0.341s)
[133.581331] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[133.650484] Starting subtest: multi-wait-for-submit-signaled
[133.652510] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[133.786856] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[133.872219] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[133.874125] Starting dynamic subtest: pipe-A-default-mode
[134.162845] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[134.167367] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s)
[134.993391] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[135.080072] Starting subtest: alpha-7efc
[135.363319] Starting dynamic subtest: pipe-A-eDP-1
[135.965510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[135.996256] Starting dynamic subtest: pipe-D-eDP-1
[137.301254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[137.303609] Subtest alpha-7efc: SUCCESS (2.221s)
[138.141708] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[138.247542] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[138.252074] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[138.394942] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[138.490227] Starting subtest: fbc-psr2-primary-mmap-cpu
[138.492432] Starting dynamic subtest: eDP-1
[138.496456] Dynamic subtest eDP-1: SKIP (0.000s)
[138.500282] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[138.581995] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[138.683134] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[138.692711] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[138.829356] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[138.917055] Starting subtest: basic-normal-all
[142.937934] Subtest basic-normal-all: SUCCESS (4.016s)
[143.146187] [023/131] (875s left) kms_big_fb (linear-16bpp-rotate-180)
[143.255080] Starting subtest: linear-16bpp-rotate-180
[144.688809] Subtest linear-16bpp-rotate-180: SUCCESS (1.434s)
[144.829892] [024/131] (874s left) kms_frontbuffer_tracking (psr-slowdraw)
[144.933191] Starting subtest: psr-slowdraw
[170.164982] Subtest psr-slowdraw: SUCCESS (25.230s)
[170.322327] [025/131] (848s left) vgem_basic (dmabuf-fence)
[170.418802] Starting subtest: dmabuf-fence
[170.421052] Subtest dmabuf-fence: SUCCESS (0.001s)
[170.496274] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[170.499651] [026/131] (848s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[170.555297] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[170.557508] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[170.684133] [027/131] (848s left) kms_psr (pr-primary-render)
[170.779772] Starting subtest: pr-primary-render
[170.784172] Subtest pr-primary-render: SKIP (0.000s)
[170.875822] [028/131] (848s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[170.961100] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[170.962843] Starting dynamic subtest: pipe-A-eDP-1
[170.981610] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.992473] Starting dynamic subtest: pipe-B-eDP-1
[171.009440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.017138] Starting dynamic subtest: pipe-C-eDP-1
[171.034039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.041841] Starting dynamic subtest: pipe-D-eDP-1
[171.059593] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.063089] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[173.144325] [029/131] (846s left) core_auth (getclient-master-drop)
[173.186140] Starting subtest: getclient-master-drop
[173.209357] Subtest getclient-master-drop: SUCCESS (0.022s)
[173.358435] [030/131] (845s left) kms_plane_scaling (planes-downscale-factor-0-5)
[173.455230] Starting subtest: planes-downscale-factor-0-5
[173.457526] Starting dynamic subtest: pipe-A
[173.479128] Dynamic subtest pipe-A: SKIP (0.017s)
[173.489305] Starting dynamic subtest: pipe-B
[173.525312] Dynamic subtest pipe-B: SKIP (0.046s)
[173.533676] Starting dynamic subtest: pipe-C
[173.562395] Dynamic subtest pipe-C: SKIP (0.038s)
[173.572675] Starting dynamic subtest: pipe-D
[173.596742] Dynamic subtest pipe-D: SKIP (0.032s)
[173.600479] Subtest planes-downscale-factor-0-5: SKIP (0.135s)
[173.735241] [031/131] (845s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[173.838806] Starting subtest: fb-8bpc-vs-panel-8bpc
[173.841094] Starting dynamic subtest: pipe-A-eDP-1
[175.213515] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[175.215735] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.374s)
[176.100698] [032/131] (843s left) gem_partial_pwrite_pread (reads-snoop)
[176.170634] Subtest reads-snoop: SKIP (0.000s)
[176.259403] [033/131] (843s left) gem_eio (in-flight-contexts-immediate)
[176.503688] Starting subtest: in-flight-contexts-immediate
[187.938506] Subtest in-flight-contexts-immediate: SUCCESS (11.435s)
[188.141644] [034/131] (831s left) gen3_render_mixed_blits
[188.274129] [035/131] (831s left) kms_pm_rpm (pm-tiling)
[190.009681] Starting subtest: pm-tiling
[190.014771] Subtest pm-tiling: SKIP (0.000s)
[190.527746] [036/131] (829s left) i915_module_load (reload-no-display)
[190.569576] Starting subtest: reload-no-display
[195.116064] Subtest reload-no-display: SUCCESS (4.546s)
[195.145524] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[195.146227] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[195.149348] [037/131] (824s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[196.783360] Starting subtest: plane-upscale-20x20-with-rotation
[196.785750] Starting dynamic subtest: pipe-A
[197.022565] Dynamic subtest pipe-A: SUCCESS (0.241s)
[197.034747] Starting dynamic subtest: pipe-B
[198.271442] Dynamic subtest pipe-B: SUCCESS (1.246s)
[198.284274] Starting dynamic subtest: pipe-C
[199.592349] Dynamic subtest pipe-C: SUCCESS (1.319s)
[199.601118] Starting dynamic subtest: pipe-D
[200.927782] Dynamic subtest pipe-D: SUCCESS (1.335s)
[200.930278] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.148s)
[202.081156] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[202.082397] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[202.086062] [038/131] (817s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[202.201700] Starting subtest: 4-tiled-8bpp-rotate-180
[203.420480] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.218s)
[203.609241] [039/131] (816s left) kms_rotation_crc (primary-rotation-90)
[203.714331] Starting subtest: primary-rotation-90
[203.718013] Subtest primary-rotation-90: SKIP (0.001s)
[203.822565] [040/131] (815s left) kms_cursor_crc (cursor-onscreen-32x10)
[203.977997] Starting subtest: cursor-onscreen-32x10
[204.023805] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[204.319611] [041/131] (815s left) kms_vblank (wait-idle)
[204.426048] Starting subtest: wait-idle
[204.427853] Starting dynamic subtest: pipe-A-eDP-1
[206.178951] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[206.193173] Starting dynamic subtest: pipe-D-eDP-1
[208.643266] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s)
[208.645522] Subtest wait-idle: SUCCESS (4.218s)
[209.494330] [042/131] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[209.598609] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[209.602643] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[209.735148] [043/131] (810s left) kms_flip (2x-flip-vs-dpms)
[209.835033] Starting subtest: 2x-flip-vs-dpms
[209.846694] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[209.953975] [044/131] (809s left) gem_exec_fence (syncobj-channel)
[210.383603] Starting subtest: syncobj-channel
[211.401534] Subtest syncobj-channel: SUCCESS (1.015s)
[212.030706] [045/131] (807s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[212.139532] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[212.141788] Starting dynamic subtest: pipe-A-eDP-1
[212.150440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.159181] Starting dynamic subtest: pipe-B-eDP-1
[212.167843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.176683] Starting dynamic subtest: pipe-C-eDP-1
[212.184879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.193036] Starting dynamic subtest: pipe-D-eDP-1
[212.201271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.205396] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[214.376643] [046/131] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[214.479895] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[221.818702] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.341s)
[222.006533] [047/131] (798s left) kms_flip (busy-flip)
[222.101242] Starting subtest: busy-flip
[222.103449] Starting dynamic subtest: A-eDP1
[223.800927] Dynamic subtest A-eDP1: SUCCESS (1.700s)
[223.811583] Starting dynamic subtest: B-eDP1
[225.525777] Dynamic subtest B-eDP1: SUCCESS (1.723s)
[225.539940] Starting dynamic subtest: C-eDP1
[227.250954] Dynamic subtest C-eDP1: SUCCESS (1.722s)
[227.259574] Starting dynamic subtest: D-eDP1
[228.880659] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[228.883354] Subtest busy-flip: SUCCESS (6.785s)
[230.155202] [048/131] (789s left) prime_mmap (test_aperture_limit)
[230.202207] Starting subtest: test_aperture_limit
[230.204119] Starting dynamic subtest: test_aperture_limit-smem
[230.210653] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[230.214925] Subtest test_aperture_limit: SKIP (0.009s)
[230.321509] [049/131] (789s left) i915_pm_rpm (sysfs-read)
[232.041059] Starting subtest: sysfs-read
[233.204580] Subtest sysfs-read: SUCCESS (1.161s)
[233.596554] [050/131] (786s left) kms_big_fb (yf-tiled-addfb)
[233.700325] Starting subtest: yf-tiled-addfb
[233.704436] Subtest yf-tiled-addfb: SKIP (0.000s)
[233.820466] [051/131] (786s left) sriov_basic (enable-vfs-autoprobe-on)
[233.873969] Starting subtest: enable-vfs-autoprobe-on
[233.876236] Starting dynamic subtest: numvfs-1
[233.957870] Dynamic subtest numvfs-1: FAIL (0.034s)
[233.969871] Starting dynamic subtest: numvfs-2
[234.043523] Dynamic subtest numvfs-2: FAIL (0.004s)
[234.053623] Starting dynamic subtest: numvfs-3
[234.125435] Dynamic subtest numvfs-3: FAIL (0.004s)
[234.135110] Starting dynamic subtest: numvfs-4
[234.206687] Dynamic subtest numvfs-4: FAIL (0.004s)
[234.216100] Starting dynamic subtest: numvfs-5
[234.287140] Dynamic subtest numvfs-5: FAIL (0.003s)
[234.296423] Starting dynamic subtest: numvfs-6
[234.366451] Dynamic subtest numvfs-6: FAIL (0.007s)
[234.375954] Starting dynamic subtest: numvfs-7
[234.448871] Dynamic subtest numvfs-7: FAIL (0.003s)
[234.458363] Starting dynamic subtest: numvfs-random
[234.525290] Dynamic subtest numvfs-random: FAIL (0.004s)
[234.533947] Starting dynamic subtest: numvfs-all
[234.589876] Dynamic subtest numvfs-all: FAIL (0.004s)
[234.591616] Subtest enable-vfs-autoprobe-on: FAIL (0.073s)
[234.626669] [052/131] (785s left) gem_exec_whisper (basic-queues)
[234.689052] Starting subtest: basic-queues
[240.280184] Subtest basic-queues: SUCCESS (5.589s)
[240.490803] [053/131] (779s left) kms_flip (2x-dpms-vs-vblank-race)
[240.610331] Starting subtest: 2x-dpms-vs-vblank-race
[240.621532] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[240.772828] [054/131] (779s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[240.872442] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[241.246254] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.048146] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[244.058133] Starting dynamic subtest: pipe-A-eDP-1-4
[246.222483] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[246.234213] Starting dynamic subtest: pipe-A-eDP-1-4
[248.232899] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.243722] Starting dynamic subtest: pipe-A-eDP-1-x
[250.411791] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[250.777934] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[253.574388] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[253.586091] Starting dynamic subtest: pipe-B-eDP-1-4
[255.760398] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[255.771833] Starting dynamic subtest: pipe-B-eDP-1-4
[257.771887] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[257.782910] Starting dynamic subtest: pipe-B-eDP-1-x
[259.960303] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[260.324996] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.104915] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[263.116703] Starting dynamic subtest: pipe-C-eDP-1-4
[265.291374] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[265.302826] Starting dynamic subtest: pipe-C-eDP-1-4
[267.301906] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[267.313714] Starting dynamic subtest: pipe-C-eDP-1-x
[269.480058] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[269.840324] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[272.637069] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[272.648682] Starting dynamic subtest: pipe-D-eDP-1-4
[274.811815] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[274.820911] Starting dynamic subtest: pipe-D-eDP-1-4
[276.822597] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[276.833640] Starting dynamic subtest: pipe-D-eDP-1-x
[279.012097] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[279.014505] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.139s)
[280.246860] [055/131] (740s left) gem_mmap_gtt (basic-write-read-distinct)
[280.309687] Subtest basic-write-read-distinct: SKIP (0.000s)
[280.386330] [056/131] (740s left) gem_mmap_offset (oob-read)
[280.458826] Starting subtest: oob-read
[280.461027] Subtest oob-read: SUCCESS (0.000s)
[280.591218] [057/131] (739s left) kms_atomic (atomic-plane-damage)
[280.690518] Starting subtest: atomic-plane-damage
[280.736810] Starting dynamic subtest: pipe-A-eDP-1
[281.313319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[281.315642] Subtest atomic-plane-damage: SUCCESS (0.623s)
[282.174148] [058/131] (738s left) kms_atomic_transition (plane-all-transition-nonblocking)
[282.267145] Starting subtest: plane-all-transition-nonblocking
[282.269393] Starting dynamic subtest: pipe-A-eDP-1
[284.761768] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[285.071777] Starting dynamic subtest: pipe-B-eDP-1
[288.280849] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.223s)
[288.578081] Subtest plane-all-transition-nonblocking: SUCCESS (6.310s)
[289.423149] [059/131] (731s left) gem_exec_parallel (contexts)
[289.492900] Starting subtest: contexts
[289.495366] Starting dynamic subtest: rcs0
[292.683283] Dynamic subtest rcs0: SUCCESS (3.188s)
[292.695199] Starting dynamic subtest: bcs0
[296.258336] Dynamic subtest bcs0: SUCCESS (3.574s)
[296.270967] Starting dynamic subtest: vcs0
[300.402605] Dynamic subtest vcs0: SUCCESS (4.140s)
[300.414466] Starting dynamic subtest: vcs1
[304.406723] Dynamic subtest vcs1: SUCCESS (4.001s)
[304.419033] Starting dynamic subtest: vecs0
[308.379027] Dynamic subtest vecs0: SUCCESS (3.969s)
[308.388677] Starting dynamic subtest: ccs0
[312.136276] Dynamic subtest ccs0: SUCCESS (3.754s)
[312.139041] Subtest contexts: SUCCESS (22.642s)
[312.350684] [060/131] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[312.452532] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[319.193241] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.743s)
[319.378740] [061/131] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[319.480310] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[319.484251] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.619102] [062/131] (701s left) kms_atomic_interruptible (legacy-pageflip)
[319.728120] Starting subtest: legacy-pageflip
[319.730390] Starting dynamic subtest: pipe-A-eDP-1
[327.165290] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[327.167670] Subtest legacy-pageflip: SUCCESS (7.438s)
[328.018871] [063/131] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[328.130568] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[328.134670] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[328.267896] [064/131] (692s left) kms_psr (psr2-sprite-mmap-cpu)
[328.362873] Starting subtest: psr2-sprite-mmap-cpu
[328.365127] Starting dynamic subtest: eDP-1
[330.072153] Dynamic subtest eDP-1: SUCCESS (1.708s)
[330.074418] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.709s)
[330.968214] [065/131] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[331.072825] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[338.205435] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.134s)
[338.400493] [066/131] (682s left) gem_exec_schedule (fairslice-all)
[338.487736] Starting subtest: fairslice-all
[340.541340] Subtest fairslice-all: SUCCESS (2.055s)
[341.968410] [067/131] (678s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[346.961482] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[346.963762] Starting dynamic subtest: pipe-A-eDP-1
[347.746386] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[347.756705] Starting dynamic subtest: pipe-B-eDP-1
[348.878467] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[348.882802] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.914s)
[350.092358] [068/131] (670s left) api_intel_allocator (two-level-inception)
[350.155630] Starting subtest: two-level-inception
[355.553818] Subtest two-level-inception: SUCCESS (5.398s)
[355.709086] [069/131] (665s left) i915_suspend (debugfs-reader)
[355.762996] Starting subtest: debugfs-reader
[374.751383] Subtest debugfs-reader: SUCCESS (8.564s)
[379.941363] [070/131] (646s left) kms_flip (plain-flip-fb-recreate-interruptible)
[380.051600] Starting subtest: plain-flip-fb-recreate-interruptible
[380.053985] Starting dynamic subtest: A-eDP1
[400.611133] Dynamic subtest A-eDP1: SUCCESS (20.691s)
[400.628622] Starting dynamic subtest: B-eDP1
[409.430845] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[409.441911] Starting dynamic subtest: C-eDP1
[418.239885] Dynamic subtest C-eDP1: SUCCESS (8.806s)
[418.250451] Starting dynamic subtest: D-eDP1
[427.070410] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[427.074924] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (47.166s)
[428.269636] [071/131] (597s left) gem_vm_create (invalid-destroy)
[428.335843] Starting subtest: invalid-destroy
[428.338119] Subtest invalid-destroy: SUCCESS (0.002s)
[428.479121] [072/131] (597s left) gem_ccs (ctrl-surf-copy-new-ctx)
[428.528444] Starting subtest: ctrl-surf-copy-new-ctx
[428.532909] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[428.649451] [073/131] (597s left) syncobj_basic (bad-destroy-pad)
[428.711600] Starting subtest: bad-destroy-pad
[428.713865] Subtest bad-destroy-pad: SUCCESS (0.000s)
[428.836448] [074/131] (597s left) kms_plane_multiple (2x-tiling-y)
[428.930775] Starting subtest: 2x-tiling-y
[428.934938] Subtest 2x-tiling-y: SKIP (0.000s)
[429.031548] [075/131] (597s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[429.127228] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[429.129479] Starting dynamic subtest: pipe-A-eDP-1
[429.151847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.163979] Starting dynamic subtest: pipe-B-eDP-1
[429.181882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.190962] Starting dynamic subtest: pipe-C-eDP-1
[429.208672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.217576] Starting dynamic subtest: pipe-D-eDP-1
[429.235283] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.238814] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[431.431350] [076/131] (595s left) kms_pm_rpm (modeset-lpsp)
[433.563606] Starting subtest: modeset-lpsp
[435.022011] Subtest modeset-lpsp: SUCCESS (1.460s)
[435.125589] [077/131] (591s left) kms_setmode (basic)
[435.185817] Starting subtest: basic
[435.508596] Starting dynamic subtest: pipe-A-eDP-1
[437.584222] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s)
[437.935242] Starting dynamic subtest: pipe-B-eDP-1
[440.015973] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.086s)
[440.336486] Subtest basic: SUCCESS (5.150s)
[441.195600] [078/131] (585s left) kms_psr (fbc-psr-suspend)
[441.294242] Starting subtest: fbc-psr-suspend
[441.296496] Starting dynamic subtest: eDP-1
[441.300929] Dynamic subtest eDP-1: SKIP (0.000s)
[441.305325] Subtest fbc-psr-suspend: SKIP (0.001s)
[441.394045] [079/131] (585s left) gem_ringfill (engines-basic)
[447.315057] Starting subtest: engines-basic
[447.317626] Starting dynamic subtest: rcs0
[447.386361] Dynamic subtest rcs0: SUCCESS (0.072s)
[447.399377] Starting dynamic subtest: bcs0
[447.432165] Dynamic subtest bcs0: SUCCESS (0.044s)
[447.443400] Starting dynamic subtest: vcs0
[447.474207] Dynamic subtest vcs0: SUCCESS (0.041s)
[447.485245] Starting dynamic subtest: vcs1
[447.517581] Dynamic subtest vcs1: SUCCESS (0.041s)
[447.530456] Starting dynamic subtest: vecs0
[447.560160] Dynamic subtest vecs0: SUCCESS (0.041s)
[447.571088] Starting dynamic subtest: ccs0
[447.605958] Dynamic subtest ccs0: SUCCESS (0.044s)
[447.608344] Subtest engines-basic: SUCCESS (0.294s)
[447.714787] [080/131] (578s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[447.770758] Starting subtest: invalid-bsd2-flag-on-vebox
[447.773150] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[447.922361] [081/131] (578s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[448.012069] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[448.014413] Starting dynamic subtest: pipe-A-eDP-1
[448.034548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[448.046764] Starting dynamic subtest: pipe-B-eDP-1
[448.066940] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[448.077622] Starting dynamic subtest: pipe-C-eDP-1
[448.097640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[448.107824] Starting dynamic subtest: pipe-D-eDP-1
[448.127799] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[448.129670] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[450.363466] [082/131] (576s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[450.458715] Starting subtest: extended-pageflip-modeset-hang-oldfb
[450.460916] Starting dynamic subtest: pipe-A
[458.361578] Dynamic subtest pipe-A: SUCCESS (7.904s)
[458.372061] Starting dynamic subtest: pipe-D
[466.953937] Dynamic subtest pipe-D: SUCCESS (8.593s)
[466.956214] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.502s)
[467.832713] [083/131] (558s left) gem_ppgtt (shrink-vs-evict-any)
[467.895781] Starting subtest: shrink-vs-evict-any
[473.386245] Subtest shrink-vs-evict-any: SUCCESS (5.491s)
[473.494378] [084/131] (553s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[473.552295] Starting subtest: etime-single-wait-for-submit-unsubmitted
[473.659440] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[473.770441] [085/131] (553s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[473.836432] Starting subtest: multi-wait-all-for-submit-signaled
[473.839104] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[473.977707] [086/131] (552s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[474.032733] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[474.139662] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[474.246380] [087/131] (552s left) gem_exec_schedule (implicit-write-read)
[474.326194] Starting subtest: implicit-write-read
[474.328387] Starting dynamic subtest: rcs0
[474.508626] Dynamic subtest rcs0: SUCCESS (0.189s)
[474.521496] Starting dynamic subtest: vcs0
[474.619793] Dynamic subtest vcs0: SUCCESS (0.111s)
[474.633256] Starting dynamic subtest: vcs1
[474.737417] Dynamic subtest vcs1: SUCCESS (0.116s)
[474.750833] Starting dynamic subtest: vecs0
[474.853550] Dynamic subtest vecs0: SUCCESS (0.114s)
[474.866446] Starting dynamic subtest: ccs0
[474.983390] Dynamic subtest ccs0: SUCCESS (0.129s)
[474.985934] Subtest implicit-write-read: SUCCESS (0.665s)
[476.439007] [088/131] (550s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[476.538705] Starting subtest: fbcpsr-rgb565-draw-blt
[483.610529] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.070s)
[483.796826] [089/131] (543s left) gem_ctx_persistence (processes)
[483.866095] Starting subtest: processes
[485.339729] Subtest processes: SUCCESS (1.475s)
[485.440582] [090/131] (541s left) kms_cursor_crc (cursor-sliding-32x10)
[485.600796] Starting subtest: cursor-sliding-32x10
[485.652281] Subtest cursor-sliding-32x10: SKIP (0.045s)
[485.973099] [091/131] (541s left) kms_psr (fbc-pr-primary-render)
[486.063422] Starting subtest: fbc-pr-primary-render
[486.067925] Subtest fbc-pr-primary-render: SKIP (0.000s)
[486.162093] [092/131] (541s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[486.227232] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[486.314467] [093/131] (540s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[486.367731] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[486.369750] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[486.507930] [094/131] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[486.611162] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[486.614684] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.751123] [095/131] (540s left) gem_exec_async (concurrent-writes)
[486.817934] Starting subtest: concurrent-writes
[486.819610] Starting dynamic subtest: rcs0
[486.830515] Dynamic subtest rcs0: SUCCESS (0.015s)
[486.843331] Starting dynamic subtest: bcs0
[486.845225] Dynamic subtest bcs0: SUCCESS (0.006s)
[486.855398] Starting dynamic subtest: vcs0
[486.857160] Dynamic subtest vcs0: SUCCESS (0.005s)
[486.867347] Starting dynamic subtest: vcs1
[486.868914] Dynamic subtest vcs1: SUCCESS (0.006s)
[486.878322] Starting dynamic subtest: vecs0
[486.879942] Dynamic subtest vecs0: SUCCESS (0.006s)
[486.889374] Starting dynamic subtest: ccs0
[486.890935] Dynamic subtest ccs0: SUCCESS (0.006s)
[486.892541] Subtest concurrent-writes: SUCCESS (0.049s)
[487.137122] [096/131] (540s left) gem_mmap_gtt (basic-small-bo-tiledx)
[487.187062] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[487.247327] [097/131] (540s left) dmabuf_sync_file (import-basic)
[487.289817] Starting subtest: import-basic
[487.291781] Subtest import-basic: SUCCESS (0.001s)
[487.372250] [098/131] (540s left) kms_feature_discovery (display)
[487.460242] Starting subtest: display
[487.462235] Subtest display: SUCCESS (0.000s)
[487.559805] [099/131] (539s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[487.664027] Starting subtest: x-tiled-64bpp-rotate-90
[487.687432] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[487.851007] [100/131] (539s left) perf_pmu (busy-no-semaphores)
[487.902531] Starting subtest: busy-no-semaphores
[487.904526] Starting dynamic subtest: rcs0
[488.500511] Dynamic subtest rcs0: SUCCESS (0.596s)
[488.514355] Starting dynamic subtest: bcs0
[489.049203] Dynamic subtest bcs0: SUCCESS (0.546s)
[489.062380] Starting dynamic subtest: vcs0
[489.601577] Dynamic subtest vcs0: SUCCESS (0.549s)
[489.614834] Starting dynamic subtest: vcs1
[490.836119] Dynamic subtest vcs1: SUCCESS (1.231s)
[490.849223] Starting dynamic subtest: vecs0
[492.817615] Dynamic subtest vecs0: SUCCESS (1.979s)
[492.830760] Starting dynamic subtest: ccs0
[494.867857] Dynamic subtest ccs0: SUCCESS (2.046s)
[494.871044] Subtest busy-no-semaphores: SUCCESS (6.964s)
[495.032002] [101/131] (532s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[495.155340] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[495.159316] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[495.293756] [102/131] (532s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[495.411536] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[495.415958] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[495.580468] [103/131] (532s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[495.974040] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[496.780327] [104/131] (530s left) kms_getfb (getfb-reject-nv12)
[496.877870] Starting subtest: getfb-reject-nv12
[496.880098] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[497.029094] [105/131] (530s left) i915_drm_fdinfo (context-close-stress)
[497.076031] Starting subtest: context-close-stress
[507.823356] Subtest context-close-stress: SUCCESS (10.746s)
[507.923576] [106/131] (519s left) perf_pmu (module-unload)
[508.174804] Starting subtest: module-unload
[516.630718] Subtest module-unload: FAIL (8.348s)
[516.662777] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[516.663469] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[516.666506] [107/131] (511s left) kms_chamelium_edid (dp-edid-read)
[518.506428] Subtest dp-edid-read: SKIP (0.000s)
[519.327479] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[519.328765] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[519.332365] [108/131] (508s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[524.321689] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[524.324009] Starting dynamic subtest: pipe-A-eDP-1
[525.126647] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[525.136795] Starting dynamic subtest: pipe-B-eDP-1
[526.246560] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[526.250674] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.925s)
[527.450826] [109/131] (500s left) kms_vblank (query-busy)
[527.549973] Starting subtest: query-busy
[527.552110] Starting dynamic subtest: pipe-A-eDP-1
[529.425450] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[529.440752] Starting dynamic subtest: pipe-D-eDP-1
[531.979051] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[531.981389] Subtest query-busy: SUCCESS (4.428s)
[532.803588] [110/131] (495s left) syncobj_timeline (wait-for-submit-complex)
[532.861522] Starting subtest: wait-for-submit-complex
[532.923080] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[533.028074] [111/131] (494s left) perf (invalid-create-userspace-config)
[533.189383] Starting subtest: invalid-create-userspace-config
[533.191683] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[533.238882] [112/131] (494s left) gem_exec_basic (basic)
[533.296865] Starting subtest: basic
[533.299224] Starting dynamic subtest: rcs0-smem
[533.301538] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[533.310819] Starting dynamic subtest: bcs0-smem
[533.313127] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[533.322409] Starting dynamic subtest: vcs0-smem
[533.324312] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[533.332712] Starting dynamic subtest: vcs1-smem
[533.334633] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[533.342958] Starting dynamic subtest: vecs0-smem
[533.344922] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[533.353210] Starting dynamic subtest: ccs0-smem
[533.355144] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[533.357109] Subtest basic: SUCCESS (0.016s)
[535.379339] [113/131] (492s left) kms_chamelium_color (ctm-0-25)
[535.491832] Subtest ctm-0-25: SKIP (0.000s)
[535.538021] [114/131] (492s left) gem_userptr_blits (process-exit-busy)
[535.610786] Starting subtest: process-exit-busy
[535.623341] Subtest process-exit-busy: SUCCESS (0.014s)
[535.792466] [115/131] (492s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[535.843266] Starting subtest: y-tiled-ccs-to-y-tiled
[535.847641] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[536.050963] [116/131] (492s left) gen7_exec_parse (bitmasks)
[536.115144] Subtest bitmasks: SKIP (0.000s)
[536.205550] [117/131] (492s left) gem_eio (wait-wedge-10ms)
[536.401846] Starting subtest: wait-wedge-10ms
[538.379421] Subtest wait-wedge-10ms: SUCCESS (1.977s)
[538.547743] [118/131] (489s left) kms_content_protection (atomic)
[538.687923] Starting subtest: atomic
[538.692388] Subtest atomic: SKIP (0.000s)
[538.832041] [119/131] (489s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[538.924059] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[538.926286] Starting dynamic subtest: pipe-A-default-mode
[539.214018] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[539.218379] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.289s)
[540.033006] [120/131] (488s left) gem_exec_params (invalid-flag)
[540.098438] Starting subtest: invalid-flag
[540.100799] Subtest invalid-flag: SUCCESS (0.000s)
[540.235718] [121/131] (488s left) kms_getfb (getfb-addfb-different-handles)
[540.332873] Starting subtest: getfb-addfb-different-handles
[540.334986] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[540.476662] [122/131] (487s left) gem_exec_flush (basic-uc-ro-default)
[540.547000] Starting subtest: basic-uc-ro-default
[545.998496] Subtest basic-uc-ro-default: SUCCESS (5.454s)
[546.212801] [123/131] (482s left) gem_sync (basic-each)
[546.285631] Starting subtest: basic-each
[548.795375] Subtest basic-each: SUCCESS (2.520s)
[549.011101] [124/131] (479s left) gem_exec_balancer (full)
[549.078938] Starting subtest: full
[554.231241] Subtest full: SUCCESS (5.156s)
[554.531043] [125/131] (474s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[554.644750] Starting subtest: y-tiled-8bpp-rotate-180
[554.648986] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[554.785237] [126/131] (473s left) sw_sync (sync_merge_invalid)
[554.827610] Starting subtest: sync_merge_invalid
[554.859309] Subtest sync_merge_invalid: SUCCESS (0.030s)
[554.936542] [127/131] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[555.058483] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[559.904788] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.849s)
[561.047803] [128/131] (467s left) gem_lmem_swapping (parallel-random-verify-ccs)
[561.087826] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[561.130602] [129/131] (467s left) kms_lease (lease-unleased-connector)
[561.217761] Starting subtest: lease-unleased-connector
[561.219831] Starting dynamic subtest: pipe-A-eDP-1
[561.224875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[561.235239] Starting dynamic subtest: pipe-B-eDP-1
[561.237529] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[561.249426] Starting dynamic subtest: pipe-C-eDP-1
[561.251798] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[561.270401] Starting dynamic subtest: pipe-D-eDP-1
[561.273065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[561.275535] Subtest lease-unleased-connector: SUCCESS (0.032s)
[561.411720] [130/131] (467s left) perf (enable-disable)
[561.531214] Starting subtest: enable-disable
[561.533930] Starting dynamic subtest: 0-rcs0
[563.789681] Dynamic subtest 0-rcs0: SUCCESS (2.258s)
[563.800083] Starting dynamic subtest: 1-vcs1
[568.264764] Dynamic subtest 1-vcs1: SUCCESS (4.474s)
[568.267073] Subtest enable-disable: SUCCESS (6.734s)
[568.327593] [131/131] (460s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[568.499927] Starting subtest: cursor-rapid-movement-32x32
[568.547808] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[568.867840] 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.