[58.697728] Initializing watchdogs
[58.697797]   /dev/watchdog0
[58.711929] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.716892] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.719187] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.722719] [001/133] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[58.858235] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[58.862376] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[58.919615] [002/133] (960s left) syncobj_timeline (single-wait-signaled)
[58.975073] Starting subtest: single-wait-signaled
[58.977333] Subtest single-wait-signaled: SUCCESS (0.000s)
[59.061767] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[59.171109] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[60.229500] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.050s)
[60.350372] [004/133] (958s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[60.405915] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[60.512696] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[60.582726] [005/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[60.682045] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[60.686321] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.775633] [006/133] (958s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[60.864305] Starting subtest: fbc-pr-cursor-mmap-cpu
[60.868598] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[60.932998] [007/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[61.034570] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[67.680787] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.622s)
[67.844571] [008/133] (951s left) kms_sequence (get-forked-busy)
[67.972979] Starting subtest: get-forked-busy
[67.975485] Starting dynamic subtest: pipe-A-eDP-1
[69.914100] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[69.925105] Starting dynamic subtest: pipe-B-eDP-1
[72.495839] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[72.507815] Starting dynamic subtest: pipe-C-eDP-1
[75.132746] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[75.144050] Starting dynamic subtest: pipe-D-eDP-1
[77.754216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[77.756654] Subtest get-forked-busy: SUCCESS (9.769s)
[78.652144] [009/133] (940s left) i915_drm_fdinfo (memory-info-purgeable)
[78.691825] Starting subtest: memory-info-purgeable
[78.694198] Starting dynamic subtest: smem0
[81.584441] Dynamic subtest smem0: SUCCESS (2.891s)
[81.586698] Subtest memory-info-purgeable: SUCCESS (2.892s)
[81.657580] [010/133] (937s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[81.720557] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[81.722606] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[81.844202] [011/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[81.950617] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[81.954068] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[82.035022] [012/133] (937s left) gem_lmem_swapping (verify-ccs)
[82.074262] Subtest verify-ccs: SKIP (0.000s)
[82.115380] [013/133] (937s left) perf_pmu (busy-idle-check-all)
[82.163038] Starting subtest: busy-idle-check-all
[82.165087] Starting dynamic subtest: rcs0
[82.816720] Dynamic subtest rcs0: SUCCESS (0.653s)
[82.827401] Starting dynamic subtest: bcs0
[83.471338] Dynamic subtest bcs0: SUCCESS (0.652s)
[83.481997] Starting dynamic subtest: vcs0
[84.884434] Dynamic subtest vcs0: SUCCESS (1.409s)
[84.894783] Starting dynamic subtest: vcs1
[86.932951] Dynamic subtest vcs1: SUCCESS (2.045s)
[86.942972] Starting dynamic subtest: vecs0
[88.917216] Dynamic subtest vecs0: SUCCESS (1.982s)
[88.927036] Starting dynamic subtest: ccs0
[89.572255] Dynamic subtest ccs0: SUCCESS (0.655s)
[89.574772] Subtest busy-idle-check-all: SUCCESS (7.403s)
[89.714292] [014/133] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[89.837798] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[89.842285] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[89.946657] [015/133] (929s left) gem_exec_flush (basic-wb-ro-default)
[90.001394] Starting subtest: basic-wb-ro-default
[95.460428] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[95.655379] [016/133] (924s left) kms_psr (psr2-sprite-plane-move)
[95.754048] Starting subtest: psr2-sprite-plane-move
[95.756450] Starting dynamic subtest: eDP-1
[97.468520] Dynamic subtest eDP-1: SUCCESS (1.715s)
[97.470837] Subtest psr2-sprite-plane-move: SUCCESS (1.716s)
[98.308745] [017/133] (921s left) syncobj_eventfd (binary-wait-signaled)
[98.370903] Starting subtest: binary-wait-signaled
[98.372902] Subtest binary-wait-signaled: SUCCESS (0.000s)
[98.477952] [018/133] (921s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[98.565074] Starting subtest: fbc-psr2-sprite-plane-onoff
[98.567327] Starting dynamic subtest: eDP-1
[98.571686] Dynamic subtest eDP-1: SKIP (0.000s)
[98.576271] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[98.636117] [019/133] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[98.730085] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[98.734365] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.816642] [020/133] (921s left) kms_flip (2x-flip-vs-panning-interruptible)
[98.916052] Starting subtest: 2x-flip-vs-panning-interruptible
[98.927409] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[99.015653] [021/133] (921s left) gem_pxp (reject-modify-context-protection-on)
[99.139579] Starting subtest: reject-modify-context-protection-on
[99.142134] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[99.240433] [022/133] (920s left) kms_chamelium_frames (dp-frame-dump)
[99.628558] Subtest dp-frame-dump: SKIP (0.000s)
[100.416753] [023/133] (919s left) syncobj_basic (bad-pad-handle-to-fd)
[100.466573] Starting subtest: bad-pad-handle-to-fd
[100.468895] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[100.571822] [024/133] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[100.662391] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[104.655608] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.995s)
[105.837968] [025/133] (914s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[108.076555] Starting subtest: dpms-mode-unset-lpsp
[112.134340] Subtest dpms-mode-unset-lpsp: SUCCESS (4.057s)
[112.536459] [026/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[112.626604] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[112.631285] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[112.717668] [027/133] (907s left) kms_addfb_basic (bad-pitch-0)
[112.771746] Starting subtest: bad-pitch-0
[112.773603] Subtest bad-pitch-0: SUCCESS (0.000s)
[112.896945] [028/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[112.991394] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[112.995702] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[113.078546] [029/133] (907s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[113.173336] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[113.177780] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[113.260887] [030/133] (907s left) gem_mmap_gtt (basic-wc)
[113.312728] Subtest basic-wc: SKIP (0.000s)
[113.370378] [031/133] (907s left) kms_async_flips (test-cursor)
[113.465884] Starting subtest: test-cursor
[113.469465] Subtest test-cursor: SKIP (0.000s)
[114.638850] [032/133] (905s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[114.743199] Starting subtest: 2x-flip-vs-modeset-vs-hang
[114.752336] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[114.828255] [033/133] (905s left) gem_exec_schedule (u-semaphore-user)
[114.901616] Starting subtest: u-semaphore-user
[114.957031] Subtest u-semaphore-user: SUCCESS (0.062s)
[116.934404] [034/133] (903s left) kms_big_fb (x-tiled-addfb-size-overflow)
[117.033166] Starting subtest: x-tiled-addfb-size-overflow
[117.035584] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[117.123354] [035/133] (903s left) kms_vblank (wait-forked-hang)
[117.221828] Starting subtest: wait-forked-hang
[117.224170] Starting dynamic subtest: pipe-A-eDP-1
[143.638941] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.410s)
[143.652971] Starting dynamic subtest: pipe-D-eDP-1
[158.678505] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.039s)
[158.680769] Subtest wait-forked-hang: SUCCESS (41.452s)
[159.490425] [036/133] (861s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[159.586083] Starting subtest: psr-shrfb-scaledprimary
[165.379716] Subtest psr-shrfb-scaledprimary: SUCCESS (5.798s)
[165.531545] [037/133] (855s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[165.581950] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[165.584290] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[165.695478] [038/133] (854s left) perf (blocking-parameterized)
[165.829059] Starting subtest: blocking-parameterized
[185.850061] Subtest blocking-parameterized: SUCCESS (20.022s)
[185.897942] [039/133] (834s left) kms_addfb_basic (bad-pitch-256)
[185.946947] Starting subtest: bad-pitch-256
[185.949638] Subtest bad-pitch-256: SUCCESS (0.000s)
[186.087594] [040/133] (834s left) gem_eio (in-flight-contexts-1us)
[186.322393] Starting subtest: in-flight-contexts-1us
[197.934067] Subtest in-flight-contexts-1us: SUCCESS (11.611s)
[198.107290] [041/133] (822s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[198.214731] Starting subtest: fbc-rgb565-draw-mmap-wc
[202.225399] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.015s)
[203.418602] [042/133] (817s left) kms_draw_crc (draw-method-pwrite)
[203.509315] Starting subtest: draw-method-pwrite
[203.511355] Starting dynamic subtest: xrgb8888-untiled
[204.129431] Dynamic subtest xrgb8888-untiled: SUCCESS (0.622s)
[204.138910] Starting dynamic subtest: rgb565-untiled
[204.596312] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[204.605506] Starting dynamic subtest: xrgb2101010-untiled
[205.163119] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.565s)
[205.174293] Starting dynamic subtest: xbgr16161616f-untiled
[205.951836] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.789s)
[205.960854] Starting dynamic subtest: xrgb8888-xtiled
[207.830534] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.876s)
[207.838770] Starting dynamic subtest: rgb565-xtiled
[208.953089] Dynamic subtest rgb565-xtiled: SUCCESS (1.120s)
[208.962140] Starting dynamic subtest: xrgb2101010-xtiled
[210.785424] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.831s)
[210.794714] Starting dynamic subtest: xbgr16161616f-xtiled
[214.197150] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.411s)
[214.206124] Starting dynamic subtest: xrgb8888-4tiled
[215.341950] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.144s)
[215.351414] Starting dynamic subtest: rgb565-4tiled
[215.919096] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[215.927726] Starting dynamic subtest: xrgb2101010-4tiled
[217.052821] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.133s)
[217.061456] Starting dynamic subtest: xbgr16161616f-4tiled
[220.163966] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.110s)
[220.166256] Subtest draw-method-pwrite: SUCCESS (16.656s)
[220.256371] [043/133] (800s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[220.371216] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[220.375731] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[220.518451] [044/133] (800s left) gem_pipe_control_store_loop (fresh-buffer)
[220.578681] Starting subtest: fresh-buffer
[222.731792] Subtest fresh-buffer: SUCCESS (2.151s)
[222.838363] [045/133] (798s left) syncobj_basic (test-valid-cycle)
[222.895070] Starting subtest: test-valid-cycle
[222.897581] Subtest test-valid-cycle: SUCCESS (0.000s)
[223.011659] [046/133] (798s left) kms_flip (basic-flip-vs-wf_vblank)
[223.115255] Starting subtest: basic-flip-vs-wf_vblank
[223.117548] Starting dynamic subtest: A-eDP1
[225.030615] Dynamic subtest A-eDP1: SUCCESS (1.914s)
[225.039904] Starting dynamic subtest: B-eDP1
[226.966743] Dynamic subtest B-eDP1: SUCCESS (1.934s)
[226.977238] Starting dynamic subtest: C-eDP1
[228.881882] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[228.895952] Starting dynamic subtest: D-eDP1
[230.812632] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[230.817685] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.703s)
[232.037899] [047/133] (789s left) gem_mmap_wc (bad-object)
[232.093712] Subtest bad-object: SKIP (0.000s)
[232.163698] [048/133] (788s left) kms_atomic_interruptible (universal-setplane-cursor)
[232.260880] Starting subtest: universal-setplane-cursor
[232.263057] Starting dynamic subtest: pipe-A-eDP-1
[239.650838] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s)
[239.653288] Subtest universal-setplane-cursor: SUCCESS (7.388s)
[240.516843] [049/133] (780s left) prime_self_import (reimport-vs-gem_close-race)
[240.554599] Starting subtest: reimport-vs-gem_close-race
[245.620939] Subtest reimport-vs-gem_close-race: SUCCESS (5.066s)
[245.740058] [050/133] (775s left) sw_sync (timeline_closed)
[245.778730] Starting subtest: timeline_closed
[245.781213] Subtest timeline_closed: SUCCESS (0.000s)
[245.840523] [051/133] (775s left) kms_psr (pr-primary-blt)
[245.944972] Starting subtest: pr-primary-blt
[245.949405] Subtest pr-primary-blt: SKIP (0.000s)
[246.015314] [052/133] (775s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[246.103875] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[246.108272] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[246.173736] [053/133] (775s left) syncobj_wait (invalid-signal-zero-handles)
[246.237153] Starting subtest: invalid-signal-zero-handles
[246.239585] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[246.352184] [054/133] (775s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[246.450369] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[250.411535] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.963s)
[251.614891] [055/133] (769s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[251.718907] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[252.752542] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[252.876060] [056/133] (768s left) gen7_exec_parse (basic-rejected)
[252.932447] Subtest basic-rejected: SKIP (0.000s)
[253.001222] [057/133] (768s left) prime_mmap (test_userptr)
[253.066307] Starting subtest: test_userptr
[253.068351] Starting dynamic subtest: test_userptr-smem
[253.070263] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[253.071935] Subtest test_userptr: SUCCESS (0.001s)
[253.174372] [058/133] (768s left) i915_pm_rc6_residency (media-rc6-accuracy)
[253.236816] Starting subtest: media-rc6-accuracy
[253.240657] Subtest media-rc6-accuracy: SKIP (0.000s)
[253.344076] [059/133] (768s left) gem_softpin (allocator-fork)
[253.403825] Starting subtest: allocator-fork
[255.623623] Subtest allocator-fork: SUCCESS (2.219s)
[255.749144] [060/133] (765s left) gem_busy (busy)
[255.810502] Starting subtest: busy
[255.812666] Starting dynamic subtest: all-engines
[255.872118] Dynamic subtest all-engines: SUCCESS (0.062s)
[255.881282] Starting dynamic subtest: rcs0
[257.887720] Dynamic subtest rcs0: SUCCESS (2.014s)
[257.898143] Starting dynamic subtest: bcs0
[257.953110] Dynamic subtest bcs0: SUCCESS (0.064s)
[257.962038] Starting dynamic subtest: vcs0
[257.992673] Dynamic subtest vcs0: SUCCESS (0.038s)
[258.002035] Starting dynamic subtest: vcs1
[259.930857] Dynamic subtest vcs1: SUCCESS (1.936s)
[259.941071] Starting dynamic subtest: vecs0
[261.914810] Dynamic subtest vecs0: SUCCESS (1.982s)
[261.925496] Starting dynamic subtest: ccs0
[263.898743] Dynamic subtest ccs0: SUCCESS (1.984s)
[263.900859] Subtest busy: SUCCESS (8.087s)
[264.288105] [061/133] (757s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[264.388870] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[264.391191] Starting dynamic subtest: pipe-A-eDP-1
[264.448254] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[264.458590] Starting dynamic subtest: pipe-B-eDP-1
[264.514621] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[264.526040] Starting dynamic subtest: pipe-C-eDP-1
[264.583409] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[264.592854] Starting dynamic subtest: pipe-D-eDP-1
[264.649647] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[264.653913] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[266.576021] [062/133] (755s left) drm_read (short-buffer-block)
[266.717160] Starting subtest: short-buffer-block
[266.719694] Subtest short-buffer-block: SUCCESS (0.000s)
[266.831707] [063/133] (754s left) kms_getfb (getfb-handle-not-fb)
[266.932997] Starting subtest: getfb-handle-not-fb
[266.935510] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[267.033674] [064/133] (754s left) kms_pm_rpm (modeset-lpsp-stress)
[269.069550] Starting subtest: modeset-lpsp-stress
[285.308573] Subtest modeset-lpsp-stress: SUCCESS (16.240s)
[285.396009] [065/133] (736s left) i915_drm_fdinfo (virtual-busy-idle-all)
[285.442800] Starting subtest: virtual-busy-idle-all
[285.447221] Subtest virtual-busy-idle-all: SKIP (0.000s)
[285.506819] [066/133] (736s left) gem_workarounds (basic-read)
[285.571047] Starting subtest: basic-read
[285.581106] Subtest basic-read: SUCCESS (0.010s)
[285.690754] [067/133] (736s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[285.832460] Starting subtest: dp-mst-type-0-suspend-resume
[285.836882] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[285.968110] [068/133] (735s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[286.072506] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[286.076537] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[286.141233] [069/133] (735s left) kms_prop_blob (invalid-set-prop)
[286.197865] Starting subtest: invalid-set-prop
[286.199702] Subtest invalid-set-prop: SUCCESS (0.000s)
[286.279434] [070/133] (735s left) kms_hdr (static-toggle-dpms)
[286.379566] Starting subtest: static-toggle-dpms
[286.384954] Subtest static-toggle-dpms: SKIP (0.000s)
[286.450561] [071/133] (735s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[286.550241] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[286.552112] Starting dynamic subtest: pipe-A-eDP-1
[286.571198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.583381] Starting dynamic subtest: pipe-B-eDP-1
[286.599704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.607300] Starting dynamic subtest: pipe-C-eDP-1
[286.624196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.631850] Starting dynamic subtest: pipe-D-eDP-1
[286.649061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.652397] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[288.824317] [072/133] (733s left) prime_vgem (shrink)
[288.957311] Starting subtest: shrink
[288.972132] Subtest shrink: SUCCESS (0.013s)
[289.091087] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[289.094088] [073/133] (733s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[289.163930] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[289.237723] [074/133] (732s left) gem_create (busy-create)
[289.306549] Starting subtest: busy-create
[289.309134] Starting dynamic subtest: smem0
[322.837093] Dynamic subtest smem0: SUCCESS (33.527s)
[322.839693] Subtest busy-create: SUCCESS (33.529s)
[323.029266] [075/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[323.146065] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[323.150416] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[323.237253] [076/133] (698s left) gem_exec_whisper (basic-contexts-forked)
[323.310426] Starting subtest: basic-contexts-forked
[348.258782] Subtest basic-contexts-forked: SUCCESS (24.941s)
[348.452403] [077/133] (673s left) gem_ctx_persistence (many-contexts)
[348.508625] Starting subtest: many-contexts
[393.698068] Subtest many-contexts: SUCCESS (45.185s)
[393.783607] [078/133] (628s left) gem_softpin (evict-active)
[393.848279] Starting subtest: evict-active
[393.854454] Subtest evict-active: SUCCESS (0.009s)
[393.986139] [079/133] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[394.097590] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[402.794171] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.698s)
[402.900012] [080/133] (619s left) kms_plane (plane-panning-top-left)
[403.009367] Starting subtest: plane-panning-top-left
[403.011544] Starting dynamic subtest: pipe-A
[404.702576] Dynamic subtest pipe-A: SUCCESS (1.692s)
[404.712372] Starting dynamic subtest: pipe-B
[407.075057] Dynamic subtest pipe-B: SUCCESS (2.370s)
[407.077359] Subtest plane-panning-top-left: SUCCESS (4.065s)
[407.864274] [081/133] (614s left) gem_exec_schedule (preempt-contexts)
[407.930621] Starting subtest: preempt-contexts
[407.932786] Starting dynamic subtest: rcs0
[407.983442] Dynamic subtest rcs0: SUCCESS (0.058s)
[407.993222] Starting dynamic subtest: bcs0
[408.039708] Dynamic subtest bcs0: SUCCESS (0.055s)
[408.049103] Starting dynamic subtest: vcs0
[408.089466] Dynamic subtest vcs0: SUCCESS (0.050s)
[408.098168] Starting dynamic subtest: vcs1
[408.138677] Dynamic subtest vcs1: SUCCESS (0.048s)
[408.148164] Starting dynamic subtest: vecs0
[408.184983] Dynamic subtest vecs0: SUCCESS (0.045s)
[408.194059] Starting dynamic subtest: ccs0
[408.236132] Dynamic subtest ccs0: SUCCESS (0.051s)
[408.238305] Subtest preempt-contexts: SUCCESS (0.312s)
[410.003807] [082/133] (612s left) gem_exec_fence (syncobj-repeat)
[410.480420] Starting subtest: syncobj-repeat
[410.669960] Subtest syncobj-repeat: SUCCESS (0.188s)
[412.021669] [083/133] (610s left) gem_exec_reloc (basic-gtt-cpu)
[412.093161] Subtest basic-gtt-cpu: SKIP (0.000s)
[412.165988] [084/133] (610s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[412.220107] Starting subtest: rel-constants-invalid-rel-gen5
[412.222807] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[412.323299] [085/133] (610s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[412.419340] Starting subtest: plane-upscale-20x20-with-modifiers
[412.421675] Starting dynamic subtest: pipe-A
[412.757477] Dynamic subtest pipe-A: SUCCESS (0.338s)
[412.768185] Starting dynamic subtest: pipe-B
[414.147464] Dynamic subtest pipe-B: SUCCESS (1.389s)
[414.156863] Starting dynamic subtest: pipe-C
[415.588414] Dynamic subtest pipe-C: SUCCESS (1.439s)
[415.597711] Starting dynamic subtest: pipe-D
[417.028109] Dynamic subtest pipe-D: SUCCESS (1.438s)
[417.030315] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.610s)
[418.200427] [086/133] (604s left) gem_exec_fence (syncobj-timeline-unused-fence)
[418.732636] Starting subtest: syncobj-timeline-unused-fence
[418.738450] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[420.020640] [087/133] (602s left) gem_ctx_param (invalid-get-no-zeromap)
[420.086600] Starting subtest: invalid-get-no-zeromap
[420.088835] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[420.198190] [088/133] (602s left) kms_cursor_edge_walk (256x256-right-edge)
[420.305019] Starting subtest: 256x256-right-edge
[420.307295] Starting dynamic subtest: pipe-A-eDP-1
[423.768058] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[423.777454] Starting dynamic subtest: pipe-D-eDP-1
[426.893457] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[426.895699] Subtest 256x256-right-edge: SUCCESS (6.589s)
[427.702954] [089/133] (595s left) core_auth (getclient-simple)
[427.746060] Starting subtest: getclient-simple
[427.763803] Subtest getclient-simple: SUCCESS (0.019s)
[427.873596] [090/133] (594s left) gem_exec_balancer (parallel-keep-in-fence)
[428.133959] Starting subtest: parallel-keep-in-fence
[429.391037] Subtest parallel-keep-in-fence: SUCCESS (1.257s)
[429.500430] [091/133] (593s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[429.595078] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[429.597232] Starting dynamic subtest: pipe-A-eDP-1
[429.619511] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.630391] Starting dynamic subtest: pipe-B-eDP-1
[429.651591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.661094] Starting dynamic subtest: pipe-C-eDP-1
[429.682680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.693555] Starting dynamic subtest: pipe-D-eDP-1
[429.715597] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.719637] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[431.864961] [092/133] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[431.960822] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[431.964909] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.066250] [093/133] (590s left) sw_sync (sync_busy_fork)
[432.105891] Starting subtest: sync_busy_fork
[433.118247] Subtest sync_busy_fork: SUCCESS (1.013s)
[433.194606] [094/133] (589s left) kms_chamelium_color (ctm-max)
[433.293338] Subtest ctm-max: SKIP (0.000s)
[433.340983] [095/133] (589s left) kms_flip (2x-plain-flip-fb-recreate)
[433.448436] Starting subtest: 2x-plain-flip-fb-recreate
[433.457197] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[433.552497] [096/133] (589s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[433.647758] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[440.585409] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.939s)
[440.722507] [097/133] (582s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[440.846340] Starting subtest: 4-tiled-64bpp-rotate-180
[442.459544] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.613s)
[442.636964] [098/133] (580s left) kms_lease (lease-unleased-connector)
[442.723031] Starting subtest: lease-unleased-connector
[442.725234] Starting dynamic subtest: pipe-A-eDP-1
[442.729619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[442.739256] Starting dynamic subtest: pipe-B-eDP-1
[442.741037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[442.750506] Starting dynamic subtest: pipe-C-eDP-1
[442.752332] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[442.761626] Starting dynamic subtest: pipe-D-eDP-1
[442.763364] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[442.765095] Subtest lease-unleased-connector: SUCCESS (0.038s)
[442.873430] [099/133] (580s left) sw_sync (sync_multi_consumer_producer)
[442.909921] Starting subtest: sync_multi_consumer_producer
[443.215796] Subtest sync_multi_consumer_producer: SUCCESS (0.306s)
[443.278101] [100/133] (580s left) kms_cursor_crc (cursor-offscreen-64x64)
[443.451163] Starting subtest: cursor-offscreen-64x64
[443.456118] Starting dynamic subtest: pipe-A-eDP-1
[445.399048] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[445.430830] Starting dynamic subtest: pipe-D-eDP-1
[447.982418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[447.984768] Subtest cursor-offscreen-64x64: SUCCESS (4.530s)
[448.836037] [101/133] (574s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[448.936375] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[448.938572] Starting dynamic subtest: pipe-A-eDP-1
[448.961050] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.973542] Starting dynamic subtest: pipe-B-eDP-1
[448.995216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.003983] Starting dynamic subtest: pipe-C-eDP-1
[449.025286] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.033947] Starting dynamic subtest: pipe-D-eDP-1
[449.055845] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.059878] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[451.433646] [102/133] (571s left) gem_mmap_gtt (flink-race)
[451.497777] Subtest flink-race: SKIP (0.000s)
[451.560146] [103/133] (571s left) kms_addfb_basic (legacy-format)
[451.619204] Starting subtest: legacy-format
[451.647824] Subtest legacy-format: SUCCESS (0.029s)
[451.785416] [104/133] (571s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[451.883498] Starting subtest: invalidate-primary-flip-overlay
[462.705198] Subtest invalidate-primary-flip-overlay: SUCCESS (10.823s)
[462.807148] [105/133] (560s left) gem_wait (busy)
[462.871083] Starting subtest: busy
[462.873027] Starting dynamic subtest: all-engines
[464.916816] Dynamic subtest all-engines: SUCCESS (2.043s)
[464.929342] Starting dynamic subtest: rcs0
[465.458383] Dynamic subtest rcs0: SUCCESS (0.541s)
[465.469683] Starting dynamic subtest: bcs0
[465.999693] Dynamic subtest bcs0: SUCCESS (0.540s)
[466.010525] Starting dynamic subtest: vcs0
[467.924559] Dynamic subtest vcs0: SUCCESS (1.922s)
[467.935855] Starting dynamic subtest: vcs1
[469.908879] Dynamic subtest vcs1: SUCCESS (1.982s)
[469.920451] Starting dynamic subtest: vecs0
[471.891777] Dynamic subtest vecs0: SUCCESS (1.981s)
[471.903881] Starting dynamic subtest: ccs0
[472.434283] Dynamic subtest ccs0: SUCCESS (0.541s)
[472.436872] Subtest busy: SUCCESS (9.564s)
[472.639536] [106/133] (550s left) api_intel_allocator (reloc-allocator)
[472.698669] Starting subtest: reloc-allocator
[472.700554] Starting dynamic subtest: basic
[472.702894] Dynamic subtest basic: SUCCESS (0.005s)
[472.718365] Starting dynamic subtest: parallel-one
[472.720446] Dynamic subtest parallel-one: SUCCESS (0.007s)
[472.731541] Starting dynamic subtest: print
[472.733746] Dynamic subtest print: SUCCESS (0.000s)
[472.744234] Starting dynamic subtest: reuse
[472.746492] Dynamic subtest reuse: SUCCESS (0.000s)
[472.755465] Starting dynamic subtest: fork-reopen-allocator
[472.757573] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[472.759636] Subtest reloc-allocator: SUCCESS (0.028s)
[472.857839] [107/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[472.956091] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[472.960155] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[473.043281] [108/133] (550s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[473.133970] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[473.136221] Starting dynamic subtest: pipe-A-default-mode
[474.285960] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[474.291631] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.151s)
[474.428412] [109/133] (549s left) i915_query (hwconfig_table)
[474.484063] Starting subtest: hwconfig_table
[474.779415] Subtest hwconfig_table: SUCCESS (0.001s)
[474.819953] [110/133] (548s left) vgem_basic (bad-flag)
[474.873520] Starting subtest: bad-flag
[474.875356] Subtest bad-flag: SUCCESS (0.000s)
[474.941350] [111/133] (548s left) kms_flip (wf_vblank-ts-check)
[475.035691] Starting subtest: wf_vblank-ts-check
[475.038160] Starting dynamic subtest: A-eDP1
[484.003083] Dynamic subtest A-eDP1: SUCCESS (8.966s)
[484.015078] Starting dynamic subtest: B-eDP1
[492.938626] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[492.947901] Starting dynamic subtest: C-eDP1
[501.866257] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[501.875889] Starting dynamic subtest: D-eDP1
[510.800998] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[510.806429] Subtest wf_vblank-ts-check: SUCCESS (35.767s)
[512.035779] [112/133] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[512.138466] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[512.142499] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[512.240283] [113/133] (511s left) kms_plane_multiple (tiling-none)
[512.340523] Starting subtest: tiling-none
[512.342849] Starting dynamic subtest: pipe-A-eDP-1
[516.160611] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.819s)
[516.175843] Starting dynamic subtest: pipe-B-eDP-1
[520.579190] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[520.591051] Starting dynamic subtest: pipe-C-eDP-1
[524.917053] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.335s)
[524.926862] Starting dynamic subtest: pipe-D-eDP-1
[529.297515] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.377s)
[529.299488] Subtest tiling-none: SUCCESS (16.955s)
[530.097237] [114/133] (493s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[530.193900] Starting subtest: basic-max-pipe-crc-check
[530.198124] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[530.242093] [115/133] (493s left) gem_exec_alignment (many)
[530.308565] Starting subtest: many
[553.596340] Subtest many: SUCCESS (23.287s)
[557.165611] [116/133] (466s left) kms_cursor_legacy (forked-bo)
[557.318539] Starting subtest: forked-bo
[557.320687] Starting dynamic subtest: pipe-A
[562.772237] Dynamic subtest pipe-A: SUCCESS (5.452s)
[562.788171] Starting dynamic subtest: pipe-B
[568.243101] Dynamic subtest pipe-B: SUCCESS (5.469s)
[568.253600] Starting dynamic subtest: pipe-C
[573.711641] Dynamic subtest pipe-C: SUCCESS (5.466s)
[573.727851] Starting dynamic subtest: pipe-D
[579.186607] Dynamic subtest pipe-D: SUCCESS (5.473s)
[579.197690] Starting dynamic subtest: all-pipes
[584.683768] Dynamic subtest all-pipes: SUCCESS (5.495s)
[584.686223] Subtest forked-bo: SUCCESS (27.365s)
[584.854209] [117/133] (439s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[584.928605] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[585.006045] [118/133] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[585.094536] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[589.769642] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.678s)
[590.901425] [119/133] (433s left) kms_rotation_crc (exhaust-fences)
[591.002573] Starting subtest: exhaust-fences
[591.007128] Subtest exhaust-fences: SKIP (0.000s)
[591.073864] [120/133] (433s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[591.173093] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[591.177332] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[591.300207] [121/133] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[591.410384] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[598.507113] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.100s)
[598.634425] [122/133] (425s left) gem_ringfill (legacy-basic)
[603.935913] Starting subtest: legacy-basic
[603.938373] Starting dynamic subtest: default
[603.992902] Dynamic subtest default: SUCCESS (0.060s)
[604.005598] Starting dynamic subtest: render
[604.035737] Dynamic subtest render: SUCCESS (0.041s)
[604.049095] Starting dynamic subtest: bsd
[604.082969] Dynamic subtest bsd: SUCCESS (0.043s)
[604.095100] Starting dynamic subtest: bsd1
[604.126714] Dynamic subtest bsd1: SUCCESS (0.041s)
[604.138056] Starting dynamic subtest: bsd2
[604.167175] Dynamic subtest bsd2: SUCCESS (0.039s)
[604.179838] Starting dynamic subtest: blt
[604.211074] Dynamic subtest blt: SUCCESS (0.041s)
[604.221808] Starting dynamic subtest: vebox
[604.252878] Dynamic subtest vebox: SUCCESS (0.039s)
[604.255261] Subtest legacy-basic: SUCCESS (0.322s)
[604.332525] [123/133] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[604.427495] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[604.431586] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[604.531728] [124/133] (419s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[604.852253] Starting subtest: cursor-rapid-movement-max-size
[604.858612] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[604.977971] [125/133] (419s left) core_getversion (all-cards)
[605.027100] Starting subtest: all-cards
[605.040977] Subtest all-cards: SUCCESS (0.020s)
[605.083749] [126/133] (419s left) gem_exec_reloc (basic-write-gtt)
[605.140354] Subtest basic-write-gtt: SKIP (0.000s)
[605.216810] [127/133] (419s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[605.594392] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[606.432178] [128/133] (418s left) kms_psr (fbc-pr-suspend)
[606.521080] Starting subtest: fbc-pr-suspend
[606.525483] Subtest fbc-pr-suspend: SKIP (0.000s)
[606.593964] [129/133] (417s left) kms_color_pipeline (plane-ctm3x4)
[606.688077] Starting subtest: plane-ctm3x4
[606.856631] Starting dynamic subtest: pipe-A-plane-0
[607.193176] Dynamic subtest pipe-A-plane-0: FAIL (0.160s)
[607.205200] Starting dynamic subtest: pipe-A-plane-1
[607.406827] Dynamic subtest pipe-A-plane-1: FAIL (0.158s)
[607.417342] Starting dynamic subtest: pipe-A-plane-2
[607.618436] Dynamic subtest pipe-A-plane-2: FAIL (0.151s)
[608.566134] Starting dynamic subtest: pipe-B-plane-0
[608.986239] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[608.998499] Starting dynamic subtest: pipe-B-plane-1
[609.312392] Dynamic subtest pipe-B-plane-1: FAIL (0.144s)
[609.325535] Starting dynamic subtest: pipe-B-plane-2
[609.614527] Dynamic subtest pipe-B-plane-2: FAIL (0.154s)
[610.268090] Starting dynamic subtest: pipe-C-plane-0
[610.707780] Dynamic subtest pipe-C-plane-0: FAIL (0.108s)
[610.718904] Starting dynamic subtest: pipe-C-plane-1
[611.089403] Dynamic subtest pipe-C-plane-1: FAIL (0.560s)
[611.099531] Starting dynamic subtest: pipe-C-plane-2
[611.445576] Dynamic subtest pipe-C-plane-2: FAIL (0.146s)
[612.309730] Starting dynamic subtest: pipe-D-plane-0
[612.846590] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[612.858927] Starting dynamic subtest: pipe-D-plane-1
[613.302829] Dynamic subtest pipe-D-plane-1: FAIL (0.597s)
[613.314351] Starting dynamic subtest: pipe-D-plane-2
[613.719235] Dynamic subtest pipe-D-plane-2: FAIL (0.542s)
[613.862088] Subtest plane-ctm3x4: FAIL (7.175s)
[614.697386] [130/133] (409s left) gem_lmem_swapping (heavy-verify-random-ccs)
[614.747197] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[614.791787] [131/133] (409s left) gem_exec_balancer (bonded-true-hang)
[615.061772] Starting subtest: bonded-true-hang
[615.066706] Subtest bonded-true-hang: SKIP (0.000s)
[615.169222] [132/133] (409s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[615.269498] Starting subtest: y-tiled-16bpp-rotate-270
[615.273930] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[615.364352] [133/133] (409s left) gem_exec_nop (basic-series)
[615.440026] Starting subtest: basic-series
[631.897486] Subtest basic-series: SUCCESS (16.464s)
[632.134415] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_sequence
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_eventfd
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: syncobj_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_draw_crc
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_pipe_control_store_loop
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_atomic_interruptible
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: sw_sync
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: i915_pm_rc6_residency
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_busy
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: drm_read
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: kms_hdr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: core_auth
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_psr_stress_test
results: parsing output: 104/ for test: gem_wait
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: i915_query
results: parsing output: 109/ for test: vgem_basic
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: kms_multipipe_modeset
results: parsing output: 114/ for test: gem_exec_alignment
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ringfill
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: core_getversion
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_nop
Done.