[57.848263] Initializing watchdogs
[57.848317]   /dev/watchdog0
[57.862822] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.867175] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.869807] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.873663] [001/132] (960s left) gem_exec_schedule (independent)
[57.982115] Starting subtest: independent
[57.984340] Starting dynamic subtest: rcs0
[59.927235] Dynamic subtest rcs0: SUCCESS (1.941s)
[59.937945] Starting dynamic subtest: vcs0
[61.952606] Dynamic subtest vcs0: SUCCESS (2.019s)
[61.960060] Starting dynamic subtest: vcs1
[63.915512] Dynamic subtest vcs1: SUCCESS (1.958s)
[63.923434] Starting dynamic subtest: vecs0
[65.926227] Dynamic subtest vecs0: SUCCESS (2.007s)
[65.936949] Starting dynamic subtest: ccs0
[67.982720] Dynamic subtest ccs0: SUCCESS (2.053s)
[67.985394] Subtest independent: SUCCESS (9.982s)
[68.302411] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[68.405510] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[68.409767] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[68.548044] [003/132] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[68.656787] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[68.661227] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.777022] [004/132] (949s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[68.840527] Starting subtest: invalid-signal-one-illegal-handle
[68.842896] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[68.949467] [005/132] (949s left) gem_softpin (32b-excludes-last-page)
[69.011363] Starting subtest: 32b-excludes-last-page
[69.015958] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[69.155878] [006/132] (949s left) gem_mmap_gtt (basic-copy)
[69.208871] Subtest basic-copy: SKIP (0.000s)
[69.274381] [007/132] (949s left) kms_content_protection (atomic-dpms-hdcp14)
[69.404679] Starting subtest: atomic-dpms-hdcp14
[69.408324] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[69.545021] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[69.644142] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[76.555099] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.910s)
[76.738187] [009/132] (941s left) gem_mmap_gtt (coherency)
[76.805146] Subtest coherency: SKIP (0.000s)
[76.877119] [010/132] (941s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[76.985162] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[76.987472] Starting dynamic subtest: pipe-A-default-mode
[79.757534] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[79.759746] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.772s)
[80.625769] [011/132] (938s left) kms_cursor_crc (cursor-offscreen-512x170)
[80.927706] Starting subtest: cursor-offscreen-512x170
[80.932044] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[81.104639] [012/132] (937s left) perf_pmu (busy-double-start)
[81.148803] Starting subtest: busy-double-start
[81.151225] Starting dynamic subtest: rcs0
[84.791680] Dynamic subtest rcs0: FAIL (3.587s)
[84.801075] Starting dynamic subtest: bcs0
[88.304799] Dynamic subtest bcs0: SUCCESS (3.566s)
[88.312983] Starting dynamic subtest: vcs0
[92.473973] Dynamic subtest vcs0: SUCCESS (4.167s)
[92.484316] Starting dynamic subtest: vcs1
[96.433662] Dynamic subtest vcs1: SUCCESS (3.959s)
[96.443614] Starting dynamic subtest: vecs0
[100.464827] Dynamic subtest vecs0: SUCCESS (4.030s)
[100.474792] Starting dynamic subtest: ccs0
[104.099865] Dynamic subtest ccs0: FAIL (3.565s)
[104.102244] Subtest busy-double-start: FAIL (22.878s)
[104.171878] [013/132] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[104.282485] Starting subtest: fbc-rgb565-draw-pwrite
[108.945069] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.665s)
[110.124849] [014/132] (908s left) gem_tiled_pread_basic
[110.259703] [015/132] (908s left) kms_psr (fbc-psr2-cursor-plane-move)
[110.363235] Starting subtest: fbc-psr2-cursor-plane-move
[110.365476] Starting dynamic subtest: eDP-1
[110.369800] Dynamic subtest eDP-1: SKIP (0.000s)
[110.374261] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[110.453277] [016/132] (908s left) gem_render_copy (y-tiled-ccs-to-linear)
[110.518318] Starting subtest: y-tiled-ccs-to-linear
[110.522877] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[110.719434] [017/132] (908s left) kms_color (ctm-0-25)
[110.824357] Starting subtest: ctm-0-25
[110.826796] Starting dynamic subtest: pipe-A-eDP-1
[114.254238] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[114.263173] Starting dynamic subtest: pipe-B-eDP-1
[118.522899] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.268s)
[118.531499] Starting dynamic subtest: pipe-C-eDP-1
[122.563885] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.039s)
[122.572745] Starting dynamic subtest: pipe-D-eDP-1
[126.633370] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.069s)
[126.635700] Subtest ctm-0-25: SUCCESS (15.805s)
[127.492909] [018/132] (891s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[128.098854] Starting subtest: syncobj-timeline-multiple-ext-nodes
[128.101560] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[130.007427] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[130.010284] [019/132] (889s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[130.110168] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[130.122782] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[130.223262] [020/132] (888s left) gem_mmap_gtt (fault-concurrent-y)
[130.276368] Subtest fault-concurrent-Y: SKIP (0.000s)
[130.346156] [021/132] (888s left) syncobj_timeline (reset-signaled)
[130.407184] Starting subtest: reset-signaled
[130.409456] Subtest reset-signaled: SUCCESS (0.000s)
[130.519865] [022/132] (888s left) kms_lease (simple-lease)
[130.617320] Starting subtest: simple-lease
[130.619604] Starting dynamic subtest: pipe-A-eDP-1
[131.143240] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s)
[131.151048] Starting dynamic subtest: pipe-B-eDP-1
[132.620506] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[132.628259] Starting dynamic subtest: pipe-C-eDP-1
[134.014083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[134.022626] Starting dynamic subtest: pipe-D-eDP-1
[135.439186] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[135.441283] Subtest simple-lease: SUCCESS (4.819s)
[136.260802] [023/132] (882s left) gem_exec_whisper (basic-queues-priority-all)
[136.333408] Starting subtest: basic-queues-priority-all
[158.055375] Subtest basic-queues-priority-all: SUCCESS (21.720s)
[158.266410] [024/132] (861s left) gem_exec_balancer (parallel-ordering)
[158.528878] Starting subtest: parallel-ordering
[159.471527] Subtest parallel-ordering: SUCCESS (0.943s)
[159.634939] [025/132] (859s left) gem_fenced_exec_thrash (too-many-fences)
[159.694343] Subtest too-many-fences: SKIP (0.000s)
[159.776338] [026/132] (859s left) kms_chamelium_frames (dp-crc-single)
[160.159617] Subtest dp-crc-single: SKIP (0.000s)
[160.950272] [027/132] (858s left) kms_big_fb (linear-16bpp-rotate-90)
[161.058393] Starting subtest: linear-16bpp-rotate-90
[161.077538] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[161.251745] [028/132] (858s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[161.351672] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[161.355725] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[161.481643] [029/132] (857s left) api_intel_bb (crc32)
[161.539227] Starting subtest: crc32
[161.541399] Starting dynamic subtest: rcs0-smem0
[161.849587] Dynamic subtest rcs0-smem0: SUCCESS (0.310s)
[161.861752] Starting dynamic subtest: bcs0-smem0
[162.171523] Dynamic subtest bcs0-smem0: SUCCESS (0.320s)
[162.183030] Starting dynamic subtest: vcs0-smem0
[162.515502] Dynamic subtest vcs0-smem0: SUCCESS (0.342s)
[162.526952] Starting dynamic subtest: vcs1-smem0
[162.884549] Dynamic subtest vcs1-smem0: SUCCESS (0.367s)
[162.895303] Starting dynamic subtest: vecs0-smem0
[163.233882] Dynamic subtest vecs0-smem0: SUCCESS (0.347s)
[163.245311] Starting dynamic subtest: ccs0-smem0
[163.564399] Dynamic subtest ccs0-smem0: SUCCESS (0.329s)
[163.567028] Subtest crc32: SUCCESS (2.026s)
[163.729438] [030/132] (855s left) kms_psr (fbc-pr-sprite-plane-onoff)
[163.825207] Starting subtest: fbc-pr-sprite-plane-onoff
[163.829626] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[163.916601] [031/132] (855s left) gem_eio (wait-1us)
[164.119032] Starting subtest: wait-1us
[164.441596] Subtest wait-1us: SUCCESS (0.323s)
[164.623827] [032/132] (854s left) kms_feature_discovery (chamelium)
[164.726526] Starting subtest: chamelium
[164.730245] Subtest chamelium: SKIP (0.000s)
[164.821115] [033/132] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[164.929475] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[164.933031] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[165.087953] [034/132] (854s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[165.185952] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[165.188242] Starting dynamic subtest: A-eDP1
[168.798279] Dynamic subtest A-eDP1: SUCCESS (3.609s)
[168.807804] Starting dynamic subtest: B-eDP1
[172.013116] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[172.022977] Starting dynamic subtest: C-eDP1
[175.111723] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[175.120347] Starting dynamic subtest: D-eDP1
[178.203621] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[178.205818] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.019s)
[179.032981] [035/132] (840s left) i915_pciid
[179.222235] [036/132] (840s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[179.322989] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[179.325304] Starting dynamic subtest: pipe-A
[179.660790] Dynamic subtest pipe-A: SUCCESS (0.339s)
[179.669163] Starting dynamic subtest: pipe-B
[181.128072] Dynamic subtest pipe-B: SUCCESS (1.466s)
[181.136651] Starting dynamic subtest: pipe-C
[182.580552] Dynamic subtest pipe-C: SUCCESS (1.452s)
[182.589555] Starting dynamic subtest: pipe-D
[183.986249] Dynamic subtest pipe-D: SUCCESS (1.405s)
[183.988513] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.666s)
[185.159834] [037/132] (834s left) gem_exec_flush (basic-wb-ro-before-default)
[185.226873] Starting subtest: basic-wb-ro-before-default
[190.679383] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[190.890282] [038/132] (828s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[191.004863] Starting subtest: 4-tiled-8bpp-rotate-180
[192.230705] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.226s)
[192.397460] [039/132] (827s left) kms_pipe_stress (stress-xrgb8888-untiled)
[192.504853] Starting subtest: stress-xrgb8888-untiled
[198.285288] Subtest stress-xrgb8888-untiled: SUCCESS (5.780s)
[198.347542] [040/132] (821s left) gem_exec_reloc (basic-cpu-wc-active)
[198.410911] Subtest basic-cpu-wc-active: SKIP (0.000s)
[198.491529] [041/132] (821s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[198.613965] Starting subtest: verify-pxp-key-change-after-suspend-resume
[210.382233] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (11.769s)
[219.553048] [042/132] (809s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[219.675282] Starting subtest: primary-yf-tiled-reflect-x-90
[219.679635] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[219.772262] [043/132] (809s left) api_intel_bb (blit-noreloc-keep-cache)
[219.839296] Starting subtest: blit-noreloc-keep-cache
[219.847433] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[220.019305] [044/132] (809s left) kms_pm_backlight (fade-with-suspend)
[220.110116] Starting subtest: fade-with-suspend
[236.474866] Starting dynamic subtest: eDP-1
[239.147207] Dynamic subtest eDP-1: SUCCESS (2.674s)
[239.149552] Subtest fade-with-suspend: SUCCESS (4.342s)
[249.024322] [045/132] (789s left) kms_addfb_basic (small-bo)
[249.167273] Starting subtest: small-bo
[249.169170] Subtest small-bo: SUCCESS (0.000s)
[249.292413] [046/132] (788s left) gem_userptr_blits (mmap-offset-banned)
[249.365729] Starting subtest: mmap-offset-banned
[249.368092] Starting dynamic subtest: wb
[249.370340] Dynamic subtest wb: SUCCESS (0.000s)
[249.379999] Starting dynamic subtest: wc
[249.382252] Dynamic subtest wc: SUCCESS (0.000s)
[249.391189] Starting dynamic subtest: uc
[249.393404] Dynamic subtest uc: SUCCESS (0.000s)
[249.395611] Subtest mmap-offset-banned: SUCCESS (0.002s)
[249.507288] [047/132] (788s left) kms_invalid_mode (zero-vdisplay)
[249.609423] Starting subtest: zero-vdisplay
[249.611802] Starting dynamic subtest: pipe-A-eDP-1
[249.900176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[249.910333] Starting dynamic subtest: pipe-B-eDP-1
[249.912354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[249.921666] Starting dynamic subtest: pipe-C-eDP-1
[249.924001] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.932943] Starting dynamic subtest: pipe-D-eDP-1
[249.935274] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.937560] Subtest zero-vdisplay: SUCCESS (0.292s)
[250.774764] [048/132] (787s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[250.870452] Starting subtest: psr-rgb101010-draw-pwrite
[258.535489] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.592s)
[258.669304] [049/132] (779s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[258.779344] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[258.781581] Starting dynamic subtest: pipe-A-eDP-1
[258.840535] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[258.851340] Starting dynamic subtest: pipe-B-eDP-1
[258.910306] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.921146] Starting dynamic subtest: pipe-C-eDP-1
[258.979081] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.989657] Starting dynamic subtest: pipe-D-eDP-1
[259.046005] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[259.049956] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[261.107760] [050/132] (777s left) kms_cursor_crc (cursor-sliding-max-size)
[261.405985] Starting subtest: cursor-sliding-max-size
[261.412404] Subtest cursor-sliding-max-size: SKIP (0.000s)
[261.577244] [051/132] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[261.666835] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[261.670912] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[261.798482] [052/132] (776s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[261.853786] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[261.956391] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[262.057028] [053/132] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[262.145626] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[262.150006] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[262.253693] [054/132] (776s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[262.351984] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[262.354255] Starting dynamic subtest: pipe-A-eDP-1
[262.376075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.385654] Starting dynamic subtest: pipe-B-eDP-1
[262.406209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.415080] Starting dynamic subtest: pipe-C-eDP-1
[262.436693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.447464] Starting dynamic subtest: pipe-D-eDP-1
[262.469036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.473094] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[264.684090] [055/132] (773s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[264.797456] Starting subtest: x-tiled-16bpp-rotate-90
[264.817560] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[264.990218] [056/132] (773s left) kms_plane (plane-panning-top-left)
[265.092448] Starting subtest: plane-panning-top-left
[265.094240] Starting dynamic subtest: pipe-A
[266.834718] Dynamic subtest pipe-A: SUCCESS (1.739s)
[266.849581] Starting dynamic subtest: pipe-B
[269.322974] Dynamic subtest pipe-B: SUCCESS (2.482s)
[269.325808] Subtest plane-panning-top-left: SUCCESS (4.225s)
[270.213436] [057/132] (768s left) kms_getfb (getfb-handle-zero)
[270.318255] Starting subtest: getfb-handle-zero
[270.320385] Subtest getfb-handle-zero: SUCCESS (0.000s)
[270.460576] [058/132] (768s left) kms_flip (dpms-vs-vblank-race-interruptible)
[270.550566] Starting subtest: dpms-vs-vblank-race-interruptible
[270.552810] Starting dynamic subtest: A-eDP1
[274.374398] Dynamic subtest A-eDP1: SUCCESS (3.815s)
[274.384875] Starting dynamic subtest: B-eDP1
[278.981359] Dynamic subtest B-eDP1: SUCCESS (4.603s)
[278.990878] Starting dynamic subtest: C-eDP1
[283.615701] Dynamic subtest C-eDP1: SUCCESS (4.632s)
[283.625579] Starting dynamic subtest: D-eDP1
[288.215919] Dynamic subtest D-eDP1: SUCCESS (4.597s)
[288.218290] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.656s)
[289.120918] [059/132] (749s left) kms_addfb_basic (bad-pitch-256)
[289.179150] Starting subtest: bad-pitch-256
[289.181295] Subtest bad-pitch-256: SUCCESS (0.000s)
[289.333739] [060/132] (749s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[289.430042] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[289.432308] Starting dynamic subtest: pipe-A-eDP-1
[290.254953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[290.264691] Starting dynamic subtest: pipe-B-eDP-1
[291.864133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.606s)
[291.873359] Starting dynamic subtest: pipe-C-eDP-1
[293.310036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.444s)
[293.320239] Starting dynamic subtest: pipe-D-eDP-1
[294.846465] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[294.848563] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.408s)
[296.045558] [061/132] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[296.147164] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[296.151417] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[296.258323] [062/132] (742s left) vgem_basic (busy-fence)
[296.300124] Starting subtest: busy-fence
[296.302469] Subtest busy-fence: SUCCESS (0.000s)
[296.387704] [063/132] (742s left) gem_ctx_shared (detached-shared-gtt)
[296.456668] Starting subtest: detached-shared-gtt
[298.611576] Subtest detached-shared-gtt: SUCCESS (2.153s)
[299.048336] [064/132] (739s left) kms_atomic_interruptible (legacy-dpms)
[299.142936] Starting subtest: legacy-dpms
[299.145076] Starting dynamic subtest: pipe-A-eDP-1
[306.557348] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s)
[306.559677] Subtest legacy-dpms: SUCCESS (7.413s)
[307.427663] [065/132] (731s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[312.472196] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[312.474781] Starting dynamic subtest: pipe-A-eDP-1
[313.293521] Dynamic subtest pipe-A-eDP-1: SKIP (0.816s)
[313.303550] Starting dynamic subtest: pipe-B-eDP-1
[314.436895] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[314.441081] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.962s)
[315.638539] [066/132] (723s left) kms_cursor_legacy (torture-bo)
[315.786439] Starting subtest: torture-bo
[315.788691] Starting dynamic subtest: pipe-A
[321.986910] Dynamic subtest pipe-A: SUCCESS (6.196s)
[321.998061] Starting dynamic subtest: pipe-B
[327.951053] Dynamic subtest pipe-B: SUCCESS (5.959s)
[327.963085] Starting dynamic subtest: pipe-C
[334.664038] Dynamic subtest pipe-C: SUCCESS (6.708s)
[334.679526] Starting dynamic subtest: pipe-D
[341.045272] Dynamic subtest pipe-D: SUCCESS (6.375s)
[341.057807] Starting dynamic subtest: all-pipes
[347.957415] Dynamic subtest all-pipes: SUCCESS (6.908s)
[347.959911] Subtest torture-bo: SUCCESS (32.159s)
[348.139078] [067/132] (690s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[348.246447] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[354.984847] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.745s)
[355.133936] [068/132] (684s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[355.236625] Starting subtest: fbcpsr-shrfb-scaledprimary
[361.043714] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.810s)
[361.208012] [069/132] (677s left) gem_ppgtt (shrink-vs-evict-pinned)
[361.276780] Starting subtest: shrink-vs-evict-pinned
[366.559954] Subtest shrink-vs-evict-pinned: SUCCESS (5.282s)
[366.679618] [070/132] (672s left) kms_flip (flip-vs-blocking-wf-vblank)
[366.804509] Starting subtest: flip-vs-blocking-wf-vblank
[366.806420] Starting dynamic subtest: A-eDP1
[375.695517] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[375.706603] Starting dynamic subtest: B-eDP1
[384.636359] Dynamic subtest B-eDP1: SUCCESS (8.939s)
[384.652082] Starting dynamic subtest: C-eDP1
[393.559390] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[393.569042] Starting dynamic subtest: D-eDP1
[402.493078] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[402.495470] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.691s)
[403.746137] [071/132] (635s left) syncobj_timeline (wait-all-interrupted)
[403.800720] Starting subtest: wait-all-interrupted
[403.902419] Subtest wait-all-interrupted: SUCCESS (0.102s)
[404.002130] [072/132] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[404.109835] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[410.921141] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.813s)
[411.073791] [073/132] (628s left) gem_mmap_gtt (cpuset-big-copy)
[411.133466] Subtest cpuset-big-copy: SKIP (0.000s)
[411.198422] [074/132] (628s left) kms_hdr (invalid-metadata-sizes)
[411.290245] Starting subtest: invalid-metadata-sizes
[411.296359] Subtest invalid-metadata-sizes: SKIP (0.000s)
[411.396907] [075/132] (628s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[411.486349] Starting subtest: plane-all-modeset-transition-fencing
[411.490328] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[411.584005] [076/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[411.691595] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[418.474429] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.784s)
[418.648404] [077/132] (620s left) gem_exec_reloc (basic-concurrent16)
[418.723909] Subtest basic-concurrent16: SKIP (0.000s)
[418.820190] [078/132] (620s left) kms_pm_rpm (legacy-planes-dpms)
[420.763380] Starting subtest: legacy-planes-dpms
[420.766250] Starting dynamic subtest: plane-63
[429.365332] Dynamic subtest plane-63: SUCCESS (8.599s)
[429.377259] Starting dynamic subtest: plane-93
[437.979972] Dynamic subtest plane-93: SUCCESS (8.609s)
[437.991879] Starting dynamic subtest: plane-123
[446.596607] Dynamic subtest plane-123: SUCCESS (8.612s)
[446.607393] Starting dynamic subtest: plane-133
[455.192269] Dynamic subtest plane-133: SUCCESS (8.591s)
[455.194553] Subtest legacy-planes-dpms: SUCCESS (34.420s)
[455.585638] [079/132] (584s left) kms_selftest (drm_cmdline_parser)
[455.629953] Starting subtest: drm_cmdline_parser
[455.673331] Starting dynamic subtest: drm_test_cmdline_force_d_only
[455.818666] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.144s)
[455.828933] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[455.941482] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.122s)
[455.952464] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[456.066331] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.124s)
[456.076386] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[456.184324] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.117s)
[456.194738] Starting dynamic subtest: drm_test_cmdline_force_e_only
[456.270248] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.086s)
[456.280633] Starting dynamic subtest: drm_test_cmdline_res
[456.414049] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.143s)
[456.424242] Starting dynamic subtest: drm_test_cmdline_res_vesa
[456.542948] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.130s)
[456.552431] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[456.668521] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.122s)
[456.678841] Starting dynamic subtest: drm_test_cmdline_res_rblank
[456.797078] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.126s)
[456.807814] Starting dynamic subtest: drm_test_cmdline_res_bpp
[456.916489] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.120s)
[456.925991] Starting dynamic subtest: drm_test_cmdline_res_refresh
[457.040276] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.122s)
[457.051220] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[457.182512] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.143s)
[457.191835] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[457.320384] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.135s)
[457.330789] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[457.455607] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.133s)
[457.464590] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[457.566616] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.112s)
[457.577087] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[457.650502] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.084s)
[457.659754] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[457.752219] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.100s)
[457.763091] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[457.894989] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.141s)
[457.905955] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[457.998384] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.102s)
[458.007700] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[458.128298] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.127s)
[458.139113] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[458.256437] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.129s)
[458.265732] Starting dynamic subtest: drm_test_cmdline_name
[458.400524] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.140s)
[458.411382] Starting dynamic subtest: drm_test_cmdline_name_bpp
[458.527462] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.126s)
[458.536723] Starting dynamic subtest: drm_test_cmdline_name_option
[458.656440] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.127s)
[458.667401] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[458.790583] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.134s)
[458.799904] Starting dynamic subtest: drm_test_cmdline_rotate_0
[458.926254] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.135s)
[458.935851] Starting dynamic subtest: drm_test_cmdline_rotate_90
[459.031446] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.106s)
[459.040694] Starting dynamic subtest: drm_test_cmdline_rotate_180
[459.126053] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.093s)
[459.136317] Starting dynamic subtest: drm_test_cmdline_rotate_270
[459.217654] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.091s)
[459.226783] Starting dynamic subtest: drm_test_cmdline_hmirror
[459.327556] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.108s)
[459.336821] Starting dynamic subtest: drm_test_cmdline_vmirror
[459.451406] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.123s)
[459.460679] Starting dynamic subtest: drm_test_cmdline_margin_options
[459.547310] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.096s)
[459.557772] Starting dynamic subtest: drm_test_cmdline_multiple_options
[459.685477] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.137s)
[459.694393] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[459.831992] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.145s)
[459.841221] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[459.914575] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.082s)
[459.923697] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[460.052271] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.136s)
[460.063380] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[460.178412] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.126s)
[460.187306] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[460.322007] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.142s)
[460.332245] Starting dynamic subtest: drm_test_cmdline_invalid
[460.450781] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.129s)
[460.459844] Starting dynamic subtest: drm_test_cmdline_tv_options
[460.601478] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.149s)
[460.603642] Subtest drm_cmdline_parser: SUCCESS (4.968s)
[460.782481] [080/132] (578s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[460.881007] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[460.883251] Starting dynamic subtest: pipe-A-eDP-1
[460.905689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.916883] Starting dynamic subtest: pipe-B-eDP-1
[460.938425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.948015] Starting dynamic subtest: pipe-C-eDP-1
[460.969453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.978530] Starting dynamic subtest: pipe-D-eDP-1
[461.000501] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.004799] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[463.160578] [081/132] (576s left) kms_psr (psr2-sprite-blt)
[463.259090] Starting subtest: psr2-sprite-blt
[463.261342] Starting dynamic subtest: eDP-1
[464.944350] Dynamic subtest eDP-1: SUCCESS (1.683s)
[464.946508] Subtest psr2-sprite-blt: SUCCESS (1.684s)
[465.835589] [082/132] (573s left) kms_setmode (invalid-clone-exclusive-crtc)
[465.895709] Starting subtest: invalid-clone-exclusive-crtc
[465.901947] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[466.029519] [083/132] (573s left) kms_flip_event_leak (basic)
[466.130344] Starting subtest: basic
[466.132482] Starting dynamic subtest: pipe-A-eDP-1
[466.550609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[466.562013] Starting dynamic subtest: pipe-B-eDP-1
[467.633519] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.083s)
[467.644824] Starting dynamic subtest: pipe-C-eDP-1
[468.768852] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[468.779455] Starting dynamic subtest: pipe-D-eDP-1
[469.905606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[469.907806] Subtest basic: SUCCESS (3.774s)
[470.776427] [084/132] (569s left) gem_workarounds (basic-read)
[470.857025] Starting subtest: basic-read
[470.866482] Subtest basic-read: SUCCESS (0.010s)
[471.009292] [085/132] (568s left) dmabuf_sync_file (import-multiple-read-only)
[471.057655] Starting subtest: import-multiple-read-only
[471.059850] Subtest import-multiple-read-only: SUCCESS (0.003s)
[471.139903] [086/132] (568s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[471.235037] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[471.608876] Starting dynamic subtest: pipe-A-eDP-1
[474.432038] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.822s)
[474.809150] Starting dynamic subtest: pipe-B-eDP-1
[477.557259] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[477.926391] Starting dynamic subtest: pipe-C-eDP-1
[480.688883] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[481.059022] Starting dynamic subtest: pipe-D-eDP-1
[483.824085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[483.826431] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.594s)
[485.032055] [087/132] (554s left) kms_atomic (plane-overlay-legacy)
[485.129049] Starting subtest: plane-overlay-legacy
[485.131340] Starting dynamic subtest: pipe-A-eDP-1
[485.584490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[485.586817] Subtest plane-overlay-legacy: SUCCESS (0.455s)
[486.466341] [088/132] (553s left) gem_exec_balancer (parallel-balancer)
[486.736246] Starting subtest: parallel-balancer
[487.605972] Subtest parallel-balancer: SUCCESS (0.870s)
[487.748284] [089/132] (552s left) gem_mmap_gtt (basic-write-gtt)
[487.812624] Subtest basic-write-gtt: SKIP (0.000s)
[487.880042] [090/132] (552s left) perf_pmu (render-node-busy)
[487.964447] Starting subtest: render-node-busy
[487.966317] Starting dynamic subtest: rcs0
[488.573753] Dynamic subtest rcs0: SUCCESS (0.611s)
[488.584365] Starting dynamic subtest: bcs0
[489.141393] Dynamic subtest bcs0: SUCCESS (0.565s)
[489.153975] Starting dynamic subtest: vcs0
[490.623677] Dynamic subtest vcs0: SUCCESS (1.479s)
[490.635948] Starting dynamic subtest: vcs1
[492.608436] Dynamic subtest vcs1: SUCCESS (1.982s)
[492.620372] Starting dynamic subtest: vecs0
[494.593962] Dynamic subtest vecs0: SUCCESS (1.983s)
[494.607246] Starting dynamic subtest: ccs0
[495.168452] Dynamic subtest ccs0: SUCCESS (0.573s)
[495.171119] Subtest render-node-busy: SUCCESS (7.209s)
[495.269656] [091/132] (544s left) i915_pm_rpm (system-suspend-execbuf)
[496.804649] Starting subtest: system-suspend-execbuf
[554.966181] Subtest system-suspend-execbuf: SUCCESS (42.807s)
[555.356445] [092/132] (484s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[560.406721] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[560.409249] Starting dynamic subtest: pipe-A-eDP-1
[567.047730] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.641s)
[567.063894] Starting dynamic subtest: pipe-B-eDP-1
[573.684266] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.640s)
[573.687118] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.285s)
[574.585609] [093/132] (465s left) kms_vblank (wait-forked)
[574.692070] Starting subtest: wait-forked
[574.694622] Starting dynamic subtest: pipe-A-eDP-1
[576.495999] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[576.511600] Starting dynamic subtest: pipe-D-eDP-1
[578.965175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s)
[578.967659] Subtest wait-forked: SUCCESS (4.273s)
[579.845491] [094/132] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[579.947106] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[579.952281] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[580.090985] [095/132] (460s left) gen9_exec_parse (allowed-single)
[580.150185] Subtest allowed-single: SKIP (0.000s)
[580.223746] [096/132] (460s left) syncobj_eventfd (timeline-wait)
[580.283033] Starting subtest: timeline-wait
[580.291105] Subtest timeline-wait: SUCCESS (0.011s)
[580.390191] [097/132] (459s left) kms_vblank (ts-continuation-modeset-rpm)
[580.483665] Starting subtest: ts-continuation-modeset-rpm
[580.485944] Starting dynamic subtest: pipe-A-eDP-1
[583.005244] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[583.022229] Starting dynamic subtest: pipe-D-eDP-1
[585.242071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.233s)
[585.245120] Subtest ts-continuation-modeset-rpm: SUCCESS (4.759s)
[586.076258] [098/132] (454s left) sw_sync (sync_busy)
[586.117245] Starting subtest: sync_busy
[586.119866] Subtest sync_busy: SUCCESS (0.002s)
[586.200834] [099/132] (454s left) gem_ctx_persistence (engines-persistence)
[586.257054] Starting subtest: engines-persistence
[586.259987] Starting dynamic subtest: rcs0
[587.117545] Dynamic subtest rcs0: SUCCESS (0.860s)
[587.130285] Starting dynamic subtest: bcs0
[587.949689] Dynamic subtest bcs0: SUCCESS (0.830s)
[587.963441] Starting dynamic subtest: vcs0
[588.759625] Dynamic subtest vcs0: SUCCESS (0.808s)
[588.772870] Starting dynamic subtest: vcs1
[589.548647] Dynamic subtest vcs1: SUCCESS (0.787s)
[589.561285] Starting dynamic subtest: vecs0
[590.338399] Dynamic subtest vecs0: SUCCESS (0.788s)
[590.348513] Starting dynamic subtest: ccs0
[591.147645] Dynamic subtest ccs0: SUCCESS (0.807s)
[591.150546] Subtest engines-persistence: SUCCESS (4.891s)
[591.253749] [100/132] (449s left) syncobj_basic (bad-handle-to-fd)
[591.309742] Starting subtest: bad-handle-to-fd
[591.312332] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[591.454117] [101/132] (449s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[591.512414] Starting subtest: yf-tiled-to-vebox-x-tiled
[591.517563] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[591.735529] [102/132] (448s left) syncobj_timeline (invalid-wait-illegal-handle)
[591.794095] Starting subtest: invalid-wait-illegal-handle
[591.797082] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[591.934157] [103/132] (448s left) i915_drm_fdinfo (memory-info-idle)
[591.975202] Starting subtest: memory-info-idle
[591.978201] Starting dynamic subtest: smem0
[592.043224] Dynamic subtest smem0: SUCCESS (0.067s)
[592.046166] Subtest memory-info-idle: SUCCESS (0.068s)
[592.147676] [104/132] (448s left) gem_softpin (noreloc)
[592.213100] Starting subtest: noreloc
[597.611873] Subtest noreloc: SUCCESS (5.396s)
[597.779507] [105/132] (442s left) i915_pm_sseu (full-enable)
[597.836047] Subtest full-enable: SKIP (0.000s)
[597.970364] [106/132] (442s left) gem_ctx_engines (execute-oneforall)
[598.043154] Starting subtest: execute-oneforall
[599.087195] Subtest execute-oneforall: SUCCESS (1.042s)
[599.924365] [107/132] (440s left) gem_exec_whisper (basic-normal)
[599.987135] Starting subtest: basic-normal
[605.064952] Subtest basic-normal: SUCCESS (5.080s)
[605.276736] [108/132] (435s left) syncobj_basic (bad-flags-handle-to-fd)
[605.336280] Starting subtest: bad-flags-handle-to-fd
[605.338809] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[605.479272] [109/132] (435s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[605.583047] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[605.588938] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[605.713866] [110/132] (435s left) gem_exec_schedule (thriceslice)
[605.796066] Starting subtest: thriceslice
[605.798688] Starting dynamic subtest: rcs0
[605.836206] Dynamic subtest rcs0: SUCCESS (0.054s)
[605.849406] Starting dynamic subtest: bcs0
[605.891649] Dynamic subtest bcs0: SUCCESS (0.054s)
[605.902428] Starting dynamic subtest: vcs0
[605.923330] Dynamic subtest vcs0: SUCCESS (0.030s)
[605.935075] Starting dynamic subtest: vcs1
[605.951933] Dynamic subtest vcs1: SUCCESS (0.029s)
[605.961579] Starting dynamic subtest: vecs0
[605.982245] Dynamic subtest vecs0: SUCCESS (0.029s)
[605.992264] Starting dynamic subtest: ccs0
[606.038280] Dynamic subtest ccs0: SUCCESS (0.055s)
[606.041276] Subtest thriceslice: SUCCESS (0.257s)
[607.833559] [111/132] (433s left) syncobj_wait (multi-wait-submitted-signaled)
[607.905164] Starting subtest: multi-wait-submitted-signaled
[607.908059] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[608.020451] [112/132] (433s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[608.125082] Starting subtest: yf-tiled-8bpp-rotate-270
[608.129793] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[608.262652] [113/132] (432s left) gem_userptr_blits (access-control)
[608.336057] Starting subtest: access-control
[608.341295] Subtest access-control: SKIP (0.000s)
[608.495651] [114/132] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[608.593137] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[612.169136] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.579s)
[613.382671] [115/132] (427s left) gem_ctx_persistence (idempotent)
[613.447111] Starting subtest: idempotent
[613.449934] Subtest idempotent: SUCCESS (0.000s)
[613.584824] [116/132] (427s left) kms_flip (2x-flip-vs-fences-interruptible)
[613.685907] Starting subtest: 2x-flip-vs-fences-interruptible
[613.691085] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[613.820285] [117/132] (427s left) gem_userptr_blits (map-fixed-invalidate)
[613.895763] Starting subtest: map-fixed-invalidate
[613.901006] Subtest map-fixed-invalidate: SKIP (0.000s)
[614.062199] [118/132] (427s left) gem_bad_reloc (negative-reloc-lut)
[614.118034] Subtest negative-reloc-lut: SKIP (0.000s)
[614.189249] [119/132] (427s left) kms_fbcon_fbt (fbc-suspend)
[614.250408] Starting subtest: fbc-suspend
[663.591568] Subtest fbc-suspend: SUCCESS (19.798s)
[667.905296] [120/132] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[668.010433] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[668.016690] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[668.125395] [121/132] (376s left) kms_psr (psr-cursor-mmap-gtt)
[668.228093] Starting subtest: psr-cursor-mmap-gtt
[668.230348] Starting dynamic subtest: eDP-1
[669.929642] Dynamic subtest eDP-1: SUCCESS (1.676s)
[669.932025] Subtest psr-cursor-mmap-gtt: SUCCESS (1.677s)
[670.833749] [122/132] (373s left) kms_color_pipeline (plane-lut1d)
[670.933327] Starting subtest: plane-lut1d
[670.946129] Starting dynamic subtest: pipe-A-eDP-1
[671.671477] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s)
[672.303959] Starting dynamic subtest: pipe-B-eDP-1
[673.129888] Dynamic subtest pipe-B-eDP-1: FAIL (0.314s)
[673.650978] Starting dynamic subtest: pipe-C-eDP-1
[674.497990] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[674.992720] Starting dynamic subtest: pipe-D-eDP-1
[675.818836] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[675.820910] Subtest plane-lut1d: FAIL (4.532s)
[676.409420] [123/132] (368s left) gem_userptr_blits (readonly-pwrite-unsync)
[676.473049] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[676.627452] [124/132] (367s left) gem_close (basic)
[676.685650] Starting subtest: basic
[676.687859] Subtest basic: SUCCESS (0.000s)
[676.813891] [125/132] (367s left) kms_chamelium_color (ctm-red-to-blue)
[676.917667] Subtest ctm-red-to-blue: SKIP (0.000s)
[676.964724] [126/132] (367s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[677.214835] Starting subtest: cursor-rapid-movement-256x256
[677.219743] Starting dynamic subtest: pipe-A-eDP-1
[677.776591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[677.806761] Starting dynamic subtest: pipe-D-eDP-1
[679.002137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[679.004534] Subtest cursor-rapid-movement-256x256: SUCCESS (1.774s)
[679.896077] [127/132] (364s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[680.026371] Starting subtest: basic-flip-after-cursor-varying-size
[680.955546] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[681.830023] [128/132] (362s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[681.934147] Starting subtest: fbc-psr-sprite-mmap-gtt
[681.936337] Starting dynamic subtest: eDP-1
[681.940349] Dynamic subtest eDP-1: SKIP (0.000s)
[681.944405] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[682.033701] [129/132] (362s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[682.148283] Starting subtest: yf-tiled-16bpp-rotate-90
[682.152349] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[682.285752] [130/132] (362s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[682.393748] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[682.398155] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[682.512567] [131/132] (362s left) kms_prop_blob (blob-prop-lifetime)
[682.573700] Starting subtest: blob-prop-lifetime
[682.575822] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[682.713975] [132/132] (362s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[682.814768] Starting subtest: y-tiled-16bpp-rotate-270
[682.818511] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[682.970881] 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.