[56.510878] Initializing watchdogs
[56.510927]   /dev/watchdog0
[56.525432] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.529866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.532106] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.535434] [001/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[56.672222] Starting subtest: 4-tiled-32bpp-rotate-270
[56.705104] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.032s)
[56.868239] [002/131] (960s left) kms_rotation_crc (multiplane-rotation)
[56.957044] Starting subtest: multiplane-rotation
[74.425068] Subtest multiplane-rotation: SUCCESS (17.427s)
[74.574553] [003/131] (942s left) perf (invalid-oa-metric-set-id)
[74.718168] Starting subtest: invalid-oa-metric-set-id
[74.727232] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[74.769260] [004/131] (942s left) syncobj_wait (wait-any-snapshot)
[74.830307] Starting subtest: wait-any-snapshot
[74.910032] Subtest wait-any-snapshot: SUCCESS (0.081s)
[75.004746] [005/131] (942s left) kms_psr (fbc-psr2-primary-blt)
[75.099314] Starting subtest: fbc-psr2-primary-blt
[75.101207] Starting dynamic subtest: eDP-1
[75.104824] Dynamic subtest eDP-1: SKIP (0.000s)
[75.108224] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[75.197425] [006/131] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[80.191358] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[80.193638] Starting dynamic subtest: pipe-A-eDP-1
[92.229241] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.034s)
[92.237919] Starting dynamic subtest: pipe-B-eDP-1
[104.250853] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.017s)
[104.253391] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.055s)
[105.126154] [007/131] (912s left) i915_pm_rc6_residency (media-rc6-accuracy)
[105.201067] Starting subtest: media-rc6-accuracy
[105.205551] Subtest media-rc6-accuracy: SKIP (0.000s)
[105.333560] [008/131] (911s left) core_getversion (basic)
[105.376141] Starting subtest: basic
[105.380565] Subtest basic: SUCCESS (0.000s)
[105.459022] [009/131] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[105.564700] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[105.568986] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[105.705342] [010/131] (911s left) kms_debugfs (display-off-read-all)
[105.803283] Starting subtest: display-off-read-all
[106.099026] Subtest display-off-read-all: SUCCESS (0.297s)
[106.961995] [011/131] (910s left) syncobj_timeline (host-signal-points)
[107.033467] Starting subtest: host-signal-points
[107.038756] Subtest host-signal-points: SUCCESS (0.004s)
[107.170976] [012/131] (910s left) gem_exec_store (basic)
[107.235726] Starting subtest: basic
[107.349932] Subtest basic: SUCCESS (0.116s)
[107.549609] [013/131] (909s left) gem_exec_flush (basic-wb-rw-default)
[107.623047] Starting subtest: basic-wb-rw-default
[113.110177] Subtest basic-wb-rw-default: SUCCESS (5.462s)
[113.307902] [014/131] (904s left) vgem_basic (setversion)
[113.407534] Starting subtest: setversion
[113.411616] Subtest setversion: SUCCESS (0.000s)
[113.483599] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[113.486761] [015/131] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[113.536659] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[113.643455] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[113.743135] [016/131] (903s left) kms_legacy_colorkey (basic)
[113.839095] Starting subtest: basic
[113.841412] Starting dynamic subtest: pipe-A
[113.884963] Dynamic subtest pipe-A: SUCCESS (0.045s)
[113.895730] Starting dynamic subtest: pipe-B
[113.898112] Dynamic subtest pipe-B: SUCCESS (0.001s)
[113.905307] Starting dynamic subtest: pipe-C
[113.907618] Dynamic subtest pipe-C: SUCCESS (0.000s)
[113.914410] Starting dynamic subtest: pipe-D
[113.916635] Dynamic subtest pipe-D: SUCCESS (0.000s)
[113.918858] Subtest basic: SUCCESS (0.049s)
[113.976069] [017/131] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[114.075681] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[117.992802] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.920s)
[119.155045] [018/131] (898s left) kms_rmfb (close-fd)
[119.254435] Starting subtest: close-fd
[119.256778] Starting dynamic subtest: pipe-A-eDP-1
[119.361890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[119.374709] Starting dynamic subtest: pipe-B-eDP-1
[120.581322] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[120.589763] Starting dynamic subtest: pipe-C-eDP-1
[121.710202] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[121.718652] Starting dynamic subtest: pipe-D-eDP-1
[122.841149] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[122.843067] Subtest close-fd: SUCCESS (3.587s)
[123.990478] [019/131] (893s left) kms_atomic_interruptible (legacy-dpms)
[124.099120] Starting subtest: legacy-dpms
[124.101274] Starting dynamic subtest: pipe-A-eDP-1
[131.487445] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[131.489692] Subtest legacy-dpms: SUCCESS (7.389s)
[132.348303] [020/131] (885s left) gem_ctx_persistence (legacy-engines-hostile)
[132.417698] Starting subtest: legacy-engines-hostile
[132.420121] Starting dynamic subtest: render
[132.592530] Dynamic subtest render: SUCCESS (0.175s)
[132.603066] Starting dynamic subtest: bsd1
[132.672563] Dynamic subtest bsd1: SUCCESS (0.078s)
[132.681513] Starting dynamic subtest: bsd2
[132.837658] Dynamic subtest bsd2: SUCCESS (0.163s)
[132.847865] Starting dynamic subtest: blt
[132.956039] Dynamic subtest blt: SUCCESS (0.116s)
[132.966981] Starting dynamic subtest: vebox
[133.074062] Dynamic subtest vebox: SUCCESS (0.116s)
[133.076980] Subtest legacy-engines-hostile: SUCCESS (0.657s)
[133.176727] [021/131] (884s left) gem_exec_whisper (basic-queues-forked-all)
[133.246540] Starting subtest: basic-queues-forked-all
[153.047836] Subtest basic-queues-forked-all: SUCCESS (19.798s)
[153.257404] [022/131] (864s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[153.373073] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[153.375358] Starting dynamic subtest: pipe-A-eDP-1
[154.201073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[154.209342] Starting dynamic subtest: pipe-B-eDP-1
[155.788148] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s)
[155.797187] Starting dynamic subtest: pipe-C-eDP-1
[157.350526] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.563s)
[157.360081] Starting dynamic subtest: pipe-D-eDP-1
[158.861187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[158.863604] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.482s)
[160.052669] [023/131] (857s left) kms_content_protection (legacy-hdcp14)
[160.207839] Starting subtest: legacy-hdcp14
[160.212113] Subtest legacy-hdcp14: SKIP (0.000s)
[160.356966] [024/131] (857s left) kms_frontbuffer_tracking (fbc-tiling-y)
[160.458059] Starting subtest: fbc-tiling-y
[160.462511] Subtest fbc-tiling-y: SKIP (0.000s)
[160.589199] [025/131] (857s left) syncobj_wait (single-wait-for-submit-submitted)
[160.647391] Starting subtest: single-wait-for-submit-submitted
[160.754800] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[160.853393] [026/131] (857s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[160.971205] Starting subtest: cursorB-vs-flipB-atomic
[160.975545] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[161.141765] [027/131] (856s left) kms_flip (2x-blocking-absolute-wf_vblank)
[161.243237] Starting subtest: 2x-blocking-absolute-wf_vblank
[161.254510] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[161.399400] [028/131] (856s left) gem_mmap_offset (partial-unmap)
[161.466962] Starting subtest: partial-unmap
[161.469186] Starting dynamic subtest: smem0
[161.950061] Dynamic subtest smem0: SUCCESS (0.482s)
[161.952634] Subtest partial-unmap: SUCCESS (0.483s)
[162.108480] [029/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[162.209654] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[169.257530] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.051s)
[169.403229] [030/131] (848s left) kms_vblank (ts-continuation-idle-hang)
[169.511300] Starting subtest: ts-continuation-idle-hang
[169.513570] Starting dynamic subtest: pipe-A-eDP-1
[195.668112] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.157s)
[195.681706] Starting dynamic subtest: pipe-D-eDP-1
[210.642038] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.971s)
[210.644582] Subtest ts-continuation-idle-hang: SUCCESS (41.132s)
[211.511467] [031/131] (806s left) gem_userptr_blits (readonly-unsync)
[211.584809] Subtest readonly-unsync: SKIP (0.000s)
[211.730344] [032/131] (806s left) gem_mmap (short-mmap)
[211.797796] Subtest short-mmap: SKIP (0.000s)
[211.867292] [033/131] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[211.979723] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[211.984382] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[212.110240] [034/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[212.214052] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[212.218274] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[212.337310] [035/131] (806s left) kms_chamelium_color (ctm-green-to-red)
[212.436179] Subtest ctm-green-to-red: SKIP (0.000s)
[212.484614] [036/131] (805s left) kms_frontbuffer_tracking (psr-suspend)
[212.572542] Starting subtest: psr-suspend
[250.620146] Subtest psr-suspend: SUCCESS (12.549s)
[250.762112] [037/131] (767s left) gem_spin_batch (engines)
[250.836995] Starting subtest: engines
[250.839448] Starting dynamic subtest: rcs0
[254.218599] Dynamic subtest rcs0: SUCCESS (3.299s)
[254.231444] Starting dynamic subtest: bcs0
[257.623567] Dynamic subtest bcs0: SUCCESS (3.315s)
[257.634450] Starting dynamic subtest: vcs0
[260.965643] Dynamic subtest vcs0: SUCCESS (3.308s)
[260.977666] Starting dynamic subtest: vcs1
[264.310741] Dynamic subtest vcs1: SUCCESS (3.324s)
[264.321610] Starting dynamic subtest: vecs0
[267.553331] Dynamic subtest vecs0: SUCCESS (3.228s)
[267.564839] Starting dynamic subtest: ccs0
[270.797074] Dynamic subtest ccs0: SUCCESS (3.232s)
[270.799201] Subtest engines: SUCCESS (19.720s)
[271.025200] [038/131] (747s left) kms_psr (fbc-pr-sprite-blt)
[271.122570] Starting subtest: fbc-pr-sprite-blt
[271.126819] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[271.221106] [039/131] (747s left) kms_psr (fbc-psr-primary-mmap-gtt)
[271.342939] Starting subtest: fbc-psr-primary-mmap-gtt
[271.345144] Starting dynamic subtest: eDP-1
[271.349769] Dynamic subtest eDP-1: SKIP (0.000s)
[271.354254] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.003s)
[271.450564] [040/131] (747s left) gem_exec_schedule (preempt-hang)
[271.631409] Starting subtest: preempt-hang
[271.634014] Starting dynamic subtest: rcs0
[271.848431] Dynamic subtest rcs0: SUCCESS (0.215s)
[271.859310] Starting dynamic subtest: bcs0
[272.070494] Dynamic subtest bcs0: SUCCESS (0.223s)
[272.080187] Starting dynamic subtest: vcs0
[272.283626] Dynamic subtest vcs0: SUCCESS (0.210s)
[272.293952] Starting dynamic subtest: vcs1
[272.501261] Dynamic subtest vcs1: SUCCESS (0.217s)
[272.512331] Starting dynamic subtest: vecs0
[272.720259] Dynamic subtest vecs0: SUCCESS (0.217s)
[272.730060] Starting dynamic subtest: ccs0
[272.947446] Dynamic subtest ccs0: SUCCESS (0.226s)
[272.949714] Subtest preempt-hang: SUCCESS (1.313s)
[273.491564] [041/131] (745s left) gem_pxp (create-regular-context-1)
[273.619812] Starting subtest: create-regular-context-1
[273.622184] Subtest create-regular-context-1: SUCCESS (0.002s)
[273.768639] [042/131] (744s left) kms_big_fb (linear-32bpp-rotate-270)
[273.880582] Starting subtest: linear-32bpp-rotate-270
[273.901365] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[274.062723] [043/131] (744s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[274.167404] Starting subtest: fbc-shrfb-scaledprimary
[277.158491] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.990s)
[278.359642] [044/131] (740s left) kms_getfb (getfb-reject-nv12)
[278.465857] Starting subtest: getfb-reject-nv12
[278.468051] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[278.606825] [045/131] (740s left) gem_exec_parallel (contexts)
[278.676128] Starting subtest: contexts
[278.678565] Starting dynamic subtest: rcs0
[281.762644] Dynamic subtest rcs0: SUCCESS (3.083s)
[281.771782] Starting dynamic subtest: bcs0
[285.245473] Dynamic subtest bcs0: SUCCESS (3.483s)
[285.260528] Starting dynamic subtest: vcs0
[289.719792] Dynamic subtest vcs0: SUCCESS (4.474s)
[289.729855] Starting dynamic subtest: vcs1
[293.725972] Dynamic subtest vcs1: SUCCESS (4.007s)
[293.735028] Starting dynamic subtest: vecs0
[297.854009] Dynamic subtest vecs0: SUCCESS (4.128s)
[297.862756] Starting dynamic subtest: ccs0
[301.621660] Dynamic subtest ccs0: SUCCESS (3.766s)
[301.624398] Subtest contexts: SUCCESS (22.951s)
[301.836584] [046/131] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[301.961320] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[301.965433] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[302.110115] [047/131] (716s left) prime_mmap_coherency (ioctl-errors)
[302.166973] Starting subtest: ioctl-errors
[318.173330] Subtest ioctl-errors: SUCCESS (16.005s)
[318.360810] [048/131] (700s left) kms_3d (basic)
[318.455993] Starting subtest: basic
[320.450742] Subtest basic: SUCCESS (1.995s)
[320.975727] [049/131] (698s left) gem_ctx_param (set-priority-not-supported)
[321.041242] Starting subtest: set-priority-not-supported
[321.046029] Subtest set-priority-not-supported: SKIP (0.000s)
[321.143296] [050/131] (697s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[321.252739] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[321.255084] Starting dynamic subtest: pipe-A-default-mode
[321.540567] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[321.545315] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.285s)
[322.369079] [051/131] (696s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[322.475785] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[322.478091] Starting dynamic subtest: pipe-A-eDP-1
[322.498863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[322.509489] Starting dynamic subtest: pipe-B-eDP-1
[322.528403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.537426] Starting dynamic subtest: pipe-C-eDP-1
[322.556565] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.565455] Starting dynamic subtest: pipe-D-eDP-1
[322.585730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.587623] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[324.775521] [052/131] (694s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[329.823748] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[329.828051] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[330.668857] [053/131] (688s left) kms_psr (psr-sprite-mmap-cpu)
[330.762636] Starting subtest: psr-sprite-mmap-cpu
[330.764970] Starting dynamic subtest: eDP-1
[332.527278] Dynamic subtest eDP-1: SUCCESS (1.765s)
[332.529798] Subtest psr-sprite-mmap-cpu: SUCCESS (1.766s)
[333.391908] [054/131] (685s left) syncobj_wait (single-wait-signaled)
[333.463533] Starting subtest: single-wait-signaled
[333.465936] Subtest single-wait-signaled: SUCCESS (0.000s)
[333.606781] [055/131] (685s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[333.703030] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[333.707187] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[333.840622] [056/131] (685s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[333.935989] Starting subtest: bad-aux-stride-yf-tiled-ccs
[333.938260] Starting dynamic subtest: pipe-A-eDP-1
[333.960680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.970843] Starting dynamic subtest: pipe-B-eDP-1
[333.992130] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[334.001677] Starting dynamic subtest: pipe-C-eDP-1
[334.023024] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[334.032236] Starting dynamic subtest: pipe-D-eDP-1
[334.053855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[334.058066] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[336.181030] [057/131] (683s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[336.285083] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[336.289543] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[336.439062] [058/131] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[336.554127] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[336.558278] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.692343] [059/131] (682s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[336.746126] Starting subtest: verify-pxp-stale-buf-optout-execution
[337.811677] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s)
[337.979370] [060/131] (681s left) kms_plane (plane-position-hole-dpms)
[338.084889] Starting subtest: plane-position-hole-dpms
[338.630258] Starting dynamic subtest: pipe-A-plane-1
[340.974958] Dynamic subtest pipe-A-plane-1: SUCCESS (2.343s)
[340.986067] Starting dynamic subtest: pipe-A-plane-2
[343.385437] Dynamic subtest pipe-A-plane-2: SUCCESS (2.409s)
[343.396755] Starting dynamic subtest: pipe-A-plane-3
[345.777436] Dynamic subtest pipe-A-plane-3: SUCCESS (2.390s)
[345.788411] Starting dynamic subtest: pipe-A-plane-4
[348.180334] Dynamic subtest pipe-A-plane-4: SUCCESS (2.403s)
[348.191141] Starting dynamic subtest: pipe-A-plane-5
[348.207374] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[349.412086] Starting dynamic subtest: pipe-B-plane-1
[351.795867] Dynamic subtest pipe-B-plane-1: SUCCESS (2.394s)
[351.807758] Starting dynamic subtest: pipe-B-plane-2
[354.151086] Dynamic subtest pipe-B-plane-2: SUCCESS (2.355s)
[354.162527] Starting dynamic subtest: pipe-B-plane-3
[356.471453] Dynamic subtest pipe-B-plane-3: SUCCESS (2.315s)
[356.482457] Starting dynamic subtest: pipe-B-plane-4
[358.899348] Dynamic subtest pipe-B-plane-4: SUCCESS (2.432s)
[358.910322] Starting dynamic subtest: pipe-B-plane-5
[358.925435] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[358.927866] Subtest plane-position-hole-dpms: SUCCESS (20.841s)
[359.768335] [061/131] (659s left) perf (gen12-mi-rpc)
[359.906936] Starting subtest: gen12-mi-rpc
[359.909381] Starting dynamic subtest: rcs0
[359.924486] Dynamic subtest rcs0: SUCCESS (0.016s)
[359.926326] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[359.967512] [062/131] (659s left) gem_ctx_param (invalid-param-set)
[360.056882] Starting subtest: invalid-param-set
[360.059605] Subtest invalid-param-set: SUCCESS (0.000s)
[360.161658] [063/131] (659s left) gem_ctx_shared (q-independent)
[360.232000] Starting subtest: Q-independent
[360.234160] Starting dynamic subtest: rcs0
[360.296422] Dynamic subtest rcs0: SUCCESS (0.067s)
[360.308369] Starting dynamic subtest: vcs0
[360.337261] Dynamic subtest vcs0: SUCCESS (0.040s)
[360.347895] Starting dynamic subtest: vcs1
[360.376965] Dynamic subtest vcs1: SUCCESS (0.039s)
[360.387578] Starting dynamic subtest: vecs0
[360.432902] Dynamic subtest vecs0: SUCCESS (0.055s)
[360.445423] Starting dynamic subtest: ccs0
[360.476124] Dynamic subtest ccs0: SUCCESS (0.043s)
[360.478425] Subtest Q-independent: SUCCESS (0.248s)
[361.486921] [064/131] (658s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[361.584812] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[361.586711] Starting dynamic subtest: pipe-A-eDP-1
[363.836792] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.253s)
[363.846922] Starting dynamic subtest: pipe-B-eDP-1
[366.256561] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.417s)
[366.266573] Starting dynamic subtest: pipe-C-eDP-1
[368.350497] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.093s)
[368.360645] Starting dynamic subtest: pipe-D-eDP-1
[370.460829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.110s)
[370.462774] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.879s)
[371.672799] [065/131] (648s left) kms_lease (atomic-implicit-crtc)
[371.779857] Starting subtest: atomic-implicit-crtc
[371.782141] Starting dynamic subtest: pipe-A-eDP-1
[371.793044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[371.802762] Starting dynamic subtest: pipe-B-eDP-1
[371.813820] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[371.823732] Starting dynamic subtest: pipe-C-eDP-1
[371.834248] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[371.843669] Starting dynamic subtest: pipe-D-eDP-1
[371.854239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[371.856346] Subtest atomic-implicit-crtc: SUCCESS (0.040s)
[371.960217] [066/131] (647s left) gem_exec_reloc (basic-wc)
[372.025194] Subtest basic-wc: SKIP (0.000s)
[372.109444] [067/131] (647s left) syncobj_timeline (transfer-timeline-point)
[372.156095] Starting subtest: transfer-timeline-point
[372.158289] Subtest transfer-timeline-point: SUCCESS (0.001s)
[372.292538] [068/131] (647s left) api_intel_bb (reset-flags)
[372.352266] Starting subtest: reset-flags
[372.357065] Subtest reset-flags: SUCCESS (0.008s)
[372.510931] [069/131] (647s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[372.617323] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[372.619302] Starting dynamic subtest: pipe-A-default-mode
[375.351321] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[375.353711] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.734s)
[376.167704] [070/131] (643s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[376.269779] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[376.272064] Starting dynamic subtest: pipe-A-eDP-1
[376.413476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[376.425757] Starting dynamic subtest: pipe-B-eDP-1
[376.444813] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[376.454099] Starting dynamic subtest: pipe-C-eDP-1
[376.473334] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[376.484342] Starting dynamic subtest: pipe-D-eDP-1
[376.502937] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[376.504829] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[378.761859] [071/131] (641s left) sw_sync (sync_merge_invalid)
[378.802188] Starting subtest: sync_merge_invalid
[378.835510] Subtest sync_merge_invalid: SUCCESS (0.032s)
[378.927433] [072/131] (641s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[379.026081] Starting subtest: yf-tiled-32bpp-rotate-180
[379.030383] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[379.145532] [073/131] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[379.246364] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[386.276523] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.032s)
[386.428400] [074/131] (633s left) gem_userptr_blits (sd-probe)
[386.503462] Starting subtest: sd-probe
[386.505744] Subtest sd-probe: SUCCESS (0.000s)
[386.676958] [075/131] (633s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[386.740186] Subtest no-spare-fences-busy: SKIP (0.000s)
[386.825224] [076/131] (633s left) kms_plane_cursor (viewport)
[386.921304] Starting subtest: viewport
[386.926738] Starting dynamic subtest: pipe-A-eDP-1-size-64
[389.459256] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.537s)
[389.518963] Starting dynamic subtest: pipe-A-eDP-1-size-128
[392.015822] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.504s)
[392.075064] Starting dynamic subtest: pipe-A-eDP-1-size-256
[394.594767] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[394.947869] Starting dynamic subtest: pipe-B-eDP-1-size-64
[398.181602] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.243s)
[398.242709] Starting dynamic subtest: pipe-B-eDP-1-size-128
[400.760037] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[400.822389] Starting dynamic subtest: pipe-B-eDP-1-size-256
[403.373847] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[403.733643] Starting dynamic subtest: pipe-C-eDP-1-size-64
[406.584769] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.862s)
[406.622654] Starting dynamic subtest: pipe-C-eDP-1-size-128
[408.807058] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[408.846290] Starting dynamic subtest: pipe-C-eDP-1-size-256
[410.995849] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.157s)
[411.340371] Starting dynamic subtest: pipe-D-eDP-1-size-64
[414.169901] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.839s)
[414.217061] Starting dynamic subtest: pipe-D-eDP-1-size-128
[416.292178] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.090s)
[416.331591] Starting dynamic subtest: pipe-D-eDP-1-size-256
[418.472077] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[418.791520] Subtest viewport: SUCCESS (31.866s)
[419.672112] [077/131] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[419.783383] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[419.787811] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[419.917381] [078/131] (600s left) syncobj_timeline (multi-wait-available-signaled)
[419.992313] Starting subtest: multi-wait-available-signaled
[419.994755] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[420.124771] [079/131] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[420.219196] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[420.223296] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[420.350173] [080/131] (599s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[420.416197] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[420.497698] [081/131] (599s left) gem_exec_reloc (basic-cpu-noreloc)
[420.557760] Subtest basic-cpu-noreloc: SKIP (0.000s)
[420.630570] [082/131] (599s left) kms_vblank (crtc-id)
[420.730897] Starting subtest: crtc-id
[420.732753] Starting dynamic subtest: pipe-A-eDP-1
[421.179177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[421.196076] Starting dynamic subtest: pipe-D-eDP-1
[422.331912] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[422.334157] Subtest crtc-id: SUCCESS (1.602s)
[423.168225] [083/131] (597s left) gem_exec_balancer (parallel-bb-first)
[423.433712] Starting subtest: parallel-bb-first
[424.370280] Subtest parallel-bb-first: SUCCESS (0.936s)
[425.413874] [084/131] (595s left) syncobj_timeline (device-submit-unordered)
[425.474204] Starting subtest: device-submit-unordered
[425.476167] Subtest device-submit-unordered: SUCCESS (0.000s)
[425.621869] [085/131] (594s left) gem_exec_parallel (userptr)
[425.696174] Starting subtest: userptr
[425.698551] Starting dynamic subtest: rcs0
[427.280600] Dynamic subtest rcs0: SUCCESS (1.584s)
[427.293848] Starting dynamic subtest: bcs0
[428.789315] Dynamic subtest bcs0: SUCCESS (1.507s)
[428.802266] Starting dynamic subtest: vcs0
[430.387562] Dynamic subtest vcs0: SUCCESS (1.595s)
[430.400642] Starting dynamic subtest: vcs1
[432.326032] Dynamic subtest vcs1: SUCCESS (1.934s)
[432.339012] Starting dynamic subtest: vecs0
[434.310907] Dynamic subtest vecs0: SUCCESS (1.981s)
[434.322989] Starting dynamic subtest: ccs0
[435.839553] Dynamic subtest ccs0: SUCCESS (1.526s)
[435.842041] Subtest userptr: SUCCESS (10.141s)
[436.053780] [086/131] (584s left) api_intel_allocator (reopen)
[436.110140] Starting subtest: reopen
[436.113991] Subtest reopen: SUCCESS (0.007s)
[436.264074] [087/131] (584s left) kms_color_pipeline (plane-lut1d-lut1d)
[436.364737] Starting subtest: plane-lut1d-lut1d
[436.382903] Starting dynamic subtest: pipe-A-eDP-1
[437.082859] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[437.788149] Starting dynamic subtest: pipe-B-eDP-1
[438.624050] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[439.199859] Starting dynamic subtest: pipe-C-eDP-1
[440.022907] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[440.495085] Starting dynamic subtest: pipe-D-eDP-1
[441.321658] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[441.324056] Subtest plane-lut1d-lut1d: FAIL (4.640s)
[441.874573] [088/131] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[441.976998] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[446.263554] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.291s)
[447.476967] [089/131] (573s left) kms_flip (flip-vs-absolute-wf_vblank)
[447.584078] Starting subtest: flip-vs-absolute-wf_vblank
[447.586445] Starting dynamic subtest: A-eDP1
[456.469074] Dynamic subtest A-eDP1: SUCCESS (8.882s)
[456.482608] Starting dynamic subtest: B-eDP1
[465.364715] Dynamic subtest B-eDP1: SUCCESS (8.891s)
[465.381236] Starting dynamic subtest: C-eDP1
[474.301490] Dynamic subtest C-eDP1: SUCCESS (8.886s)
[474.317979] Starting dynamic subtest: D-eDP1
[483.192484] Dynamic subtest D-eDP1: SUCCESS (8.891s)
[483.194540] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.563s)
[484.367747] [090/131] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[484.465738] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[484.470082] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[484.591821] [091/131] (536s left) i915_suspend (basic-s2idle-without-i915)
[484.631304] Starting subtest: basic-s2idle-without-i915
[506.638639] Subtest basic-s2idle-without-i915: SUCCESS (7.246s)
[506.775330] [092/131] (514s left) kms_pm_rpm (basic-rte)
[506.823443] Starting subtest: basic-rte
[509.813052] Subtest basic-rte: SUCCESS (2.927s)
[511.641097] [093/131] (509s left) i915_pm_freq_api (freq-reset)
[511.718754] Starting subtest: freq-reset
[511.721113] Starting dynamic subtest: gt0
[511.864985] Dynamic subtest gt0: SUCCESS (0.142s)
[511.873955] Starting dynamic subtest: gt1
[511.998381] Dynamic subtest gt1: SUCCESS (0.131s)
[512.001027] Subtest freq-reset: SUCCESS (0.275s)
[512.098743] [094/131] (508s left) i915_drm_fdinfo (all-busy-idle-check-all)
[512.143694] Starting subtest: all-busy-idle-check-all
[512.150610] Subtest all-busy-idle-check-all: SKIP (0.004s)
[512.235662] [095/131] (508s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[512.338432] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[512.426070] [096/131] (508s left) gen9_exec_parse (basic-rejected-ctx-param)
[512.485688] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[512.563571] [097/131] (508s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[512.663214] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[512.665574] Starting dynamic subtest: pipe-A
[512.685738] Dynamic subtest pipe-A: SKIP (0.018s)
[512.695659] Starting dynamic subtest: pipe-B
[512.720690] Dynamic subtest pipe-B: SKIP (0.034s)
[512.729990] Starting dynamic subtest: pipe-C
[512.754820] Dynamic subtest pipe-C: SKIP (0.034s)
[512.763801] Starting dynamic subtest: pipe-D
[512.790857] Dynamic subtest pipe-D: SKIP (0.034s)
[512.794481] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.123s)
[512.902381] [098/131] (508s left) gem_ctx_isolation (preservation)
[512.971940] Starting subtest: preservation
[512.974242] Starting dynamic subtest: rcs0
[513.123079] Dynamic subtest rcs0: SUCCESS (0.149s)
[513.135790] Starting dynamic subtest: bcs0
[513.300456] Dynamic subtest bcs0: SUCCESS (0.175s)
[513.311892] Starting dynamic subtest: vcs0
[513.476784] Dynamic subtest vcs0: SUCCESS (0.173s)
[513.488855] Starting dynamic subtest: vcs1
[515.216111] Dynamic subtest vcs1: SUCCESS (1.722s)
[515.227532] Starting dynamic subtest: vecs0
[517.220003] Dynamic subtest vecs0: SUCCESS (1.987s)
[517.232332] Starting dynamic subtest: ccs0
[519.286073] Dynamic subtest ccs0: SUCCESS (2.054s)
[519.288595] Subtest preservation: SUCCESS (6.265s)
[519.561148] [099/131] (501s left) kms_feature_discovery (display-2x)
[519.659406] Starting subtest: display-2x
[519.663984] Subtest display-2x: SKIP (0.000s)
[519.760333] [100/131] (501s left) perf_pmu (event-wait)
[519.805977] Starting subtest: event-wait
[519.808424] Starting dynamic subtest: rcs0
[519.813013] Dynamic subtest rcs0: SKIP (0.000s)
[519.817539] Subtest event-wait: SKIP (0.001s)
[519.948733] [101/131] (501s left) gem_ctx_engines (execute-oneforall)
[520.015932] Starting subtest: execute-oneforall
[520.493840] Subtest execute-oneforall: SUCCESS (0.476s)
[522.289569] [102/131] (498s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[522.393952] Starting subtest: y-tiled-64bpp-rotate-0
[522.398355] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[522.525171] [103/131] (498s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[522.582102] Subtest untiled-to-tiled: SKIP (0.000s)
[522.660462] [104/131] (498s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[523.045548] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[523.898545] [105/131] (497s left) gem_mmap (big-bo)
[523.958591] Subtest big-bo: SKIP (0.000s)
[524.028195] [106/131] (497s left) gem_exec_fence (syncobj-signal)
[524.451347] Starting subtest: syncobj-signal
[524.457193] Subtest syncobj-signal: SUCCESS (0.005s)
[526.216457] [107/131] (495s left) kms_cursor_edge_walk (128x128-left-edge)
[526.309444] Starting subtest: 128x128-left-edge
[526.311677] Starting dynamic subtest: pipe-A-eDP-1
[529.807421] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[529.816829] Starting dynamic subtest: pipe-D-eDP-1
[532.952961] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[532.955056] Subtest 128x128-left-edge: SUCCESS (6.633s)
[533.775272] [108/131] (487s left) syncobj_wait (single-wait-submitted)
[533.837143] Starting subtest: single-wait-submitted
[533.937792] Subtest single-wait-submitted: SUCCESS (0.101s)
[534.040427] [109/131] (487s left) kms_atomic (plane-invalid-params-fence)
[534.140351] Starting subtest: plane-invalid-params-fence
[534.142627] Starting dynamic subtest: pipe-A-eDP-1
[534.510866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[534.513172] Subtest plane-invalid-params-fence: SUCCESS (0.371s)
[535.397772] [110/131] (486s left) gem_exec_await (wide-contexts)
[535.595364] Starting subtest: wide-contexts
[558.966015] Subtest wide-contexts: SUCCESS (23.361s)
[559.180284] [111/131] (462s left) kms_prop_blob (invalid-get-prop)
[559.270394] Starting subtest: invalid-get-prop
[559.272603] Subtest invalid-get-prop: SUCCESS (0.000s)
[559.406436] [112/131] (462s left) kms_psr (psr2-primary-page-flip)
[559.522066] Starting subtest: psr2-primary-page-flip
[559.524229] Starting dynamic subtest: eDP-1
[561.265961] Dynamic subtest eDP-1: SUCCESS (1.744s)
[561.268130] Subtest psr2-primary-page-flip: SUCCESS (1.745s)
[562.171543] [113/131] (459s left) gem_userptr_blits (invalid-null-pointer)
[562.246789] Starting subtest: invalid-null-pointer
[562.248735] Subtest invalid-null-pointer: SUCCESS (0.001s)
[562.424488] [114/131] (459s left) syncobj_timeline (reset-multiple-signaled)
[562.495037] Starting subtest: reset-multiple-signaled
[562.497428] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[562.614063] [115/131] (459s left) gem_exec_async (forked-writes)
[562.680938] Starting subtest: forked-writes
[562.683219] Starting dynamic subtest: rcs0
[562.709628] Dynamic subtest rcs0: SUCCESS (0.028s)
[562.722926] Starting dynamic subtest: bcs0
[562.735149] Dynamic subtest bcs0: SUCCESS (0.025s)
[562.747143] Starting dynamic subtest: vcs0
[562.755698] Dynamic subtest vcs0: SUCCESS (0.020s)
[562.768903] Starting dynamic subtest: vcs1
[562.779711] Dynamic subtest vcs1: SUCCESS (0.023s)
[562.789835] Starting dynamic subtest: vecs0
[562.805414] Dynamic subtest vecs0: SUCCESS (0.025s)
[562.815526] Starting dynamic subtest: ccs0
[562.827614] Dynamic subtest ccs0: SUCCESS (0.021s)
[562.829863] Subtest forked-writes: SUCCESS (0.147s)
[563.087876] [116/131] (458s left) kms_plane_scaling (planes-downscale-factor-0-75)
[563.195401] Starting subtest: planes-downscale-factor-0-75
[563.197636] Starting dynamic subtest: pipe-A
[563.217757] Dynamic subtest pipe-A: SKIP (0.018s)
[563.228109] Starting dynamic subtest: pipe-B
[563.254604] Dynamic subtest pipe-B: SKIP (0.035s)
[563.264478] Starting dynamic subtest: pipe-C
[563.290055] Dynamic subtest pipe-C: SKIP (0.035s)
[563.299780] Starting dynamic subtest: pipe-D
[563.320519] Dynamic subtest pipe-D: SKIP (0.031s)
[563.324191] Subtest planes-downscale-factor-0-75: SKIP (0.123s)
[563.458127] [117/131] (458s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[563.525571] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[563.599356] [118/131] (458s left) dumb_buffer (map-uaf)
[563.664984] Starting subtest: map-uaf
[563.670272] Subtest map-uaf: SUCCESS (0.006s)
[563.804643] [119/131] (458s left) kms_fbcon_fbt (fbc-suspend)
[563.866101] Starting subtest: fbc-suspend
[612.339913] Subtest fbc-suspend: SUCCESS (18.893s)
[613.677880] [120/131] (408s left) perf (blocking)
[613.839110] Starting subtest: blocking
[613.841534] Starting dynamic subtest: 0-rcs0
[623.851431] Dynamic subtest 0-rcs0: SUCCESS (9.939s)
[623.862757] Starting dynamic subtest: 1-vecs0
[633.919455] Dynamic subtest 1-vecs0: SUCCESS (9.993s)
[633.922089] Subtest blocking: SUCCESS (19.935s)
[633.963759] [121/131] (388s left) kms_cursor_crc (cursor-onscreen-128x128)
[634.190455] Starting subtest: cursor-onscreen-128x128
[634.192928] Starting dynamic subtest: pipe-A-eDP-1
[636.330364] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[636.357947] Starting dynamic subtest: pipe-D-eDP-1
[639.082666] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.730s)
[639.084978] Subtest cursor-onscreen-128x128: SUCCESS (4.887s)
[639.979940] [122/131] (382s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[640.265094] Starting subtest: cursor-rapid-movement-512x170
[640.270822] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[640.452911] [123/131] (381s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[640.582485] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[641.569806] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[642.401969] [124/131] (379s left) gem_exec_schedule (preempt-self)
[642.478098] Starting subtest: preempt-self
[642.480575] Starting dynamic subtest: rcs0
[642.491558] Dynamic subtest rcs0: SUCCESS (0.024s)
[642.503477] Starting dynamic subtest: bcs0
[642.510916] Dynamic subtest bcs0: SUCCESS (0.019s)
[642.521886] Starting dynamic subtest: vcs0
[642.542607] Dynamic subtest vcs0: SUCCESS (0.030s)
[642.555251] Starting dynamic subtest: vcs1
[642.580061] Dynamic subtest vcs1: SUCCESS (0.035s)
[642.590351] Starting dynamic subtest: vecs0
[642.612700] Dynamic subtest vecs0: SUCCESS (0.030s)
[642.622647] Starting dynamic subtest: ccs0
[642.628445] Dynamic subtest ccs0: SUCCESS (0.014s)
[642.630886] Subtest preempt-self: SUCCESS (0.161s)
[644.496858] [125/131] (377s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[644.615859] Starting subtest: x-tiled-64bpp-rotate-180
[646.149997] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.534s)
[646.389930] [126/131] (375s left) kms_flip (2x-flip-vs-modeset)
[646.492041] Starting subtest: 2x-flip-vs-modeset
[646.503842] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[646.614632] [127/131] (375s left) perf_pmu (most-busy-check-all)
[646.657809] Starting subtest: most-busy-check-all
[646.660219] Starting dynamic subtest: rcs0
[648.398932] Dynamic subtest rcs0: SUCCESS (1.741s)
[648.413055] Starting dynamic subtest: bcs0
[650.383941] Dynamic subtest bcs0: SUCCESS (1.982s)
[650.398097] Starting dynamic subtest: vcs0
[652.430414] Dynamic subtest vcs0: SUCCESS (2.043s)
[652.444061] Starting dynamic subtest: vcs1
[654.414318] Dynamic subtest vcs1: SUCCESS (1.981s)
[654.427082] Starting dynamic subtest: vecs0
[656.397479] Dynamic subtest vecs0: SUCCESS (1.980s)
[656.410688] Starting dynamic subtest: ccs0
[658.381869] Dynamic subtest ccs0: SUCCESS (1.981s)
[658.384809] Subtest most-busy-check-all: SUCCESS (11.725s)
[658.512773] [128/131] (363s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[658.900065] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[659.687592] [129/131] (362s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[659.736841] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[659.742780] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[659.949667] [130/131] (362s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[660.043851] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[660.048996] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[660.177797] [131/131] (362s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[660.283495] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[667.211721] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.928s)
[667.359260] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: core_getversion
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_debugfs
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_legacy_colorkey
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap_coherency
results: parsing output: 47/ for test: kms_3d
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_suspend
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_set_tiling_vs_blt
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_await
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_async
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: dumb_buffer
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.