[60.167032] Initializing watchdogs
[60.167095]   /dev/watchdog0
[60.181843] [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]
[60.186487] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.188759] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.192084] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[60.318128] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[60.322304] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[60.443815] [002/131] (960s left) i915_drm_fdinfo (isolation)
[60.490637] Starting subtest: isolation
[60.492880] Starting dynamic subtest: rcs0
[60.522512] Dynamic subtest rcs0: SKIP (0.030s)
[60.532065] Starting dynamic subtest: bcs0
[60.535801] Dynamic subtest bcs0: SKIP (0.000s)
[60.542724] Starting dynamic subtest: vcs0
[60.546213] Dynamic subtest vcs0: SKIP (0.000s)
[60.555104] Starting dynamic subtest: vcs1
[60.559073] Dynamic subtest vcs1: SKIP (0.000s)
[60.567870] Starting dynamic subtest: vecs0
[60.571482] Dynamic subtest vecs0: SKIP (0.000s)
[60.577924] Starting dynamic subtest: ccs0
[60.581473] Dynamic subtest ccs0: SKIP (0.000s)
[60.584915] Subtest isolation: SKIP (0.032s)
[60.617045] [003/131] (960s left) kms_pm_rpm (modeset-lpsp)
[62.166476] Starting subtest: modeset-lpsp
[63.639769] Subtest modeset-lpsp: SUCCESS (1.462s)
[63.762190] [004/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[63.866710] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[63.870734] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[63.979402] [005/131] (956s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[64.067124] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[64.069629] Starting dynamic subtest: pipe-A
[65.143184] Dynamic subtest pipe-A: SUCCESS (1.070s)
[65.151985] Starting dynamic subtest: pipe-B
[67.320904] Dynamic subtest pipe-B: SUCCESS (2.166s)
[67.329298] Starting dynamic subtest: pipe-C
[68.529670] Dynamic subtest pipe-C: SUCCESS (1.203s)
[68.539296] Starting dynamic subtest: pipe-D
[69.762237] Dynamic subtest pipe-D: SUCCESS (1.229s)
[69.764597] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.669s)
[70.978608] [006/131] (949s left) kms_flip (basic-flip-vs-dpms)
[71.281840] Starting subtest: basic-flip-vs-dpms
[71.284267] Starting dynamic subtest: A-eDP1
[73.870220] Dynamic subtest A-eDP1: SUCCESS (2.580s)
[73.880587] Starting dynamic subtest: B-eDP1
[76.034817] Dynamic subtest B-eDP1: SUCCESS (2.160s)
[76.044223] Starting dynamic subtest: C-eDP1
[78.104730] Dynamic subtest C-eDP1: SUCCESS (2.068s)
[78.117393] Starting dynamic subtest: D-eDP1
[80.172761] Dynamic subtest D-eDP1: SUCCESS (2.064s)
[80.175188] Subtest basic-flip-vs-dpms: SUCCESS (8.880s)
[80.976484] [007/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[81.076408] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[81.080830] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[81.209772] [008/131] (939s left) syncobj_eventfd (invalid-illegal-handle)
[81.275535] Starting subtest: invalid-illegal-handle
[81.277956] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[81.385384] [009/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[81.483720] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[81.487845] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[81.596153] [010/131] (939s left) sw_sync (timeline_closed)
[81.632598] Starting subtest: timeline_closed
[81.634864] Subtest timeline_closed: SUCCESS (0.000s)
[81.726213] [011/131] (939s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[86.765774] Starting subtest: fbc-psr2-cursor-plane-update-sf
[86.768017] Starting dynamic subtest: pipe-A-eDP-1
[87.560941] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s)
[87.569163] Starting dynamic subtest: pipe-B-eDP-1
[88.682662] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[88.687312] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.916s)
[89.885225] [012/131] (931s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[89.988481] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[89.990902] Starting dynamic subtest: pipe-A-default-mode
[91.139466] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[91.143514] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.149s)
[91.304783] [013/131] (929s left) syncobj_basic (bad-flags-fd-to-handle)
[91.368620] Starting subtest: bad-flags-fd-to-handle
[91.371568] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[91.490252] [014/131] (929s left) gem_exec_params (mmapped)
[91.547862] Starting subtest: mmapped
[91.552224] Subtest mmapped: SUCCESS (0.003s)
[91.714472] [015/131] (929s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[91.822381] Starting subtest: modeset-transition-nonblocking-fencing
[91.824604] Starting dynamic subtest: 1x-outputs
[102.666233] Dynamic subtest 1x-outputs: SUCCESS (10.842s)
[102.668720] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.843s)
[103.536203] [016/131] (917s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[103.633580] Starting subtest: primary-x-tiled-reflect-x-0
[110.525578] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.891s)
[111.709925] [017/131] (909s left) kms_cursor_crc (cursor-random-512x170)
[111.982144] Starting subtest: cursor-random-512x170
[111.986629] Subtest cursor-random-512x170: SKIP (0.001s)
[112.145646] [018/131] (909s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[112.242218] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[112.244530] Starting dynamic subtest: pipe-A-eDP-1
[112.253714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[112.263991] Starting dynamic subtest: pipe-B-eDP-1
[112.273711] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.281707] Starting dynamic subtest: pipe-C-eDP-1
[112.290608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.303202] Starting dynamic subtest: pipe-D-eDP-1
[112.312208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.316555] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[114.561952] [019/131] (906s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[114.949496] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[115.765773] [020/131] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[115.872776] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[115.877054] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[116.015620] [021/131] (905s left) syncobj_wait (wait-all-complex)
[116.077975] Starting subtest: wait-all-complex
[116.290206] Subtest wait-all-complex: SUCCESS (0.213s)
[116.374353] [022/131] (905s left) gem_partial_pwrite_pread (reads)
[116.440537] Subtest reads: SKIP (0.000s)
[116.522149] [023/131] (905s left) kms_async_flips (crc)
[116.614081] Starting subtest: crc
[116.996467] Starting dynamic subtest: pipe-A-eDP-1
[119.913310] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.914s)
[120.303685] Starting dynamic subtest: pipe-B-eDP-1
[123.239309] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.944s)
[123.613554] Starting dynamic subtest: pipe-C-eDP-1
[126.464183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.859s)
[126.854791] Starting dynamic subtest: pipe-D-eDP-1
[129.692719] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.845s)
[129.695068] Subtest crc: SUCCESS (13.077s)
[130.885387] [024/131] (890s left) gem_spin_batch (resubmit-all)
[130.939333] Starting subtest: resubmit-all
[130.941602] Starting dynamic subtest: rcs0
[130.950366] Dynamic subtest rcs0: SUCCESS (0.011s)
[130.962414] Starting dynamic subtest: bcs0
[130.964837] Dynamic subtest bcs0: SUCCESS (0.002s)
[130.972411] Starting dynamic subtest: vcs0
[130.974595] Dynamic subtest vcs0: SUCCESS (0.002s)
[130.982174] Starting dynamic subtest: vcs1
[130.984267] Dynamic subtest vcs1: SUCCESS (0.002s)
[130.991765] Starting dynamic subtest: vecs0
[130.993956] Dynamic subtest vecs0: SUCCESS (0.002s)
[131.001268] Starting dynamic subtest: ccs0
[131.003447] Dynamic subtest ccs0: SUCCESS (0.002s)
[131.005630] Subtest resubmit-all: SUCCESS (0.024s)
[132.943679] [025/131] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[133.051084] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[133.852866] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[134.058190] [026/131] (887s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[134.167492] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[135.145509] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.978s)
[135.322090] [027/131] (886s left) kms_cursor_crc (cursor-sliding-128x42)
[135.537181] Starting subtest: cursor-sliding-128x42
[135.585769] Subtest cursor-sliding-128x42: SKIP (0.044s)
[135.796482] [028/131] (885s left) syncobj_wait (reset-unsignaled)
[135.850312] Starting subtest: reset-unsignaled
[135.852112] Subtest reset-unsignaled: SUCCESS (0.000s)
[135.977867] [029/131] (885s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[136.074165] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[136.077802] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[136.200482] [030/131] (885s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[136.305328] Starting subtest: psr-modesetfrombusy
[142.441625] Subtest psr-modesetfrombusy: SUCCESS (6.139s)
[142.604801] [031/131] (879s left) i915_query (query-topology-matches-eu-total)
[142.654769] Starting subtest: query-topology-matches-eu-total
[142.656458] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[142.784141] [032/131] (879s left) kms_chamelium_edid (dp-edid-resolution-list)
[143.159332] Subtest dp-edid-resolution-list: SKIP (0.000s)
[143.926542] [033/131] (877s left) gem_lmem_swapping (parallel-random-engines)
[143.965309] Subtest parallel-random-engines: SKIP (0.000s)
[143.999843] [034/131] (877s left) kms_atomic_interruptible (legacy-setmode)
[144.081694] Starting subtest: legacy-setmode
[144.084229] Starting dynamic subtest: pipe-A-eDP-1
[150.977978] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.897s)
[150.980574] Subtest legacy-setmode: SUCCESS (6.899s)
[151.865031] [035/131] (870s left) api_intel_bb (intel-bb-blit-none)
[151.926502] Starting subtest: intel-bb-blit-none
[156.285447] Subtest intel-bb-blit-none: SUCCESS (4.359s)
[156.423971] [036/131] (865s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[156.527610] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[156.530030] Starting dynamic subtest: pipe-A-eDP-1
[156.550251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[156.560228] Starting dynamic subtest: pipe-B-eDP-1
[156.580304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[156.588746] Starting dynamic subtest: pipe-C-eDP-1
[156.608241] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[156.617608] Starting dynamic subtest: pipe-D-eDP-1
[156.638457] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[156.640430] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[158.915378] [037/131] (863s left) kms_plane_alpha_blend (alpha-transparent-fb)
[159.007618] Starting subtest: alpha-transparent-fb
[159.303654] Starting dynamic subtest: pipe-A-eDP-1
[159.897594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[159.906533] Starting dynamic subtest: pipe-D-eDP-1
[161.239647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[161.242064] Subtest alpha-transparent-fb: SUCCESS (2.234s)
[162.077091] [038/131] (860s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[162.189165] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[162.191522] Starting dynamic subtest: pipe-A-eDP-1
[162.338202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[162.348650] Starting dynamic subtest: pipe-B-eDP-1
[162.369190] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[162.377110] Starting dynamic subtest: pipe-C-eDP-1
[162.396710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[162.404707] Starting dynamic subtest: pipe-D-eDP-1
[162.424291] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[162.426505] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[164.633376] [039/131] (857s left) gen9_exec_parse (basic-rejected-ctx-param)
[164.703094] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[164.773257] [040/131] (857s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[164.871288] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[164.875324] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[164.996459] [041/131] (857s left) kms_writeback (writeback-pixel-formats)
[165.089208] Subtest writeback-pixel-formats: SKIP (0.000s)
[165.146344] [042/131] (857s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[165.246058] Starting subtest: plane-all-transition-nonblocking-fencing
[165.248194] Starting dynamic subtest: pipe-A-eDP-1
[167.743555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[168.061554] Starting dynamic subtest: pipe-B-eDP-1
[171.260386] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[171.561670] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.316s)
[172.402418] [043/131] (849s left) kms_flip (dpms-vs-vblank-race-interruptible)
[172.503529] Starting subtest: dpms-vs-vblank-race-interruptible
[172.505942] Starting dynamic subtest: A-eDP1
[177.476335] Dynamic subtest A-eDP1: SUCCESS (4.967s)
[177.490723] Starting dynamic subtest: B-eDP1
[180.989368] Dynamic subtest B-eDP1: SUCCESS (3.512s)
[180.997676] Starting dynamic subtest: C-eDP1
[185.588258] Dynamic subtest C-eDP1: SUCCESS (4.599s)
[185.597550] Starting dynamic subtest: D-eDP1
[190.219999] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[190.222040] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.718s)
[191.105510] [044/131] (831s left) syncobj_wait (wait-for-submit-snapshot)
[191.172829] Starting subtest: wait-for-submit-snapshot
[191.254430] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[191.340154] [045/131] (831s left) gem_sync (basic-store-each)
[191.413805] Starting subtest: basic-store-each
[193.967573] Subtest basic-store-each: SUCCESS (2.566s)
[194.162659] [046/131] (828s left) kms_flip (wf_vblank-ts-check-interruptible)
[194.262426] Starting subtest: wf_vblank-ts-check-interruptible
[194.264782] Starting dynamic subtest: A-eDP1
[203.152146] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[203.161248] Starting dynamic subtest: B-eDP1
[212.081638] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[212.090320] Starting dynamic subtest: C-eDP1
[220.995362] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[221.004470] Starting dynamic subtest: D-eDP1
[229.838161] Dynamic subtest D-eDP1: SUCCESS (8.841s)
[229.843208] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.577s)
[231.075965] [047/131] (791s left) i915_power (sanity)
[231.122545] Starting subtest: sanity
[231.127102] Subtest sanity: SKIP (0.000s)
[231.233874] [048/131] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[231.325195] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[237.987522] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.664s)
[238.144637] [049/131] (784s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[238.250234] Starting subtest: y-tiled-16bpp-rotate-90
[238.254640] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[238.396236] [050/131] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[238.499563] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[242.944509] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.448s)
[244.119362] [051/131] (778s left) gem_exec_balancer (bonded-true-hang)
[244.370516] Starting subtest: bonded-true-hang
[244.375424] Subtest bonded-true-hang: SKIP (0.000s)
[244.492290] [052/131] (778s left) kms_sharpness_filter (filter-rotations)
[244.577397] Starting subtest: filter-rotations
[244.599629] Subtest filter-rotations: SKIP (0.001s)
[244.658854] [053/131] (778s left) gem_softpin (noreloc)
[244.721198] Starting subtest: noreloc
[250.130496] Subtest noreloc: SUCCESS (5.407s)
[250.235331] [054/131] (772s left) i915_hangman (gt-engine-hang)
[250.306893] Starting subtest: gt-engine-hang
[250.309221] Starting dynamic subtest: rcs0
[251.893311] Dynamic subtest rcs0: SUCCESS (1.584s)
[251.902854] Starting dynamic subtest: bcs0
[253.877991] Dynamic subtest bcs0: SUCCESS (1.982s)
[253.891511] Starting dynamic subtest: vcs0
[255.859834] Dynamic subtest vcs0: SUCCESS (1.979s)
[255.871827] Starting dynamic subtest: vcs1
[257.843131] Dynamic subtest vcs1: SUCCESS (1.980s)
[257.854381] Starting dynamic subtest: vecs0
[259.892433] Dynamic subtest vecs0: SUCCESS (2.046s)
[259.904033] Starting dynamic subtest: ccs0
[261.875429] Dynamic subtest ccs0: SUCCESS (1.980s)
[261.878336] Subtest gt-engine-hang: SUCCESS (11.568s)
[261.967458] [055/131] (760s left) prime_mmap (test_correct)
[262.025166] Starting subtest: test_correct
[262.027372] Starting dynamic subtest: test_correct-smem
[262.059352] Dynamic subtest test_correct-smem: SUCCESS (0.035s)
[262.061662] Subtest test_correct: SUCCESS (0.036s)
[262.165585] [056/131] (760s left) perf_pmu (event-wait)
[262.203823] Starting subtest: event-wait
[262.206368] Starting dynamic subtest: rcs0
[262.211101] Dynamic subtest rcs0: SKIP (0.000s)
[262.215581] Subtest event-wait: SKIP (0.001s)
[262.347302] [057/131] (760s left) kms_psr (fbc-psr-primary-mmap-cpu)
[262.448040] Starting subtest: fbc-psr-primary-mmap-cpu
[262.450318] Starting dynamic subtest: eDP-1
[262.454728] Dynamic subtest eDP-1: SKIP (0.000s)
[262.459091] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[262.534297] [058/131] (760s left) gem_exec_balancer (parallel-contexts)
[262.783857] Starting subtest: parallel-contexts
[265.326467] Subtest parallel-contexts: SUCCESS (2.546s)
[265.477225] [059/131] (757s left) gem_exec_schedule (wide)
[265.655453] Starting subtest: wide
[265.657673] Starting dynamic subtest: rcs0
[276.818048] Dynamic subtest rcs0: SUCCESS (11.163s)
[276.829434] Starting dynamic subtest: vcs0
[289.685137] Dynamic subtest vcs0: SUCCESS (12.866s)
[289.697054] Starting dynamic subtest: vcs1
[300.413215] Dynamic subtest vcs1: SUCCESS (10.726s)
[300.422140] Starting dynamic subtest: vecs0
[309.880076] Dynamic subtest vecs0: SUCCESS (9.466s)
[309.888568] Starting dynamic subtest: ccs0
[323.281807] Dynamic subtest ccs0: SUCCESS (13.400s)
[323.284709] Subtest wide: SUCCESS (57.628s)
[324.887268] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[324.890575] [060/131] (698s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[325.477049] Starting subtest: syncobj-timeline-multiple-ext-nodes
[325.483179] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[327.026640] [061/131] (695s left) tools_test (sysfs_l3_parity)
[327.073452] Starting subtest: sysfs_l3_parity
[327.147425] Subtest sysfs_l3_parity: SKIP (0.084s)
[327.229252] [062/131] (695s left) gem_mmap_gtt (basic-read)
[327.283328] Subtest basic-read: SKIP (0.000s)
[327.348427] [063/131] (695s left) gem_basic (create-fd-close)
[327.392848] Starting subtest: create-fd-close
[327.396981] Subtest create-fd-close: SUCCESS (0.000s)
[327.522859] [064/131] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[327.617262] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[327.621160] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[327.745575] [065/131] (695s left) kms_cursor_crc (cursor-dpms)
[327.873050] Starting subtest: cursor-dpms
[327.875207] Starting dynamic subtest: pipe-A-eDP-1
[330.954072] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.079s)
[330.963502] Starting dynamic subtest: pipe-D-eDP-1
[334.548739] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.592s)
[334.551192] Subtest cursor-dpms: SUCCESS (6.675s)
[335.403412] [066/131] (687s left) drm_read (short-buffer-nonblock)
[335.549196] Starting subtest: short-buffer-nonblock
[335.551363] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[335.696909] [067/131] (687s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[335.790621] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[339.954651] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.168s)
[341.097854] [068/131] (682s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[341.187828] Starting subtest: plane-downscale-factor-0-5-with-rotation
[341.190172] Starting dynamic subtest: pipe-A
[341.217819] Dynamic subtest pipe-A: SKIP (0.015s)
[341.244234] Starting dynamic subtest: pipe-B
[341.253699] Dynamic subtest pipe-B: SKIP (0.028s)
[341.264310] Starting dynamic subtest: pipe-C
[341.273356] Dynamic subtest pipe-C: SKIP (0.029s)
[341.281934] Starting dynamic subtest: pipe-D
[341.295564] Dynamic subtest pipe-D: SKIP (0.030s)
[341.300040] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.107s)
[341.422383] [069/131] (681s left) gem_mmap_gtt (basic-short)
[341.480276] Subtest basic-short: SKIP (0.000s)
[341.537668] [070/131] (681s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[341.598781] Starting subtest: invalid-multi-wait-unsubmitted
[341.601102] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[341.727487] [071/131] (681s left) gem_create (create-massive)
[341.791225] Starting subtest: create-massive
[341.793417] Subtest create-massive: SUCCESS (0.000s)
[341.994217] [072/131] (681s left) perf (gen12-invalid-class-instance)
[342.132378] Starting subtest: gen12-invalid-class-instance
[342.143081] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[342.190126] [073/131] (681s left) gem_lmem_swapping (parallel-random)
[342.233717] Subtest parallel-random: SKIP (0.000s)
[342.277993] [074/131] (681s left) kms_invalid_mode (bad-vsync-end)
[342.372292] Starting subtest: bad-vsync-end
[342.374497] Starting dynamic subtest: pipe-A-eDP-1
[342.663581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[342.672420] Starting dynamic subtest: pipe-B-eDP-1
[342.674392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[342.682213] Starting dynamic subtest: pipe-C-eDP-1
[342.684170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[342.692389] Starting dynamic subtest: pipe-D-eDP-1
[342.694645] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[342.696919] Subtest bad-vsync-end: SUCCESS (0.299s)
[343.519052] [075/131] (680s left) syncobj_timeline (wait-any-snapshot)
[343.571216] Starting subtest: wait-any-snapshot
[343.651590] Subtest wait-any-snapshot: SUCCESS (0.081s)
[343.738567] [076/131] (679s left) syncobj_wait (multi-wait-all-signaled)
[343.785962] Starting subtest: multi-wait-all-signaled
[343.788287] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[343.888965] [077/131] (679s left) gem_exec_reloc (basic-range-active)
[343.953875] Subtest basic-range-active: SKIP (0.000s)
[344.014372] [078/131] (679s left) api_intel_bb (blit-noreloc-keep-cache)
[344.068489] Starting subtest: blit-noreloc-keep-cache
[344.077409] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[344.214507] [079/131] (679s left) kms_feature_discovery (chamelium)
[344.311286] Starting subtest: chamelium
[344.315185] Subtest chamelium: SKIP (0.000s)
[344.410374] [080/131] (679s left) kms_getfb (getfb2-handle-zero)
[344.510859] Starting subtest: getfb2-handle-zero
[344.512904] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[344.643256] [081/131] (679s left) kms_psr (fbc-pr-no-drrs)
[344.726413] Starting subtest: fbc-pr-no-drrs
[344.730172] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[344.813763] [082/131] (679s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[349.796852] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[349.799044] Starting dynamic subtest: pipe-A-eDP-1
[356.416302] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.618s)
[356.428280] Starting dynamic subtest: pipe-B-eDP-1
[363.081914] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s)
[363.084385] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.284s)
[363.987162] [083/131] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[364.087512] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[370.604078] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.518s)
[370.728482] [084/131] (653s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[370.815791] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[370.818059] Starting dynamic subtest: pipe-A-eDP-1
[370.840288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[370.850237] Starting dynamic subtest: pipe-B-eDP-1
[370.872103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[370.880274] Starting dynamic subtest: pipe-C-eDP-1
[370.902161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[370.910543] Starting dynamic subtest: pipe-D-eDP-1
[370.932716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[370.936769] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[373.076927] [085/131] (650s left) kms_pwrite_crc
[374.710383] [086/131] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[374.821500] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[374.825798] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[374.958271] [087/131] (649s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[375.053226] Starting subtest: fbc-psr2-cursor-plane-onoff
[375.055502] Starting dynamic subtest: eDP-1
[375.059898] Dynamic subtest eDP-1: SKIP (0.000s)
[375.064306] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[375.153118] [088/131] (648s left) kms_atomic_interruptible (legacy-pageflip)
[375.243848] Starting subtest: legacy-pageflip
[375.246050] Starting dynamic subtest: pipe-A-eDP-1
[382.710550] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.463s)
[382.712534] Subtest legacy-pageflip: SUCCESS (7.464s)
[383.559631] [089/131] (640s left) kms_pm_rpm (system-suspend-modeset)
[385.094442] Starting subtest: system-suspend-modeset
[403.965116] Subtest system-suspend-modeset: SUCCESS (4.308s)
[404.373450] [090/131] (619s left) kms_psr (psr-dpms)
[404.490903] Starting subtest: psr-dpms
[404.493266] Starting dynamic subtest: eDP-1
[407.536769] Dynamic subtest eDP-1: SUCCESS (2.981s)
[407.539169] Subtest psr-dpms: SUCCESS (2.983s)
[408.428349] [091/131] (615s left) i915_pm_rpm (system-suspend)
[410.567102] Starting subtest: system-suspend
[428.567047] Subtest system-suspend: SUCCESS (2.864s)
[428.970315] [092/131] (595s left) gem_exec_reloc (basic-wc-active)
[429.027416] Subtest basic-wc-active: SKIP (0.000s)
[429.113866] [093/131] (595s left) syncobj_wait (single-wait-all-for-submit-signaled)
[429.168296] Starting subtest: single-wait-all-for-submit-signaled
[429.170281] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[429.288031] [094/131] (595s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[429.395974] Starting subtest: basic-busy-flip-before-cursor-varying-size
[429.400486] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[429.564169] [095/131] (594s left) gem_eio (throttle)
[429.808010] Starting subtest: throttle
[430.168308] Subtest throttle: SUCCESS (0.348s)
[430.335260] [096/131] (594s left) gem_exec_schedule (semaphore-noskip)
[430.404749] Starting subtest: semaphore-noskip
[430.854501] Subtest semaphore-noskip: SUCCESS (0.432s)
[431.222269] [097/131] (593s left) gem_mmap_offset (pf-nonblock)
[431.285514] Starting subtest: pf-nonblock
[431.293405] Subtest pf-nonblock: SUCCESS (0.011s)
[431.435023] [098/131] (593s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[431.491962] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[431.493971] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[431.611155] [099/131] (592s left) kms_plane_cursor (primary)
[431.701656] Starting subtest: primary
[431.706185] Starting dynamic subtest: pipe-A-eDP-1-size-64
[434.403288] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.651s)
[434.429100] Starting dynamic subtest: pipe-A-eDP-1-size-128
[437.094988] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.638s)
[437.122524] Starting dynamic subtest: pipe-A-eDP-1-size-256
[439.822050] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.684s)
[440.138942] Starting dynamic subtest: pipe-B-eDP-1-size-64
[443.498599] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.348s)
[443.523896] Starting dynamic subtest: pipe-B-eDP-1-size-128
[446.231108] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.704s)
[446.258656] Starting dynamic subtest: pipe-B-eDP-1-size-256
[449.010223] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.750s)
[449.332458] Starting dynamic subtest: pipe-C-eDP-1-size-64
[452.325620] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.996s)
[452.352167] Starting dynamic subtest: pipe-C-eDP-1-size-128
[454.506231] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[454.533924] Starting dynamic subtest: pipe-C-eDP-1-size-256
[456.742797] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.213s)
[457.063222] Starting dynamic subtest: pipe-D-eDP-1-size-64
[460.045864] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.991s)
[460.073382] Starting dynamic subtest: pipe-D-eDP-1-size-128
[462.279497] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[462.306783] Starting dynamic subtest: pipe-D-eDP-1-size-256
[464.413771] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.113s)
[464.732064] Subtest primary: SUCCESS (32.857s)
[465.542390] [100/131] (559s left) prime_vgem (busy)
[465.610814] Starting subtest: busy
[465.613158] Starting dynamic subtest: rcs0
[465.688747] Dynamic subtest rcs0: SUCCESS (0.078s)
[465.702000] Starting dynamic subtest: bcs0
[465.764745] Dynamic subtest bcs0: SUCCESS (0.075s)
[465.774639] Starting dynamic subtest: vcs0
[465.812791] Dynamic subtest vcs0: SUCCESS (0.047s)
[465.822926] Starting dynamic subtest: vcs1
[465.861347] Dynamic subtest vcs1: SUCCESS (0.048s)
[465.871034] Starting dynamic subtest: vecs0
[465.906968] Dynamic subtest vecs0: SUCCESS (0.045s)
[465.916446] Starting dynamic subtest: ccs0
[465.952663] Dynamic subtest ccs0: SUCCESS (0.045s)
[465.954915] Subtest busy: SUCCESS (0.342s)
[466.122265] [101/131] (558s left) gem_softpin (evict-active)
[466.187499] Starting subtest: evict-active
[466.193282] Subtest evict-active: SUCCESS (0.006s)
[466.348034] [102/131] (558s left) kms_vblank (wait-busy)
[466.452377] Starting subtest: wait-busy
[466.454512] Starting dynamic subtest: pipe-A-eDP-1
[468.340164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[468.355253] Starting dynamic subtest: pipe-D-eDP-1
[470.892966] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[470.895117] Subtest wait-busy: SUCCESS (4.440s)
[471.704809] [103/131] (553s left) gem_mmap_gtt (isolation)
[471.763672] Subtest isolation: SKIP (0.000s)
[471.830726] [104/131] (552s left) kms_lease (possible-crtcs-filtering)
[471.941655] Starting subtest: possible-crtcs-filtering
[471.948116] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[472.074034] [105/131] (552s left) syncobj_timeline (invalid-signal-bad-pad)
[472.125593] Starting subtest: invalid-signal-bad-pad
[472.127616] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[472.247585] [106/131] (552s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[472.355287] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[472.357447] Starting dynamic subtest: pipe-A-default-mode
[472.655117] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[472.659567] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.300s)
[473.535349] [107/131] (551s left) sysfs_defaults (readonly)
[473.613931] Starting subtest: readonly
[473.616163] Starting dynamic subtest: vecs0
[473.618504] Dynamic subtest vecs0: SUCCESS (0.000s)
[473.628338] Starting dynamic subtest: ccs0
[473.630287] Dynamic subtest ccs0: SUCCESS (0.000s)
[473.639880] Starting dynamic subtest: vcs0
[473.642135] Dynamic subtest vcs0: SUCCESS (0.000s)
[473.651337] Starting dynamic subtest: bcs0
[473.653279] Dynamic subtest bcs0: SUCCESS (0.000s)
[473.662375] Starting dynamic subtest: rcs0
[473.664283] Dynamic subtest rcs0: SUCCESS (0.000s)
[473.673293] Starting dynamic subtest: vcs1
[473.675166] Dynamic subtest vcs1: SUCCESS (0.000s)
[473.677014] Subtest readonly: SUCCESS (0.006s)
[473.715321] [108/131] (551s left) kms_psr (psr2-primary-blt)
[473.808550] Starting subtest: psr2-primary-blt
[473.810864] Starting dynamic subtest: eDP-1
[475.508267] Dynamic subtest eDP-1: SUCCESS (1.699s)
[475.510512] Subtest psr2-primary-blt: SUCCESS (1.700s)
[476.394359] [109/131] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[476.485472] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[483.770954] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.285s)
[483.939945] [110/131] (541s left) gem_ctx_persistence (many-contexts)
[484.008839] Starting subtest: many-contexts
[529.275601] Subtest many-contexts: SUCCESS (45.251s)
[529.380743] [111/131] (495s left) kms_color (degamma)
[529.473247] Starting subtest: degamma
[529.475307] Starting dynamic subtest: pipe-A-eDP-1
[530.169201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[530.179743] Starting dynamic subtest: pipe-B-eDP-1
[531.615215] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[531.626003] Starting dynamic subtest: pipe-C-eDP-1
[532.902874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[532.912762] Starting dynamic subtest: pipe-D-eDP-1
[534.240121] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[534.242568] Subtest degamma: SUCCESS (4.770s)
[535.065524] [112/131] (490s left) gem_pipe_control_store_loop (fresh-buffer)
[535.126685] Starting subtest: fresh-buffer
[537.279001] Subtest fresh-buffer: SUCCESS (2.152s)
[537.444722] [113/131] (487s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[537.545026] Starting subtest: random-ccs-data-y-tiled-ccs
[537.547248] Starting dynamic subtest: pipe-A-eDP-1
[537.580701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[537.590575] Starting dynamic subtest: pipe-B-eDP-1
[537.613994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[537.623486] Starting dynamic subtest: pipe-C-eDP-1
[537.648187] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[537.657584] Starting dynamic subtest: pipe-D-eDP-1
[537.682138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[537.686224] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[539.820569] [114/131] (485s left) gem_ctx_param (vm)
[539.875594] Starting subtest: vm
[539.915682] Subtest vm: SUCCESS (0.040s)
[540.047265] [115/131] (485s left) kms_flip (2x-absolute-wf_vblank)
[540.148654] Starting subtest: 2x-absolute-wf_vblank
[540.158033] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[540.312340] [116/131] (484s left) gem_ccs (block-copy-compressed)
[540.381333] Starting subtest: block-copy-compressed
[540.385348] Subtest block-copy-compressed: SKIP (0.000s)
[540.515323] [117/131] (484s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[540.601243] Starting subtest: multiplane-rotation-cropping-top
[547.769295] Subtest multiplane-rotation-cropping-top: SUCCESS (7.171s)
[547.923823] [118/131] (477s left) prime_self_import (basic-llseek-bad)
[547.957289] Starting subtest: basic-llseek-bad
[547.978516] Subtest basic-llseek-bad: SUCCESS (0.021s)
[548.097298] [119/131] (477s left) core_getversion (all-cards)
[548.133672] Starting subtest: all-cards
[548.142025] Subtest all-cards: SUCCESS (0.011s)
[548.190643] [120/131] (477s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[548.285938] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[549.122058] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[549.329060] [121/131] (476s left) gem_ringfill (basic-all)
[555.519273] Starting subtest: basic-all
[556.680307] Subtest basic-all: SUCCESS (1.161s)
[556.847950] [122/131] (468s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[556.947184] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[558.002501] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.055s)
[558.161855] [123/131] (467s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[558.259636] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[558.263294] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[558.363586] [124/131] (467s left) gem_pxp (verify-pxp-stale-buf-execution)
[558.478836] Starting subtest: verify-pxp-stale-buf-execution
[559.537396] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.060s)
[559.707404] [125/131] (465s left) gem_sync (basic-each)
[559.783857] Starting subtest: basic-each
[562.377642] Subtest basic-each: SUCCESS (2.604s)
[562.576301] [126/131] (463s left) gem_render_copy_redux (flink)
[562.636275] Starting subtest: flink
[563.836899] Subtest flink: SUCCESS (1.201s)
[564.010325] [127/131] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[564.105791] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[564.109212] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[564.233485] [128/131] (461s left) gem_spin_batch (user-each)
[564.304772] Starting subtest: user-each
[567.590733] Subtest user-each: SUCCESS (3.260s)
[569.566144] [129/131] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[569.681822] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[576.618976] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.937s)
[576.805874] [130/131] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[576.911040] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[583.915502] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.005s)
[584.065322] [131/131] (441s left) gem_exec_schedule (independent)
[584.145115] Starting subtest: independent
[584.147183] Starting dynamic subtest: rcs0
[585.533973] Dynamic subtest rcs0: SUCCESS (1.396s)
[585.546895] Starting dynamic subtest: vcs0
[587.554267] Dynamic subtest vcs0: SUCCESS (2.018s)
[587.567389] Starting dynamic subtest: vcs1
[589.519376] Dynamic subtest vcs1: SUCCESS (1.962s)
[589.532217] Starting dynamic subtest: vecs0
[591.535879] Dynamic subtest vecs0: SUCCESS (2.015s)
[591.547735] Starting dynamic subtest: ccs0
[593.532947] Dynamic subtest ccs0: SUCCESS (1.994s)
[593.535851] Subtest independent: SUCCESS (9.396s)
[593.844625] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_partial_pwrite_pread
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_atomic_interruptible
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_writeback
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: i915_power
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_sharpness_filter
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: prime_mmap
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: tools_test
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: drm_read
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_lmem_swapping
results: parsing output: 73/ for test: kms_invalid_mode
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_pwrite_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_plane_cursor
results: parsing output: 99/ for test: prime_vgem
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: sysfs_defaults
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: gem_pipe_control_store_loop
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: core_getversion
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_ringfill
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: gem_sync
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_schedule
Done.