[59.084094] Initializing watchdogs
[59.084144]   /dev/watchdog0
[59.097761] [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]
[59.102106] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.104357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.107765] [001/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[59.237330] Starting subtest: 4-tiled-32bpp-rotate-270
[59.269410] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.031s)
[59.438005] [002/131] (960s left) kms_rotation_crc (multiplane-rotation)
[59.538269] Starting subtest: multiplane-rotation
[77.003221] Subtest multiplane-rotation: SUCCESS (17.426s)
[77.146100] [003/131] (942s left) perf (invalid-oa-metric-set-id)
[77.299860] Starting subtest: invalid-oa-metric-set-id
[77.309075] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[77.344875] [004/131] (942s left) syncobj_wait (wait-any-snapshot)
[77.401482] Starting subtest: wait-any-snapshot
[77.483799] Subtest wait-any-snapshot: SUCCESS (0.082s)
[77.586500] [005/131] (942s left) kms_psr (fbc-psr2-primary-blt)
[77.679348] Starting subtest: fbc-psr2-primary-blt
[77.680995] Starting dynamic subtest: eDP-1
[77.684478] Dynamic subtest eDP-1: SKIP (0.000s)
[77.687939] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[77.775868] [006/131] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[82.792596] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[82.795065] Starting dynamic subtest: pipe-A-eDP-1
[94.820547] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.021s)
[94.828928] Starting dynamic subtest: pipe-B-eDP-1
[106.835994] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.009s)
[106.838499] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.034s)
[107.712311] [007/131] (912s left) i915_pm_rc6_residency (media-rc6-accuracy)
[107.772130] Starting subtest: media-rc6-accuracy
[107.776277] Subtest media-rc6-accuracy: SKIP (0.000s)
[107.881274] [008/131] (911s left) core_getversion (basic)
[107.922391] Starting subtest: basic
[107.926675] Subtest basic: SUCCESS (0.000s)
[108.002361] [009/131] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[108.089860] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[108.094314] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[108.220708] [010/131] (911s left) kms_debugfs (display-off-read-all)
[108.316147] Starting subtest: display-off-read-all
[108.609207] Subtest display-off-read-all: SUCCESS (0.293s)
[109.448386] [011/131] (910s left) syncobj_timeline (host-signal-points)
[109.512844] Starting subtest: host-signal-points
[109.517729] Subtest host-signal-points: SUCCESS (0.005s)
[109.643865] [012/131] (910s left) gem_exec_store (basic)
[109.694097] Starting subtest: basic
[109.813597] Subtest basic: SUCCESS (0.119s)
[110.019340] [013/131] (910s left) gem_exec_flush (basic-wb-rw-default)
[110.091578] Starting subtest: basic-wb-rw-default
[115.545567] Subtest basic-wb-rw-default: SUCCESS (5.454s)
[115.756218] [014/131] (904s left) vgem_basic (setversion)
[115.834286] Starting subtest: setversion
[115.838432] Subtest setversion: SUCCESS (0.000s)
[115.908239] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[115.911432] [015/131] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[115.977915] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[116.081924] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[116.183696] [016/131] (903s left) kms_legacy_colorkey (basic)
[116.289087] Starting subtest: basic
[116.290972] Starting dynamic subtest: pipe-A
[116.332555] Dynamic subtest pipe-A: SUCCESS (0.045s)
[116.342666] Starting dynamic subtest: pipe-B
[116.344928] Dynamic subtest pipe-B: SUCCESS (0.001s)
[116.353770] Starting dynamic subtest: pipe-C
[116.356093] Dynamic subtest pipe-C: SUCCESS (0.000s)
[116.362771] Starting dynamic subtest: pipe-D
[116.364978] Dynamic subtest pipe-D: SUCCESS (0.000s)
[116.367193] Subtest basic: SUCCESS (0.051s)
[116.424792] [017/131] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[116.519183] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[120.465109] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.948s)
[121.668771] [018/131] (898s left) kms_rmfb (close-fd)
[121.766892] Starting subtest: close-fd
[121.768842] Starting dynamic subtest: pipe-A-eDP-1
[121.874253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[121.883142] Starting dynamic subtest: pipe-B-eDP-1
[123.093412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s)
[123.102979] Starting dynamic subtest: pipe-C-eDP-1
[124.226173] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.132s)
[124.235322] Starting dynamic subtest: pipe-D-eDP-1
[125.364113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[125.366426] Subtest close-fd: SUCCESS (3.597s)
[126.594083] [019/131] (893s left) kms_atomic_interruptible (legacy-dpms)
[126.694160] Starting subtest: legacy-dpms
[126.696276] Starting dynamic subtest: pipe-A-eDP-1
[134.104314] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.408s)
[134.106627] Subtest legacy-dpms: SUCCESS (7.410s)
[134.955321] [020/131] (885s left) gem_ctx_persistence (legacy-engines-hostile)
[135.013342] Starting subtest: legacy-engines-hostile
[135.015808] Starting dynamic subtest: render
[135.106726] Dynamic subtest render: SUCCESS (0.093s)
[135.117690] Starting dynamic subtest: bsd1
[135.223193] Dynamic subtest bsd1: SUCCESS (0.113s)
[135.233720] Starting dynamic subtest: bsd2
[135.330270] Dynamic subtest bsd2: SUCCESS (0.105s)
[135.340387] Starting dynamic subtest: blt
[135.408668] Dynamic subtest blt: SUCCESS (0.077s)
[135.418031] Starting dynamic subtest: vebox
[135.561360] Dynamic subtest vebox: SUCCESS (0.150s)
[135.564279] Subtest legacy-engines-hostile: SUCCESS (0.548s)
[135.699416] [021/131] (884s left) gem_exec_whisper (basic-queues-forked-all)
[135.768133] Starting subtest: basic-queues-forked-all
[157.010464] Subtest basic-queues-forked-all: SUCCESS (21.237s)
[157.211305] [022/131] (863s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[157.305171] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[157.307260] Starting dynamic subtest: pipe-A-eDP-1
[158.164510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[158.174084] Starting dynamic subtest: pipe-B-eDP-1
[159.653278] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s)
[159.662215] Starting dynamic subtest: pipe-C-eDP-1
[161.169305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.516s)
[161.178303] Starting dynamic subtest: pipe-D-eDP-1
[162.648890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[162.651180] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.337s)
[163.822911] [023/131] (856s left) kms_content_protection (legacy-hdcp14)
[163.976574] Starting subtest: legacy-hdcp14
[163.981174] Subtest legacy-hdcp14: SKIP (0.000s)
[164.148500] [024/131] (856s left) kms_frontbuffer_tracking (fbc-tiling-y)
[164.247186] Starting subtest: fbc-tiling-y
[164.251605] Subtest fbc-tiling-y: SKIP (0.000s)
[164.395708] [025/131] (856s left) syncobj_wait (single-wait-for-submit-submitted)
[164.459863] Starting subtest: single-wait-for-submit-submitted
[164.561681] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[164.661927] [026/131] (855s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[164.795233] Starting subtest: cursorB-vs-flipB-atomic
[164.800047] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[164.963341] [027/131] (855s left) kms_flip (2x-blocking-absolute-wf_vblank)
[165.066458] Starting subtest: 2x-blocking-absolute-wf_vblank
[165.077082] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[165.182094] [028/131] (855s left) gem_mmap_offset (partial-unmap)
[165.241290] Starting subtest: partial-unmap
[165.243242] Starting dynamic subtest: smem0
[165.733392] Dynamic subtest smem0: SUCCESS (0.492s)
[165.735952] Subtest partial-unmap: SUCCESS (0.493s)
[165.889054] [029/131] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[165.985781] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[173.130063] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.146s)
[173.256771] [030/131] (847s left) kms_vblank (ts-continuation-idle-hang)
[173.352823] Starting subtest: ts-continuation-idle-hang
[173.355110] Starting dynamic subtest: pipe-A-eDP-1
[199.639187] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.283s)
[199.652740] Starting dynamic subtest: pipe-D-eDP-1
[214.674874] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[214.677218] Subtest ts-continuation-idle-hang: SUCCESS (41.321s)
[215.496590] [031/131] (805s left) gem_userptr_blits (readonly-unsync)
[215.573045] Subtest readonly-unsync: SKIP (0.000s)
[215.742352] [032/131] (805s left) gem_mmap (short-mmap)
[215.799082] Subtest short-mmap: SKIP (0.000s)
[215.865578] [033/131] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[215.967361] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[215.971329] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[216.084893] [034/131] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[216.188516] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[216.192909] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[216.345727] [035/131] (804s left) kms_chamelium_color (ctm-green-to-red)
[216.429926] Subtest ctm-green-to-red: SKIP (0.000s)
[216.473202] [036/131] (804s left) kms_frontbuffer_tracking (psr-suspend)
[216.584330] Starting subtest: psr-suspend
[254.308975] Subtest psr-suspend: SUCCESS (11.615s)
[254.477978] [037/131] (766s left) gem_spin_batch (engines)
[254.543356] Starting subtest: engines
[254.545844] Starting dynamic subtest: rcs0
[257.920244] Dynamic subtest rcs0: SUCCESS (3.290s)
[257.928890] Starting dynamic subtest: bcs0
[261.267794] Dynamic subtest bcs0: SUCCESS (3.293s)
[261.278262] Starting dynamic subtest: vcs0
[264.609338] Dynamic subtest vcs0: SUCCESS (3.305s)
[264.619984] Starting dynamic subtest: vcs1
[267.953953] Dynamic subtest vcs1: SUCCESS (3.319s)
[267.964598] Starting dynamic subtest: vecs0
[271.297212] Dynamic subtest vecs0: SUCCESS (3.325s)
[271.308340] Starting dynamic subtest: ccs0
[274.636442] Dynamic subtest ccs0: SUCCESS (3.326s)
[274.638499] Subtest engines: SUCCESS (19.874s)
[274.900591] [038/131] (746s left) kms_psr (fbc-pr-sprite-blt)
[275.000451] Starting subtest: fbc-pr-sprite-blt
[275.004963] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[275.092398] [039/131] (746s left) kms_psr (fbc-psr-primary-mmap-gtt)
[275.182611] Starting subtest: fbc-psr-primary-mmap-gtt
[275.184527] Starting dynamic subtest: eDP-1
[275.188586] Dynamic subtest eDP-1: SKIP (0.000s)
[275.192665] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[275.281230] [040/131] (745s left) gem_exec_schedule (preempt-hang)
[275.459717] Starting subtest: preempt-hang
[275.462238] Starting dynamic subtest: rcs0
[275.675510] Dynamic subtest rcs0: SUCCESS (0.217s)
[275.684963] Starting dynamic subtest: bcs0
[275.891598] Dynamic subtest bcs0: SUCCESS (0.215s)
[275.901794] Starting dynamic subtest: vcs0
[276.105033] Dynamic subtest vcs0: SUCCESS (0.212s)
[276.115891] Starting dynamic subtest: vcs1
[276.320945] Dynamic subtest vcs1: SUCCESS (0.213s)
[276.330012] Starting dynamic subtest: vecs0
[276.545203] Dynamic subtest vecs0: SUCCESS (0.223s)
[276.556331] Starting dynamic subtest: ccs0
[276.766179] Dynamic subtest ccs0: SUCCESS (0.221s)
[276.768081] Subtest preempt-hang: SUCCESS (1.306s)
[278.123226] [041/131] (743s left) gem_pxp (create-regular-context-1)
[278.245182] Starting subtest: create-regular-context-1
[278.247672] Subtest create-regular-context-1: SUCCESS (0.002s)
[278.390585] [042/131] (742s left) kms_big_fb (linear-32bpp-rotate-270)
[278.502984] Starting subtest: linear-32bpp-rotate-270
[278.522620] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[278.681792] [043/131] (742s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[278.769774] Starting subtest: fbc-shrfb-scaledprimary
[281.767734] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.997s)
[282.964756] [044/131] (738s left) kms_getfb (getfb-reject-nv12)
[283.066611] Starting subtest: getfb-reject-nv12
[283.068940] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[283.203359] [045/131] (738s left) gem_exec_parallel (contexts)
[283.268947] Starting subtest: contexts
[283.271395] Starting dynamic subtest: rcs0
[286.054723] Dynamic subtest rcs0: SUCCESS (2.783s)
[286.066326] Starting dynamic subtest: bcs0
[289.659059] Dynamic subtest bcs0: SUCCESS (3.604s)
[289.668563] Starting dynamic subtest: vcs0
[293.459384] Dynamic subtest vcs0: SUCCESS (3.800s)
[293.468020] Starting dynamic subtest: vcs1
[297.512971] Dynamic subtest vcs1: SUCCESS (4.051s)
[297.521507] Starting dynamic subtest: vecs0
[301.570255] Dynamic subtest vecs0: SUCCESS (4.055s)
[301.578917] Starting dynamic subtest: ccs0
[305.107180] Dynamic subtest ccs0: SUCCESS (3.533s)
[305.110219] Subtest contexts: SUCCESS (21.840s)
[305.319661] [046/131] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[305.422795] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[305.426923] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[305.565785] [047/131] (715s left) prime_mmap_coherency (ioctl-errors)
[305.627145] Starting subtest: ioctl-errors
[322.211661] Subtest ioctl-errors: SUCCESS (16.581s)
[322.417877] [048/131] (699s left) kms_3d (basic)
[322.524689] Starting subtest: basic
[324.533180] Subtest basic: SUCCESS (2.009s)
[325.053394] [049/131] (696s left) gem_ctx_param (set-priority-not-supported)
[325.120775] Starting subtest: set-priority-not-supported
[325.125630] Subtest set-priority-not-supported: SKIP (0.000s)
[325.243840] [050/131] (696s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[325.355083] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[325.357401] Starting dynamic subtest: pipe-A-default-mode
[325.648767] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[325.653115] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.292s)
[326.461697] [051/131] (695s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[326.561487] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[326.563767] Starting dynamic subtest: pipe-A-eDP-1
[326.583674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[326.593977] Starting dynamic subtest: pipe-B-eDP-1
[326.612951] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[326.622064] Starting dynamic subtest: pipe-C-eDP-1
[326.641472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[326.650471] Starting dynamic subtest: pipe-D-eDP-1
[326.669309] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[326.671521] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[328.828290] [052/131] (692s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[333.807881] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[333.812520] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[334.666486] [053/131] (687s left) kms_psr (psr-sprite-mmap-cpu)
[334.757245] Starting subtest: psr-sprite-mmap-cpu
[334.759369] Starting dynamic subtest: eDP-1
[336.455412] Dynamic subtest eDP-1: SUCCESS (1.697s)
[336.457730] Subtest psr-sprite-mmap-cpu: SUCCESS (1.698s)
[337.322703] [054/131] (684s left) syncobj_wait (single-wait-signaled)
[337.389441] Starting subtest: single-wait-signaled
[337.391667] Subtest single-wait-signaled: SUCCESS (0.000s)
[337.507443] [055/131] (684s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[337.609621] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[337.613937] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[337.730689] [056/131] (684s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[337.833186] Starting subtest: bad-aux-stride-yf-tiled-ccs
[337.835604] Starting dynamic subtest: pipe-A-eDP-1
[337.858927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.884348] Starting dynamic subtest: pipe-B-eDP-1
[337.906611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.925888] Starting dynamic subtest: pipe-C-eDP-1
[337.949728] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.961213] Starting dynamic subtest: pipe-D-eDP-1
[337.983922] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.988129] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[340.106491] [057/131] (681s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[340.228678] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[340.232571] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[340.352552] [058/131] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[340.442980] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[340.447044] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[340.548844] [059/131] (681s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[340.616601] Starting subtest: verify-pxp-stale-buf-optout-execution
[341.677898] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.058s)
[341.851611] [060/131] (680s left) kms_plane (plane-position-hole-dpms)
[341.954527] Starting subtest: plane-position-hole-dpms
[342.463346] Starting dynamic subtest: pipe-A-plane-1
[344.818621] Dynamic subtest pipe-A-plane-1: SUCCESS (2.354s)
[344.829141] Starting dynamic subtest: pipe-A-plane-2
[347.067247] Dynamic subtest pipe-A-plane-2: SUCCESS (2.248s)
[347.082653] Starting dynamic subtest: pipe-A-plane-3
[349.337949] Dynamic subtest pipe-A-plane-3: SUCCESS (2.269s)
[349.350701] Starting dynamic subtest: pipe-A-plane-4
[351.706146] Dynamic subtest pipe-A-plane-4: SUCCESS (2.368s)
[351.715620] Starting dynamic subtest: pipe-A-plane-5
[351.730904] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[352.867942] Starting dynamic subtest: pipe-B-plane-1
[355.225297] Dynamic subtest pipe-B-plane-1: SUCCESS (2.363s)
[355.235269] Starting dynamic subtest: pipe-B-plane-2
[357.566951] Dynamic subtest pipe-B-plane-2: SUCCESS (2.342s)
[357.576132] Starting dynamic subtest: pipe-B-plane-3
[359.935107] Dynamic subtest pipe-B-plane-3: SUCCESS (2.369s)
[359.945388] Starting dynamic subtest: pipe-B-plane-4
[362.205240] Dynamic subtest pipe-B-plane-4: SUCCESS (2.269s)
[362.215249] Starting dynamic subtest: pipe-B-plane-5
[362.232881] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[362.235283] Subtest plane-position-hole-dpms: SUCCESS (20.280s)
[363.026513] [061/131] (659s left) perf (gen12-mi-rpc)
[363.157329] Starting subtest: gen12-mi-rpc
[363.159803] Starting dynamic subtest: rcs0
[363.175678] Dynamic subtest rcs0: SUCCESS (0.016s)
[363.177568] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[363.218941] [062/131] (658s left) gem_ctx_param (invalid-param-set)
[363.307088] Starting subtest: invalid-param-set
[363.309742] Subtest invalid-param-set: SUCCESS (0.000s)
[363.406474] [063/131] (658s left) gem_ctx_shared (q-independent)
[363.475361] Starting subtest: Q-independent
[363.477691] Starting dynamic subtest: rcs0
[363.542237] Dynamic subtest rcs0: SUCCESS (0.066s)
[363.553830] Starting dynamic subtest: vcs0
[363.581293] Dynamic subtest vcs0: SUCCESS (0.039s)
[363.590818] Starting dynamic subtest: vcs1
[363.615921] Dynamic subtest vcs1: SUCCESS (0.034s)
[363.625067] Starting dynamic subtest: vecs0
[363.648977] Dynamic subtest vecs0: SUCCESS (0.033s)
[363.658017] Starting dynamic subtest: ccs0
[363.691978] Dynamic subtest ccs0: SUCCESS (0.042s)
[363.694403] Subtest Q-independent: SUCCESS (0.217s)
[365.105657] [064/131] (657s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[365.209520] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[365.211460] Starting dynamic subtest: pipe-A-eDP-1
[367.272424] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.063s)
[367.282231] Starting dynamic subtest: pipe-B-eDP-1
[369.420273] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.147s)
[369.429214] Starting dynamic subtest: pipe-C-eDP-1
[371.445331] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.024s)
[371.454916] Starting dynamic subtest: pipe-D-eDP-1
[373.516706] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.070s)
[373.518917] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.309s)
[374.751893] [065/131] (647s left) kms_lease (atomic-implicit-crtc)
[374.860510] Starting subtest: atomic-implicit-crtc
[374.862648] Starting dynamic subtest: pipe-A-eDP-1
[374.873825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[374.884971] Starting dynamic subtest: pipe-B-eDP-1
[374.896087] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[374.905142] Starting dynamic subtest: pipe-C-eDP-1
[374.915394] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[374.924150] Starting dynamic subtest: pipe-D-eDP-1
[374.934544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[374.936319] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[375.029752] [066/131] (647s left) gem_exec_reloc (basic-wc)
[375.086837] Subtest basic-wc: SKIP (0.000s)
[375.175556] [067/131] (647s left) syncobj_timeline (transfer-timeline-point)
[375.237884] Starting subtest: transfer-timeline-point
[375.240169] Subtest transfer-timeline-point: SUCCESS (0.000s)
[375.372328] [068/131] (646s left) api_intel_bb (reset-flags)
[375.435408] Starting subtest: reset-flags
[375.440924] Subtest reset-flags: SUCCESS (0.008s)
[375.604200] [069/131] (646s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[375.715841] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[375.717835] Starting dynamic subtest: pipe-A-default-mode
[378.488578] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[378.490848] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.771s)
[379.344591] [070/131] (643s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[379.436538] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[379.438833] Starting dynamic subtest: pipe-A-eDP-1
[379.578009] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.133s)
[379.589506] Starting dynamic subtest: pipe-B-eDP-1
[379.609440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[379.618698] Starting dynamic subtest: pipe-C-eDP-1
[379.637109] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[379.646562] Starting dynamic subtest: pipe-D-eDP-1
[379.666186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[379.668115] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[381.908461] [071/131] (640s left) sw_sync (sync_merge_invalid)
[381.947956] Starting subtest: sync_merge_invalid
[381.979142] Subtest sync_merge_invalid: SUCCESS (0.031s)
[382.064561] [072/131] (640s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[382.168887] Starting subtest: yf-tiled-32bpp-rotate-180
[382.173385] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[382.315388] [073/131] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[382.410766] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[389.320217] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.912s)
[389.456375] [074/131] (633s left) gem_userptr_blits (sd-probe)
[389.525393] Starting subtest: sd-probe
[389.527650] Subtest sd-probe: SUCCESS (0.000s)
[389.694227] [075/131] (632s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[389.764838] Subtest no-spare-fences-busy: SKIP (0.000s)
[389.855465] [076/131] (632s left) kms_plane_cursor (viewport)
[389.956147] Starting subtest: viewport
[389.960584] Starting dynamic subtest: pipe-A-eDP-1-size-64
[392.385792] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.430s)
[392.451213] Starting dynamic subtest: pipe-A-eDP-1-size-128
[394.953228] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.515s)
[395.015398] Starting dynamic subtest: pipe-A-eDP-1-size-256
[397.412249] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.404s)
[397.770991] Starting dynamic subtest: pipe-B-eDP-1-size-64
[400.866284] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.106s)
[400.928493] Starting dynamic subtest: pipe-B-eDP-1-size-128
[403.436426] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[403.497079] Starting dynamic subtest: pipe-B-eDP-1-size-256
[405.869218] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.381s)
[406.230857] Starting dynamic subtest: pipe-C-eDP-1-size-64
[409.118755] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.898s)
[409.156511] Starting dynamic subtest: pipe-C-eDP-1-size-128
[411.320542] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.171s)
[411.357432] Starting dynamic subtest: pipe-C-eDP-1-size-256
[413.474574] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s)
[413.803903] Starting dynamic subtest: pipe-D-eDP-1-size-64
[416.591055] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.799s)
[416.629913] Starting dynamic subtest: pipe-D-eDP-1-size-128
[418.668265] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.046s)
[418.709294] Starting dynamic subtest: pipe-D-eDP-1-size-256
[420.802925] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[421.125874] Subtest viewport: SUCCESS (31.165s)
[421.978459] [077/131] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[422.085952] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[422.090035] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.223375] [078/131] (600s left) syncobj_timeline (multi-wait-available-signaled)
[422.271930] Starting subtest: multi-wait-available-signaled
[422.273988] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[422.386140] [079/131] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[422.485641] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[422.489602] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[422.614916] [080/131] (600s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[422.678171] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[422.752152] [081/131] (600s left) gem_exec_reloc (basic-cpu-noreloc)
[422.808154] Subtest basic-cpu-noreloc: SKIP (0.000s)
[422.895890] [082/131] (600s left) kms_vblank (crtc-id)
[422.990608] Starting subtest: crtc-id
[422.992287] Starting dynamic subtest: pipe-A-eDP-1
[423.434669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[423.451140] Starting dynamic subtest: pipe-D-eDP-1
[424.571135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[424.573951] Subtest crtc-id: SUCCESS (1.581s)
[425.424102] [083/131] (597s left) gem_exec_balancer (parallel-bb-first)
[425.692076] Starting subtest: parallel-bb-first
[426.590809] Subtest parallel-bb-first: SUCCESS (0.901s)
[427.040280] [084/131] (595s left) syncobj_timeline (device-submit-unordered)
[427.102722] Starting subtest: device-submit-unordered
[427.105101] Subtest device-submit-unordered: SUCCESS (0.001s)
[427.240878] [085/131] (595s left) gem_exec_parallel (userptr)
[427.301793] Starting subtest: userptr
[427.304235] Starting dynamic subtest: rcs0
[428.884388] Dynamic subtest rcs0: SUCCESS (1.580s)
[428.896947] Starting dynamic subtest: bcs0
[430.395402] Dynamic subtest bcs0: SUCCESS (1.510s)
[430.407544] Starting dynamic subtest: vcs0
[431.992072] Dynamic subtest vcs0: SUCCESS (1.593s)
[432.004211] Starting dynamic subtest: vcs1
[433.952622] Dynamic subtest vcs1: SUCCESS (1.957s)
[433.965686] Starting dynamic subtest: vecs0
[435.936443] Dynamic subtest vecs0: SUCCESS (1.981s)
[435.947868] Starting dynamic subtest: ccs0
[437.436264] Dynamic subtest ccs0: SUCCESS (1.498s)
[437.438632] Subtest userptr: SUCCESS (10.133s)
[437.649093] [086/131] (585s left) api_intel_allocator (reopen)
[437.709374] Starting subtest: reopen
[437.713701] Subtest reopen: SUCCESS (0.007s)
[437.878929] [087/131] (585s left) kms_color_pipeline (plane-lut1d-lut1d)
[437.974010] Starting subtest: plane-lut1d-lut1d
[437.989406] Starting dynamic subtest: pipe-A-eDP-1
[438.683516] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[439.396678] Starting dynamic subtest: pipe-B-eDP-1
[440.243345] Dynamic subtest pipe-B-eDP-1: FAIL (0.327s)
[440.818835] Starting dynamic subtest: pipe-C-eDP-1
[441.669527] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[442.141445] Starting dynamic subtest: pipe-D-eDP-1
[442.948842] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[442.951010] Subtest plane-lut1d-lut1d: FAIL (4.683s)
[443.543901] [088/131] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[443.641705] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[447.953319] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.314s)
[449.138830] [089/131] (574s left) kms_flip (flip-vs-absolute-wf_vblank)
[449.239248] Starting subtest: flip-vs-absolute-wf_vblank
[449.241554] Starting dynamic subtest: A-eDP1
[458.155611] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[458.166640] Starting dynamic subtest: B-eDP1
[467.081652] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[467.090726] Starting dynamic subtest: C-eDP1
[476.005963] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[476.017527] Starting dynamic subtest: D-eDP1
[484.942103] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[484.944187] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.697s)
[486.179725] [090/131] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[486.289093] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[486.293148] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[486.434314] [091/131] (536s left) i915_suspend (basic-s2idle-without-i915)
[486.471953] Starting subtest: basic-s2idle-without-i915
[507.266689] Subtest basic-s2idle-without-i915: SUCCESS (5.942s)
[507.410998] [092/131] (515s left) kms_pm_rpm (basic-rte)
[507.457885] Starting subtest: basic-rte
[510.458203] Subtest basic-rte: SUCCESS (2.926s)
[512.309220] [093/131] (511s left) i915_pm_freq_api (freq-reset)
[512.372706] Starting subtest: freq-reset
[512.375210] Starting dynamic subtest: gt0
[512.524778] Dynamic subtest gt0: SUCCESS (0.147s)
[512.533786] Starting dynamic subtest: gt1
[512.655880] Dynamic subtest gt1: SUCCESS (0.129s)
[512.658590] Subtest freq-reset: SUCCESS (0.279s)
[512.759941] [094/131] (510s left) i915_drm_fdinfo (all-busy-idle-check-all)
[512.808481] Starting subtest: all-busy-idle-check-all
[512.812882] Subtest all-busy-idle-check-all: SKIP (0.003s)
[512.910663] [095/131] (510s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[513.004555] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[513.087511] [096/131] (510s left) gen9_exec_parse (basic-rejected-ctx-param)
[513.156905] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[513.246326] [097/131] (510s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[513.331914] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[513.334406] Starting dynamic subtest: pipe-A
[513.364667] Dynamic subtest pipe-A: SKIP (0.029s)
[513.375001] Starting dynamic subtest: pipe-B
[513.402753] Dynamic subtest pipe-B: SKIP (0.036s)
[513.412018] Starting dynamic subtest: pipe-C
[513.444876] Dynamic subtest pipe-C: SKIP (0.039s)
[513.453682] Starting dynamic subtest: pipe-D
[513.477933] Dynamic subtest pipe-D: SKIP (0.035s)
[513.481712] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.142s)
[513.617254] [098/131] (509s left) gem_ctx_isolation (preservation)
[513.688260] Starting subtest: preservation
[513.690318] Starting dynamic subtest: rcs0
[513.840512] Dynamic subtest rcs0: SUCCESS (0.149s)
[513.851894] Starting dynamic subtest: bcs0
[514.010228] Dynamic subtest bcs0: SUCCESS (0.167s)
[514.021621] Starting dynamic subtest: vcs0
[514.180303] Dynamic subtest vcs0: SUCCESS (0.166s)
[514.194575] Starting dynamic subtest: vcs1
[515.914625] Dynamic subtest vcs1: SUCCESS (1.715s)
[515.927101] Starting dynamic subtest: vecs0
[517.905700] Dynamic subtest vecs0: SUCCESS (1.972s)
[517.918202] Starting dynamic subtest: ccs0
[519.961502] Dynamic subtest ccs0: SUCCESS (2.040s)
[519.964704] Subtest preservation: SUCCESS (6.214s)
[520.223992] [099/131] (503s left) kms_feature_discovery (display-2x)
[520.322039] Starting subtest: display-2x
[520.326719] Subtest display-2x: SKIP (0.000s)
[520.421854] [100/131] (503s left) perf_pmu (event-wait)
[520.466828] Starting subtest: event-wait
[520.469126] Starting dynamic subtest: rcs0
[520.473245] Dynamic subtest rcs0: SKIP (0.000s)
[520.477404] Subtest event-wait: SKIP (0.001s)
[520.597550] [101/131] (503s left) gem_ctx_engines (execute-oneforall)
[520.660198] Starting subtest: execute-oneforall
[521.149874] Subtest execute-oneforall: SUCCESS (0.487s)
[522.917820] [102/131] (500s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[523.029306] Starting subtest: y-tiled-64bpp-rotate-0
[523.033343] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[523.161001] [103/131] (500s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[523.243442] Subtest untiled-to-tiled: SKIP (0.000s)
[523.334010] [104/131] (500s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[523.728235] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[524.506134] [105/131] (499s left) gem_mmap (big-bo)
[524.579988] Subtest big-bo: SKIP (0.000s)
[524.659073] [106/131] (499s left) gem_exec_fence (syncobj-signal)
[525.091872] Starting subtest: syncobj-signal
[525.097875] Subtest syncobj-signal: SUCCESS (0.004s)
[526.896173] [107/131] (497s left) kms_cursor_edge_walk (128x128-left-edge)
[526.984977] Starting subtest: 128x128-left-edge
[526.987313] Starting dynamic subtest: pipe-A-eDP-1
[530.403498] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[530.413019] Starting dynamic subtest: pipe-D-eDP-1
[533.518602] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[533.520951] Subtest 128x128-left-edge: SUCCESS (6.523s)
[534.357698] [108/131] (489s left) syncobj_wait (single-wait-submitted)
[534.428411] Starting subtest: single-wait-submitted
[534.536871] Subtest single-wait-submitted: SUCCESS (0.107s)
[534.637766] [109/131] (489s left) kms_atomic (plane-invalid-params-fence)
[534.726960] Starting subtest: plane-invalid-params-fence
[534.729284] Starting dynamic subtest: pipe-A-eDP-1
[535.079149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[535.081585] Subtest plane-invalid-params-fence: SUCCESS (0.354s)
[535.995552] [110/131] (488s left) gem_exec_await (wide-contexts)
[536.177314] Starting subtest: wide-contexts
[559.665923] Subtest wide-contexts: SUCCESS (23.483s)
[559.880752] [111/131] (464s left) kms_prop_blob (invalid-get-prop)
[559.984141] Starting subtest: invalid-get-prop
[559.986544] Subtest invalid-get-prop: SUCCESS (0.000s)
[560.123812] [112/131] (464s left) kms_psr (psr2-primary-page-flip)
[560.231726] Starting subtest: psr2-primary-page-flip
[560.234044] Starting dynamic subtest: eDP-1
[561.965340] Dynamic subtest eDP-1: SUCCESS (1.731s)
[561.967586] Subtest psr2-primary-page-flip: SUCCESS (1.732s)
[562.860244] [113/131] (461s left) gem_userptr_blits (invalid-null-pointer)
[562.927712] Starting subtest: invalid-null-pointer
[562.930131] Subtest invalid-null-pointer: SUCCESS (0.001s)
[563.089948] [114/131] (461s left) syncobj_timeline (reset-multiple-signaled)
[563.152423] Starting subtest: reset-multiple-signaled
[563.154915] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[563.291070] [115/131] (461s left) gem_exec_async (forked-writes)
[563.353503] Starting subtest: forked-writes
[563.356006] Starting dynamic subtest: rcs0
[563.383818] Dynamic subtest rcs0: SUCCESS (0.030s)
[563.396881] Starting dynamic subtest: bcs0
[563.408483] Dynamic subtest bcs0: SUCCESS (0.024s)
[563.418795] Starting dynamic subtest: vcs0
[563.430545] Dynamic subtest vcs0: SUCCESS (0.021s)
[563.441052] Starting dynamic subtest: vcs1
[563.451890] Dynamic subtest vcs1: SUCCESS (0.020s)
[563.462496] Starting dynamic subtest: vecs0
[563.472257] Dynamic subtest vecs0: SUCCESS (0.020s)
[563.482789] Starting dynamic subtest: ccs0
[563.495888] Dynamic subtest ccs0: SUCCESS (0.022s)
[563.498193] Subtest forked-writes: SUCCESS (0.143s)
[563.806671] [116/131] (460s left) kms_plane_scaling (planes-downscale-factor-0-75)
[563.900543] Starting subtest: planes-downscale-factor-0-75
[563.902785] Starting dynamic subtest: pipe-A
[563.919506] Dynamic subtest pipe-A: SKIP (0.017s)
[563.929074] Starting dynamic subtest: pipe-B
[563.954401] Dynamic subtest pipe-B: SKIP (0.034s)
[563.963702] Starting dynamic subtest: pipe-C
[563.988772] Dynamic subtest pipe-C: SKIP (0.033s)
[563.997745] Starting dynamic subtest: pipe-D
[564.017715] Dynamic subtest pipe-D: SKIP (0.029s)
[564.021273] Subtest planes-downscale-factor-0-75: SKIP (0.115s)
[564.140364] [117/131] (460s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[564.213746] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[564.286294] [118/131] (460s left) dumb_buffer (map-uaf)
[564.350342] Starting subtest: map-uaf
[564.355397] Subtest map-uaf: SUCCESS (0.005s)
[564.491968] [119/131] (459s left) kms_fbcon_fbt (fbc-suspend)
[564.553805] Starting subtest: fbc-suspend
[614.239207] Subtest fbc-suspend: SUCCESS (19.323s)
[615.630039] [120/131] (408s left) perf (blocking)
[615.790163] Starting subtest: blocking
[615.792082] Starting dynamic subtest: 0-rcs0
[625.812943] Dynamic subtest 0-rcs0: SUCCESS (9.928s)
[625.823209] Starting dynamic subtest: 1-vcs0
[635.835768] Dynamic subtest 1-vcs0: SUCCESS (9.993s)
[635.838539] Subtest blocking: SUCCESS (19.924s)
[635.886169] [121/131] (388s left) kms_cursor_crc (cursor-onscreen-128x128)
[636.097975] Starting subtest: cursor-onscreen-128x128
[636.100187] Starting dynamic subtest: pipe-A-eDP-1
[638.210386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.106s)
[638.241891] Starting dynamic subtest: pipe-D-eDP-1
[640.941189] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.707s)
[640.943551] Subtest cursor-onscreen-128x128: SUCCESS (4.839s)
[641.769621] [122/131] (382s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[642.049807] Starting subtest: cursor-rapid-movement-512x170
[642.054268] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[642.237632] [123/131] (382s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[642.357031] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[643.304923] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[644.190407] [124/131] (380s left) gem_exec_schedule (preempt-self)
[644.278473] Starting subtest: preempt-self
[644.280591] Starting dynamic subtest: rcs0
[644.296641] Dynamic subtest rcs0: SUCCESS (0.024s)
[644.313730] Starting dynamic subtest: bcs0
[644.316131] Dynamic subtest bcs0: SUCCESS (0.016s)
[644.328181] Starting dynamic subtest: vcs0
[644.332754] Dynamic subtest vcs0: SUCCESS (0.019s)
[644.341949] Starting dynamic subtest: vcs1
[644.350548] Dynamic subtest vcs1: SUCCESS (0.017s)
[644.359465] Starting dynamic subtest: vecs0
[644.367261] Dynamic subtest vecs0: SUCCESS (0.016s)
[644.376325] Starting dynamic subtest: ccs0
[644.382900] Dynamic subtest ccs0: SUCCESS (0.015s)
[644.385124] Subtest preempt-self: SUCCESS (0.112s)
[645.902892] [125/131] (378s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[646.016470] Starting subtest: x-tiled-64bpp-rotate-180
[647.512238] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.495s)
[647.737777] [126/131] (377s left) kms_flip (2x-flip-vs-modeset)
[647.838353] Starting subtest: 2x-flip-vs-modeset
[647.849123] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[647.952062] [127/131] (376s left) perf_pmu (most-busy-check-all)
[647.993578] Starting subtest: most-busy-check-all
[647.995868] Starting dynamic subtest: rcs0
[649.827917] Dynamic subtest rcs0: SUCCESS (1.832s)
[649.840905] Starting dynamic subtest: bcs0
[651.810955] Dynamic subtest bcs0: SUCCESS (1.981s)
[651.823611] Starting dynamic subtest: vcs0
[653.857416] Dynamic subtest vcs0: SUCCESS (2.043s)
[653.871969] Starting dynamic subtest: vcs1
[655.842220] Dynamic subtest vcs1: SUCCESS (1.982s)
[655.855928] Starting dynamic subtest: vecs0
[657.826546] Dynamic subtest vecs0: SUCCESS (1.982s)
[657.838280] Starting dynamic subtest: ccs0
[659.810903] Dynamic subtest ccs0: SUCCESS (1.982s)
[659.813935] Subtest most-busy-check-all: SUCCESS (11.819s)
[659.938650] [128/131] (364s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[660.318205] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[661.169084] [129/131] (363s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[661.234246] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[661.238919] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[661.439312] [130/131] (363s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[661.544751] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[661.549132] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[661.681071] [131/131] (363s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[661.789519] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[668.587195] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.799s)
[668.754196] 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.