[61.845055] Initializing watchdogs
[61.845099]   /dev/watchdog0
[61.859363] [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]
[61.864028] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.866546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.870475] [001/132] (960s left) kms_plane_lowres (tiling-4)
[61.980645] Starting subtest: tiling-4
[61.982834] Starting dynamic subtest: pipe-A-eDP-1
[61.987247] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.285372] Starting dynamic subtest: pipe-B-eDP-1
[62.290531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.299206] Starting dynamic subtest: pipe-C-eDP-1
[62.303817] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.310855] Starting dynamic subtest: pipe-D-eDP-1
[62.315263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.319197] Subtest tiling-4: SKIP (0.305s)
[63.155233] [002/132] (959s left) kms_cursor_crc (cursor-random-256x85)
[63.432875] Starting subtest: cursor-random-256x85
[63.485236] Subtest cursor-random-256x85: SKIP (0.048s)
[63.664605] [003/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[63.763594] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[63.768205] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[63.838144] [004/132] (958s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[63.932427] Starting subtest: plane-ctm3x4-lut1d
[64.054351] Starting dynamic subtest: pipe-A-plane-0
[64.363503] Dynamic subtest pipe-A-plane-0: FAIL (0.169s)
[64.370441] Starting dynamic subtest: pipe-A-plane-1
[64.577251] Dynamic subtest pipe-A-plane-1: FAIL (0.172s)
[64.586694] Starting dynamic subtest: pipe-A-plane-2
[64.795456] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[65.749890] Starting dynamic subtest: pipe-B-plane-0
[66.204115] Dynamic subtest pipe-B-plane-0: FAIL (0.186s)
[66.213244] Starting dynamic subtest: pipe-B-plane-1
[66.528056] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[66.536628] Starting dynamic subtest: pipe-B-plane-2
[66.829435] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[67.469808] Starting dynamic subtest: pipe-C-plane-0
[67.998976] Dynamic subtest pipe-C-plane-0: FAIL (0.156s)
[68.007187] Starting dynamic subtest: pipe-C-plane-1
[68.384743] Dynamic subtest pipe-C-plane-1: FAIL (0.163s)
[68.392649] Starting dynamic subtest: pipe-C-plane-2
[68.775396] Dynamic subtest pipe-C-plane-2: FAIL (0.616s)
[69.612331] Starting dynamic subtest: pipe-D-plane-0
[70.228675] Dynamic subtest pipe-D-plane-0: FAIL (0.154s)
[70.237668] Starting dynamic subtest: pipe-D-plane-1
[70.681181] Dynamic subtest pipe-D-plane-1: FAIL (0.644s)
[70.688912] Starting dynamic subtest: pipe-D-plane-2
[71.109316] Dynamic subtest pipe-D-plane-2: FAIL (0.528s)
[71.239708] Subtest plane-ctm3x4-lut1d: FAIL (7.321s)
[72.068237] [005/132] (950s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[72.167612] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[72.857436] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.692s)
[73.031079] [006/132] (949s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[73.097283] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[73.099585] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[73.197625] [007/132] (949s left) gem_eio (execbuf)
[73.409677] Starting subtest: execbuf
[73.711656] Subtest execbuf: SUCCESS (0.304s)
[73.879163] [008/132] (948s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[73.987059] Starting subtest: yf-tiled-16bpp-rotate-90
[73.990517] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[74.072733] [009/132] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[74.181460] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[74.183259] Starting dynamic subtest: pipe-A-eDP-1
[74.294512] Dynamic subtest pipe-A-eDP-1: SKIP (0.115s)
[74.304790] Starting dynamic subtest: pipe-B-eDP-1
[75.454560] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[75.459307] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.277s)
[76.742512] [010/132] (945s left) kms_psr (psr-sprite-plane-onoff)
[76.836207] Starting subtest: psr-sprite-plane-onoff
[76.838644] Starting dynamic subtest: eDP-1
[78.591449] Dynamic subtest eDP-1: SUCCESS (1.756s)
[78.593734] Subtest psr-sprite-plane-onoff: SUCCESS (1.757s)
[79.403779] [011/132] (943s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[79.505656] Starting subtest: y-tiled-32bpp-rotate-90
[79.510194] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[79.621270] [012/132] (943s left) perf (rc6-disable)
[79.760245] Starting subtest: rc6-disable
[79.935683] Subtest rc6-disable: SUCCESS (0.175s)
[79.978917] [013/132] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[80.071699] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[80.076084] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[80.160043] [014/132] (942s left) i915_pm_rc6_residency (rc6-fence)
[80.214782] Starting subtest: rc6-fence
[80.227220] Starting dynamic subtest: gt0
[92.552218] Dynamic subtest gt0: SUCCESS (12.322s)
[92.563693] Starting dynamic subtest: gt1
[106.839514] Dynamic subtest gt1: SUCCESS (14.284s)
[106.842518] Subtest rc6-fence: SUCCESS (26.624s)
[106.922109] [015/132] (916s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[107.043342] Starting subtest: stress-xrgb8888-yftiled
[107.047868] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[107.113929] [016/132] (915s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[107.206758] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[107.209031] Starting dynamic subtest: pipe-A-eDP-1
[107.236763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.247069] Starting dynamic subtest: pipe-B-eDP-1
[107.267318] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.275051] Starting dynamic subtest: pipe-C-eDP-1
[107.295707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.305752] Starting dynamic subtest: pipe-D-eDP-1
[107.327950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.331980] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[109.459897] [017/132] (913s left) gem_ctx_sseu (mmap-args)
[109.519237] Subtest mmap-args: SKIP (0.000s)
[109.580601] [018/132] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[109.677556] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[109.681792] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[109.795655] [019/132] (913s left) gem_eio (throttle)
[109.995869] Starting subtest: throttle
[110.300574] Subtest throttle: SUCCESS (0.304s)
[110.465305] [020/132] (912s left) kms_prop_blob (blob-multiple)
[110.523925] Starting subtest: blob-multiple
[110.525807] Subtest blob-multiple: SUCCESS (0.002s)
[110.620515] [021/132] (912s left) kms_plane (pixel-format-linear-modifier)
[110.702185] Starting subtest: pixel-format-linear-modifier
[110.728910] Starting dynamic subtest: pipe-A-plane-0
[114.339871] Dynamic subtest pipe-A-plane-0: SUCCESS (3.611s)
[114.348496] Starting dynamic subtest: pipe-A-plane-3
[116.085280] Dynamic subtest pipe-A-plane-3: SUCCESS (1.743s)
[116.092867] Starting dynamic subtest: pipe-A-plane-5
[116.306977] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[117.454833] Starting dynamic subtest: pipe-B-plane-0
[121.169913] Dynamic subtest pipe-B-plane-0: SUCCESS (3.722s)
[121.180191] Starting dynamic subtest: pipe-B-plane-3
[122.948065] Dynamic subtest pipe-B-plane-3: SUCCESS (1.777s)
[122.956454] Starting dynamic subtest: pipe-B-plane-5
[123.158696] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[123.468372] Subtest pixel-format-linear-modifier: SUCCESS (12.766s)
[124.330526] [022/132] (898s left) kms_big_fb (linear-16bpp-rotate-0)
[124.425574] Starting subtest: linear-16bpp-rotate-0
[125.792806] Subtest linear-16bpp-rotate-0: SUCCESS (1.367s)
[125.913416] [023/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[126.021094] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[126.024893] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[126.100462] [024/132] (897s left) gem_ctx_bad_destroy (invalid-ctx)
[126.146373] Starting subtest: invalid-ctx
[126.148297] Subtest invalid-ctx: SUCCESS (0.000s)
[126.214813] [025/132] (897s left) gem_compute (compute-square)
[126.274243] Starting subtest: compute-square
[126.279767] Subtest compute-square: SUCCESS (0.007s)
[126.393458] [026/132] (896s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[126.492941] Starting subtest: psr-rgb565-draw-render
[133.533553] Subtest psr-rgb565-draw-render: SUCCESS (7.044s)
[133.651565] [027/132] (889s left) gem_exec_params (rel-constants-invalid-ring)
[133.713210] Starting subtest: rel-constants-invalid-ring
[133.715113] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[133.805966] [028/132] (889s left) syncobj_timeline (invalid-signal-bad-pad)
[133.859763] Starting subtest: invalid-signal-bad-pad
[133.861947] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[133.956536] [029/132] (889s left) gem_exec_reloc (basic-wc-noreloc)
[134.011252] Subtest basic-wc-noreloc: SKIP (0.000s)
[134.076935] [030/132] (889s left) gem_userptr_blits (access-control)
[134.149083] Starting subtest: access-control
[134.153155] Subtest access-control: SKIP (0.000s)
[134.263806] [031/132] (889s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[134.383132] Starting subtest: cursorA-vs-flipB-atomic
[134.387470] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[134.523761] [032/132] (889s left) gem_ctx_freq (sysfs)
[134.584301] Starting subtest: sysfs
[134.586312] Starting dynamic subtest: gt0
[140.088306] Dynamic subtest gt0: SUCCESS (5.503s)
[140.098329] Starting dynamic subtest: gt1
[181.910245] Dynamic subtest gt1: SUCCESS (41.817s)
[181.912879] Subtest sysfs: SUCCESS (47.322s)
[182.012640] [033/132] (841s left) syncobj_wait (wait-all-complex)
[182.072946] Starting subtest: wait-all-complex
[182.288026] Subtest wait-all-complex: SUCCESS (0.214s)
[182.360440] [034/132] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[182.470574] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[182.474844] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[182.586936] [035/132] (841s left) gem_softpin (full)
[182.643411] Starting subtest: full
[182.653466] Subtest full: SUCCESS (0.010s)
[182.772481] [036/132] (840s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[182.890780] Starting subtest: cursor-vs-flip-legacy
[212.230064] Subtest cursor-vs-flip-legacy: SUCCESS (29.336s)
[213.070625] [037/132] (810s left) kms_psr (fbc-pr-cursor-plane-move)
[213.167089] Starting subtest: fbc-pr-cursor-plane-move
[213.171463] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[213.255333] [038/132] (810s left) gem_exec_schedule (semaphore-resolve)
[213.336046] Starting subtest: semaphore-resolve
[213.368931] Subtest semaphore-resolve: SUCCESS (0.041s)
[213.704495] [039/132] (810s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[213.801076] Starting subtest: fbc-modesetfrombusy
[217.543191] Subtest fbc-modesetfrombusy: SUCCESS (3.747s)
[218.700304] [040/132] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[218.808271] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[226.180722] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.376s)
[226.303297] [041/132] (797s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[226.365139] Starting subtest: x-tiled-to-vebox-yf-tiled
[226.369329] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[226.544318] [042/132] (797s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[226.608218] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[226.610123] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[226.708894] [043/132] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[226.815681] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[233.925013] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.112s)
[234.065206] [044/132] (790s left) gem_ringfill (basic-all)
[239.898724] Starting subtest: basic-all
[241.057405] Subtest basic-all: SUCCESS (1.157s)
[241.176025] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[241.179902] [045/132] (782s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[241.240415] Starting subtest: multi-wait-all-for-submit-signaled
[241.243238] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[241.328060] [046/132] (782s left) kms_content_protection (atomic-dpms-hdcp14)
[241.469341] Starting subtest: atomic-dpms-hdcp14
[241.473762] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[241.570923] [047/132] (782s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[241.639841] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[241.765929] [048/132] (782s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[241.862305] Starting subtest: yf-tiled-64bpp-rotate-90
[241.866416] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[241.961952] [049/132] (782s left) kms_cursor_crc (cursor-suspend)
[242.103590] Starting subtest: cursor-suspend
[242.105567] Starting dynamic subtest: pipe-A-eDP-1
[276.600988] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.095s)
[276.610735] Starting dynamic subtest: pipe-D-eDP-1
[311.593381] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.547s)
[311.595647] Subtest cursor-suspend: SUCCESS (8.645s)
[317.446403] [050/132] (711s left) gem_pwrite (basic-self)
[317.525877] Subtest basic-self: SKIP (0.000s)
[317.604664] [051/132] (711s left) kms_pm_backlight (basic-brightness)
[317.710664] Starting subtest: basic-brightness
[317.763465] Starting dynamic subtest: eDP-1
[318.079666] Dynamic subtest eDP-1: SUCCESS (0.319s)
[318.082122] Subtest basic-brightness: SUCCESS (0.371s)
[318.951748] [052/132] (710s left) i915_drm_fdinfo (virtual-busy)
[318.995602] Starting subtest: virtual-busy
[318.999821] Subtest virtual-busy: SKIP (0.000s)
[319.071845] [053/132] (710s left) kms_vrr (negative-basic)
[319.177008] Starting subtest: negative-basic
[319.183921] Starting dynamic subtest: pipe-A-eDP-1
[324.609454] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.497s)
[324.890801] Subtest negative-basic: SUCCESS (5.806s)
[325.692329] [054/132] (703s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[325.791145] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[329.712616] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.954s)
[330.847979] [055/132] (698s left) kms_psr (fbc-psr-primary-page-flip)
[330.935041] Starting subtest: fbc-psr-primary-page-flip
[330.937318] Starting dynamic subtest: eDP-1
[330.941533] Dynamic subtest eDP-1: SKIP (0.000s)
[330.945770] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[331.008191] [056/132] (698s left) kms_getfb (getfb-reject-nv12)
[331.092029] Starting subtest: getfb-reject-nv12
[331.094310] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[331.213476] [057/132] (698s left) gem_partial_pwrite_pread (reads-snoop)
[331.268880] Subtest reads-snoop: SKIP (0.000s)
[331.337242] [058/132] (698s left) gem_mmap_gtt (medium-copy-xy)
[331.391295] Subtest medium-copy-XY: SKIP (0.000s)
[331.446990] [059/132] (698s left) kms_pm_dc (dc5-dpms)
[332.557655] Starting subtest: dc5-dpms
[334.602402] Subtest dc5-dpms: SUCCESS (2.054s)
[334.680895] [060/132] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[334.777648] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[338.322335] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.559s)
[339.456869] [061/132] (690s left) gem_exec_schedule (fairslice)
[339.531839] Starting subtest: fairslice
[339.534312] Starting dynamic subtest: rcs0
[341.548403] Dynamic subtest rcs0: SUCCESS (2.025s)
[341.560199] Starting dynamic subtest: bcs0
[343.568988] Dynamic subtest bcs0: SUCCESS (2.022s)
[343.579645] Starting dynamic subtest: vcs0
[345.591222] Dynamic subtest vcs0: SUCCESS (2.020s)
[345.606269] Starting dynamic subtest: vcs1
[347.609281] Dynamic subtest vcs1: SUCCESS (2.020s)
[347.619414] Starting dynamic subtest: vecs0
[349.625911] Dynamic subtest vecs0: SUCCESS (2.017s)
[349.636229] Starting dynamic subtest: ccs0
[351.646813] Dynamic subtest ccs0: SUCCESS (2.020s)
[351.649004] Subtest fairslice: SUCCESS (12.132s)
[351.945098] [062/132] (677s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[352.037696] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[352.039904] Starting dynamic subtest: pipe-A-eDP-1
[352.062217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.077474] Starting dynamic subtest: pipe-B-eDP-1
[352.098801] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.108352] Starting dynamic subtest: pipe-C-eDP-1
[352.130469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.140941] Starting dynamic subtest: pipe-D-eDP-1
[352.163271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.167361] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[354.205405] [063/132] (675s left) kms_cursor_legacy (forked-move)
[354.315885] Starting subtest: forked-move
[354.318185] Starting dynamic subtest: pipe-A
[359.786123] Dynamic subtest pipe-A: SUCCESS (5.466s)
[359.796894] Starting dynamic subtest: pipe-B
[365.275160] Dynamic subtest pipe-B: SUCCESS (5.486s)
[365.297365] Starting dynamic subtest: pipe-C
[370.749965] Dynamic subtest pipe-C: SUCCESS (5.474s)
[370.761577] Starting dynamic subtest: pipe-D
[376.217537] Dynamic subtest pipe-D: SUCCESS (5.467s)
[376.229576] Starting dynamic subtest: all-pipes
[381.722548] Dynamic subtest all-pipes: SUCCESS (5.504s)
[381.725265] Subtest forked-move: SUCCESS (27.409s)
[381.873776] [064/132] (648s left) gem_exec_schedule (preemptive-hang)
[382.073044] Starting subtest: preemptive-hang
[382.075890] Starting dynamic subtest: rcs0
[390.895921] Dynamic subtest rcs0: SUCCESS (8.825s)
[390.906253] Starting dynamic subtest: bcs0
[399.911688] Dynamic subtest bcs0: SUCCESS (9.019s)
[399.922406] Starting dynamic subtest: vcs0
[408.875614] Dynamic subtest vcs0: SUCCESS (8.963s)
[408.887564] Starting dynamic subtest: vcs1
[417.898002] Dynamic subtest vcs1: SUCCESS (9.021s)
[417.910751] Starting dynamic subtest: vecs0
[426.854485] Dynamic subtest vecs0: SUCCESS (8.951s)
[426.865782] Starting dynamic subtest: ccs0
[435.947361] Dynamic subtest ccs0: SUCCESS (9.091s)
[435.949784] Subtest preemptive-hang: SUCCESS (53.879s)
[436.201877] [065/132] (593s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[436.262443] Starting subtest: multi-wait-for-submit-available-signaled
[436.264848] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[436.352188] [066/132] (593s left) kms_chamelium_frames (dp-crc-single)
[436.755363] Subtest dp-crc-single: SKIP (0.000s)
[437.598236] [067/132] (592s left) prime_vgem (shrink)
[437.681943] Starting subtest: shrink
[437.698961] Subtest shrink: SUCCESS (0.015s)
[437.816327] [068/132] (592s left) kms_atomic_interruptible (universal-setplane-cursor)
[437.914784] Starting subtest: universal-setplane-cursor
[437.916971] Starting dynamic subtest: pipe-A-eDP-1
[445.340983] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.426s)
[445.343406] Subtest universal-setplane-cursor: SUCCESS (7.427s)
[446.196354] [069/132] (583s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[446.247046] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[446.294448] [070/132] (583s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[446.676394] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[447.501170] [071/132] (582s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[447.596534] Starting subtest: fbcpsr-tiling-4
[454.734624] Subtest fbcpsr-tiling-4: SUCCESS (7.140s)
[454.837201] [072/132] (575s left) kms_flip (basic-plain-flip)
[454.936350] Starting subtest: basic-plain-flip
[454.938303] Starting dynamic subtest: A-eDP1
[456.654589] Dynamic subtest A-eDP1: SUCCESS (1.720s)
[456.674097] Starting dynamic subtest: B-eDP1
[458.301999] Dynamic subtest B-eDP1: SUCCESS (1.644s)
[458.318067] Starting dynamic subtest: C-eDP1
[460.029518] Dynamic subtest C-eDP1: SUCCESS (1.725s)
[460.050563] Starting dynamic subtest: D-eDP1
[461.754545] Dynamic subtest D-eDP1: SUCCESS (1.722s)
[461.760784] Subtest basic-plain-flip: SUCCESS (6.828s)
[462.913611] [073/132] (567s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[463.027465] Starting subtest: psr-1p-primscrn-spr-indfb-move
[470.587983] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.564s)
[470.715592] [074/132] (559s left) gem_eio (wait-immediate)
[470.927760] Starting subtest: wait-immediate
[471.245048] Subtest wait-immediate: SUCCESS (0.318s)
[471.390042] [075/132] (559s left) kms_cdclk (plane-scaling)
[471.472992] Starting subtest: plane-scaling
[471.475255] Starting dynamic subtest: pipe-A-eDP-1
[471.764282] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[471.774607] Starting dynamic subtest: pipe-B-eDP-1
[471.779291] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[471.788633] Starting dynamic subtest: pipe-C-eDP-1
[471.793371] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[471.802483] Starting dynamic subtest: pipe-D-eDP-1
[471.806950] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[471.811352] Subtest plane-scaling: SKIP (0.297s)
[472.565309] [076/132] (557s left) syncobj_timeline (single-wait-all-available-signaled)
[472.626853] Starting subtest: single-wait-all-available-signaled
[472.629135] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[472.739074] [077/132] (557s left) kms_cursor_crc (cursor-offscreen-128x42)
[472.977655] Starting subtest: cursor-offscreen-128x42
[473.028835] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[473.220147] [078/132] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[473.275003] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[473.380995] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[473.460875] [079/132] (557s left) kms_invalid_mode (zero-vdisplay)
[473.547894] Starting subtest: zero-vdisplay
[473.550108] Starting dynamic subtest: pipe-A-eDP-1
[473.830407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[473.840625] Starting dynamic subtest: pipe-B-eDP-1
[473.842827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[473.851770] Starting dynamic subtest: pipe-C-eDP-1
[473.854009] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[473.864507] Starting dynamic subtest: pipe-D-eDP-1
[473.866793] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[473.869127] Subtest zero-vdisplay: SUCCESS (0.291s)
[474.696436] [080/132] (555s left) kms_atomic_transition (modeset-transition-nonblocking)
[474.799760] Starting subtest: modeset-transition-nonblocking
[474.801593] Starting dynamic subtest: 1x-outputs
[485.651415] Dynamic subtest 1x-outputs: SUCCESS (10.855s)
[485.653985] Subtest modeset-transition-nonblocking: SUCCESS (10.857s)
[486.507467] [081/132] (544s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[486.629308] Starting subtest: cursor-vs-flip-toggle
[517.519706] Subtest cursor-vs-flip-toggle: SUCCESS (30.896s)
[518.337167] [082/132] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[518.448305] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[518.452358] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[518.557905] [083/132] (512s left) kms_feature_discovery (dp-mst)
[518.655060] Starting subtest: dp-mst
[518.659374] Subtest dp-mst: SKIP (0.000s)
[518.742623] [084/132] (512s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[518.844619] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[518.855537] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[518.984468] [085/132] (511s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[519.078899] Starting subtest: fbc-pr-sprite-mmap-cpu
[519.082938] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[519.165564] [086/132] (511s left) kms_plane (planar-pixel-format-settings)
[519.257985] Starting subtest: planar-pixel-format-settings
[519.321289] Subtest planar-pixel-format-settings: SUCCESS (0.064s)
[519.430590] [087/132] (511s left) kms_flip (flip-vs-absolute-wf_vblank)
[519.517808] Starting subtest: flip-vs-absolute-wf_vblank
[519.519827] Starting dynamic subtest: A-eDP1
[528.481405] Dynamic subtest A-eDP1: SUCCESS (8.966s)
[528.490643] Starting dynamic subtest: B-eDP1
[537.413506] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[537.422411] Starting dynamic subtest: C-eDP1
[546.336792] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[546.347826] Starting dynamic subtest: D-eDP1
[555.277405] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[555.282546] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.765s)
[556.511196] [088/132] (474s left) kms_psr (pr-cursor-mmap-gtt)
[556.595883] Starting subtest: pr-cursor-mmap-gtt
[556.599937] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[556.670088] [089/132] (474s left) sysfs_timeslice_duration (duration)
[556.738364] Starting subtest: duration
[556.740793] Starting dynamic subtest: vecs0
[570.653802] Dynamic subtest vecs0: SUCCESS (13.909s)
[570.666624] Starting dynamic subtest: ccs0
[583.798974] Dynamic subtest ccs0: SUCCESS (13.141s)
[583.810956] Starting dynamic subtest: vcs0
[598.686228] Dynamic subtest vcs0: SUCCESS (14.881s)
[598.698005] Starting dynamic subtest: bcs0
[611.832781] Dynamic subtest bcs0: SUCCESS (13.144s)
[611.845793] Starting dynamic subtest: rcs0
[624.973810] Dynamic subtest rcs0: SUCCESS (13.139s)
[624.986026] Starting dynamic subtest: vcs1
[639.710796] Dynamic subtest vcs1: SUCCESS (14.733s)
[639.713430] Subtest duration: SUCCESS (82.965s)
[639.802767] [090/132] (391s left) gem_exec_capture (pi)
[639.886874] Starting subtest: pi
[639.889146] Starting dynamic subtest: rcs0
[644.305774] Dynamic subtest rcs0: SUCCESS (4.421s)
[644.320759] Starting dynamic subtest: bcs0
[648.204923] Dynamic subtest bcs0: SUCCESS (3.897s)
[648.216963] Starting dynamic subtest: vcs0
[652.124974] Dynamic subtest vcs0: SUCCESS (3.918s)
[652.136061] Starting dynamic subtest: vcs1
[656.093568] Dynamic subtest vcs1: SUCCESS (3.967s)
[656.105829] Starting dynamic subtest: vecs0
[660.058555] Dynamic subtest vecs0: SUCCESS (3.964s)
[660.071411] Starting dynamic subtest: ccs0
[663.995800] Dynamic subtest ccs0: SUCCESS (3.936s)
[663.998704] Subtest pi: SUCCESS (24.115s)
[664.077218] [091/132] (367s left) gem_mmap_gtt (basic-read)
[664.190225] Subtest basic-read: SKIP (0.000s)
[664.251207] [092/132] (366s left) gem_exec_balancer (bonded-semaphore)
[664.321033] Starting subtest: bonded-semaphore
[664.325406] Subtest bonded-semaphore: SKIP (0.000s)
[664.627435] [093/132] (366s left) perf (invalid-oa-metric-set-id)
[664.757341] Starting subtest: invalid-oa-metric-set-id
[664.767290] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[664.807795] [094/132] (366s left) kms_pwrite_crc
[666.478310] [095/132] (364s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[666.583640] Starting subtest: psr-rgb565-draw-blt
[674.051112] Subtest psr-rgb565-draw-blt: SUCCESS (7.470s)
[674.188801] [096/132] (357s left) gem_exec_fence (syncobj-import)
[674.641843] Starting subtest: syncobj-import
[674.647579] Subtest syncobj-import: SUCCESS (0.004s)
[675.792542] [097/132] (355s left) gem_mmap_offset (basic-uaf)
[675.860223] Starting subtest: basic-uaf
[675.862530] Subtest basic-uaf: SUCCESS (0.001s)
[675.968456] [098/132] (355s left) syncobj_wait (wait-any-snapshot)
[676.027789] Starting subtest: wait-any-snapshot
[676.111447] Subtest wait-any-snapshot: SUCCESS (0.083s)
[676.189890] [099/132] (355s left) vgem_basic (dmabuf-mmap)
[676.240217] Starting subtest: dmabuf-mmap
[676.246910] Subtest dmabuf-mmap: SUCCESS (0.008s)
[676.298855] [100/132] (355s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[676.415271] Starting subtest: cursorB-vs-flipB-toggle
[676.419909] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[676.563721] [101/132] (355s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[676.657351] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[676.669542] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[676.744025] [102/132] (354s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[676.829305] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[676.831124] Starting dynamic subtest: pipe-A-eDP-1
[676.849484] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[676.864715] Starting dynamic subtest: pipe-B-eDP-1
[676.881555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[676.890835] Starting dynamic subtest: pipe-C-eDP-1
[676.908203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[676.917960] Starting dynamic subtest: pipe-D-eDP-1
[676.935232] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[676.938506] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[679.143222] [103/132] (352s left) kms_flip (2x-absolute-wf_vblank)
[679.233071] Starting subtest: 2x-absolute-wf_vblank
[679.244783] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[679.321346] [104/132] (352s left) i915_hangman (engine-engine-error)
[679.375663] Starting subtest: engine-engine-error
[679.377531] Starting dynamic subtest: rcs0
[680.735201] Dynamic subtest rcs0: SUCCESS (1.359s)
[680.748644] Starting dynamic subtest: bcs0
[682.719214] Dynamic subtest bcs0: SUCCESS (1.981s)
[682.731778] Starting dynamic subtest: vcs0
[684.701568] Dynamic subtest vcs0: SUCCESS (1.981s)
[684.713890] Starting dynamic subtest: vcs1
[686.750762] Dynamic subtest vcs1: SUCCESS (2.046s)
[686.763782] Starting dynamic subtest: vecs0
[688.733704] Dynamic subtest vecs0: SUCCESS (1.981s)
[688.746943] Starting dynamic subtest: ccs0
[690.718930] Dynamic subtest ccs0: SUCCESS (1.982s)
[690.721685] Subtest engine-engine-error: SUCCESS (11.346s)
[690.815625] [105/132] (340s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[690.910836] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[691.296355] Starting dynamic subtest: pipe-A-eDP-1
[694.018866] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.723s)
[694.385204] Starting dynamic subtest: pipe-B-eDP-1
[697.142597] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[697.502498] Starting dynamic subtest: pipe-C-eDP-1
[700.273777] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s)
[700.644576] Starting dynamic subtest: pipe-D-eDP-1
[703.409391] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[703.411993] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.502s)
[704.602937] [106/132] (327s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[704.701363] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[704.705424] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[704.803349] [107/132] (327s left) sw_sync (sync_merge)
[704.839472] Starting subtest: sync_merge
[704.841310] Subtest sync_merge: SUCCESS (0.000s)
[704.915674] [108/132] (326s left) gem_ctx_persistence (heartbeat-many)
[704.980304] Starting subtest: heartbeat-many
[704.984242] Subtest heartbeat-many: SKIP (0.000s)
[705.089510] [109/132] (326s left) api_intel_allocator (simple-allocator)
[705.164200] Starting subtest: simple-allocator
[705.166104] Starting dynamic subtest: basic
[705.168430] Dynamic subtest basic: SUCCESS (0.004s)
[705.179420] Starting dynamic subtest: parallel-one
[705.365800] Dynamic subtest parallel-one: SUCCESS (0.197s)
[705.375539] Starting dynamic subtest: print
[705.377419] Dynamic subtest print: SUCCESS (0.000s)
[705.386922] Starting dynamic subtest: reuse
[705.389062] Dynamic subtest reuse: SUCCESS (0.000s)
[705.398080] Starting dynamic subtest: reserve
[705.400274] Dynamic subtest reserve: SUCCESS (0.000s)
[705.409806] Starting dynamic subtest: fork-reopen-allocator
[705.411951] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[705.414137] Subtest simple-allocator: SUCCESS (0.221s)
[705.548787] [110/132] (326s left) gem_lmem_swapping (verify)
[705.606131] Subtest verify: SKIP (0.000s)
[705.655558] [111/132] (326s left) perf (invalid-oa-format-id)
[705.742279] Starting subtest: invalid-oa-format-id
[705.751922] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[705.801167] [112/132] (326s left) api_intel_bb (lot-of-buffers)
[705.849551] Starting subtest: lot-of-buffers
[706.893929] Subtest lot-of-buffers: SUCCESS (1.045s)
[707.217505] [113/132] (324s left) gem_busy (semaphore)
[707.411800] Subtest semaphore: SKIP (0.000s)
[707.640051] [114/132] (324s left) kms_vblank (ts-continuation-dpms-suspend)
[707.742636] Starting subtest: ts-continuation-dpms-suspend
[707.744769] Starting dynamic subtest: pipe-A-eDP-1
[725.696139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.279s)
[725.711453] Starting dynamic subtest: pipe-D-eDP-1
[743.677600] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[743.680143] Subtest ts-continuation-dpms-suspend: SUCCESS (5.151s)
[749.487180] [115/132] (287s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[749.550610] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[749.553706] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[749.663511] [116/132] (287s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[749.770481] Starting subtest: fbc-rgb101010-draw-blt
[754.431620] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.639s)
[755.612400] [117/132] (281s left) dmabuf_sync_file (import-multiple-read-write)
[755.656547] Starting subtest: import-multiple-read-write
[755.659017] Subtest import-multiple-read-write: SUCCESS (0.003s)
[755.717225] [118/132] (281s left) gem_exec_store (dword)
[755.776365] Starting subtest: dword
[755.778693] Starting dynamic subtest: rcs0
[755.840291] Dynamic subtest rcs0: SUCCESS (0.069s)
[755.853844] Starting dynamic subtest: bcs0
[755.882975] Dynamic subtest bcs0: SUCCESS (0.041s)
[755.894517] Starting dynamic subtest: vcs0
[755.926600] Dynamic subtest vcs0: SUCCESS (0.041s)
[755.938363] Starting dynamic subtest: vcs1
[755.969562] Dynamic subtest vcs1: SUCCESS (0.041s)
[755.981300] Starting dynamic subtest: vecs0
[756.012253] Dynamic subtest vecs0: SUCCESS (0.040s)
[756.023728] Starting dynamic subtest: ccs0
[756.055884] Dynamic subtest ccs0: SUCCESS (0.041s)
[756.058692] Subtest dword: SUCCESS (0.285s)
[756.258540] [119/132] (281s left) gem_sync (basic-all)
[756.335966] Starting subtest: basic-all
[758.527868] Subtest basic-all: SUCCESS (2.197s)
[758.715543] [120/132] (278s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[758.811521] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[758.816405] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[758.907059] [121/132] (278s left) i915_suspend (debugfs-reader)
[758.957243] Starting subtest: debugfs-reader
[777.142745] Subtest debugfs-reader: SUCCESS (3.599s)
[782.369575] [122/132] (260s left) kms_busy (extended-modeset-hang-newfb)
[782.482610] Starting subtest: extended-modeset-hang-newfb
[782.484895] Starting dynamic subtest: pipe-A
[817.988243] Dynamic subtest pipe-A: SUCCESS (35.449s)
[817.999041] Starting dynamic subtest: pipe-D
[841.071981] Dynamic subtest pipe-D: SUCCESS (23.075s)
[841.074690] Subtest extended-modeset-hang-newfb: SUCCESS (58.528s)
[841.871365] [123/132] (200s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[841.980299] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[841.982517] Starting dynamic subtest: pipe-A-eDP-1
[852.678425] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.699s)
[852.688891] Starting dynamic subtest: pipe-B-eDP-1
[864.101230] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.417s)
[864.103580] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.119s)
[864.942090] [124/132] (177s left) kms_psr (psr-cursor-mmap-cpu)
[865.035607] Starting subtest: psr-cursor-mmap-cpu
[865.037937] Starting dynamic subtest: eDP-1
[866.745945] Dynamic subtest eDP-1: SUCCESS (1.709s)
[866.748071] Subtest psr-cursor-mmap-cpu: SUCCESS (1.710s)
[867.612680] [125/132] (175s left) gen9_exec_parse (allowed-all)
[867.674001] Subtest allowed-all: SKIP (0.000s)
[867.753340] [126/132] (175s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[867.845415] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[867.849349] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[867.944299] [127/132] (174s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[868.035322] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[868.037590] Starting dynamic subtest: pipe-A-eDP-1
[868.059680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[868.071909] Starting dynamic subtest: pipe-B-eDP-1
[868.092551] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[868.101919] Starting dynamic subtest: pipe-C-eDP-1
[868.122878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[868.132380] Starting dynamic subtest: pipe-D-eDP-1
[868.154673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[868.159166] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[870.268295] [128/132] (172s left) perf_pmu (busy-no-semaphores)
[870.325813] Starting subtest: busy-no-semaphores
[870.327705] Starting dynamic subtest: rcs0
[870.879643] Dynamic subtest rcs0: SUCCESS (0.553s)
[870.892457] Starting dynamic subtest: bcs0
[871.428325] Dynamic subtest bcs0: SUCCESS (0.545s)
[871.439741] Starting dynamic subtest: vcs0
[871.977534] Dynamic subtest vcs0: SUCCESS (0.546s)
[871.988493] Starting dynamic subtest: vcs1
[873.656888] Dynamic subtest vcs1: SUCCESS (1.674s)
[873.672996] Starting dynamic subtest: vecs0
[875.639963] Dynamic subtest vecs0: SUCCESS (1.979s)
[875.652448] Starting dynamic subtest: ccs0
[877.624237] Dynamic subtest ccs0: SUCCESS (1.981s)
[877.626989] Subtest busy-no-semaphores: SUCCESS (7.297s)
[877.742009] [129/132] (165s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[877.861068] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[877.863370] Starting dynamic subtest: pipe-A-default-mode
[879.029978] Dynamic subtest pipe-A-default-mode: SKIP (1.167s)
[879.033598] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.169s)
[879.188438] [130/132] (163s left) kms_lease (lessee-list)
[879.279165] Starting subtest: lessee-list
[879.281406] Starting dynamic subtest: pipe-A-eDP-1
[879.283727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[879.294092] Starting dynamic subtest: pipe-B-eDP-1
[879.295910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[879.305158] Starting dynamic subtest: pipe-C-eDP-1
[879.307009] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[879.316175] Starting dynamic subtest: pipe-D-eDP-1
[879.318095] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[879.320057] Subtest lessee-list: SUCCESS (0.009s)
[879.418299] [131/132] (163s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[879.532274] Starting subtest: x-tiled-32bpp-rotate-270
[879.552708] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[879.655981] [132/132] (163s left) kms_selftest (drm_format)
[879.697916] Starting subtest: drm_format
[879.721212] Starting dynamic subtest: drm_test_format_block_width_invalid
[879.808468] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.087s)
[879.820401] Starting dynamic subtest: drm_test_format_block_width_one_plane
[879.913064] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.105s)
[879.923663] Starting dynamic subtest: drm_test_format_block_width_two_plane
[880.006739] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.094s)
[880.017403] Starting dynamic subtest: drm_test_format_block_width_three_plane
[880.110693] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.102s)
[880.120281] Starting dynamic subtest: drm_test_format_block_width_tiled
[880.213675] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.102s)
[880.223651] Starting dynamic subtest: drm_test_format_block_height_invalid
[880.306759] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.092s)
[880.317753] Starting dynamic subtest: drm_test_format_block_height_one_plane
[880.396525] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.088s)
[880.406326] Starting dynamic subtest: drm_test_format_block_height_two_plane
[880.485646] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.089s)
[880.494757] Starting dynamic subtest: drm_test_format_block_height_three_plane
[880.569715] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.083s)
[880.587423] Starting dynamic subtest: drm_test_format_block_height_tiled
[880.657116] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.085s)
[880.668373] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[880.751927] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.093s)
[880.762838] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[880.834030] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.081s)
[880.845798] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[880.930816] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.096s)
[880.941797] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[881.018806] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.088s)
[881.029510] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[881.109780] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.090s)
[881.120249] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[881.195687] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.086s)
[881.206261] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[881.312064] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.113s)
[881.323145] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[881.409513] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.097s)
[881.411503] Subtest drm_format: SUCCESS (1.711s)
[881.554615] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_lowres
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_pm_rc6_residency
results: parsing output: 14/ for test: kms_pipe_stress
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_ctx_sseu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_prop_blob
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_bad_destroy
results: parsing output: 24/ for test: gem_compute
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: gem_ctx_freq
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ringfill
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_pwrite
results: parsing output: 50/ for test: kms_pm_backlight
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: kms_vrr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: gem_partial_pwrite_pread
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_pm_dc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_chamelium_frames
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_atomic_interruptible
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cdclk
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_atomic_transition
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: sysfs_timeslice_duration
results: parsing output: 89/ for test: gem_exec_capture
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_pwrite_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_hangman
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: gem_busy
results: parsing output: 113/ for test: kms_vblank
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: dmabuf_sync_file
results: parsing output: 117/ for test: gem_exec_store
results: parsing output: 118/ for test: gem_sync
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_suspend
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_selftest
Done.