[58.003670] Initializing watchdogs
[58.003721]   /dev/watchdog0
[58.017711] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.022167] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.024243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.026219] [001/132] (960s left) gem_exec_schedule (independent)
[58.102367] Starting subtest: independent
[58.103426] Starting dynamic subtest: rcs0
[59.928821] Dynamic subtest rcs0: SUCCESS (1.824s)
[59.937061] Starting dynamic subtest: vcs0
[61.953285] Dynamic subtest vcs0: SUCCESS (2.025s)
[61.961330] Starting dynamic subtest: vcs1
[63.942215] Dynamic subtest vcs1: SUCCESS (1.986s)
[63.950289] Starting dynamic subtest: vecs0
[65.926416] Dynamic subtest vecs0: SUCCESS (1.983s)
[65.934463] Starting dynamic subtest: ccs0
[67.926195] Dynamic subtest ccs0: SUCCESS (1.999s)
[67.927584] Subtest independent: SUCCESS (9.823s)
[68.241419] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[68.343401] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[68.345270] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[68.488377] [003/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[68.573760] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[68.575802] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.685052] [004/132] (949s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[68.738450] Starting subtest: invalid-signal-one-illegal-handle
[68.739372] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[68.854192] [005/132] (949s left) gem_softpin (32b-excludes-last-page)
[68.909699] Starting subtest: 32b-excludes-last-page
[68.914541] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[69.049213] [006/132] (949s left) gem_mmap_gtt (basic-copy)
[69.106457] Subtest basic-copy: SKIP (0.000s)
[69.173328] [007/132] (949s left) kms_content_protection (atomic-dpms-hdcp14)
[69.303875] Starting subtest: atomic-dpms-hdcp14
[69.305955] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[69.453140] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[69.534872] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[76.416292] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.880s)
[76.579065] [009/132] (942s left) gem_mmap_gtt (coherency)
[76.635386] Subtest coherency: SKIP (0.000s)
[76.697187] [010/132] (942s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[76.795531] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[76.796467] Starting dynamic subtest: pipe-A-default-mode
[79.509680] Dynamic subtest pipe-A-default-mode: SUCCESS (2.713s)
[79.510711] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.714s)
[80.362285] [011/132] (938s left) kms_cursor_crc (cursor-offscreen-512x170)
[80.626984] Starting subtest: cursor-offscreen-512x170
[80.628952] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[80.775733] [012/132] (938s left) perf_pmu (busy-double-start)
[80.810228] Starting subtest: busy-double-start
[80.811419] Starting dynamic subtest: rcs0
[84.407520] Dynamic subtest rcs0: FAIL (3.580s)
[84.413302] Starting dynamic subtest: bcs0
[87.964435] Dynamic subtest bcs0: SUCCESS (3.574s)
[87.972933] Starting dynamic subtest: vcs0
[92.447591] Dynamic subtest vcs0: SUCCESS (4.482s)
[92.456518] Starting dynamic subtest: vcs1
[96.451404] Dynamic subtest vcs1: SUCCESS (4.003s)
[96.460267] Starting dynamic subtest: vecs0
[100.468560] Dynamic subtest vecs0: SUCCESS (4.016s)
[100.477160] Starting dynamic subtest: ccs0
[104.059281] Dynamic subtest ccs0: FAIL (3.570s)
[104.060081] Subtest busy-double-start: FAIL (23.229s)
[104.158748] [013/132] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[104.259092] Starting subtest: fbc-rgb565-draw-pwrite
[108.918382] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.660s)
[110.066337] [014/132] (908s left) gem_tiled_pread_basic
[110.188817] [015/132] (908s left) kms_psr (fbc-psr2-cursor-plane-move)
[110.268943] Starting subtest: fbc-psr2-cursor-plane-move
[110.269910] Starting dynamic subtest: eDP-1
[110.271566] Dynamic subtest eDP-1: SKIP (0.000s)
[110.273200] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[110.362322] [016/132] (908s left) gem_render_copy (y-tiled-ccs-to-linear)
[110.423128] Starting subtest: y-tiled-ccs-to-linear
[110.425084] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[110.622955] [017/132] (908s left) kms_color (ctm-0-25)
[110.715416] Starting subtest: ctm-0-25
[110.716449] Starting dynamic subtest: pipe-A-eDP-1
[114.162378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[114.169402] Starting dynamic subtest: pipe-B-eDP-1
[118.286791] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.123s)
[118.293459] Starting dynamic subtest: pipe-C-eDP-1
[122.317845] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.032s)
[122.324822] Starting dynamic subtest: pipe-D-eDP-1
[126.299182] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.981s)
[126.300184] Subtest ctm-0-25: SUCCESS (15.585s)
[127.178208] [018/132] (891s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[127.727898] Starting subtest: syncobj-timeline-multiple-ext-nodes
[127.730853] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[128.994773] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[128.996569] [019/132] (890s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[129.088563] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[129.100320] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[129.229913] [020/132] (889s left) gem_mmap_gtt (fault-concurrent-y)
[129.288182] Subtest fault-concurrent-Y: SKIP (0.000s)
[129.355739] [021/132] (889s left) syncobj_timeline (reset-signaled)
[129.408965] Starting subtest: reset-signaled
[129.409897] Subtest reset-signaled: SUCCESS (0.000s)
[129.532080] [022/132] (889s left) kms_lease (simple-lease)
[129.630445] Starting subtest: simple-lease
[129.631337] Starting dynamic subtest: pipe-A-eDP-1
[130.143554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[130.151053] Starting dynamic subtest: pipe-B-eDP-1
[131.588646] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[131.595940] Starting dynamic subtest: pipe-C-eDP-1
[133.005557] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s)
[133.011689] Starting dynamic subtest: pipe-D-eDP-1
[134.420883] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[134.421775] Subtest simple-lease: SUCCESS (4.792s)
[135.243227] [023/132] (883s left) gem_exec_whisper (basic-queues-priority-all)
[135.303396] Starting subtest: basic-queues-priority-all
[157.177221] Subtest basic-queues-priority-all: SUCCESS (21.869s)
[157.378610] [024/132] (861s left) gem_exec_balancer (parallel-ordering)
[157.642574] Starting subtest: parallel-ordering
[158.592845] Subtest parallel-ordering: SUCCESS (0.950s)
[158.753380] [025/132] (860s left) gem_fenced_exec_thrash (too-many-fences)
[158.826272] Subtest too-many-fences: SKIP (0.000s)
[158.894696] [026/132] (860s left) kms_chamelium_frames (dp-crc-single)
[159.263397] Subtest dp-crc-single: SKIP (0.000s)
[160.036466] [027/132] (859s left) kms_big_fb (linear-16bpp-rotate-90)
[160.159442] Starting subtest: linear-16bpp-rotate-90
[160.182963] Subtest linear-16bpp-rotate-90: SKIP (0.022s)
[160.318317] [028/132] (859s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[160.417932] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[160.419705] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[160.531386] [029/132] (858s left) api_intel_bb (crc32)
[160.588347] Starting subtest: crc32
[160.589365] Starting dynamic subtest: rcs0-smem0
[160.905405] Dynamic subtest rcs0-smem0: SUCCESS (0.314s)
[160.915993] Starting dynamic subtest: bcs0-smem0
[161.229055] Dynamic subtest bcs0-smem0: SUCCESS (0.322s)
[161.239291] Starting dynamic subtest: vcs0-smem0
[161.600426] Dynamic subtest vcs0-smem0: SUCCESS (0.369s)
[161.610560] Starting dynamic subtest: vcs1-smem0
[161.948232] Dynamic subtest vcs1-smem0: SUCCESS (0.346s)
[161.955950] Starting dynamic subtest: vecs0-smem0
[162.299033] Dynamic subtest vecs0-smem0: SUCCESS (0.349s)
[162.308499] Starting dynamic subtest: ccs0-smem0
[162.632765] Dynamic subtest ccs0-smem0: SUCCESS (0.331s)
[162.634274] Subtest crc32: SUCCESS (2.044s)
[162.790127] [030/132] (856s left) kms_psr (fbc-pr-sprite-plane-onoff)
[162.894990] Starting subtest: fbc-pr-sprite-plane-onoff
[162.896729] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[162.986823] [031/132] (856s left) gem_eio (wait-1us)
[163.206088] Starting subtest: wait-1us
[163.529616] Subtest wait-1us: SUCCESS (0.325s)
[163.698696] [032/132] (855s left) kms_feature_discovery (chamelium)
[163.786526] Starting subtest: chamelium
[163.788318] Subtest chamelium: SKIP (0.000s)
[163.874988] [033/132] (855s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[163.973444] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[163.975260] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[164.100560] [034/132] (855s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[164.188069] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[164.190297] Starting dynamic subtest: A-eDP1
[168.030238] Dynamic subtest A-eDP1: SUCCESS (3.840s)
[168.036976] Starting dynamic subtest: B-eDP1
[171.234775] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[171.244891] Starting dynamic subtest: C-eDP1
[174.319944] Dynamic subtest C-eDP1: SUCCESS (3.084s)
[174.327393] Starting dynamic subtest: D-eDP1
[177.427939] Dynamic subtest D-eDP1: SUCCESS (3.106s)
[177.429050] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.241s)
[178.249248] [035/132] (841s left) i915_pciid
[178.430228] [036/132] (841s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[178.532798] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[178.533873] Starting dynamic subtest: pipe-A
[178.882857] Dynamic subtest pipe-A: SUCCESS (0.351s)
[178.895858] Starting dynamic subtest: pipe-B
[180.328223] Dynamic subtest pipe-B: SUCCESS (1.445s)
[180.336155] Starting dynamic subtest: pipe-C
[181.747610] Dynamic subtest pipe-C: SUCCESS (1.418s)
[181.760541] Starting dynamic subtest: pipe-D
[183.199967] Dynamic subtest pipe-D: SUCCESS (1.452s)
[183.200934] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.668s)
[184.357100] [037/132] (835s left) gem_exec_flush (basic-wb-ro-before-default)
[184.420236] Starting subtest: basic-wb-ro-before-default
[189.875823] Subtest basic-wb-ro-before-default: SUCCESS (5.455s)
[190.080941] [038/132] (829s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[190.192897] Starting subtest: 4-tiled-8bpp-rotate-180
[191.296149] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.104s)
[191.447293] [039/132] (828s left) kms_pipe_stress (stress-xrgb8888-untiled)
[191.552819] Starting subtest: stress-xrgb8888-untiled
[197.444049] Subtest stress-xrgb8888-untiled: SUCCESS (5.893s)
[197.503792] [040/132] (822s left) gem_exec_reloc (basic-cpu-wc-active)
[197.564510] Subtest basic-cpu-wc-active: SKIP (0.000s)
[197.639060] [041/132] (822s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[197.749698] Starting subtest: verify-pxp-key-change-after-suspend-resume
[208.708419] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (10.960s)
[214.877458] [042/132] (810s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[214.985441] Starting subtest: primary-yf-tiled-reflect-x-90
[214.987440] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[215.076943] [043/132] (810s left) api_intel_bb (blit-noreloc-keep-cache)
[215.139054] Starting subtest: blit-noreloc-keep-cache
[215.148318] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[215.310167] [044/132] (810s left) kms_pm_backlight (fade-with-suspend)
[215.409476] Starting subtest: fade-with-suspend
[232.107623] Starting dynamic subtest: eDP-1
[234.777875] Dynamic subtest eDP-1: SUCCESS (2.670s)
[234.778829] Subtest fade-with-suspend: SUCCESS (4.293s)
[238.651153] [045/132] (790s left) kms_addfb_basic (small-bo)
[238.754803] Starting subtest: small-bo
[238.756319] Subtest small-bo: SUCCESS (0.000s)
[238.887244] [046/132] (790s left) gem_userptr_blits (mmap-offset-banned)
[238.958308] Starting subtest: mmap-offset-banned
[238.959446] Starting dynamic subtest: wb
[238.960456] Dynamic subtest wb: SUCCESS (0.000s)
[238.970293] Starting dynamic subtest: wc
[238.971334] Dynamic subtest wc: SUCCESS (0.000s)
[238.980437] Starting dynamic subtest: uc
[238.981357] Dynamic subtest uc: SUCCESS (0.000s)
[238.982266] Subtest mmap-offset-banned: SUCCESS (0.002s)
[239.120380] [047/132] (789s left) kms_invalid_mode (zero-vdisplay)
[239.198089] Starting subtest: zero-vdisplay
[239.198991] Starting dynamic subtest: pipe-A-eDP-1
[239.488070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[239.497148] Starting dynamic subtest: pipe-B-eDP-1
[239.498045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[239.505139] Starting dynamic subtest: pipe-C-eDP-1
[239.506029] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[239.513246] Starting dynamic subtest: pipe-D-eDP-1
[239.514139] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[239.515035] Subtest zero-vdisplay: SUCCESS (0.295s)
[240.363147] [048/132] (788s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[240.461051] Starting subtest: psr-rgb101010-draw-pwrite
[248.012409] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.548s)
[248.162431] [049/132] (780s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[248.269123] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[248.270037] Starting dynamic subtest: pipe-A-eDP-1
[248.292119] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[248.300611] Starting dynamic subtest: pipe-B-eDP-1
[248.322046] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[248.329977] Starting dynamic subtest: pipe-C-eDP-1
[248.352207] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[248.360898] Starting dynamic subtest: pipe-D-eDP-1
[248.381849] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[248.383504] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[250.431382] [050/132] (778s left) kms_cursor_crc (cursor-sliding-max-size)
[250.723209] Starting subtest: cursor-sliding-max-size
[250.725834] Subtest cursor-sliding-max-size: SKIP (0.000s)
[250.887190] [051/132] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[250.983697] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[250.985553] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[251.122172] [052/132] (778s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[251.180534] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[251.287150] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[251.382209] [053/132] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[251.475357] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[251.477145] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[251.625212] [054/132] (777s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[251.715236] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[251.716145] Starting dynamic subtest: pipe-A-eDP-1
[251.724527] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.734576] Starting dynamic subtest: pipe-B-eDP-1
[251.743097] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.752860] Starting dynamic subtest: pipe-C-eDP-1
[251.762214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.769530] Starting dynamic subtest: pipe-D-eDP-1
[251.778114] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.779788] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[253.897697] [055/132] (775s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[253.997232] Starting subtest: x-tiled-16bpp-rotate-90
[254.019769] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[254.159055] [056/132] (775s left) kms_plane (plane-panning-top-left)
[254.272264] Starting subtest: plane-panning-top-left
[254.273179] Starting dynamic subtest: pipe-A
[255.933692] Dynamic subtest pipe-A: SUCCESS (1.659s)
[255.942245] Starting dynamic subtest: pipe-B
[258.252416] Dynamic subtest pipe-B: SUCCESS (2.317s)
[258.253279] Subtest plane-panning-top-left: SUCCESS (3.980s)
[259.147274] [057/132] (770s left) kms_getfb (getfb-handle-zero)
[259.242078] Starting subtest: getfb-handle-zero
[259.242918] Subtest getfb-handle-zero: SUCCESS (0.000s)
[259.378932] [058/132] (770s left) kms_flip (dpms-vs-vblank-race-interruptible)
[259.481665] Starting subtest: dpms-vs-vblank-race-interruptible
[259.483229] Starting dynamic subtest: A-eDP1
[263.294602] Dynamic subtest A-eDP1: SUCCESS (3.810s)
[263.302716] Starting dynamic subtest: B-eDP1
[267.924478] Dynamic subtest B-eDP1: SUCCESS (4.627s)
[267.937462] Starting dynamic subtest: C-eDP1
[272.551953] Dynamic subtest C-eDP1: SUCCESS (4.626s)
[272.560121] Starting dynamic subtest: D-eDP1
[277.181309] Dynamic subtest D-eDP1: SUCCESS (4.627s)
[277.183454] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.700s)
[278.082152] [059/132] (751s left) kms_addfb_basic (bad-pitch-256)
[278.139855] Starting subtest: bad-pitch-256
[278.140701] Subtest bad-pitch-256: SUCCESS (0.000s)
[278.291127] [060/132] (751s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[278.371861] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[278.372685] Starting dynamic subtest: pipe-A-eDP-1
[279.159175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[279.167313] Starting dynamic subtest: pipe-B-eDP-1
[280.649083] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[280.657222] Starting dynamic subtest: pipe-C-eDP-1
[282.148574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[282.156687] Starting dynamic subtest: pipe-D-eDP-1
[283.595489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[283.596405] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.221s)
[284.802190] [061/132] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[284.901305] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[284.903010] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[285.032965] [062/132] (744s left) vgem_basic (busy-fence)
[285.077822] Starting subtest: busy-fence
[285.078794] Subtest busy-fence: SUCCESS (0.000s)
[285.153254] [063/132] (744s left) gem_ctx_shared (detached-shared-gtt)
[285.217117] Starting subtest: detached-shared-gtt
[287.371130] Subtest detached-shared-gtt: SUCCESS (2.152s)
[287.757171] [064/132] (741s left) kms_atomic_interruptible (legacy-dpms)
[287.849021] Starting subtest: legacy-dpms
[287.849838] Starting dynamic subtest: pipe-A-eDP-1
[295.314461] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.464s)
[295.315348] Subtest legacy-dpms: SUCCESS (7.465s)
[296.166359] [065/132] (733s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[301.239936] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[301.240868] Starting dynamic subtest: pipe-A-eDP-1
[302.021774] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[302.031700] Starting dynamic subtest: pipe-B-eDP-1
[303.154035] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[303.156356] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.915s)
[304.458108] [066/132] (725s left) kms_cursor_legacy (torture-bo)
[304.581956] Starting subtest: torture-bo
[304.582820] Starting dynamic subtest: pipe-A
[310.481489] Dynamic subtest pipe-A: SUCCESS (5.897s)
[310.493119] Starting dynamic subtest: pipe-B
[316.464575] Dynamic subtest pipe-B: SUCCESS (5.978s)
[316.475407] Starting dynamic subtest: pipe-C
[322.028121] Dynamic subtest pipe-C: SUCCESS (5.563s)
[322.042733] Starting dynamic subtest: pipe-D
[328.383759] Dynamic subtest pipe-D: SUCCESS (6.351s)
[328.395011] Starting dynamic subtest: all-pipes
[334.601501] Dynamic subtest all-pipes: SUCCESS (6.215s)
[334.602766] Subtest torture-bo: SUCCESS (30.014s)
[334.775080] [067/132] (694s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[334.864164] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[341.486702] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.625s)
[341.650700] [068/132] (688s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[341.752099] Starting subtest: fbcpsr-shrfb-scaledprimary
[347.539707] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.788s)
[347.694118] [069/132] (682s left) gem_ppgtt (shrink-vs-evict-pinned)
[347.748471] Starting subtest: shrink-vs-evict-pinned
[353.045397] Subtest shrink-vs-evict-pinned: SUCCESS (5.296s)
[353.150515] [070/132] (676s left) kms_flip (flip-vs-blocking-wf-vblank)
[353.251600] Starting subtest: flip-vs-blocking-wf-vblank
[353.253723] Starting dynamic subtest: A-eDP1
[362.210273] Dynamic subtest A-eDP1: SUCCESS (8.957s)
[362.219823] Starting dynamic subtest: B-eDP1
[371.139560] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[371.150304] Starting dynamic subtest: C-eDP1
[380.055035] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[380.063698] Starting dynamic subtest: D-eDP1
[388.979143] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[388.983552] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.732s)
[390.216269] [071/132] (639s left) syncobj_timeline (wait-all-interrupted)
[390.272763] Starting subtest: wait-all-interrupted
[390.375402] Subtest wait-all-interrupted: SUCCESS (0.102s)
[390.469909] [072/132] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[390.579234] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[397.395672] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.817s)
[397.548659] [073/132] (632s left) gem_mmap_gtt (cpuset-big-copy)
[397.609277] Subtest cpuset-big-copy: SKIP (0.000s)
[397.667677] [074/132] (632s left) kms_hdr (invalid-metadata-sizes)
[397.752395] Starting subtest: invalid-metadata-sizes
[397.755222] Subtest invalid-metadata-sizes: SKIP (0.000s)
[397.845309] [075/132] (632s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[397.961120] Starting subtest: plane-all-modeset-transition-fencing
[397.962882] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[398.057921] [076/132] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[398.149123] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[404.773449] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.625s)
[404.939632] [077/132] (625s left) gem_exec_reloc (basic-concurrent16)
[405.005789] Subtest basic-concurrent16: SKIP (0.000s)
[405.092527] [078/132] (624s left) kms_pm_rpm (legacy-planes-dpms)
[407.106999] Starting subtest: legacy-planes-dpms
[407.107995] Starting dynamic subtest: plane-63
[415.769470] Dynamic subtest plane-63: SUCCESS (8.660s)
[415.780147] Starting dynamic subtest: plane-93
[424.387041] Dynamic subtest plane-93: SUCCESS (8.617s)
[424.400117] Starting dynamic subtest: plane-123
[432.983475] Dynamic subtest plane-123: SUCCESS (8.594s)
[432.995585] Starting dynamic subtest: plane-133
[441.667356] Dynamic subtest plane-133: SUCCESS (8.681s)
[441.670780] Subtest legacy-planes-dpms: SUCCESS (34.562s)
[442.062613] [079/132] (588s left) kms_selftest (drm_cmdline_parser)
[442.096124] Starting subtest: drm_cmdline_parser
[442.134675] Starting dynamic subtest: drm_test_cmdline_force_d_only
[442.272809] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.137s)
[442.282365] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[442.392424] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.120s)
[442.401689] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[442.555804] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.161s)
[442.565018] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[442.703805] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.148s)
[442.713302] Starting dynamic subtest: drm_test_cmdline_force_e_only
[442.840721] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.136s)
[442.850224] Starting dynamic subtest: drm_test_cmdline_res
[442.974813] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.133s)
[442.983933] Starting dynamic subtest: drm_test_cmdline_res_vesa
[443.107854] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.135s)
[443.117246] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[443.244057] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.133s)
[443.251867] Starting dynamic subtest: drm_test_cmdline_res_rblank
[443.380860] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.136s)
[443.388810] Starting dynamic subtest: drm_test_cmdline_res_bpp
[443.511724] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.131s)
[443.520344] Starting dynamic subtest: drm_test_cmdline_res_refresh
[443.659806] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.146s)
[443.669155] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[443.793943] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.136s)
[443.803392] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[443.942793] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.146s)
[443.951721] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[444.081709] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.139s)
[444.089657] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[444.158384] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.077s)
[444.166937] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[444.298950] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.138s)
[444.307045] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[444.425057] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.125s)
[444.433051] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[444.529097] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.105s)
[444.537809] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[444.642789] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.111s)
[444.650618] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[444.772839] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.130s)
[444.780806] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[444.858616] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.087s)
[444.867320] Starting dynamic subtest: drm_test_cmdline_name
[444.978928] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.118s)
[444.988301] Starting dynamic subtest: drm_test_cmdline_name_bpp
[445.120861] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.141s)
[445.129994] Starting dynamic subtest: drm_test_cmdline_name_option
[445.257137] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.137s)
[445.266286] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[445.405947] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.146s)
[445.415027] Starting dynamic subtest: drm_test_cmdline_rotate_0
[445.552881] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.146s)
[445.561835] Starting dynamic subtest: drm_test_cmdline_rotate_90
[445.676929] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.123s)
[445.685728] Starting dynamic subtest: drm_test_cmdline_rotate_180
[445.805044] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.126s)
[445.814221] Starting dynamic subtest: drm_test_cmdline_rotate_270
[445.877929] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.075s)
[445.886833] Starting dynamic subtest: drm_test_cmdline_hmirror
[445.990286] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.111s)
[445.999634] Starting dynamic subtest: drm_test_cmdline_vmirror
[446.115433] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.122s)
[446.124527] Starting dynamic subtest: drm_test_cmdline_margin_options
[446.232171] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.117s)
[446.239885] Starting dynamic subtest: drm_test_cmdline_multiple_options
[446.331623] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.100s)
[446.341932] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[446.449132] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.113s)
[446.458532] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[446.567971] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.119s)
[446.582961] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[446.727035] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.159s)
[446.736824] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[446.871494] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.144s)
[446.881844] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[447.009691] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.134s)
[447.019112] Starting dynamic subtest: drm_test_cmdline_invalid
[447.159969] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.151s)
[447.167807] Starting dynamic subtest: drm_test_cmdline_tv_options
[447.299757] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.138s)
[447.300605] Subtest drm_cmdline_parser: SUCCESS (5.204s)
[447.537957] [080/132] (582s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[447.637070] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[447.637892] Starting dynamic subtest: pipe-A-eDP-1
[447.646054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.654576] Starting dynamic subtest: pipe-B-eDP-1
[447.662754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.671029] Starting dynamic subtest: pipe-C-eDP-1
[447.678875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.686639] Starting dynamic subtest: pipe-D-eDP-1
[447.694824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.696337] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[449.837619] [081/132] (580s left) kms_psr (psr2-sprite-blt)
[449.920083] Starting subtest: psr2-sprite-blt
[449.920932] Starting dynamic subtest: eDP-1
[451.618144] Dynamic subtest eDP-1: SUCCESS (1.698s)
[451.619002] Subtest psr2-sprite-blt: SUCCESS (1.698s)
[452.509550] [082/132] (577s left) kms_setmode (invalid-clone-exclusive-crtc)
[452.564804] Starting subtest: invalid-clone-exclusive-crtc
[452.567582] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[452.698692] [083/132] (577s left) kms_flip_event_leak (basic)
[452.793021] Starting subtest: basic
[452.793905] Starting dynamic subtest: pipe-A-eDP-1
[453.219722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[453.228098] Starting dynamic subtest: pipe-B-eDP-1
[454.312558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[454.320625] Starting dynamic subtest: pipe-C-eDP-1
[455.431963] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[455.439985] Starting dynamic subtest: pipe-D-eDP-1
[456.561750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[456.562780] Subtest basic: SUCCESS (3.767s)
[457.445687] [084/132] (572s left) gem_workarounds (basic-read)
[457.510394] Starting subtest: basic-read
[457.520120] Subtest basic-read: SUCCESS (0.010s)
[457.673275] [085/132] (572s left) dmabuf_sync_file (import-multiple-read-only)
[457.708042] Starting subtest: import-multiple-read-only
[457.709646] Subtest import-multiple-read-only: SUCCESS (0.004s)
[457.786593] [086/132] (572s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[457.876474] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[458.257021] Starting dynamic subtest: pipe-A-eDP-1
[460.999084] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.739s)
[461.359525] Starting dynamic subtest: pipe-B-eDP-1
[464.129158] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[464.499600] Starting dynamic subtest: pipe-C-eDP-1
[467.264803] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[467.626936] Starting dynamic subtest: pipe-D-eDP-1
[470.394646] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[470.395534] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.517s)
[471.603043] [087/132] (558s left) kms_atomic (plane-overlay-legacy)
[471.702099] Starting subtest: plane-overlay-legacy
[471.703064] Starting dynamic subtest: pipe-A-eDP-1
[472.149444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[472.150373] Subtest plane-overlay-legacy: SUCCESS (0.447s)
[473.032861] [088/132] (557s left) gem_exec_balancer (parallel-balancer)
[473.300227] Starting subtest: parallel-balancer
[474.183113] Subtest parallel-balancer: SUCCESS (0.883s)
[474.336123] [089/132] (556s left) gem_mmap_gtt (basic-write-gtt)
[474.395838] Subtest basic-write-gtt: SKIP (0.000s)
[474.445925] [090/132] (556s left) perf_pmu (render-node-busy)
[474.523229] Starting subtest: render-node-busy
[474.524171] Starting dynamic subtest: rcs0
[475.134858] Dynamic subtest rcs0: SUCCESS (0.614s)
[475.147309] Starting dynamic subtest: bcs0
[475.702983] Dynamic subtest bcs0: SUCCESS (0.565s)
[475.714808] Starting dynamic subtest: vcs0
[476.986230] Dynamic subtest vcs0: SUCCESS (1.280s)
[476.999254] Starting dynamic subtest: vcs1
[478.969958] Dynamic subtest vcs1: SUCCESS (1.981s)
[478.983060] Starting dynamic subtest: vecs0
[481.019076] Dynamic subtest vecs0: SUCCESS (2.045s)
[481.030308] Starting dynamic subtest: ccs0
[481.586198] Dynamic subtest ccs0: SUCCESS (0.567s)
[481.589553] Subtest render-node-busy: SUCCESS (7.068s)
[481.678782] [091/132] (548s left) i915_pm_rpm (system-suspend-execbuf)
[483.187601] Starting subtest: system-suspend-execbuf
[541.720436] Subtest system-suspend-execbuf: SUCCESS (43.031s)
[542.105987] [092/132] (488s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[547.119967] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[547.120975] Starting dynamic subtest: pipe-A-eDP-1
[553.757164] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s)
[553.766538] Starting dynamic subtest: pipe-B-eDP-1
[560.334615] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.576s)
[560.335548] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.216s)
[561.246213] [093/132] (469s left) kms_vblank (wait-forked)
[561.341947] Starting subtest: wait-forked
[561.342881] Starting dynamic subtest: pipe-A-eDP-1
[563.166028] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[563.180513] Starting dynamic subtest: pipe-D-eDP-1
[565.630601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s)
[565.631512] Subtest wait-forked: SUCCESS (4.289s)
[566.531670] [094/132] (464s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[566.629959] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[566.631694] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[566.750330] [095/132] (463s left) gen9_exec_parse (allowed-single)
[566.801623] Subtest allowed-single: SKIP (0.000s)
[566.870788] [096/132] (463s left) syncobj_eventfd (timeline-wait)
[566.930956] Starting subtest: timeline-wait
[566.941234] Subtest timeline-wait: SUCCESS (0.011s)
[567.038021] [097/132] (463s left) kms_vblank (ts-continuation-modeset-rpm)
[567.136899] Starting subtest: ts-continuation-modeset-rpm
[567.137852] Starting dynamic subtest: pipe-A-eDP-1
[569.620477] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.483s)
[569.630500] Starting dynamic subtest: pipe-D-eDP-1
[571.847213] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.223s)
[571.848426] Subtest ts-continuation-modeset-rpm: SUCCESS (4.710s)
[572.661534] [098/132] (458s left) sw_sync (sync_busy)
[572.699103] Starting subtest: sync_busy
[572.699929] Subtest sync_busy: SUCCESS (0.002s)
[572.771925] [099/132] (458s left) gem_ctx_persistence (engines-persistence)
[572.815338] Starting subtest: engines-persistence
[572.816446] Starting dynamic subtest: rcs0
[573.667329] Dynamic subtest rcs0: SUCCESS (0.851s)
[573.680248] Starting dynamic subtest: bcs0
[574.470251] Dynamic subtest bcs0: SUCCESS (0.800s)
[574.482674] Starting dynamic subtest: vcs0
[575.255442] Dynamic subtest vcs0: SUCCESS (0.783s)
[575.267814] Starting dynamic subtest: vcs1
[576.072456] Dynamic subtest vcs1: SUCCESS (0.815s)
[576.085205] Starting dynamic subtest: vecs0
[576.835307] Dynamic subtest vecs0: SUCCESS (0.761s)
[576.847773] Starting dynamic subtest: ccs0
[577.573402] Dynamic subtest ccs0: SUCCESS (0.736s)
[577.574769] Subtest engines-persistence: SUCCESS (4.759s)
[577.741167] [100/132] (453s left) syncobj_basic (bad-handle-to-fd)
[577.786676] Starting subtest: bad-handle-to-fd
[577.787626] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[577.898598] [101/132] (453s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[577.955492] Starting subtest: yf-tiled-to-vebox-x-tiled
[577.957537] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[578.160887] [102/132] (452s left) syncobj_timeline (invalid-wait-illegal-handle)
[578.214571] Starting subtest: invalid-wait-illegal-handle
[578.215553] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[578.349457] [103/132] (452s left) i915_drm_fdinfo (memory-info-idle)
[578.387891] Starting subtest: memory-info-idle
[578.388719] Starting dynamic subtest: smem0
[578.460972] Dynamic subtest smem0: SUCCESS (0.072s)
[578.462218] Subtest memory-info-idle: SUCCESS (0.073s)
[578.552787] [104/132] (452s left) gem_softpin (noreloc)
[578.609556] Starting subtest: noreloc
[584.005558] Subtest noreloc: SUCCESS (5.393s)
[584.152022] [105/132] (446s left) i915_pm_sseu (full-enable)
[584.217474] Subtest full-enable: SKIP (0.000s)
[584.350362] [106/132] (446s left) gem_ctx_engines (execute-oneforall)
[584.416004] Starting subtest: execute-oneforall
[585.377984] Subtest execute-oneforall: SUCCESS (0.959s)
[586.624179] [107/132] (444s left) gem_exec_whisper (basic-normal)
[586.673997] Starting subtest: basic-normal
[591.779927] Subtest basic-normal: SUCCESS (5.104s)
[591.980671] [108/132] (439s left) syncobj_basic (bad-flags-handle-to-fd)
[592.028891] Starting subtest: bad-flags-handle-to-fd
[592.029820] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[592.174257] [109/132] (439s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[592.279257] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[592.280922] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[592.409226] [110/132] (438s left) gem_exec_schedule (thriceslice)
[592.481911] Starting subtest: thriceslice
[592.482950] Starting dynamic subtest: rcs0
[592.512246] Dynamic subtest rcs0: SUCCESS (0.030s)
[592.523362] Starting dynamic subtest: bcs0
[592.540785] Dynamic subtest bcs0: SUCCESS (0.028s)
[592.550644] Starting dynamic subtest: vcs0
[592.570890] Dynamic subtest vcs0: SUCCESS (0.028s)
[592.581548] Starting dynamic subtest: vcs1
[592.599884] Dynamic subtest vcs1: SUCCESS (0.028s)
[592.610607] Starting dynamic subtest: vecs0
[592.628772] Dynamic subtest vecs0: SUCCESS (0.028s)
[592.636661] Starting dynamic subtest: ccs0
[592.657657] Dynamic subtest ccs0: SUCCESS (0.028s)
[592.658551] Subtest thriceslice: SUCCESS (0.177s)
[592.978630] [111/132] (438s left) syncobj_wait (multi-wait-submitted-signaled)
[593.041670] Starting subtest: multi-wait-submitted-signaled
[593.042701] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[593.172904] [112/132] (438s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[593.271720] Starting subtest: yf-tiled-8bpp-rotate-270
[593.273535] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[593.400557] [113/132] (437s left) gem_userptr_blits (access-control)
[593.477548] Starting subtest: access-control
[593.479498] Subtest access-control: SKIP (0.000s)
[593.644135] [114/132] (437s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[593.759304] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[597.345644] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.586s)
[598.564871] [115/132] (432s left) gem_ctx_persistence (idempotent)
[598.623623] Starting subtest: idempotent
[598.624545] Subtest idempotent: SUCCESS (0.000s)
[598.751936] [116/132] (432s left) kms_flip (2x-flip-vs-fences-interruptible)
[598.835806] Starting subtest: 2x-flip-vs-fences-interruptible
[598.837372] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[598.966607] [117/132] (432s left) gem_userptr_blits (map-fixed-invalidate)
[599.036218] Starting subtest: map-fixed-invalidate
[599.037958] Subtest map-fixed-invalidate: SKIP (0.000s)
[599.194489] [118/132] (432s left) gem_bad_reloc (negative-reloc-lut)
[599.258827] Subtest negative-reloc-lut: SKIP (0.000s)
[599.335040] [119/132] (432s left) kms_fbcon_fbt (fbc-suspend)
[599.389316] Starting subtest: fbc-suspend
[649.251685] Subtest fbc-suspend: SUCCESS (19.709s)
[650.630300] [120/132] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[650.726308] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[650.728565] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[650.836445] [121/132] (380s left) kms_psr (psr-cursor-mmap-gtt)
[650.923340] Starting subtest: psr-cursor-mmap-gtt
[650.924527] Starting dynamic subtest: eDP-1
[652.637398] Dynamic subtest eDP-1: SUCCESS (1.713s)
[652.638553] Subtest psr-cursor-mmap-gtt: SUCCESS (1.714s)
[653.529992] [122/132] (378s left) kms_color_pipeline (plane-lut1d)
[653.626060] Starting subtest: plane-lut1d
[653.639973] Starting dynamic subtest: pipe-A-eDP-1
[654.093564] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[654.992880] Starting dynamic subtest: pipe-B-eDP-1
[655.489864] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[656.334298] Starting dynamic subtest: pipe-C-eDP-1
[656.843802] Dynamic subtest pipe-C-eDP-1: FAIL (0.267s)
[657.672105] Starting dynamic subtest: pipe-D-eDP-1
[658.165943] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[658.199083] Subtest plane-lut1d: FAIL (4.569s)
[659.066134] [123/132] (372s left) gem_userptr_blits (readonly-pwrite-unsync)
[659.138235] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[659.293601] [124/132] (372s left) gem_close (basic)
[659.352444] Starting subtest: basic
[659.353844] Subtest basic: SUCCESS (0.000s)
[659.485685] [125/132] (372s left) kms_chamelium_color (ctm-red-to-blue)
[659.573394] Subtest ctm-red-to-blue: SKIP (0.000s)
[659.618885] [126/132] (372s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[659.843415] Starting subtest: cursor-rapid-movement-256x256
[659.847030] Starting dynamic subtest: pipe-A-eDP-1
[660.549444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[660.576156] Starting dynamic subtest: pipe-D-eDP-1
[661.755350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[661.756306] Subtest cursor-rapid-movement-256x256: SUCCESS (1.910s)
[662.628157] [127/132] (369s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[662.757276] Starting subtest: basic-flip-after-cursor-varying-size
[663.683723] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[664.563678] [128/132] (367s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[664.659758] Starting subtest: fbc-psr-sprite-mmap-gtt
[664.660773] Starting dynamic subtest: eDP-1
[664.662636] Dynamic subtest eDP-1: SKIP (0.000s)
[664.664582] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[664.753482] [129/132] (367s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[664.849392] Starting subtest: yf-tiled-16bpp-rotate-90
[664.850989] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[664.974792] [130/132] (366s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[665.073871] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[665.075872] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[665.193092] [131/132] (366s left) kms_prop_blob (blob-prop-lifetime)
[665.238864] Starting subtest: blob-prop-lifetime
[665.239884] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[665.379741] [132/132] (366s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[665.475174] Starting subtest: y-tiled-16bpp-rotate-270
[665.476911] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[665.618939] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_tiled_pread_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_fenced_exec_thrash
results: parsing output: 25/ for test: kms_chamelium_frames
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_pciid
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_pipe_stress
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_pm_backlight
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_setmode
results: parsing output: 82/ for test: kms_flip_event_leak
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_atomic
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: i915_pm_sseu
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_bad_reloc
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: gem_close
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_prop_blob
results: parsing output: 131/ for test: kms_big_fb
Done.