[56.582388] Initializing watchdogs
[56.582440]   /dev/watchdog0
[56.597251] [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]
[56.601626] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.604187] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.607530] [001/132] (960s left) gem_exec_schedule (independent)
[56.703357] Starting subtest: independent
[56.705373] Starting dynamic subtest: rcs0
[57.880298] Dynamic subtest rcs0: SUCCESS (1.187s)
[57.888556] Starting dynamic subtest: vcs0
[59.950761] Dynamic subtest vcs0: SUCCESS (2.075s)
[59.959894] Starting dynamic subtest: vcs1
[61.931918] Dynamic subtest vcs1: SUCCESS (1.984s)
[61.941681] Starting dynamic subtest: vecs0
[63.929264] Dynamic subtest vecs0: SUCCESS (1.999s)
[63.938831] Starting dynamic subtest: ccs0
[65.880640] Dynamic subtest ccs0: SUCCESS (1.952s)
[65.883385] Subtest independent: SUCCESS (9.202s)
[66.202113] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[66.307724] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[66.312267] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[66.436194] [003/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[66.546469] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[66.550721] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[66.663264] [004/132] (950s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[66.763404] Starting subtest: invalid-signal-one-illegal-handle
[66.765782] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[66.956208] [005/132] (950s left) gem_softpin (32b-excludes-last-page)
[67.168080] Starting subtest: 32b-excludes-last-page
[67.176443] Subtest 32b-excludes-last-page: SUCCESS (0.008s)
[67.614713] [006/132] (949s left) gem_mmap_gtt (basic-copy)
[67.726796] Subtest basic-copy: SKIP (0.000s)
[67.884413] [007/132] (949s left) kms_content_protection (atomic-dpms-hdcp14)
[68.106989] Starting subtest: atomic-dpms-hdcp14
[68.111708] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[68.259391] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[68.352733] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[75.195342] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.848s)
[75.355817] [009/132] (942s left) gem_mmap_gtt (coherency)
[75.416667] Subtest coherency: SKIP (0.000s)
[75.484688] [010/132] (941s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[75.576027] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[75.578303] Starting dynamic subtest: pipe-A-default-mode
[78.304650] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[78.307085] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.730s)
[79.150206] [011/132] (938s left) kms_cursor_crc (cursor-offscreen-512x170)
[79.452319] Starting subtest: cursor-offscreen-512x170
[79.456682] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[79.628290] [012/132] (937s left) perf_pmu (busy-double-start)
[79.668670] Starting subtest: busy-double-start
[79.670944] Starting dynamic subtest: rcs0
[83.314116] Dynamic subtest rcs0: FAIL (3.590s)
[83.323305] Starting dynamic subtest: bcs0
[86.832707] Dynamic subtest bcs0: SUCCESS (3.573s)
[86.840592] Starting dynamic subtest: vcs0
[92.401716] Dynamic subtest vcs0: SUCCESS (5.568s)
[92.412548] Starting dynamic subtest: vcs1
[96.413888] Dynamic subtest vcs1: SUCCESS (4.011s)
[96.422663] Starting dynamic subtest: vecs0
[100.482326] Dynamic subtest vecs0: SUCCESS (4.067s)
[100.493081] Starting dynamic subtest: ccs0
[104.121099] Dynamic subtest ccs0: FAIL (3.567s)
[104.123453] Subtest busy-double-start: FAIL (24.380s)
[104.196723] [013/132] (913s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[104.306664] Starting subtest: fbc-rgb565-draw-pwrite
[108.881644] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.578s)
[110.048756] [014/132] (907s left) gem_tiled_pread_basic
[110.181595] [015/132] (907s left) kms_psr (fbc-psr2-cursor-plane-move)
[110.281855] Starting subtest: fbc-psr2-cursor-plane-move
[110.284162] Starting dynamic subtest: eDP-1
[110.288339] Dynamic subtest eDP-1: SKIP (0.000s)
[110.292621] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[110.377764] [016/132] (907s left) gem_render_copy (y-tiled-ccs-to-linear)
[110.439358] Starting subtest: y-tiled-ccs-to-linear
[110.443713] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[110.647605] [017/132] (907s left) kms_color (ctm-0-25)
[110.752675] Starting subtest: ctm-0-25
[110.754788] Starting dynamic subtest: pipe-A-eDP-1
[114.346371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.594s)
[114.355300] Starting dynamic subtest: pipe-B-eDP-1
[118.615423] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.269s)
[118.623319] Starting dynamic subtest: pipe-C-eDP-1
[122.672582] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.056s)
[122.682219] Starting dynamic subtest: pipe-D-eDP-1
[126.653375] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.979s)
[126.655667] Subtest ctm-0-25: SUCCESS (15.901s)
[127.503697] [018/132] (890s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[128.078114] Starting subtest: syncobj-timeline-multiple-ext-nodes
[128.081241] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[129.972550] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[129.978553] [019/132] (887s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[130.087729] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[130.099901] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[130.200267] [020/132] (887s left) gem_mmap_gtt (fault-concurrent-y)
[130.259499] Subtest fault-concurrent-Y: SKIP (0.000s)
[130.318875] [021/132] (887s left) syncobj_timeline (reset-signaled)
[130.374857] Starting subtest: reset-signaled
[130.377198] Subtest reset-signaled: SUCCESS (0.000s)
[130.496145] [022/132] (887s left) kms_lease (simple-lease)
[130.596895] Starting subtest: simple-lease
[130.599129] Starting dynamic subtest: pipe-A-eDP-1
[131.132815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[131.140429] Starting dynamic subtest: pipe-B-eDP-1
[132.527232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[132.535573] Starting dynamic subtest: pipe-C-eDP-1
[133.921666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[133.930279] Starting dynamic subtest: pipe-D-eDP-1
[135.321312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[135.323855] Subtest simple-lease: SUCCESS (4.725s)
[136.156511] [023/132] (881s left) gem_exec_whisper (basic-queues-priority-all)
[136.232047] Starting subtest: basic-queues-priority-all
[158.118081] Subtest basic-queues-priority-all: SUCCESS (21.884s)
[158.327274] [024/132] (859s left) gem_exec_balancer (parallel-ordering)
[158.595989] Starting subtest: parallel-ordering
[159.546512] Subtest parallel-ordering: SUCCESS (0.953s)
[159.716276] [025/132] (858s left) gem_fenced_exec_thrash (too-many-fences)
[159.772343] Subtest too-many-fences: SKIP (0.000s)
[159.837460] [026/132] (858s left) kms_chamelium_frames (dp-crc-single)
[160.227813] Subtest dp-crc-single: SKIP (0.000s)
[161.035282] [027/132] (857s left) kms_big_fb (linear-16bpp-rotate-90)
[161.139714] Starting subtest: linear-16bpp-rotate-90
[161.158930] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[161.308102] [028/132] (856s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[161.415665] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[161.419774] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[161.544817] [029/132] (856s left) api_intel_bb (crc32)
[161.605091] Starting subtest: crc32
[161.607039] Starting dynamic subtest: rcs0-smem0
[161.901775] Dynamic subtest rcs0-smem0: SUCCESS (0.297s)
[161.912586] Starting dynamic subtest: bcs0-smem0
[162.232093] Dynamic subtest bcs0-smem0: SUCCESS (0.328s)
[162.242974] Starting dynamic subtest: vcs0-smem0
[162.608349] Dynamic subtest vcs0-smem0: SUCCESS (0.375s)
[162.618817] Starting dynamic subtest: vcs1-smem0
[162.912841] Dynamic subtest vcs1-smem0: SUCCESS (0.303s)
[162.922373] Starting dynamic subtest: vecs0-smem0
[163.178304] Dynamic subtest vecs0-smem0: SUCCESS (0.264s)
[163.187316] Starting dynamic subtest: ccs0-smem0
[163.540507] Dynamic subtest ccs0-smem0: SUCCESS (0.360s)
[163.543213] Subtest crc32: SUCCESS (1.937s)
[163.696032] [030/132] (854s left) kms_psr (fbc-pr-sprite-plane-onoff)
[163.787079] Starting subtest: fbc-pr-sprite-plane-onoff
[163.791126] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[163.880741] [031/132] (854s left) gem_eio (wait-1us)
[164.098111] Starting subtest: wait-1us
[164.422465] Subtest wait-1us: SUCCESS (0.324s)
[164.601939] [032/132] (853s left) kms_feature_discovery (chamelium)
[164.696107] Starting subtest: chamelium
[164.699791] Subtest chamelium: SKIP (0.000s)
[164.790267] [033/132] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[164.884810] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[164.888121] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[165.008160] [034/132] (853s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[165.105338] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[165.107361] Starting dynamic subtest: A-eDP1
[168.667045] Dynamic subtest A-eDP1: SUCCESS (3.562s)
[168.677789] Starting dynamic subtest: B-eDP1
[171.870632] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[171.879889] Starting dynamic subtest: C-eDP1
[174.984112] Dynamic subtest C-eDP1: SUCCESS (3.113s)
[174.994653] Starting dynamic subtest: D-eDP1
[178.070886] Dynamic subtest D-eDP1: SUCCESS (3.085s)
[178.073063] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.969s)
[178.908441] [035/132] (839s left) i915_pciid
[179.102838] [036/132] (839s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[179.198857] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[179.201105] Starting dynamic subtest: pipe-A
[179.535630] Dynamic subtest pipe-A: SUCCESS (0.339s)
[179.548536] Starting dynamic subtest: pipe-B
[181.002677] Dynamic subtest pipe-B: SUCCESS (1.465s)
[181.011540] Starting dynamic subtest: pipe-C
[182.406294] Dynamic subtest pipe-C: SUCCESS (1.402s)
[182.421274] Starting dynamic subtest: pipe-D
[183.843182] Dynamic subtest pipe-D: SUCCESS (1.436s)
[183.845766] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.647s)
[185.037429] [037/132] (833s left) gem_exec_flush (basic-wb-ro-before-default)
[185.106904] Starting subtest: basic-wb-ro-before-default
[190.553474] Subtest basic-wb-ro-before-default: SUCCESS (5.448s)
[190.758712] [038/132] (827s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[190.852420] Starting subtest: 4-tiled-8bpp-rotate-180
[192.079258] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.227s)
[192.245885] [039/132] (826s left) kms_pipe_stress (stress-xrgb8888-untiled)
[192.338953] Starting subtest: stress-xrgb8888-untiled
[198.279193] Subtest stress-xrgb8888-untiled: SUCCESS (5.942s)
[198.329433] [040/132] (820s left) gem_exec_reloc (basic-cpu-wc-active)
[198.398926] Subtest basic-cpu-wc-active: SKIP (0.000s)
[198.494966] [041/132] (820s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[198.623990] Starting subtest: verify-pxp-key-change-after-suspend-resume
[210.309688] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (11.687s)
[210.471519] [042/132] (808s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[210.587258] Starting subtest: primary-yf-tiled-reflect-x-90
[210.591612] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[210.684717] [043/132] (808s left) api_intel_bb (blit-noreloc-keep-cache)
[210.742592] Starting subtest: blit-noreloc-keep-cache
[210.751769] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[210.867663] [044/132] (807s left) kms_pm_backlight (fade-with-suspend)
[210.962111] Starting subtest: fade-with-suspend
[227.208479] Starting dynamic subtest: eDP-1
[229.873728] Dynamic subtest eDP-1: SUCCESS (2.708s)
[229.876149] Subtest fade-with-suspend: SUCCESS (3.936s)
[230.696694] [045/132] (788s left) kms_addfb_basic (small-bo)
[230.802565] Starting subtest: small-bo
[230.804438] Subtest small-bo: SUCCESS (0.000s)
[230.927965] [046/132] (787s left) gem_userptr_blits (mmap-offset-banned)
[230.991149] Starting subtest: mmap-offset-banned
[230.993538] Starting dynamic subtest: wb
[230.995860] Dynamic subtest wb: SUCCESS (0.000s)
[231.007398] Starting dynamic subtest: wc
[231.009238] Dynamic subtest wc: SUCCESS (0.000s)
[231.017904] Starting dynamic subtest: uc
[231.019792] Dynamic subtest uc: SUCCESS (0.000s)
[231.021664] Subtest mmap-offset-banned: SUCCESS (0.002s)
[231.160171] [047/132] (787s left) kms_invalid_mode (zero-vdisplay)
[231.258946] Starting subtest: zero-vdisplay
[231.261191] Starting dynamic subtest: pipe-A-eDP-1
[231.538718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[231.548159] Starting dynamic subtest: pipe-B-eDP-1
[231.550029] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[231.558983] Starting dynamic subtest: pipe-C-eDP-1
[231.561132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[231.570002] Starting dynamic subtest: pipe-D-eDP-1
[231.572091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[231.574251] Subtest zero-vdisplay: SUCCESS (0.289s)
[232.417713] [048/132] (786s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[232.509353] Starting subtest: psr-rgb101010-draw-pwrite
[240.159666] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.687s)
[240.296163] [049/132] (778s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[240.401767] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[240.404091] Starting dynamic subtest: pipe-A-eDP-1
[240.462716] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[240.473448] Starting dynamic subtest: pipe-B-eDP-1
[240.534483] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[240.544370] Starting dynamic subtest: pipe-C-eDP-1
[240.600759] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[240.611905] Starting dynamic subtest: pipe-D-eDP-1
[240.667742] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[240.671833] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[242.640407] [050/132] (776s left) kms_cursor_crc (cursor-sliding-max-size)
[242.949359] Starting subtest: cursor-sliding-max-size
[242.956042] Subtest cursor-sliding-max-size: SKIP (0.000s)
[243.161459] [051/132] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[243.257009] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[243.261357] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[243.375910] [052/132] (775s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[243.437180] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[243.541661] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[243.642786] [053/132] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[243.751601] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[243.756164] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[243.881211] [054/132] (775s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[243.989387] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[243.991532] Starting dynamic subtest: pipe-A-eDP-1
[244.013345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.024606] Starting dynamic subtest: pipe-B-eDP-1
[244.045377] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.054238] Starting dynamic subtest: pipe-C-eDP-1
[244.074948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.084010] Starting dynamic subtest: pipe-D-eDP-1
[244.105569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.109547] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[246.211108] [055/132] (773s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[246.316183] Starting subtest: x-tiled-16bpp-rotate-90
[246.336022] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[246.495950] [056/132] (772s left) kms_plane (plane-panning-top-left)
[246.592542] Starting subtest: plane-panning-top-left
[246.594728] Starting dynamic subtest: pipe-A
[248.239366] Dynamic subtest pipe-A: SUCCESS (1.648s)
[248.250721] Starting dynamic subtest: pipe-B
[250.614152] Dynamic subtest pipe-B: SUCCESS (2.378s)
[250.616878] Subtest plane-panning-top-left: SUCCESS (4.029s)
[251.436242] [057/132] (767s left) kms_getfb (getfb-handle-zero)
[251.550040] Starting subtest: getfb-handle-zero
[251.552248] Subtest getfb-handle-zero: SUCCESS (0.000s)
[251.698560] [058/132] (767s left) kms_flip (dpms-vs-vblank-race-interruptible)
[251.798005] Starting subtest: dpms-vs-vblank-race-interruptible
[251.800382] Starting dynamic subtest: A-eDP1
[255.606678] Dynamic subtest A-eDP1: SUCCESS (3.809s)
[255.616774] Starting dynamic subtest: B-eDP1
[260.221095] Dynamic subtest B-eDP1: SUCCESS (4.614s)
[260.231071] Starting dynamic subtest: C-eDP1
[264.810625] Dynamic subtest C-eDP1: SUCCESS (4.587s)
[264.820116] Starting dynamic subtest: D-eDP1
[269.455139] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[269.457488] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.658s)
[270.358491] [059/132] (749s left) kms_addfb_basic (bad-pitch-256)
[270.418206] Starting subtest: bad-pitch-256
[270.420227] Subtest bad-pitch-256: SUCCESS (0.000s)
[270.562302] [060/132] (748s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[270.652257] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[270.654528] Starting dynamic subtest: pipe-A-eDP-1
[271.483231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[271.498016] Starting dynamic subtest: pipe-B-eDP-1
[273.133109] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.646s)
[273.143413] Starting dynamic subtest: pipe-C-eDP-1
[274.680733] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.548s)
[274.690647] Starting dynamic subtest: pipe-D-eDP-1
[276.191893] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[276.193833] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.532s)
[277.366132] [061/132] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[277.470727] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[277.475109] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[277.603792] [062/132] (741s left) vgem_basic (busy-fence)
[277.646184] Starting subtest: busy-fence
[277.648413] Subtest busy-fence: SUCCESS (0.000s)
[277.728483] [063/132] (741s left) gem_ctx_shared (detached-shared-gtt)
[277.797855] Starting subtest: detached-shared-gtt
[279.950428] Subtest detached-shared-gtt: SUCCESS (2.152s)
[280.369680] [064/132] (739s left) kms_atomic_interruptible (legacy-dpms)
[280.481373] Starting subtest: legacy-dpms
[280.483980] Starting dynamic subtest: pipe-A-eDP-1
[287.872768] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.392s)
[287.874658] Subtest legacy-dpms: SUCCESS (7.394s)
[288.716927] [065/132] (731s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[293.679586] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[293.681891] Starting dynamic subtest: pipe-A-eDP-1
[294.475345] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[294.485368] Starting dynamic subtest: pipe-B-eDP-1
[295.609843] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[295.614234] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.930s)
[296.824109] [066/132] (722s left) kms_cursor_legacy (torture-bo)
[296.948406] Starting subtest: torture-bo
[296.950563] Starting dynamic subtest: pipe-A
[303.212439] Dynamic subtest pipe-A: SUCCESS (6.264s)
[303.224993] Starting dynamic subtest: pipe-B
[309.854045] Dynamic subtest pipe-B: SUCCESS (6.642s)
[309.866265] Starting dynamic subtest: pipe-C
[315.569797] Dynamic subtest pipe-C: SUCCESS (5.717s)
[315.583898] Starting dynamic subtest: pipe-D
[321.141307] Dynamic subtest pipe-D: SUCCESS (5.571s)
[321.154767] Starting dynamic subtest: all-pipes
[327.722655] Dynamic subtest all-pipes: SUCCESS (6.575s)
[327.725354] Subtest torture-bo: SUCCESS (30.780s)
[327.904193] [067/132] (691s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[328.006865] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[334.876111] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.868s)
[335.026534] [068/132] (684s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[335.130920] Starting subtest: fbcpsr-shrfb-scaledprimary
[340.924342] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.794s)
[341.082034] [069/132] (678s left) gem_ppgtt (shrink-vs-evict-pinned)
[341.134270] Starting subtest: shrink-vs-evict-pinned
[346.896330] Subtest shrink-vs-evict-pinned: SUCCESS (5.759s)
[346.980682] [070/132] (672s left) kms_flip (flip-vs-blocking-wf-vblank)
[347.072655] Starting subtest: flip-vs-blocking-wf-vblank
[347.074915] Starting dynamic subtest: A-eDP1
[355.992737] Dynamic subtest A-eDP1: SUCCESS (8.919s)
[356.005921] Starting dynamic subtest: B-eDP1
[364.913275] Dynamic subtest B-eDP1: SUCCESS (8.918s)
[364.924086] Starting dynamic subtest: C-eDP1
[373.835488] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[373.846492] Starting dynamic subtest: D-eDP1
[382.752981] Dynamic subtest D-eDP1: SUCCESS (8.916s)
[382.755509] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.684s)
[384.002081] [071/132] (635s left) syncobj_timeline (wait-all-interrupted)
[384.052576] Starting subtest: wait-all-interrupted
[384.153348] Subtest wait-all-interrupted: SUCCESS (0.102s)
[384.259730] [072/132] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[384.356827] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[391.228027] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.876s)
[391.402465] [073/132] (628s left) gem_mmap_gtt (cpuset-big-copy)
[391.459215] Subtest cpuset-big-copy: SKIP (0.000s)
[391.528517] [074/132] (628s left) kms_hdr (invalid-metadata-sizes)
[391.627253] Starting subtest: invalid-metadata-sizes
[391.633242] Subtest invalid-metadata-sizes: SKIP (0.000s)
[391.723627] [075/132] (628s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[391.825667] Starting subtest: plane-all-modeset-transition-fencing
[391.830053] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[391.942999] [076/132] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[392.042922] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[398.739598] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.700s)
[398.931859] [077/132] (621s left) gem_exec_reloc (basic-concurrent16)
[398.997136] Subtest basic-concurrent16: SKIP (0.000s)
[399.087074] [078/132] (621s left) kms_pm_rpm (legacy-planes-dpms)
[401.108366] Starting subtest: legacy-planes-dpms
[401.111162] Starting dynamic subtest: plane-63
[409.773575] Dynamic subtest plane-63: SUCCESS (8.666s)
[409.787924] Starting dynamic subtest: plane-93
[418.066400] Dynamic subtest plane-93: SUCCESS (8.292s)
[418.078700] Starting dynamic subtest: plane-123
[426.627052] Dynamic subtest plane-123: SUCCESS (8.561s)
[426.638451] Starting dynamic subtest: plane-133
[435.047815] Dynamic subtest plane-133: SUCCESS (8.420s)
[435.050327] Subtest legacy-planes-dpms: SUCCESS (33.949s)
[435.456729] [079/132] (584s left) kms_selftest (drm_cmdline_parser)
[435.498063] Starting subtest: drm_cmdline_parser
[435.538174] Starting dynamic subtest: drm_test_cmdline_force_d_only
[435.663283] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.123s)
[435.674399] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[435.804721] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.142s)
[435.813789] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[435.931499] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.125s)
[435.940313] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[436.035335] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.103s)
[436.045958] Starting dynamic subtest: drm_test_cmdline_force_e_only
[436.190319] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.154s)
[436.199466] Starting dynamic subtest: drm_test_cmdline_res
[436.340375] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.149s)
[436.351078] Starting dynamic subtest: drm_test_cmdline_res_vesa
[436.473780] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.135s)
[436.482938] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[436.611836] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.136s)
[436.620785] Starting dynamic subtest: drm_test_cmdline_res_rblank
[436.731472] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.117s)
[436.742247] Starting dynamic subtest: drm_test_cmdline_res_bpp
[436.859777] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.129s)
[436.869112] Starting dynamic subtest: drm_test_cmdline_res_refresh
[437.007751] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.147s)
[437.017119] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[437.123715] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.116s)
[437.132872] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[437.277088] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.152s)
[437.297206] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[437.430682] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.151s)
[437.450109] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[437.562700] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.131s)
[437.582447] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[437.691606] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.128s)
[437.713104] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[437.823160] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.131s)
[437.843456] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[437.931646] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.110s)
[437.942166] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[438.072149] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.139s)
[438.083381] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[438.195351] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.122s)
[438.205943] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[438.321751] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.127s)
[438.330969] Starting dynamic subtest: drm_test_cmdline_name
[438.479816] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.156s)
[438.489136] Starting dynamic subtest: drm_test_cmdline_name_bpp
[438.608239] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.124s)
[438.620379] Starting dynamic subtest: drm_test_cmdline_name_option
[438.718556] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.111s)
[438.729624] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[438.846348] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.126s)
[438.857613] Starting dynamic subtest: drm_test_cmdline_rotate_0
[438.989681] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.143s)
[438.998998] Starting dynamic subtest: drm_test_cmdline_rotate_90
[439.094802] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.105s)
[439.104207] Starting dynamic subtest: drm_test_cmdline_rotate_180
[439.233622] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.137s)
[439.242947] Starting dynamic subtest: drm_test_cmdline_rotate_270
[439.364329] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.128s)
[439.373963] Starting dynamic subtest: drm_test_cmdline_hmirror
[439.490848] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.127s)
[439.501957] Starting dynamic subtest: drm_test_cmdline_vmirror
[439.629378] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.137s)
[439.638436] Starting dynamic subtest: drm_test_cmdline_margin_options
[439.769577] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.140s)
[439.780473] Starting dynamic subtest: drm_test_cmdline_multiple_options
[439.900395] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.130s)
[439.911475] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[440.030528] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.130s)
[440.041941] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[440.174725] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.141s)
[440.185863] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[440.314575] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.139s)
[440.325617] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[440.460966] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.146s)
[440.471592] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[440.580192] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.118s)
[440.590369] Starting dynamic subtest: drm_test_cmdline_invalid
[440.722431] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.142s)
[440.731644] Starting dynamic subtest: drm_test_cmdline_tv_options
[440.891329] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.168s)
[440.893364] Subtest drm_cmdline_parser: SUCCESS (5.394s)
[441.126903] [080/132] (579s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[441.213613] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[441.215891] Starting dynamic subtest: pipe-A-eDP-1
[441.238997] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.249367] Starting dynamic subtest: pipe-B-eDP-1
[441.271638] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.281485] Starting dynamic subtest: pipe-C-eDP-1
[441.304808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.315808] Starting dynamic subtest: pipe-D-eDP-1
[441.339145] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.343276] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[443.509861] [081/132] (576s left) kms_psr (psr2-sprite-blt)
[443.599495] Starting subtest: psr2-sprite-blt
[443.601799] Starting dynamic subtest: eDP-1
[445.280607] Dynamic subtest eDP-1: SUCCESS (1.681s)
[445.282913] Subtest psr2-sprite-blt: SUCCESS (1.682s)
[446.172125] [082/132] (574s left) kms_setmode (invalid-clone-exclusive-crtc)
[446.225004] Starting subtest: invalid-clone-exclusive-crtc
[446.231623] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[446.352687] [083/132] (574s left) kms_flip_event_leak (basic)
[446.446083] Starting subtest: basic
[446.447914] Starting dynamic subtest: pipe-A-eDP-1
[446.865174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[446.874947] Starting dynamic subtest: pipe-B-eDP-1
[447.966065] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[447.976343] Starting dynamic subtest: pipe-C-eDP-1
[449.072927] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[449.083194] Starting dynamic subtest: pipe-D-eDP-1
[450.202012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[450.204498] Subtest basic: SUCCESS (3.759s)
[451.094962] [084/132] (569s left) gem_workarounds (basic-read)
[451.173902] Starting subtest: basic-read
[451.182644] Subtest basic-read: SUCCESS (0.012s)
[451.333786] [085/132] (569s left) dmabuf_sync_file (import-multiple-read-only)
[451.375960] Starting subtest: import-multiple-read-only
[451.378261] Subtest import-multiple-read-only: SUCCESS (0.003s)
[451.452716] [086/132] (569s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[451.547364] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[451.917804] Starting dynamic subtest: pipe-A-eDP-1
[454.648941] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.728s)
[455.030491] Starting dynamic subtest: pipe-B-eDP-1
[457.778397] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[458.150833] Starting dynamic subtest: pipe-C-eDP-1
[460.914168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[461.280699] Starting dynamic subtest: pipe-D-eDP-1
[464.050943] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[464.053750] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.500s)
[465.263291] [087/132] (555s left) kms_atomic (plane-overlay-legacy)
[465.348578] Starting subtest: plane-overlay-legacy
[465.350846] Starting dynamic subtest: pipe-A-eDP-1
[465.761995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[465.763934] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[466.604398] [088/132] (554s left) gem_exec_balancer (parallel-balancer)
[466.867453] Starting subtest: parallel-balancer
[467.738743] Subtest parallel-balancer: SUCCESS (0.871s)
[467.872423] [089/132] (552s left) gem_mmap_gtt (basic-write-gtt)
[467.938796] Subtest basic-write-gtt: SKIP (0.000s)
[468.009623] [090/132] (552s left) perf_pmu (render-node-busy)
[468.099072] Starting subtest: render-node-busy
[468.101536] Starting dynamic subtest: rcs0
[468.699040] Dynamic subtest rcs0: SUCCESS (0.602s)
[468.712097] Starting dynamic subtest: bcs0
[469.256418] Dynamic subtest bcs0: SUCCESS (0.555s)
[469.269147] Starting dynamic subtest: vcs0
[470.896901] Dynamic subtest vcs0: SUCCESS (1.636s)
[470.910127] Starting dynamic subtest: vcs1
[472.881456] Dynamic subtest vcs1: SUCCESS (1.981s)
[472.895104] Starting dynamic subtest: vecs0
[474.928366] Dynamic subtest vecs0: SUCCESS (2.044s)
[474.941117] Starting dynamic subtest: ccs0
[475.499783] Dynamic subtest ccs0: SUCCESS (0.570s)
[475.502475] Subtest render-node-busy: SUCCESS (7.403s)
[475.602409] [091/132] (545s left) i915_pm_rpm (system-suspend-execbuf)
[477.126518] Starting subtest: system-suspend-execbuf
[535.041894] Subtest system-suspend-execbuf: SUCCESS (43.042s)
[535.449648] [092/132] (485s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[540.485778] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[540.488176] Starting dynamic subtest: pipe-A-eDP-1
[547.024896] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.539s)
[547.035607] Starting dynamic subtest: pipe-B-eDP-1
[553.672871] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.648s)
[553.675191] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.192s)
[554.571967] [093/132] (466s left) kms_vblank (wait-forked)
[554.674718] Starting subtest: wait-forked
[554.676908] Starting dynamic subtest: pipe-A-eDP-1
[556.470913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s)
[556.485340] Starting dynamic subtest: pipe-D-eDP-1
[558.937968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s)
[558.940305] Subtest wait-forked: SUCCESS (4.267s)
[559.841625] [094/132] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[559.945186] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[559.949416] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[560.090341] [095/132] (460s left) gen9_exec_parse (allowed-single)
[560.156597] Subtest allowed-single: SKIP (0.000s)
[560.243630] [096/132] (460s left) syncobj_eventfd (timeline-wait)
[560.299423] Starting subtest: timeline-wait
[560.310244] Subtest timeline-wait: SUCCESS (0.011s)
[560.447304] [097/132] (460s left) kms_vblank (ts-continuation-modeset-rpm)
[560.547009] Starting subtest: ts-continuation-modeset-rpm
[560.549135] Starting dynamic subtest: pipe-A-eDP-1
[563.032582] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.484s)
[563.047913] Starting dynamic subtest: pipe-D-eDP-1
[565.266146] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.235s)
[565.268539] Subtest ts-continuation-modeset-rpm: SUCCESS (4.723s)
[566.080572] [098/132] (455s left) sw_sync (sync_busy)
[566.117781] Starting subtest: sync_busy
[566.120184] Subtest sync_busy: SUCCESS (0.002s)
[566.202824] [099/132] (454s left) gem_ctx_persistence (engines-persistence)
[566.272427] Starting subtest: engines-persistence
[566.274786] Starting dynamic subtest: rcs0
[567.106687] Dynamic subtest rcs0: SUCCESS (0.834s)
[567.125201] Starting dynamic subtest: bcs0
[567.873524] Dynamic subtest bcs0: SUCCESS (0.765s)
[567.886208] Starting dynamic subtest: vcs0
[568.655393] Dynamic subtest vcs0: SUCCESS (0.780s)
[568.668460] Starting dynamic subtest: vcs1
[569.485457] Dynamic subtest vcs1: SUCCESS (0.828s)
[569.497974] Starting dynamic subtest: vecs0
[570.313128] Dynamic subtest vecs0: SUCCESS (0.826s)
[570.325652] Starting dynamic subtest: ccs0
[571.080433] Dynamic subtest ccs0: SUCCESS (0.765s)
[571.083204] Subtest engines-persistence: SUCCESS (4.811s)
[571.186647] [100/132] (450s left) syncobj_basic (bad-handle-to-fd)
[571.249979] Starting subtest: bad-handle-to-fd
[571.252120] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[571.384172] [101/132] (449s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[571.461789] Starting subtest: yf-tiled-to-vebox-x-tiled
[571.466335] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[571.672275] [102/132] (449s left) syncobj_timeline (invalid-wait-illegal-handle)
[571.727131] Starting subtest: invalid-wait-illegal-handle
[571.729364] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[571.871597] [103/132] (449s left) i915_drm_fdinfo (memory-info-idle)
[571.913259] Starting subtest: memory-info-idle
[571.916032] Starting dynamic subtest: smem0
[571.966508] Dynamic subtest smem0: SUCCESS (0.056s)
[571.969429] Subtest memory-info-idle: SUCCESS (0.057s)
[572.071343] [104/132] (449s left) gem_softpin (noreloc)
[572.134815] Starting subtest: noreloc
[577.539553] Subtest noreloc: SUCCESS (5.406s)
[577.716299] [105/132] (443s left) i915_pm_sseu (full-enable)
[577.788613] Subtest full-enable: SKIP (0.000s)
[577.914355] [106/132] (443s left) gem_ctx_engines (execute-oneforall)
[577.977889] Starting subtest: execute-oneforall
[578.918591] Subtest execute-oneforall: SUCCESS (0.940s)
[580.043438] [107/132] (441s left) gem_exec_whisper (basic-normal)
[580.116145] Starting subtest: basic-normal
[585.232029] Subtest basic-normal: SUCCESS (5.118s)
[585.450137] [108/132] (436s left) syncobj_basic (bad-flags-handle-to-fd)
[585.515213] Starting subtest: bad-flags-handle-to-fd
[585.517641] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[585.666742] [109/132] (435s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[585.768968] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[585.773195] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[585.895380] [110/132] (435s left) gem_exec_schedule (thriceslice)
[585.977413] Starting subtest: thriceslice
[585.980219] Starting dynamic subtest: rcs0
[585.997687] Dynamic subtest rcs0: SUCCESS (0.031s)
[586.009982] Starting dynamic subtest: bcs0
[586.027760] Dynamic subtest bcs0: SUCCESS (0.029s)
[586.039579] Starting dynamic subtest: vcs0
[586.080868] Dynamic subtest vcs0: SUCCESS (0.050s)
[586.096589] Starting dynamic subtest: vcs1
[586.112323] Dynamic subtest vcs1: SUCCESS (0.029s)
[586.123976] Starting dynamic subtest: vecs0
[586.141901] Dynamic subtest vecs0: SUCCESS (0.028s)
[586.151103] Starting dynamic subtest: ccs0
[586.171947] Dynamic subtest ccs0: SUCCESS (0.029s)
[586.174107] Subtest thriceslice: SUCCESS (0.206s)
[586.495275] [111/132] (435s left) syncobj_wait (multi-wait-submitted-signaled)
[586.559862] Starting subtest: multi-wait-submitted-signaled
[586.562329] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[586.692893] [112/132] (435s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[586.810399] Starting subtest: yf-tiled-8bpp-rotate-270
[586.815066] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[586.937911] [113/132] (434s left) gem_userptr_blits (access-control)
[587.015108] Starting subtest: access-control
[587.019281] Subtest access-control: SKIP (0.000s)
[587.184762] [114/132] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[587.305893] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[590.932837] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.632s)
[592.161883] [115/132] (429s left) gem_ctx_persistence (idempotent)
[592.233938] Starting subtest: idempotent
[592.236336] Subtest idempotent: SUCCESS (0.000s)
[592.396104] [116/132] (429s left) kms_flip (2x-flip-vs-fences-interruptible)
[592.490857] Starting subtest: 2x-flip-vs-fences-interruptible
[592.495122] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[592.636526] [117/132] (429s left) gem_userptr_blits (map-fixed-invalidate)
[592.721838] Starting subtest: map-fixed-invalidate
[592.726244] Subtest map-fixed-invalidate: SKIP (0.000s)
[592.900764] [118/132] (429s left) gem_bad_reloc (negative-reloc-lut)
[592.968384] Subtest negative-reloc-lut: SKIP (0.000s)
[593.059515] [119/132] (429s left) kms_fbcon_fbt (fbc-suspend)
[593.121305] Starting subtest: fbc-suspend
[642.572663] Subtest fbc-suspend: SUCCESS (19.478s)
[643.885297] [120/132] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[643.987132] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[643.991218] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[644.129824] [121/132] (378s left) kms_psr (psr-cursor-mmap-gtt)
[644.222540] Starting subtest: psr-cursor-mmap-gtt
[644.224711] Starting dynamic subtest: eDP-1
[645.891982] Dynamic subtest eDP-1: SUCCESS (1.678s)
[645.894219] Subtest psr-cursor-mmap-gtt: SUCCESS (1.679s)
[646.778599] [122/132] (375s left) kms_color_pipeline (plane-lut1d)
[646.880713] Starting subtest: plane-lut1d
[646.893398] Starting dynamic subtest: pipe-A-eDP-1
[647.587679] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[648.220209] Starting dynamic subtest: pipe-B-eDP-1
[649.039163] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[649.648286] Starting dynamic subtest: pipe-C-eDP-1
[650.468789] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[650.975837] Starting dynamic subtest: pipe-D-eDP-1
[651.815675] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[651.818014] Subtest plane-lut1d: FAIL (4.646s)
[652.376590] [123/132] (369s left) gem_userptr_blits (readonly-pwrite-unsync)
[652.455549] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[652.611096] [124/132] (369s left) gem_close (basic)
[652.675365] Starting subtest: basic
[652.677319] Subtest basic: SUCCESS (0.000s)
[652.810946] [125/132] (369s left) kms_chamelium_color (ctm-red-to-blue)
[652.904534] Subtest ctm-red-to-blue: SKIP (0.000s)
[652.953914] [126/132] (369s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[653.192211] Starting subtest: cursor-rapid-movement-256x256
[653.197045] Starting dynamic subtest: pipe-A-eDP-1
[653.738951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[653.764566] Starting dynamic subtest: pipe-D-eDP-1
[654.944545] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s)
[654.946813] Subtest cursor-rapid-movement-256x256: SUCCESS (1.755s)
[655.826703] [127/132] (366s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[655.944925] Starting subtest: basic-flip-after-cursor-varying-size
[656.871498] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.929s)
[657.754271] [128/132] (364s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[657.852562] Starting subtest: fbc-psr-sprite-mmap-gtt
[657.854755] Starting dynamic subtest: eDP-1
[657.858801] Dynamic subtest eDP-1: SKIP (0.000s)
[657.862871] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[657.950122] [129/132] (364s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[658.036246] Starting subtest: yf-tiled-16bpp-rotate-90
[658.040722] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[658.168015] [130/132] (364s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[658.259044] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[658.263147] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[658.373904] [131/132] (364s left) kms_prop_blob (blob-prop-lifetime)
[658.425799] Starting subtest: blob-prop-lifetime
[658.427743] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[658.568399] [132/132] (364s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[658.671096] Starting subtest: y-tiled-16bpp-rotate-270
[658.674867] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[658.792146] 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.