[57.182533] Initializing watchdogs
[57.182578]   /dev/watchdog0
[57.200499] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.205261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.208097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.211602] [001/132] (960s left) kms_addfb_basic (unused-pitches)
[57.287503] Starting subtest: unused-pitches
[57.290702] Subtest unused-pitches: SUCCESS (0.000s)
[57.429791] [002/132] (960s left) kms_psr (fbc-pr-cursor-plane-onoff)
[57.534759] Starting subtest: fbc-pr-cursor-plane-onoff
[57.538694] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[57.621238] [003/132] (960s left) kms_fbcon_fbt (fbc-suspend)
[57.668926] Starting subtest: fbc-suspend
[107.599030] Subtest fbc-suspend: SUCCESS (19.217s)
[108.923211] [004/132] (908s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[109.018511] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[109.020849] Starting dynamic subtest: pipe-A-eDP-1
[109.079923] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[109.089569] Starting dynamic subtest: pipe-B-eDP-1
[109.147161] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[109.156753] Starting dynamic subtest: pipe-C-eDP-1
[109.214943] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[109.223998] Starting dynamic subtest: pipe-D-eDP-1
[109.282548] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[109.286582] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[111.302147] [005/132] (906s left) syncobj_timeline (multi-wait-signaled)
[111.356444] Starting subtest: multi-wait-signaled
[111.358920] Subtest multi-wait-signaled: SUCCESS (0.001s)
[111.450760] [006/132] (906s left) kms_psr (psr-sprite-plane-move)
[111.541007] Starting subtest: psr-sprite-plane-move
[111.543358] Starting dynamic subtest: eDP-1
[113.345472] Dynamic subtest eDP-1: SUCCESS (1.802s)
[113.347889] Subtest psr-sprite-plane-move: SUCCESS (1.802s)
[114.161174] [007/132] (903s left) kms_plane_multiple (tiling-yf)
[114.259218] Starting subtest: tiling-yf
[114.263125] Subtest tiling-yf: SKIP (0.000s)
[114.330559] [008/132] (903s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[114.387021] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[114.438930] [009/132] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[114.533001] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[114.537289] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[114.634437] [010/132] (903s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[114.756432] Starting subtest: flip-vs-cursor-atomic-transitions
[122.817270] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.055s)
[123.609546] [011/132] (894s left) prime_busy (before)
[123.683060] Starting subtest: before
[123.687957] Starting dynamic subtest: rcs0
[123.725291] Dynamic subtest rcs0: SUCCESS (0.039s)
[123.735783] Starting dynamic subtest: bcs0
[123.765081] Dynamic subtest bcs0: SUCCESS (0.039s)
[123.775519] Starting dynamic subtest: vcs0
[123.806925] Dynamic subtest vcs0: SUCCESS (0.041s)
[123.816274] Starting dynamic subtest: vcs1
[123.847557] Dynamic subtest vcs1: SUCCESS (0.041s)
[123.856901] Starting dynamic subtest: vecs0
[123.888462] Dynamic subtest vecs0: SUCCESS (0.041s)
[123.898488] Starting dynamic subtest: ccs0
[123.928884] Dynamic subtest ccs0: SUCCESS (0.040s)
[124.038310] Subtest before: SUCCESS (0.353s)
[124.111790] [012/132] (894s left) kms_plane_scaling (invalid-parameters)
[124.206953] Starting subtest: invalid-parameters
[124.209224] Starting dynamic subtest: less-than-1-height-src
[124.221318] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[124.229996] Starting dynamic subtest: less-than-1-width-src
[124.235149] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[124.237415] Subtest invalid-parameters: SUCCESS (0.028s)
[124.341690] [013/132] (893s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[124.435941] Starting subtest: plane-lut1d-pre-ctm3x4
[124.593433] Starting dynamic subtest: pipe-A-plane-0
[124.759834] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[124.768784] Starting dynamic subtest: pipe-A-plane-1
[124.926615] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[124.936558] Starting dynamic subtest: pipe-A-plane-2
[125.093007] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[126.367280] Starting dynamic subtest: pipe-B-plane-0
[126.538141] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[126.548001] Starting dynamic subtest: pipe-B-plane-1
[126.715959] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[126.725585] Starting dynamic subtest: pipe-B-plane-2
[126.905015] Dynamic subtest pipe-B-plane-2: SUCCESS (0.189s)
[128.077824] Starting dynamic subtest: pipe-C-plane-0
[128.214890] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[128.225188] Starting dynamic subtest: pipe-C-plane-1
[128.382953] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[128.391789] Starting dynamic subtest: pipe-C-plane-2
[128.536838] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[129.697923] Starting dynamic subtest: pipe-D-plane-0
[129.847528] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[129.857067] Starting dynamic subtest: pipe-D-plane-1
[129.993493] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[130.002497] Starting dynamic subtest: pipe-D-plane-2
[130.148642] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[130.439468] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.997s)
[131.273673] [014/132] (886s left) kms_draw_crc (draw-method-render)
[131.369286] Starting subtest: draw-method-render
[131.371271] Starting dynamic subtest: xrgb8888-untiled
[131.648184] Dynamic subtest xrgb8888-untiled: SUCCESS (0.279s)
[131.657756] Starting dynamic subtest: rgb565-untiled
[131.893207] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[131.902555] Starting dynamic subtest: xrgb2101010-untiled
[132.126920] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[132.135757] Starting dynamic subtest: xbgr16161616f-untiled
[132.371545] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[132.379978] Starting dynamic subtest: xrgb8888-xtiled
[132.504804] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[132.513234] Starting dynamic subtest: rgb565-xtiled
[132.638327] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[132.646516] Starting dynamic subtest: xrgb2101010-xtiled
[132.760909] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[132.769565] Starting dynamic subtest: xbgr16161616f-xtiled
[132.894454] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[132.902742] Starting dynamic subtest: xrgb8888-4tiled
[133.028252] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[133.038879] Starting dynamic subtest: rgb565-4tiled
[133.161758] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[133.170986] Starting dynamic subtest: xrgb2101010-4tiled
[133.284308] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[133.293295] Starting dynamic subtest: xbgr16161616f-4tiled
[133.417931] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[133.419818] Subtest draw-method-render: SUCCESS (2.046s)
[133.514166] [015/132] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[133.618117] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[133.621630] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[133.717162] [016/132] (884s left) syncobj_basic (illegal-fd-to-handle)
[133.778947] Starting subtest: illegal-fd-to-handle
[133.780957] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[133.871222] [017/132] (884s left) gem_ctx_bad_destroy (invalid-pad)
[133.929605] Starting subtest: invalid-pad
[133.931464] Subtest invalid-pad: SUCCESS (0.000s)
[134.000951] [018/132] (884s left) gem_wait (invalid-buf)
[134.066130] Starting subtest: invalid-buf
[134.068646] Subtest invalid-buf: SUCCESS (0.000s)
[134.266064] [019/132] (884s left) drm_read (short-buffer-nonblock)
[134.406640] Starting subtest: short-buffer-nonblock
[134.409113] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[134.522279] [020/132] (883s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[134.612992] Starting subtest: fbcpsr-rgb565-draw-render
[141.577523] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.959s)
[141.700060] [021/132] (876s left) i915_pm_rps (min-max-config-idle)
[141.756312] Starting subtest: min-max-config-idle
[141.760959] Subtest min-max-config-idle: SKIP (0.001s)
[141.855046] [022/132] (876s left) kms_prop_blob (blob-prop-validate)
[141.910692] Starting subtest: blob-prop-validate
[141.912677] Subtest blob-prop-validate: SUCCESS (0.000s)
[142.003578] [023/132] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[142.103470] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[142.107776] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[142.207322] [024/132] (876s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[142.259089] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[142.365273] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[142.438639] [025/132] (876s left) kms_joiner (basic-big-joiner)
[142.536647] Starting subtest: basic-big-joiner
[142.540903] Subtest basic-big-joiner: SKIP (0.000s)
[142.609289] [026/132] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[142.705585] Starting subtest: fbc-rgb101010-draw-blt
[147.311253] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.604s)
[148.495284] [027/132] (870s left) kms_flip (2x-nonexisting-fb-interruptible)
[148.590023] Starting subtest: 2x-nonexisting-fb-interruptible
[148.602443] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[148.680339] [028/132] (870s left) kms_cursor_crc (cursor-offscreen-512x170)
[148.980753] Starting subtest: cursor-offscreen-512x170
[148.985363] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[149.142063] [029/132] (869s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[149.249525] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[149.254060] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[149.348725] [030/132] (869s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[149.439368] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[149.441256] Starting dynamic subtest: pipe-A-eDP-1
[149.459836] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.469967] Starting dynamic subtest: pipe-B-eDP-1
[149.487296] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.495082] Starting dynamic subtest: pipe-C-eDP-1
[149.512290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.520363] Starting dynamic subtest: pipe-D-eDP-1
[149.537779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.541166] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[151.655968] [031/132] (867s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[151.743393] Starting subtest: flip-vs-dpms-on-nop-interruptible
[151.745694] Starting dynamic subtest: A-eDP1
[153.657880] Dynamic subtest A-eDP1: SUCCESS (1.912s)
[153.668805] Starting dynamic subtest: B-eDP1
[155.505466] Dynamic subtest B-eDP1: SUCCESS (1.845s)
[155.517116] Starting dynamic subtest: C-eDP1
[157.313270] Dynamic subtest C-eDP1: SUCCESS (1.805s)
[157.323945] Starting dynamic subtest: D-eDP1
[159.141990] Dynamic subtest D-eDP1: SUCCESS (1.825s)
[159.149334] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.402s)
[160.329168] [032/132] (858s left) gem_ctx_param (invalid-set-no-zeromap)
[160.387219] Starting subtest: invalid-set-no-zeromap
[160.389698] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[160.473302] [033/132] (858s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[160.565858] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[161.611518] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[161.749756] [034/132] (857s left) gem_pwrite_snooped
[161.893134] [035/132] (857s left) gem_create (create-ext-set-pat)
[162.059146] Starting subtest: create-ext-set-pat
[162.061806] Subtest create-ext-set-pat: SUCCESS (0.001s)
[162.148264] [036/132] (856s left) kms_lease (implicit-plane-lease)
[162.253092] Starting subtest: implicit-plane-lease
[162.255227] Subtest implicit-plane-lease: SUCCESS (0.003s)
[162.375892] [037/132] (856s left) gem_exec_schedule (u-submit-early-slice)
[162.442447] Starting subtest: u-submit-early-slice
[162.444951] Starting dynamic subtest: rcs0
[162.480767] Dynamic subtest rcs0: SUCCESS (0.045s)
[162.489795] Starting dynamic subtest: bcs0
[162.524229] Dynamic subtest bcs0: SUCCESS (0.043s)
[162.533250] Starting dynamic subtest: vcs0
[162.568222] Dynamic subtest vcs0: SUCCESS (0.043s)
[162.578674] Starting dynamic subtest: vcs1
[162.601900] Dynamic subtest vcs1: SUCCESS (0.033s)
[162.611012] Starting dynamic subtest: vecs0
[162.629770] Dynamic subtest vecs0: SUCCESS (0.027s)
[162.638285] Starting dynamic subtest: ccs0
[162.663181] Dynamic subtest ccs0: SUCCESS (0.032s)
[162.666139] Subtest u-submit-early-slice: SUCCESS (0.228s)
[163.617404] [038/132] (855s left) gem_exec_fence (concurrent)
[163.807289] Starting subtest: concurrent
[163.812012] Subtest concurrent: SKIP (0.000s)
[165.671895] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[165.677879] [039/132] (853s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[165.777227] Starting subtest: fbc-psr-cursor-mmap-gtt
[165.779449] Starting dynamic subtest: eDP-1
[165.783469] Dynamic subtest eDP-1: SKIP (0.000s)
[165.787576] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[165.851223] [040/132] (853s left) syncobj_timeline (invalid-query-bad-pad)
[165.913099] Starting subtest: invalid-query-bad-pad
[165.915360] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[166.025355] [041/132] (853s left) kms_psr (psr2-suspend)
[166.120171] Starting subtest: psr2-suspend
[166.122461] Starting dynamic subtest: eDP-1
[183.749769] Dynamic subtest eDP-1: SUCCESS (2.864s)
[183.752866] Subtest psr2-suspend: SUCCESS (2.865s)
[184.651497] [042/132] (834s left) core_auth (basic-auth)
[184.723884] Starting subtest: basic-auth
[184.726529] Subtest basic-auth: SUCCESS (0.001s)
[184.823231] [043/132] (834s left) kms_content_protection (atomic)
[184.960862] Starting subtest: atomic
[184.965840] Subtest atomic: SKIP (0.000s)
[185.081475] [044/132] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[185.177739] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[185.182909] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[185.280891] [045/132] (834s left) syncobj_eventfd (invalid-illegal-handle)
[185.338597] Starting subtest: invalid-illegal-handle
[185.341023] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[185.454611] [046/132] (834s left) prime_mmap_coherency (ioctl-errors)
[185.510794] Starting subtest: ioctl-errors
[208.093060] Subtest ioctl-errors: SUCCESS (22.534s)
[208.230800] [047/132] (811s left) gem_tiled_pread_basic (basic)
[208.333738] Subtest basic: SKIP (0.000s)
[208.391944] [048/132] (811s left) gem_exec_balancer (bonded-chain)
[208.451295] Starting subtest: bonded-chain
[215.526384] Subtest bonded-chain: SUCCESS (7.070s)
[215.842867] [049/132] (803s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[215.977768] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[215.982480] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[216.121294] [050/132] (803s left) gem_exec_whisper (basic-fds)
[216.193596] Starting subtest: basic-fds
[222.310796] Subtest basic-fds: SUCCESS (6.114s)
[222.500798] [051/132] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[222.600811] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[222.605862] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[222.679496] [052/132] (797s left) core_sysfs (read-all-entries)
[222.749259] Starting subtest: read-all-entries
[222.754941] Subtest read-all-entries: SUCCESS (0.004s)
[222.860355] [053/132] (796s left) perf_pmu (busy-accuracy-98)
[222.920834] Starting subtest: busy-accuracy-98
[222.923757] Starting dynamic subtest: rcs0
[225.960301] Dynamic subtest rcs0: SUCCESS (3.039s)
[225.973032] Starting dynamic subtest: bcs0
[229.015567] Dynamic subtest bcs0: SUCCESS (3.052s)
[229.033041] Starting dynamic subtest: vcs0
[232.058918] Dynamic subtest vcs0: SUCCESS (3.041s)
[232.071464] Starting dynamic subtest: vcs1
[235.104512] Dynamic subtest vcs1: SUCCESS (3.042s)
[235.115880] Starting dynamic subtest: vecs0
[238.148545] Dynamic subtest vecs0: SUCCESS (3.041s)
[238.159770] Starting dynamic subtest: ccs0
[241.201029] Dynamic subtest ccs0: SUCCESS (3.049s)
[241.203923] Subtest busy-accuracy-98: SUCCESS (18.279s)
[241.322263] [054/132] (778s left) kms_psr (fbc-pr-primary-page-flip)
[241.426752] Starting subtest: fbc-pr-primary-page-flip
[241.431829] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[241.501177] [055/132] (778s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[241.564501] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[241.665721] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[241.745692] [056/132] (778s left) kms_cursor_crc (cursor-sliding-256x85)
[241.994428] Starting subtest: cursor-sliding-256x85
[242.040035] Subtest cursor-sliding-256x85: SKIP (0.042s)
[242.207435] [057/132] (777s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[242.317723] Starting subtest: x-tiled-8bpp-rotate-0
[243.565335] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.248s)
[243.711466] [058/132] (776s left) kms_flip (flip-vs-panning-interruptible)
[243.820482] Starting subtest: flip-vs-panning-interruptible
[243.822626] Starting dynamic subtest: A-eDP1
[252.496172] Dynamic subtest A-eDP1: SUCCESS (8.671s)
[252.515158] Starting dynamic subtest: B-eDP1
[261.227747] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[261.238868] Starting dynamic subtest: C-eDP1
[269.940144] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[269.956571] Starting dynamic subtest: D-eDP1
[278.678589] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[278.683244] Subtest flip-vs-panning-interruptible: SUCCESS (34.850s)
[279.842357] [059/132] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[279.943944] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[279.949041] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[280.052089] [060/132] (740s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[280.149009] Starting subtest: pr-overlay-plane-update-continuous-sf
[280.154618] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[280.233163] [061/132] (739s left) gem_render_copy (yf-tiled)
[280.282008] Starting subtest: yf-tiled
[280.287227] Subtest yf-tiled: SKIP (0.000s)
[280.466130] [062/132] (739s left) kms_pm_backlight (fade)
[280.559177] Starting subtest: fade
[280.608139] Starting dynamic subtest: eDP-1
[283.094855] Dynamic subtest eDP-1: SUCCESS (2.487s)
[283.097581] Subtest fade: SUCCESS (2.538s)
[283.974290] [063/132] (736s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[284.036758] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[284.039175] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[284.126029] [064/132] (736s left) kms_addfb_basic (unused-modifier)
[284.181270] Starting subtest: unused-modifier
[284.183546] Subtest unused-modifier: SUCCESS (0.000s)
[284.320350] [065/132] (736s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[284.430944] Starting subtest: stress-xrgb8888-yftiled
[284.436459] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[284.483639] [066/132] (735s left) i915_drm_fdinfo (virtual-busy)
[284.527033] Starting subtest: virtual-busy
[284.531533] Subtest virtual-busy: SKIP (0.000s)
[284.604599] [067/132] (735s left) gem_busy (parallel)
[284.784558] Starting subtest: parallel
[284.787340] Starting dynamic subtest: rcs0
[286.343143] Dynamic subtest rcs0: SUCCESS (1.557s)
[286.356823] Starting dynamic subtest: bcs0
[288.336368] Dynamic subtest bcs0: SUCCESS (1.981s)
[288.349891] Starting dynamic subtest: vcs0
[290.311940] Dynamic subtest vcs0: SUCCESS (1.985s)
[290.324235] Starting dynamic subtest: vcs1
[292.296606] Dynamic subtest vcs1: SUCCESS (1.983s)
[292.309782] Starting dynamic subtest: vecs0
[294.342200] Dynamic subtest vecs0: SUCCESS (2.044s)
[294.355051] Starting dynamic subtest: ccs0
[296.327682] Dynamic subtest ccs0: SUCCESS (1.982s)
[296.330997] Subtest parallel: SUCCESS (11.546s)
[296.534468] [068/132] (723s left) gem_shrink (reclaim)
[296.588739] Starting subtest: reclaim
[299.041879] Subtest reclaim: SUCCESS (2.444s)
[299.179800] [069/132] (721s left) gem_partial_pwrite_pread (reads-snoop)
[299.236877] Subtest reads-snoop: SKIP (0.000s)
[299.309536] [070/132] (721s left) gem_exec_reloc (basic-write-cpu-active)
[299.380960] Subtest basic-write-cpu-active: SKIP (0.000s)
[299.453891] [071/132] (721s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[299.562642] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[299.567846] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[299.662231] [072/132] (721s left) gem_reg_read (bad-register)
[299.711899] Starting subtest: bad-register
[299.714305] Subtest bad-register: SUCCESS (0.000s)
[299.807275] [073/132] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[299.902789] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[299.907826] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[300.000980] [074/132] (720s left) sw_sync (sync_busy)
[300.042855] Starting subtest: sync_busy
[300.045704] Subtest sync_busy: SUCCESS (0.002s)
[300.098431] [075/132] (720s left) kms_sequence (queue-idle)
[300.198270] Starting subtest: queue-idle
[300.200490] Starting dynamic subtest: pipe-A-eDP-1
[302.014942] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[302.026406] Starting dynamic subtest: pipe-B-eDP-1
[304.536590] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.520s)
[304.548632] Starting dynamic subtest: pipe-C-eDP-1
[306.950933] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[306.962258] Starting dynamic subtest: pipe-D-eDP-1
[309.375340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[309.378094] Subtest queue-idle: SUCCESS (9.179s)
[310.179113] [076/132] (710s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[310.278820] Starting subtest: psr-modesetfrombusy
[316.437032] Subtest psr-modesetfrombusy: SUCCESS (6.162s)
[316.569134] [077/132] (704s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[316.684628] Starting subtest: 2x-cursor-vs-flip-atomic
[316.689012] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[316.828779] [078/132] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[316.927155] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[316.931374] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[317.022933] [079/132] (703s left) kms_flip (flip-vs-blocking-wf-vblank)
[317.108165] Starting subtest: flip-vs-blocking-wf-vblank
[317.110638] Starting dynamic subtest: A-eDP1
[326.082492] Dynamic subtest A-eDP1: SUCCESS (8.972s)
[326.093341] Starting dynamic subtest: B-eDP1
[335.013411] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[335.026601] Starting dynamic subtest: C-eDP1
[343.931893] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[343.942298] Starting dynamic subtest: D-eDP1
[352.869226] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[352.874916] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.759s)
[354.110029] [080/132] (666s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[354.205744] Starting subtest: primary-yf-tiled-reflect-x-90
[354.210817] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[354.280757] [081/132] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[354.380027] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[361.715189] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.336s)
[361.841875] [082/132] (659s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[361.953491] Starting subtest: pixel-format-linear-modifier-source-clamping
[361.981697] Starting dynamic subtest: pipe-A-plane-0
[365.847356] Dynamic subtest pipe-A-plane-0: SUCCESS (3.867s)
[365.857026] Starting dynamic subtest: pipe-A-plane-3
[367.614361] Dynamic subtest pipe-A-plane-3: SUCCESS (1.764s)
[368.687050] Starting dynamic subtest: pipe-B-plane-0
[372.512635] Dynamic subtest pipe-B-plane-0: SUCCESS (3.832s)
[372.522849] Starting dynamic subtest: pipe-B-plane-3
[374.179460] Dynamic subtest pipe-B-plane-3: SUCCESS (1.665s)
[374.499774] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.544s)
[375.365664] [083/132] (645s left) gem_mmap_gtt (basic-small-bo-tiledx)
[375.436321] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[375.508178] [084/132] (645s left) gem_userptr_blits (unsync-unmap)
[375.568793] Subtest unsync-unmap: SKIP (0.000s)
[375.699418] [085/132] (645s left) gem_pread (exhaustion)
[375.756857] Subtest exhaustion: SKIP (0.000s)
[375.813792] [086/132] (645s left) gem_mmap_offset (partial-remap)
[375.870787] Starting subtest: partial-remap
[375.873455] Starting dynamic subtest: smem0
[375.883388] Dynamic subtest smem0: SUCCESS (0.004s)
[375.885484] Subtest partial-remap: SUCCESS (0.005s)
[375.990072] [087/132] (645s left) gem_ctx_param (set-priority-range)
[376.040367] Starting subtest: set-priority-range
[376.054831] Subtest set-priority-range: SUCCESS (0.015s)
[376.168482] [088/132] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[376.279865] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[376.284740] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[376.361195] [089/132] (645s left) core_auth (getclient-simple)
[376.402185] Starting subtest: getclient-simple
[376.425656] Subtest getclient-simple: SUCCESS (0.024s)
[376.525811] [090/132] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[376.625532] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[383.725811] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[383.853407] [091/132] (637s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[383.954948] Starting subtest: fb-8bpc-vs-panel-6bpc
[383.957734] Starting dynamic subtest: pipe-A-eDP-1
[385.371280] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s)
[385.374013] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.416s)
[386.239318] [092/132] (635s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[386.342400] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[386.347250] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[386.418333] [093/132] (635s left) gem_exec_flush (basic-uc-rw-default)
[386.491317] Starting subtest: basic-uc-rw-default
[391.951945] Subtest basic-uc-rw-default: SUCCESS (5.458s)
[392.142904] [094/132] (629s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[392.207152] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[392.212937] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[392.393216] [095/132] (629s left) tools_test (sysfs_l3_parity)
[392.448458] Starting subtest: sysfs_l3_parity
[392.527865] Subtest sysfs_l3_parity: SKIP (0.088s)
[392.582541] [096/132] (629s left) kms_cursor_crc (cursor-sliding-128x42)
[392.807741] Starting subtest: cursor-sliding-128x42
[392.855635] Subtest cursor-sliding-128x42: SKIP (0.044s)
[393.054476] [097/132] (628s left) i915_suspend (sysfs-reader)
[393.113954] Starting subtest: sysfs-reader
[411.311883] Subtest sysfs-reader: SUCCESS (3.128s)
[411.379886] [098/132] (610s left) vgem_basic (bad-pad)
[411.429487] Starting subtest: bad-pad
[411.431471] Subtest bad-pad: SUCCESS (0.000s)
[411.486859] [099/132] (610s left) gem_ctx_param (invalid-size-get)
[411.543278] Starting subtest: invalid-size-get
[411.547138] Subtest invalid-size-get: SUCCESS (0.001s)
[411.646071] [100/132] (610s left) kms_big_fb (y-tiled-addfb-size-overflow)
[411.741108] Starting subtest: y-tiled-addfb-size-overflow
[411.744852] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[411.837324] [101/132] (610s left) kms_chamelium_hpd (hdmi-hpd-fast)
[412.213066] Subtest hdmi-hpd-fast: SKIP (0.000s)
[413.013683] [102/132] (609s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[413.122194] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[413.126456] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[413.223558] [103/132] (608s left) perf_pmu (invalid-open)
[413.263498] Starting subtest: invalid-open
[413.265790] Subtest invalid-open: SUCCESS (0.000s)
[413.365062] [104/132] (608s left) kms_getfb (getfb-reject-nv12)
[413.452132] Starting subtest: getfb-reject-nv12
[413.454427] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[413.569438] [105/132] (608s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[413.652835] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[413.655080] Starting dynamic subtest: pipe-A-eDP-1
[414.400646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[414.411370] Starting dynamic subtest: pipe-B-eDP-1
[416.196505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s)
[416.208154] Starting dynamic subtest: pipe-C-eDP-1
[418.035551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.831s)
[418.047963] Starting dynamic subtest: pipe-D-eDP-1
[419.885973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.844s)
[419.888331] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.202s)
[421.014988] [106/132] (601s left) gem_workarounds (suspend-resume-context)
[421.087922] Starting subtest: suspend-resume-context
[437.332895] Subtest suspend-resume-context: SUCCESS (1.140s)
[437.468146] [107/132] (584s left) kms_vblank (query-forked-busy)
[437.560466] Starting subtest: query-forked-busy
[437.563289] Starting dynamic subtest: pipe-A-eDP-1
[439.458249] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[439.476619] Starting dynamic subtest: pipe-D-eDP-1
[442.003464] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[442.006335] Subtest query-forked-busy: SUCCESS (4.436s)
[442.799653] [108/132] (579s left) kms_atomic_transition (modeset-transition-fencing)
[442.893443] Starting subtest: modeset-transition-fencing
[442.896427] Starting dynamic subtest: 1x-outputs
[453.877706] Dynamic subtest 1x-outputs: SUCCESS (10.948s)
[453.880640] Subtest modeset-transition-fencing: SUCCESS (10.950s)
[454.738853] [109/132] (567s left) kms_psr (pr-primary-blt)
[454.828199] Starting subtest: pr-primary-blt
[454.833325] Subtest pr-primary-blt: SKIP (0.000s)
[454.931335] [110/132] (567s left) gem_ppgtt (blt-vs-render-ctxn)
[454.999926] Starting subtest: blt-vs-render-ctxN
[487.958985] Subtest blt-vs-render-ctxN: SUCCESS (32.941s)
[488.085756] [111/132] (534s left) gem_softpin (allocator-evict)
[488.191325] Starting subtest: allocator-evict
[488.194191] Starting dynamic subtest: rcs0
[512.223346] Dynamic subtest rcs0: SUCCESS (24.025s)
[512.236302] Starting dynamic subtest: bcs0
[535.987898] Dynamic subtest bcs0: SUCCESS (23.755s)
[536.001315] Starting dynamic subtest: vcs0
[559.780618] Dynamic subtest vcs0: SUCCESS (23.794s)
[559.793832] Starting dynamic subtest: vcs1
[583.642202] Dynamic subtest vcs1: SUCCESS (23.858s)
[583.654203] Starting dynamic subtest: vecs0
[607.374294] Dynamic subtest vecs0: SUCCESS (23.726s)
[607.385590] Starting dynamic subtest: ccs0
[631.461362] Dynamic subtest ccs0: SUCCESS (24.080s)
[631.464438] Subtest allocator-evict: SUCCESS (143.245s)
[631.547577] [112/132] (390s left) gem_exec_reloc (basic-wc-cpu)
[631.644274] Subtest basic-wc-cpu: SKIP (0.000s)
[631.711795] [113/132] (390s left) gem_exec_schedule (preempt)
[631.825979] Starting subtest: preempt
[631.828449] Starting dynamic subtest: rcs0
[631.863383] Dynamic subtest rcs0: SUCCESS (0.040s)
[631.877378] Starting dynamic subtest: bcs0
[631.908455] Dynamic subtest bcs0: SUCCESS (0.043s)
[631.919905] Starting dynamic subtest: vcs0
[631.939059] Dynamic subtest vcs0: SUCCESS (0.030s)
[631.949745] Starting dynamic subtest: vcs1
[631.974379] Dynamic subtest vcs1: SUCCESS (0.035s)
[631.988364] Starting dynamic subtest: vecs0
[632.013055] Dynamic subtest vecs0: SUCCESS (0.038s)
[632.023801] Starting dynamic subtest: ccs0
[632.054225] Dynamic subtest ccs0: SUCCESS (0.040s)
[632.057089] Subtest preempt: SUCCESS (0.232s)
[633.588821] [114/132] (388s left) gem_ctx_param (root-set)
[633.645167] Starting subtest: root-set
[633.648059] Subtest root-set: SUCCESS (0.001s)
[633.760309] [115/132] (388s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[633.862210] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[633.865087] Starting dynamic subtest: pipe-A
[634.210299] Dynamic subtest pipe-A: SUCCESS (0.350s)
[634.221451] Starting dynamic subtest: pipe-B
[635.634154] Dynamic subtest pipe-B: SUCCESS (1.421s)
[635.645344] Starting dynamic subtest: pipe-C
[637.066984] Dynamic subtest pipe-C: SUCCESS (1.432s)
[637.077911] Starting dynamic subtest: pipe-D
[638.513482] Dynamic subtest pipe-D: SUCCESS (1.446s)
[638.516166] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.653s)
[639.668811] [116/132] (382s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[640.063343] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[640.886176] [117/132] (381s left) api_intel_bb (blit-reloc-keep-cache)
[640.939361] Starting subtest: blit-reloc-keep-cache
[640.945102] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[641.068291] [118/132] (381s left) gem_lmem_swapping (massive)
[641.115252] Subtest massive: SKIP (0.000s)
[641.165017] [119/132] (381s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[641.281188] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[642.083474] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.804s)
[642.247288] [120/132] (380s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[642.350117] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[642.352436] Starting dynamic subtest: pipe-A-eDP-1
[642.502120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[642.514607] Starting dynamic subtest: pipe-B-eDP-1
[642.536596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[642.546992] Starting dynamic subtest: pipe-C-eDP-1
[642.570924] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[642.581212] Starting dynamic subtest: pipe-D-eDP-1
[642.604146] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[642.606683] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[644.794194] [121/132] (378s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[645.383456] Starting subtest: syncobj-timeline-invalid-flags
[645.386311] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[646.580434] [122/132] (376s left) i915_fb_tiling (basic-x-tiling)
[646.644477] Subtest basic-x-tiling: SKIP (0.000s)
[646.706831] [123/132] (376s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[646.802485] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[646.805448] Starting dynamic subtest: pipe-A-eDP-1
[646.831476] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.848304] Starting dynamic subtest: pipe-B-eDP-1
[646.876055] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.892431] Starting dynamic subtest: pipe-C-eDP-1
[646.918249] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.933468] Starting dynamic subtest: pipe-D-eDP-1
[646.959540] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.964740] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[648.979470] [124/132] (374s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[649.088525] Starting subtest: 4-tiled-64bpp-rotate-90
[649.109324] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[649.230665] [125/132] (373s left) gem_ctx_shared (q-in-order)
[649.295246] Starting subtest: Q-in-order
[649.298197] Starting dynamic subtest: rcs0
[649.400924] Dynamic subtest rcs0: SUCCESS (0.105s)
[649.418051] Starting dynamic subtest: vcs0
[649.482719] Dynamic subtest vcs0: SUCCESS (0.080s)
[649.500355] Starting dynamic subtest: vcs1
[649.559859] Dynamic subtest vcs1: SUCCESS (0.076s)
[649.577706] Starting dynamic subtest: vecs0
[649.637243] Dynamic subtest vecs0: SUCCESS (0.077s)
[649.654068] Starting dynamic subtest: ccs0
[649.727348] Dynamic subtest ccs0: SUCCESS (0.088s)
[649.730562] Subtest Q-in-order: SUCCESS (0.433s)
[650.657629] [126/132] (372s left) gem_mmap_wc (read-write)
[650.726461] Subtest read-write: SKIP (0.000s)
[650.789257] [127/132] (372s left) gen9_exec_parse (secure-batches)
[650.851265] Subtest secure-batches: SKIP (0.000s)
[650.920340] [128/132] (372s left) syncobj_timeline (wait-all-complex)
[650.971491] Starting subtest: wait-all-complex
[651.188663] Subtest wait-all-complex: SUCCESS (0.217s)
[651.278431] [129/132] (372s left) gem_exec_fence (syncobj-unused-fence)
[651.689053] Starting subtest: syncobj-unused-fence
[651.695487] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[653.589134] [130/132] (369s left) gem_ctx_persistence (processes)
[653.665357] Starting subtest: processes
[655.461848] Subtest processes: SUCCESS (1.800s)
[655.550742] [131/132] (367s left) kms_addfb_basic (legacy-format)
[655.607217] Starting subtest: legacy-format
[655.636300] Subtest legacy-format: SUCCESS (0.023s)
[655.782364] [132/132] (367s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[655.887035] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[662.557954] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.670s)
[662.710128] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_fbcon_fbt
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_plane_multiple
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_color_pipeline
results: parsing output: 13/ for test: kms_draw_crc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_basic
results: parsing output: 16/ for test: gem_ctx_bad_destroy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: drm_read
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_prop_blob
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_pwrite_snooped
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: core_auth
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_eventfd
results: parsing output: 45/ for test: prime_mmap_coherency
results: parsing output: 46/ for test: gem_tiled_pread_basic
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: core_sysfs
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_pm_backlight
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_pipe_stress
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: gem_busy
results: parsing output: 67/ for test: gem_shrink
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_reg_read
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: sw_sync
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_pread
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: core_auth
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_dither
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: gem_exec_flush
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: tools_test
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: i915_suspend
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_workarounds
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_ppgtt
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: i915_fb_tiling
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.