[56.988842] Initializing watchdogs
[56.988889]   /dev/watchdog0
[57.003488] [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.007898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.010294] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.013600] [001/133] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[57.149630] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[57.153810] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[57.223678] [002/133] (960s left) syncobj_timeline (single-wait-signaled)
[57.279685] Starting subtest: single-wait-signaled
[57.281839] Subtest single-wait-signaled: SUCCESS (0.000s)
[57.383806] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[57.479328] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[58.558964] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.080s)
[58.686669] [004/133] (958s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[58.732739] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[58.842830] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[58.916156] [005/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[59.014626] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[59.018976] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[59.095228] [006/133] (958s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[59.193155] Starting subtest: fbc-pr-cursor-mmap-cpu
[59.197277] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[59.265453] [007/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[59.370715] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[65.941755] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.576s)
[66.076857] [008/133] (951s left) kms_sequence (get-forked-busy)
[66.183088] Starting subtest: get-forked-busy
[66.185449] Starting dynamic subtest: pipe-A-eDP-1
[68.114730] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[68.124709] Starting dynamic subtest: pipe-B-eDP-1
[70.774660] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.658s)
[70.784663] Starting dynamic subtest: pipe-C-eDP-1
[73.411869] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s)
[73.421348] Starting dynamic subtest: pipe-D-eDP-1
[76.003603] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[76.005855] Subtest get-forked-busy: SUCCESS (9.823s)
[76.793089] [009/133] (941s left) i915_drm_fdinfo (memory-info-purgeable)
[76.835605] Starting subtest: memory-info-purgeable
[76.838124] Starting dynamic subtest: smem0
[79.567469] Dynamic subtest smem0: SUCCESS (2.736s)
[79.569680] Subtest memory-info-purgeable: SUCCESS (2.736s)
[79.639121] [010/133] (938s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[79.707624] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[79.710212] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[79.815338] [011/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[79.909821] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[79.913573] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.015900] [012/133] (937s left) gem_lmem_swapping (verify-ccs)
[80.056490] Subtest verify-ccs: SKIP (0.000s)
[80.102404] [013/133] (937s left) perf_pmu (busy-idle-check-all)
[80.146543] Starting subtest: busy-idle-check-all
[80.148421] Starting dynamic subtest: rcs0
[80.797046] Dynamic subtest rcs0: SUCCESS (0.652s)
[80.807149] Starting dynamic subtest: bcs0
[81.448888] Dynamic subtest bcs0: SUCCESS (0.650s)
[81.462215] Starting dynamic subtest: vcs0
[82.902261] Dynamic subtest vcs0: SUCCESS (1.450s)
[82.912788] Starting dynamic subtest: vcs1
[84.886504] Dynamic subtest vcs1: SUCCESS (1.983s)
[84.896849] Starting dynamic subtest: vecs0
[86.933573] Dynamic subtest vecs0: SUCCESS (2.046s)
[86.943870] Starting dynamic subtest: ccs0
[87.590900] Dynamic subtest ccs0: SUCCESS (0.657s)
[87.593504] Subtest busy-idle-check-all: SUCCESS (7.444s)
[87.681208] [014/133] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[87.788217] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[87.792392] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[87.872243] [015/133] (930s left) gem_exec_flush (basic-wb-ro-default)
[87.939754] Starting subtest: basic-wb-ro-default
[93.394785] Subtest basic-wb-ro-default: SUCCESS (5.456s)
[93.580792] [016/133] (924s left) kms_psr (psr2-sprite-plane-move)
[93.677241] Starting subtest: psr2-sprite-plane-move
[93.679510] Starting dynamic subtest: eDP-1
[95.419835] Dynamic subtest eDP-1: SUCCESS (1.743s)
[95.422162] Subtest psr2-sprite-plane-move: SUCCESS (1.744s)
[96.271798] [017/133] (921s left) syncobj_eventfd (binary-wait-signaled)
[96.331238] Starting subtest: binary-wait-signaled
[96.333857] Subtest binary-wait-signaled: SUCCESS (0.000s)
[96.434843] [018/133] (921s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[96.529798] Starting subtest: fbc-psr2-sprite-plane-onoff
[96.531665] Starting dynamic subtest: eDP-1
[96.535669] Dynamic subtest eDP-1: SKIP (0.000s)
[96.539727] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[96.595940] [019/133] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[96.690593] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[96.694719] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[96.777210] [020/133] (921s left) kms_flip (2x-flip-vs-panning-interruptible)
[96.888971] Starting subtest: 2x-flip-vs-panning-interruptible
[96.901243] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[96.989984] [021/133] (921s left) gem_pxp (reject-modify-context-protection-on)
[97.117828] Starting subtest: reject-modify-context-protection-on
[97.120638] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[97.228261] [022/133] (921s left) kms_chamelium_frames (dp-frame-dump)
[97.609302] Subtest dp-frame-dump: SKIP (0.000s)
[98.388499] [023/133] (919s left) syncobj_basic (bad-pad-handle-to-fd)
[98.443026] Starting subtest: bad-pad-handle-to-fd
[98.445439] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[98.544214] [024/133] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[98.640067] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[102.630449] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.993s)
[103.813876] [025/133] (914s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[106.148547] Starting subtest: dpms-mode-unset-lpsp
[110.209296] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[110.609485] [026/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[110.707472] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[110.711537] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[110.799728] [027/133] (907s left) kms_addfb_basic (bad-pitch-0)
[110.874592] Starting subtest: bad-pitch-0
[110.876514] Subtest bad-pitch-0: SUCCESS (0.000s)
[111.019261] [028/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[111.126387] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[111.130851] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[111.244852] [029/133] (907s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[111.344962] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[111.349430] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[111.434324] [030/133] (907s left) gem_mmap_gtt (basic-wc)
[111.485530] Subtest basic-wc: SKIP (0.000s)
[111.545164] [031/133] (907s left) kms_async_flips (test-cursor)
[111.637787] Starting subtest: test-cursor
[111.641228] Subtest test-cursor: SKIP (0.000s)
[112.820656] [032/133] (905s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[112.915086] Starting subtest: 2x-flip-vs-modeset-vs-hang
[112.926641] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[113.002767] [033/133] (905s left) gem_exec_schedule (u-semaphore-user)
[113.082754] Starting subtest: u-semaphore-user
[113.140795] Subtest u-semaphore-user: SUCCESS (0.059s)
[114.946325] [034/133] (903s left) kms_big_fb (x-tiled-addfb-size-overflow)
[115.056534] Starting subtest: x-tiled-addfb-size-overflow
[115.058806] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[115.150200] [035/133] (903s left) kms_vblank (wait-forked-hang)
[115.242954] Starting subtest: wait-forked-hang
[115.244884] Starting dynamic subtest: pipe-A-eDP-1
[141.680140] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.430s)
[141.693015] Starting dynamic subtest: pipe-D-eDP-1
[156.694262] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.017s)
[156.696247] Subtest wait-forked-hang: SUCCESS (41.451s)
[157.506799] [036/133] (861s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[157.602511] Starting subtest: psr-shrfb-scaledprimary
[163.403999] Subtest psr-shrfb-scaledprimary: SUCCESS (5.805s)
[163.518676] [037/133] (855s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[163.571696] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[163.573837] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[163.668193] [038/133] (855s left) perf (blocking-parameterized)
[163.801593] Starting subtest: blocking-parameterized
[183.823791] Subtest blocking-parameterized: SUCCESS (20.020s)
[183.871769] [039/133] (835s left) kms_addfb_basic (bad-pitch-256)
[183.918862] Starting subtest: bad-pitch-256
[183.920997] Subtest bad-pitch-256: SUCCESS (0.000s)
[184.056740] [040/133] (834s left) gem_eio (in-flight-contexts-1us)
[184.261058] Starting subtest: in-flight-contexts-1us
[192.937455] Subtest in-flight-contexts-1us: SUCCESS (8.676s)
[193.128621] [041/133] (825s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[193.245334] Starting subtest: fbc-rgb565-draw-mmap-wc
[197.286642] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.045s)
[198.450080] [042/133] (820s left) kms_draw_crc (draw-method-pwrite)
[198.544778] Starting subtest: draw-method-pwrite
[198.547115] Starting dynamic subtest: xrgb8888-untiled
[199.144892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.601s)
[199.155020] Starting dynamic subtest: rgb565-untiled
[199.622205] Dynamic subtest rgb565-untiled: SUCCESS (0.476s)
[199.631327] Starting dynamic subtest: xrgb2101010-untiled
[200.200263] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s)
[200.208852] Starting dynamic subtest: xbgr16161616f-untiled
[200.989216] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.788s)
[201.000096] Starting dynamic subtest: xrgb8888-xtiled
[202.811467] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.822s)
[202.820665] Starting dynamic subtest: rgb565-xtiled
[203.911415] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[203.920776] Starting dynamic subtest: xrgb2101010-xtiled
[205.978169] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.066s)
[205.987949] Starting dynamic subtest: xbgr16161616f-xtiled
[209.378130] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.399s)
[209.386565] Starting dynamic subtest: xrgb8888-4tiled
[210.489424] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.111s)
[210.499030] Starting dynamic subtest: rgb565-4tiled
[211.056054] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[211.065316] Starting dynamic subtest: xrgb2101010-4tiled
[212.167288] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.111s)
[212.177338] Starting dynamic subtest: xbgr16161616f-4tiled
[215.222742] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.054s)
[215.224874] Subtest draw-method-pwrite: SUCCESS (16.680s)
[215.314472] [043/133] (803s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[215.441105] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[215.445602] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[215.584641] [044/133] (803s left) gem_pipe_control_store_loop (fresh-buffer)
[215.644015] Starting subtest: fresh-buffer
[217.798337] Subtest fresh-buffer: SUCCESS (2.152s)
[217.894727] [045/133] (801s left) syncobj_basic (test-valid-cycle)
[217.944047] Starting subtest: test-valid-cycle
[217.946038] Subtest test-valid-cycle: SUCCESS (0.000s)
[218.036750] [046/133] (801s left) kms_flip (basic-flip-vs-wf_vblank)
[218.143103] Starting subtest: basic-flip-vs-wf_vblank
[218.145454] Starting dynamic subtest: A-eDP1
[220.086874] Dynamic subtest A-eDP1: SUCCESS (1.943s)
[220.095886] Starting dynamic subtest: B-eDP1
[222.020616] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[222.031531] Starting dynamic subtest: C-eDP1
[223.947854] Dynamic subtest C-eDP1: SUCCESS (1.926s)
[223.959353] Starting dynamic subtest: D-eDP1
[225.883588] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[225.888883] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.745s)
[227.107452] [047/133] (792s left) gem_mmap_wc (bad-object)
[227.172912] Subtest bad-object: SKIP (0.000s)
[227.232038] [048/133] (792s left) kms_atomic_interruptible (universal-setplane-cursor)
[227.333575] Starting subtest: universal-setplane-cursor
[227.335702] Starting dynamic subtest: pipe-A-eDP-1
[234.722895] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[234.725507] Subtest universal-setplane-cursor: SUCCESS (7.389s)
[235.562213] [049/133] (783s left) prime_self_import (reimport-vs-gem_close-race)
[235.604820] Starting subtest: reimport-vs-gem_close-race
[240.686737] Subtest reimport-vs-gem_close-race: SUCCESS (5.083s)
[240.765029] [050/133] (778s left) sw_sync (timeline_closed)
[240.797643] Starting subtest: timeline_closed
[240.799953] Subtest timeline_closed: SUCCESS (0.000s)
[240.849521] [051/133] (778s left) kms_psr (pr-primary-blt)
[240.965937] Starting subtest: pr-primary-blt
[240.970759] Subtest pr-primary-blt: SKIP (0.000s)
[241.052948] [052/133] (778s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[241.147492] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[241.151607] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[241.220880] [053/133] (778s left) syncobj_wait (invalid-signal-zero-handles)
[241.279051] Starting subtest: invalid-signal-zero-handles
[241.281274] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[241.387481] [054/133] (778s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[241.484408] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[245.529919] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.049s)
[246.673330] [055/133] (772s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[246.782703] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[247.838108] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.056s)
[247.960481] [056/133] (771s left) gen7_exec_parse (basic-rejected)
[248.017358] Subtest basic-rejected: SKIP (0.000s)
[248.084497] [057/133] (771s left) prime_mmap (test_userptr)
[248.138170] Starting subtest: test_userptr
[248.140025] Starting dynamic subtest: test_userptr-smem
[248.141623] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[248.143246] Subtest test_userptr: SUCCESS (0.001s)
[248.249066] [058/133] (771s left) i915_pm_rc6_residency (media-rc6-accuracy)
[248.298788] Starting subtest: media-rc6-accuracy
[248.302462] Subtest media-rc6-accuracy: SKIP (0.000s)
[248.388745] [059/133] (771s left) gem_softpin (allocator-fork)
[248.467626] Starting subtest: allocator-fork
[250.683644] Subtest allocator-fork: SUCCESS (2.213s)
[250.810221] [060/133] (769s left) gem_busy (busy)
[250.889035] Starting subtest: busy
[250.890971] Starting dynamic subtest: all-engines
[250.946109] Dynamic subtest all-engines: SUCCESS (0.059s)
[250.955284] Starting dynamic subtest: rcs0
[252.896265] Dynamic subtest rcs0: SUCCESS (1.949s)
[252.907089] Starting dynamic subtest: bcs0
[252.937324] Dynamic subtest bcs0: SUCCESS (0.039s)
[252.946789] Starting dynamic subtest: vcs0
[252.977136] Dynamic subtest vcs0: SUCCESS (0.039s)
[252.986387] Starting dynamic subtest: vcs1
[254.938810] Dynamic subtest vcs1: SUCCESS (1.958s)
[254.947300] Starting dynamic subtest: vecs0
[256.923252] Dynamic subtest vecs0: SUCCESS (1.983s)
[256.931755] Starting dynamic subtest: ccs0
[258.906887] Dynamic subtest ccs0: SUCCESS (1.983s)
[258.909042] Subtest busy: SUCCESS (8.018s)
[259.251543] [061/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[259.354240] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[259.356826] Starting dynamic subtest: pipe-A-eDP-1
[259.417067] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[259.427219] Starting dynamic subtest: pipe-B-eDP-1
[259.486845] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[259.497777] Starting dynamic subtest: pipe-C-eDP-1
[259.555537] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[259.565237] Starting dynamic subtest: pipe-D-eDP-1
[259.622769] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[259.627126] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[261.633326] [062/133] (758s left) drm_read (short-buffer-block)
[261.768448] Starting subtest: short-buffer-block
[261.770824] Subtest short-buffer-block: SUCCESS (0.000s)
[261.895787] [063/133] (758s left) kms_getfb (getfb-handle-not-fb)
[261.978931] Starting subtest: getfb-handle-not-fb
[261.981244] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[262.085495] [064/133] (757s left) kms_pm_rpm (modeset-lpsp-stress)
[264.018232] Starting subtest: modeset-lpsp-stress
[280.179520] Subtest modeset-lpsp-stress: SUCCESS (16.162s)
[280.265567] [065/133] (739s left) i915_drm_fdinfo (virtual-busy-idle-all)
[280.315802] Starting subtest: virtual-busy-idle-all
[280.320508] Subtest virtual-busy-idle-all: SKIP (0.000s)
[280.378537] [066/133] (739s left) gem_workarounds (basic-read)
[280.437386] Starting subtest: basic-read
[280.447167] Subtest basic-read: SUCCESS (0.010s)
[280.559843] [067/133] (739s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[280.699946] Starting subtest: dp-mst-type-0-suspend-resume
[280.704346] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[280.834086] [068/133] (739s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[280.921191] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[280.925199] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[281.001287] [069/133] (739s left) kms_prop_blob (invalid-set-prop)
[281.051411] Starting subtest: invalid-set-prop
[281.053261] Subtest invalid-set-prop: SUCCESS (0.000s)
[281.145992] [070/133] (739s left) kms_hdr (static-toggle-dpms)
[281.231614] Starting subtest: static-toggle-dpms
[281.236884] Subtest static-toggle-dpms: SKIP (0.000s)
[281.302436] [071/133] (738s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[281.393310] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[281.395203] Starting dynamic subtest: pipe-A-eDP-1
[281.413365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.423480] Starting dynamic subtest: pipe-B-eDP-1
[281.442862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.452572] Starting dynamic subtest: pipe-C-eDP-1
[281.469751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.479089] Starting dynamic subtest: pipe-D-eDP-1
[281.496478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.499772] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[283.682390] [072/133] (736s left) prime_vgem (shrink)
[283.846183] Starting subtest: shrink
[283.862019] Subtest shrink: SUCCESS (0.014s)
[283.984273] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[283.987743] [073/133] (736s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[284.044615] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[284.121046] [074/133] (736s left) gem_create (busy-create)
[284.171637] Starting subtest: busy-create
[284.173851] Starting dynamic subtest: smem0
[317.913613] Dynamic subtest smem0: SUCCESS (33.737s)
[317.916279] Subtest busy-create: SUCCESS (33.739s)
[318.114178] [075/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[318.216515] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[318.220524] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[318.305201] [076/133] (702s left) gem_exec_whisper (basic-contexts-forked)
[318.368261] Starting subtest: basic-contexts-forked
[343.512210] Subtest basic-contexts-forked: SUCCESS (25.141s)
[343.698730] [077/133] (676s left) gem_ctx_persistence (many-contexts)
[343.765578] Starting subtest: many-contexts
[388.986793] Subtest many-contexts: SUCCESS (45.222s)
[389.079799] [078/133] (631s left) gem_softpin (evict-active)
[389.140362] Starting subtest: evict-active
[389.148123] Subtest evict-active: SUCCESS (0.010s)
[389.261746] [079/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[389.364462] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[398.080356] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.718s)
[398.194902] [080/133] (622s left) kms_plane (plane-panning-top-left)
[398.304160] Starting subtest: plane-panning-top-left
[398.306096] Starting dynamic subtest: pipe-A
[399.941264] Dynamic subtest pipe-A: SUCCESS (1.636s)
[399.951355] Starting dynamic subtest: pipe-B
[402.342533] Dynamic subtest pipe-B: SUCCESS (2.401s)
[402.344992] Subtest plane-panning-top-left: SUCCESS (4.040s)
[403.157856] [081/133] (617s left) gem_exec_schedule (preempt-contexts)
[403.237811] Starting subtest: preempt-contexts
[403.239780] Starting dynamic subtest: rcs0
[403.285366] Dynamic subtest rcs0: SUCCESS (0.054s)
[403.295188] Starting dynamic subtest: bcs0
[403.334571] Dynamic subtest bcs0: SUCCESS (0.049s)
[403.344044] Starting dynamic subtest: vcs0
[403.392487] Dynamic subtest vcs0: SUCCESS (0.056s)
[403.402689] Starting dynamic subtest: vcs1
[403.440704] Dynamic subtest vcs1: SUCCESS (0.048s)
[403.449944] Starting dynamic subtest: vecs0
[403.488354] Dynamic subtest vecs0: SUCCESS (0.048s)
[403.497361] Starting dynamic subtest: ccs0
[403.547169] Dynamic subtest ccs0: SUCCESS (0.058s)
[403.549431] Subtest preempt-contexts: SUCCESS (0.316s)
[404.986435] [082/133] (615s left) gem_exec_fence (syncobj-repeat)
[405.448485] Starting subtest: syncobj-repeat
[405.663068] Subtest syncobj-repeat: SUCCESS (0.214s)
[407.019159] [083/133] (613s left) gem_exec_reloc (basic-gtt-cpu)
[407.084706] Subtest basic-gtt-cpu: SKIP (0.000s)
[407.159171] [084/133] (613s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[407.228162] Starting subtest: rel-constants-invalid-rel-gen5
[407.230465] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[407.350541] [085/133] (613s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[407.448818] Starting subtest: plane-upscale-20x20-with-modifiers
[407.451140] Starting dynamic subtest: pipe-A
[407.784821] Dynamic subtest pipe-A: SUCCESS (0.338s)
[407.794301] Starting dynamic subtest: pipe-B
[409.239768] Dynamic subtest pipe-B: SUCCESS (1.454s)
[409.249753] Starting dynamic subtest: pipe-C
[410.685331] Dynamic subtest pipe-C: SUCCESS (1.444s)
[410.695442] Starting dynamic subtest: pipe-D
[412.102370] Dynamic subtest pipe-D: SUCCESS (1.416s)
[412.104981] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.656s)
[413.278454] [086/133] (607s left) gem_exec_fence (syncobj-timeline-unused-fence)
[413.814644] Starting subtest: syncobj-timeline-unused-fence
[413.820995] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[415.012631] [087/133] (605s left) gem_ctx_param (invalid-get-no-zeromap)
[415.066865] Starting subtest: invalid-get-no-zeromap
[415.069137] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[415.171720] [088/133] (605s left) kms_cursor_edge_walk (256x256-right-edge)
[415.271315] Starting subtest: 256x256-right-edge
[415.273581] Starting dynamic subtest: pipe-A-eDP-1
[418.749431] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[418.766837] Starting dynamic subtest: pipe-D-eDP-1
[421.960184] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.208s)
[421.962290] Subtest 256x256-right-edge: SUCCESS (6.689s)
[422.770152] [089/133] (598s left) core_auth (getclient-simple)
[422.813712] Starting subtest: getclient-simple
[422.828787] Subtest getclient-simple: SUCCESS (0.015s)
[422.947104] [090/133] (598s left) gem_exec_balancer (parallel-keep-in-fence)
[423.201803] Starting subtest: parallel-keep-in-fence
[424.440437] Subtest parallel-keep-in-fence: SUCCESS (1.241s)
[424.530994] [091/133] (596s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[424.632257] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[424.634660] Starting dynamic subtest: pipe-A-eDP-1
[424.658022] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.678824] Starting dynamic subtest: pipe-B-eDP-1
[424.701598] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.720870] Starting dynamic subtest: pipe-C-eDP-1
[424.743562] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.761971] Starting dynamic subtest: pipe-D-eDP-1
[424.785110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.789619] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[426.845556] [092/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[426.947804] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[426.952344] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.061777] [093/133] (594s left) sw_sync (sync_busy_fork)
[427.098657] Starting subtest: sync_busy_fork
[428.112486] Subtest sync_busy_fork: SUCCESS (1.012s)
[428.192608] [094/133] (593s left) kms_chamelium_color (ctm-max)
[428.280697] Subtest ctm-max: SKIP (0.000s)
[428.325469] [095/133] (592s left) kms_flip (2x-plain-flip-fb-recreate)
[428.413626] Starting subtest: 2x-plain-flip-fb-recreate
[428.424900] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[428.509635] [096/133] (592s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[428.610397] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[435.508728] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.901s)
[435.651233] [097/133] (585s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[435.749748] Starting subtest: 4-tiled-64bpp-rotate-180
[437.451438] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.701s)
[437.622890] [098/133] (583s left) kms_lease (lease-unleased-connector)
[437.712422] Starting subtest: lease-unleased-connector
[437.714456] Starting dynamic subtest: pipe-A-eDP-1
[437.720960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[437.730451] Starting dynamic subtest: pipe-B-eDP-1
[437.732357] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[437.741907] Starting dynamic subtest: pipe-C-eDP-1
[437.743833] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[437.753074] Starting dynamic subtest: pipe-D-eDP-1
[437.754905] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[437.756759] Subtest lease-unleased-connector: SUCCESS (0.038s)
[437.855741] [099/133] (583s left) sw_sync (sync_multi_consumer_producer)
[437.889119] Starting subtest: sync_multi_consumer_producer
[438.180841] Subtest sync_multi_consumer_producer: SUCCESS (0.290s)
[438.242607] [100/133] (583s left) kms_cursor_crc (cursor-offscreen-64x64)
[438.417854] Starting subtest: cursor-offscreen-64x64
[438.422969] Starting dynamic subtest: pipe-A-eDP-1
[440.370058] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[440.404893] Starting dynamic subtest: pipe-D-eDP-1
[442.990336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[442.992508] Subtest cursor-offscreen-64x64: SUCCESS (4.571s)
[443.846228] [101/133] (577s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[443.934337] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[443.936691] Starting dynamic subtest: pipe-A-eDP-1
[443.959087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.968999] Starting dynamic subtest: pipe-B-eDP-1
[443.989125] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.997901] Starting dynamic subtest: pipe-C-eDP-1
[444.018116] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[444.026475] Starting dynamic subtest: pipe-D-eDP-1
[444.048205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[444.052494] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[446.190179] [102/133] (575s left) gem_mmap_gtt (flink-race)
[446.261505] Subtest flink-race: SKIP (0.000s)
[446.324196] [103/133] (575s left) kms_addfb_basic (legacy-format)
[446.374070] Starting subtest: legacy-format
[446.410286] Subtest legacy-format: SUCCESS (0.032s)
[446.540726] [104/133] (575s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[446.632902] Starting subtest: invalidate-primary-flip-overlay
[457.457666] Subtest invalidate-primary-flip-overlay: SUCCESS (10.826s)
[457.573889] [105/133] (564s left) gem_wait (busy)
[457.632035] Starting subtest: busy
[457.634024] Starting dynamic subtest: all-engines
[458.901804] Dynamic subtest all-engines: SUCCESS (1.267s)
[458.914028] Starting dynamic subtest: rcs0
[459.442744] Dynamic subtest rcs0: SUCCESS (0.540s)
[459.457629] Starting dynamic subtest: bcs0
[459.981290] Dynamic subtest bcs0: SUCCESS (0.538s)
[459.997032] Starting dynamic subtest: vcs0
[461.909534] Dynamic subtest vcs0: SUCCESS (1.925s)
[461.921582] Starting dynamic subtest: vcs1
[463.893376] Dynamic subtest vcs1: SUCCESS (1.981s)
[463.905394] Starting dynamic subtest: vecs0
[465.941713] Dynamic subtest vecs0: SUCCESS (2.045s)
[465.953756] Starting dynamic subtest: ccs0
[466.484307] Dynamic subtest ccs0: SUCCESS (0.541s)
[466.486871] Subtest busy: SUCCESS (8.852s)
[466.684947] [106/133] (555s left) api_intel_allocator (reloc-allocator)
[466.741681] Starting subtest: reloc-allocator
[466.743640] Starting dynamic subtest: basic
[466.748922] Dynamic subtest basic: SUCCESS (0.009s)
[466.758652] Starting dynamic subtest: parallel-one
[466.761099] Dynamic subtest parallel-one: SUCCESS (0.008s)
[466.770419] Starting dynamic subtest: print
[466.772677] Dynamic subtest print: SUCCESS (0.000s)
[466.781684] Starting dynamic subtest: reuse
[466.783650] Dynamic subtest reuse: SUCCESS (0.000s)
[466.793055] Starting dynamic subtest: fork-reopen-allocator
[466.795311] Dynamic subtest fork-reopen-allocator: SUCCESS (0.018s)
[466.797578] Subtest reloc-allocator: SUCCESS (0.046s)
[466.902809] [107/133] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[467.004266] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[467.008308] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[467.091743] [108/133] (554s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[467.183779] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[467.186097] Starting dynamic subtest: pipe-A-default-mode
[468.361142] Dynamic subtest pipe-A-default-mode: SKIP (1.175s)
[468.365732] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.176s)
[468.496082] [109/133] (553s left) i915_query (hwconfig_table)
[468.546267] Starting subtest: hwconfig_table
[468.839550] Subtest hwconfig_table: SUCCESS (0.001s)
[468.881299] [110/133] (553s left) vgem_basic (bad-flag)
[468.942702] Starting subtest: bad-flag
[468.944962] Subtest bad-flag: SUCCESS (0.000s)
[469.000951] [111/133] (552s left) kms_flip (wf_vblank-ts-check)
[469.094391] Starting subtest: wf_vblank-ts-check
[469.096630] Starting dynamic subtest: A-eDP1
[477.995768] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[478.009725] Starting dynamic subtest: B-eDP1
[486.932555] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[486.946305] Starting dynamic subtest: C-eDP1
[495.849914] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[495.860280] Starting dynamic subtest: D-eDP1
[504.785846] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[504.787764] Subtest wf_vblank-ts-check: SUCCESS (35.695s)
[506.020023] [112/133] (515s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[506.129080] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[506.133344] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[506.242878] [113/133] (515s left) kms_plane_multiple (tiling-none)
[506.337125] Starting subtest: tiling-none
[506.339451] Starting dynamic subtest: pipe-A-eDP-1
[510.031793] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.694s)
[510.041670] Starting dynamic subtest: pipe-B-eDP-1
[514.583375] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.551s)
[514.594192] Starting dynamic subtest: pipe-C-eDP-1
[518.928926] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.343s)
[518.939371] Starting dynamic subtest: pipe-D-eDP-1
[523.255732] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s)
[523.257976] Subtest tiling-none: SUCCESS (16.918s)
[524.060458] [114/133] (498s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[524.151524] Starting subtest: basic-max-pipe-crc-check
[524.155730] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[524.199758] [115/133] (497s left) gem_exec_alignment (many)
[524.258855] Starting subtest: many
[548.340709] Subtest many: SUCCESS (24.079s)
[550.948479] [116/133] (471s left) kms_cursor_legacy (forked-bo)
[551.118402] Starting subtest: forked-bo
[551.120573] Starting dynamic subtest: pipe-A
[556.585297] Dynamic subtest pipe-A: SUCCESS (5.463s)
[556.599021] Starting dynamic subtest: pipe-B
[562.076422] Dynamic subtest pipe-B: SUCCESS (5.489s)
[562.088083] Starting dynamic subtest: pipe-C
[567.556989] Dynamic subtest pipe-C: SUCCESS (5.478s)
[567.568975] Starting dynamic subtest: pipe-D
[573.030094] Dynamic subtest pipe-D: SUCCESS (5.471s)
[573.041578] Starting dynamic subtest: all-pipes
[578.550947] Dynamic subtest all-pipes: SUCCESS (5.518s)
[578.553749] Subtest forked-bo: SUCCESS (27.429s)
[578.698993] [117/133] (443s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[578.776339] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[578.848419] [118/133] (443s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[578.953610] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[583.600959] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.651s)
[584.749786] [119/133] (437s left) kms_rotation_crc (exhaust-fences)
[584.853978] Starting subtest: exhaust-fences
[584.858305] Subtest exhaust-fences: SKIP (0.000s)
[584.934797] [120/133] (437s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[585.057970] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[585.062453] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[585.163951] [121/133] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[585.280281] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[592.340703] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.061s)
[592.468657] [122/133] (429s left) gem_ringfill (legacy-basic)
[597.916560] Starting subtest: legacy-basic
[597.918863] Starting dynamic subtest: default
[597.972063] Dynamic subtest default: SUCCESS (0.057s)
[597.984842] Starting dynamic subtest: render
[598.015498] Dynamic subtest render: SUCCESS (0.041s)
[598.027779] Starting dynamic subtest: bsd
[598.059069] Dynamic subtest bsd: SUCCESS (0.040s)
[598.071234] Starting dynamic subtest: bsd1
[598.101089] Dynamic subtest bsd1: SUCCESS (0.039s)
[598.114053] Starting dynamic subtest: bsd2
[598.146027] Dynamic subtest bsd2: SUCCESS (0.042s)
[598.159204] Starting dynamic subtest: blt
[598.191053] Dynamic subtest blt: SUCCESS (0.042s)
[598.204447] Starting dynamic subtest: vebox
[598.235951] Dynamic subtest vebox: SUCCESS (0.042s)
[598.238307] Subtest legacy-basic: SUCCESS (0.324s)
[598.317050] [123/133] (424s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[598.422026] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[598.426191] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[598.526689] [124/133] (424s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[598.919231] Starting subtest: cursor-rapid-movement-max-size
[598.925205] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[599.038634] [125/133] (423s left) core_getversion (all-cards)
[599.083448] Starting subtest: all-cards
[599.117054] Subtest all-cards: SUCCESS (0.039s)
[599.161841] [126/133] (423s left) gem_exec_reloc (basic-write-gtt)
[599.225496] Subtest basic-write-gtt: SKIP (0.000s)
[599.312740] [127/133] (423s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[599.692877] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[600.506814] [128/133] (422s left) kms_psr (fbc-pr-suspend)
[600.608321] Starting subtest: fbc-pr-suspend
[600.612460] Subtest fbc-pr-suspend: SKIP (0.000s)
[600.683662] [129/133] (422s left) kms_color_pipeline (plane-ctm3x4)
[600.775459] Starting subtest: plane-ctm3x4
[600.944576] Starting dynamic subtest: pipe-A-plane-0
[601.270127] Dynamic subtest pipe-A-plane-0: FAIL (0.160s)
[601.281947] Starting dynamic subtest: pipe-A-plane-1
[601.482978] Dynamic subtest pipe-A-plane-1: FAIL (0.147s)
[601.493066] Starting dynamic subtest: pipe-A-plane-2
[601.693061] Dynamic subtest pipe-A-plane-2: FAIL (0.156s)
[602.628129] Starting dynamic subtest: pipe-B-plane-0
[603.018345] Dynamic subtest pipe-B-plane-0: FAIL (0.142s)
[603.029391] Starting dynamic subtest: pipe-B-plane-1
[603.321197] Dynamic subtest pipe-B-plane-1: FAIL (0.156s)
[603.333896] Starting dynamic subtest: pipe-B-plane-2
[603.633728] Dynamic subtest pipe-B-plane-2: FAIL (0.153s)
[604.249352] Starting dynamic subtest: pipe-C-plane-0
[604.707270] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[604.718565] Starting dynamic subtest: pipe-C-plane-1
[605.091824] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[605.101505] Starting dynamic subtest: pipe-C-plane-2
[605.445394] Dynamic subtest pipe-C-plane-2: FAIL (0.588s)
[606.291937] Starting dynamic subtest: pipe-D-plane-0
[606.826297] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[606.837803] Starting dynamic subtest: pipe-D-plane-1
[607.287459] Dynamic subtest pipe-D-plane-1: FAIL (0.608s)
[607.297578] Starting dynamic subtest: pipe-D-plane-2
[607.704027] Dynamic subtest pipe-D-plane-2: FAIL (0.537s)
[607.836628] Subtest plane-ctm3x4: FAIL (7.060s)
[608.657043] [130/133] (414s left) gem_lmem_swapping (heavy-verify-random-ccs)
[608.703284] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[608.767435] [131/133] (414s left) gem_exec_balancer (bonded-true-hang)
[609.025435] Starting subtest: bonded-true-hang
[609.030089] Subtest bonded-true-hang: SKIP (0.000s)
[609.156235] [132/133] (413s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[609.266189] Starting subtest: y-tiled-16bpp-rotate-270
[609.270114] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[609.370403] [133/133] (413s left) gem_exec_nop (basic-series)
[609.448644] Starting subtest: basic-series
[624.335937] Subtest basic-series: SUCCESS (14.895s)
[624.558927] 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.