[57.584791] Initializing watchdogs
[57.584844]   /dev/watchdog0
[57.599560] [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.603952] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.606422] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.609923] [001/132] (960s left) kms_cursor_crc (cursor-offscreen-256x256)
[57.878836] Starting subtest: cursor-offscreen-256x256
[57.894262] Starting dynamic subtest: pipe-A-eDP-1
[59.895311] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.999s)
[59.926822] Starting dynamic subtest: pipe-D-eDP-1
[62.543512] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[62.545817] Subtest cursor-offscreen-256x256: SUCCESS (4.663s)
[63.407405] [002/132] (954s left) gem_userptr_blits (create-destroy-unsync)
[63.477901] Subtest create-destroy-unsync: SKIP (0.000s)
[63.595316] [003/132] (954s left) gem_ctx_param (non-root-set)
[63.646942] Starting subtest: non-root-set
[63.674618] Subtest non-root-set: SUCCESS (0.028s)
[63.768468] [004/132] (954s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[63.861804] Starting subtest: plane-use-after-nonblocking-unbind
[63.864149] Starting dynamic subtest: pipe-A-eDP-1
[63.923038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[64.219506] Starting dynamic subtest: pipe-B-eDP-1
[64.998556] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[65.285191] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.423s)
[66.142318] [005/132] (952s left) kms_cursor_crc (cursor-random-64x21)
[66.326202] Starting subtest: cursor-random-64x21
[66.381885] Subtest cursor-random-64x21: SKIP (0.051s)
[66.609400] [006/132] (951s left) kms_content_protection (uevent-hdcp14)
[66.746745] Starting subtest: uevent-hdcp14
[66.751821] Subtest uevent-hdcp14: SKIP (0.000s)
[66.976012] [007/132] (951s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[67.143158] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[67.303151] [008/132] (951s left) kms_psr (fbc-psr-basic)
[67.425235] Starting subtest: fbc-psr-basic
[67.427667] Starting dynamic subtest: eDP-1
[67.432296] Dynamic subtest eDP-1: SKIP (0.000s)
[67.436961] Subtest fbc-psr-basic: SKIP (0.001s)
[67.733378] [009/132] (950s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[67.902361] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[67.904815] Starting dynamic subtest: pipe-A-eDP-1
[67.928432] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.937271] Starting dynamic subtest: pipe-B-eDP-1
[67.960356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.967566] Starting dynamic subtest: pipe-C-eDP-1
[67.989632] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.996513] Starting dynamic subtest: pipe-D-eDP-1
[68.018592] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.022946] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[70.191579] [010/132] (948s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[70.571464] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[71.393990] [011/132] (947s left) perf_pmu (interrupts-sync)
[71.434644] Starting subtest: interrupts-sync
[72.555025] Subtest interrupts-sync: SUCCESS (1.120s)
[72.664657] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[72.667940] [012/132] (945s left) kms_hdr (bpc-switch-suspend)
[72.766191] Starting subtest: bpc-switch-suspend
[73.791061] Starting dynamic subtest: pipe-A-eDP-1
[93.821858] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.698s)
[93.824236] Subtest bpc-switch-suspend: SUCCESS (5.726s)
[93.934008] [013/132] (924s left) gem_mmap_gtt (big-copy-odd)
[94.008329] Subtest big-copy-odd: SKIP (0.000s)
[94.069753] [014/132] (924s left) i915_pm_freq_mult (media-freq)
[94.139777] Starting subtest: media-freq
[94.142449] Starting dynamic subtest: gt0
[94.147096] Dynamic subtest gt0: SKIP (0.000s)
[94.161512] Starting dynamic subtest: gt1
[94.165786] Dynamic subtest gt1: SKIP (0.000s)
[94.169931] Subtest media-freq: SKIP (0.001s)
[94.259189] [015/132] (924s left) kms_async_flips (test-time-stamp)
[94.346029] Starting subtest: test-time-stamp
[94.721592] Starting dynamic subtest: pipe-A-eDP-1
[95.480764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[95.867865] Starting dynamic subtest: pipe-B-eDP-1
[96.628418] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[97.020459] Starting dynamic subtest: pipe-C-eDP-1
[97.773188] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[98.137178] Starting dynamic subtest: pipe-D-eDP-1
[98.902913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[98.905333] Subtest test-time-stamp: SUCCESS (4.556s)
[100.065635] [016/132] (918s left) i915_query (test-query-geometry-subslices)
[100.123831] Starting subtest: test-query-geometry-subslices
[100.125796] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[100.217854] [017/132] (918s left) gem_ctx_persistence (legacy-engines-mixed)
[100.283492] Starting subtest: legacy-engines-mixed
[100.285612] Starting dynamic subtest: render
[100.343523] Dynamic subtest render: SUCCESS (0.062s)
[100.355002] Starting dynamic subtest: bsd1
[100.404477] Dynamic subtest bsd1: SUCCESS (0.060s)
[100.415356] Starting dynamic subtest: bsd2
[100.467800] Dynamic subtest bsd2: SUCCESS (0.061s)
[100.478919] Starting dynamic subtest: blt
[100.509931] Dynamic subtest blt: SUCCESS (0.040s)
[100.519902] Starting dynamic subtest: vebox
[100.555659] Dynamic subtest vebox: SUCCESS (0.045s)
[100.558506] Subtest legacy-engines-mixed: SUCCESS (0.274s)
[100.645721] [018/132] (918s left) gem_userptr_blits (unsync-unmap-cycles)
[100.705664] Subtest unsync-unmap-cycles: SKIP (0.000s)
[100.826595] [019/132] (918s left) kms_dsc (dsc-with-output-formats)
[100.912015] Starting subtest: dsc-with-output-formats
[100.934442] Subtest dsc-with-output-formats: SKIP (0.001s)
[100.985369] [020/132] (917s left) gem_ctx_exec (basic-invalid-context)
[101.035905] Starting subtest: basic-invalid-context
[101.039540] Subtest basic-invalid-context: SUCCESS (0.005s)
[101.156160] [021/132] (917s left) kms_pm_rpm (modeset-lpsp)
[103.390471] Starting subtest: modeset-lpsp
[104.860357] Subtest modeset-lpsp: SUCCESS (1.473s)
[104.957435] [022/132] (914s left) kms_psr (pr-cursor-render)
[105.055433] Starting subtest: pr-cursor-render
[105.059605] Subtest pr-cursor-render: SKIP (0.000s)
[105.132863] [023/132] (913s left) gem_softpin (evict-prime-sanity-check)
[105.187855] Starting subtest: evict-prime-sanity-check
[105.190283] Starting dynamic subtest: rcs0
[106.326455] Dynamic subtest rcs0: SUCCESS (1.138s)
[106.337632] Starting dynamic subtest: bcs0
[107.443737] Dynamic subtest bcs0: SUCCESS (1.117s)
[107.455441] Starting dynamic subtest: vcs0
[109.176359] Dynamic subtest vcs0: SUCCESS (1.730s)
[109.187854] Starting dynamic subtest: vcs1
[111.221235] Dynamic subtest vcs1: SUCCESS (2.044s)
[111.232778] Starting dynamic subtest: vecs0
[113.186614] Dynamic subtest vecs0: SUCCESS (1.963s)
[113.198411] Starting dynamic subtest: ccs0
[114.336889] Dynamic subtest ccs0: SUCCESS (1.150s)
[114.348304] Starting dynamic subtest: all
[115.459518] Dynamic subtest all: SUCCESS (1.122s)
[115.461763] Subtest evict-prime-sanity-check: SUCCESS (10.272s)
[115.538443] [024/132] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[115.643192] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[115.647642] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[115.745781] [025/132] (903s left) kms_joiner (basic-big-joiner)
[115.852169] Starting subtest: basic-big-joiner
[115.856544] Subtest basic-big-joiner: SKIP (0.000s)
[115.915949] [026/132] (903s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[116.025161] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[122.879958] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.858s)
[123.012008] [027/132] (896s left) kms_addfb_basic (addfb25-modifier-no-flag)
[123.113822] Starting subtest: addfb25-modifier-no-flag
[123.116038] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[123.210883] [028/132] (896s left) kms_flip (flip-vs-rmfb)
[123.299351] Starting subtest: flip-vs-rmfb
[123.301711] Starting dynamic subtest: A-eDP1
[131.941112] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[131.951097] Starting dynamic subtest: B-eDP1
[140.571651] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[140.589345] Starting dynamic subtest: C-eDP1
[149.200906] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[149.210701] Starting dynamic subtest: D-eDP1
[157.834844] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[157.839271] Subtest flip-vs-rmfb: SUCCESS (34.542s)
[159.013647] [029/132] (860s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[159.124854] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[159.126713] Starting dynamic subtest: pipe-A-eDP-1
[159.998732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s)
[160.008102] Starting dynamic subtest: pipe-B-eDP-1
[161.695072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.695s)
[161.704063] Starting dynamic subtest: pipe-C-eDP-1
[163.264812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.568s)
[163.279146] Starting dynamic subtest: pipe-D-eDP-1
[164.762316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s)
[164.764619] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.632s)
[165.928891] [030/132] (853s left) gem_busy (extended)
[166.123429] Starting subtest: extended
[166.125574] Starting dynamic subtest: rcs0
[166.201447] Dynamic subtest rcs0: SUCCESS (0.079s)
[166.213187] Starting dynamic subtest: bcs0
[166.245445] Dynamic subtest bcs0: SUCCESS (0.040s)
[166.255613] Starting dynamic subtest: vcs0
[168.252259] Dynamic subtest vcs0: SUCCESS (2.005s)
[168.264236] Starting dynamic subtest: vcs1
[170.236397] Dynamic subtest vcs1: SUCCESS (1.980s)
[170.248254] Starting dynamic subtest: vecs0
[172.219961] Dynamic subtest vecs0: SUCCESS (1.981s)
[172.232190] Starting dynamic subtest: ccs0
[172.264943] Dynamic subtest ccs0: SUCCESS (0.044s)
[172.267361] Subtest extended: SUCCESS (6.144s)
[172.504047] [031/132] (846s left) sw_sync (sync_busy_fork_unixsocket)
[172.539511] Starting subtest: sync_busy_fork_unixsocket
[172.544770] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[172.603364] [032/132] (846s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[172.659280] Starting subtest: x-tiled-to-vebox-yf-tiled
[172.663792] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[172.847168] [033/132] (846s left) gem_exec_store (dword)
[172.916462] Starting subtest: dword
[172.918382] Starting dynamic subtest: rcs0
[172.995173] Dynamic subtest rcs0: SUCCESS (0.079s)
[173.006386] Starting dynamic subtest: bcs0
[173.040098] Dynamic subtest bcs0: SUCCESS (0.043s)
[173.050258] Starting dynamic subtest: vcs0
[173.085128] Dynamic subtest vcs0: SUCCESS (0.043s)
[173.098410] Starting dynamic subtest: vcs1
[173.131113] Dynamic subtest vcs1: SUCCESS (0.044s)
[173.141391] Starting dynamic subtest: vecs0
[173.175049] Dynamic subtest vecs0: SUCCESS (0.042s)
[173.184481] Starting dynamic subtest: ccs0
[173.221061] Dynamic subtest ccs0: SUCCESS (0.044s)
[173.223367] Subtest dword: SUCCESS (0.307s)
[173.409473] [034/132] (846s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[173.498758] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[173.503113] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[173.600744] [035/132] (845s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[173.707294] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[173.711168] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.810834] [036/132] (845s left) kms_getfb (getfb-handle-valid)
[173.911929] Starting subtest: getfb-handle-valid
[173.914171] Subtest getfb-handle-valid: SUCCESS (0.000s)
[174.031454] [037/132] (845s left) kms_frontbuffer_tracking (fbc-2p-rte)
[174.140131] Starting subtest: fbc-2p-rte
[174.144080] Subtest fbc-2p-rte: SKIP (0.000s)
[174.243398] [038/132] (845s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[174.341234] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[174.345247] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[174.433506] [039/132] (845s left) api_intel_bb (blit-reloc-purge-cache)
[174.488147] Starting subtest: blit-reloc-purge-cache
[174.491801] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[174.621455] [040/132] (845s left) gem_mmap (bad-offset)
[174.678305] Subtest bad-offset: SKIP (0.000s)
[174.739402] [041/132] (845s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[174.832073] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[175.833716] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[175.952548] [042/132] (843s left) gem_sync (basic-many-each)
[176.017481] Starting subtest: basic-many-each
[178.309097] Subtest basic-many-each: SUCCESS (2.302s)
[178.492553] [043/132] (841s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[178.579940] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[178.584282] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[178.650367] [044/132] (841s left) syncobj_basic (bad-handle-to-fd)
[178.711774] Starting subtest: bad-handle-to-fd
[178.714119] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[178.815832] [045/132] (841s left) kms_psr (psr-cursor-mmap-gtt)
[178.907852] Starting subtest: psr-cursor-mmap-gtt
[178.910146] Starting dynamic subtest: eDP-1
[180.611562] Dynamic subtest eDP-1: SUCCESS (1.701s)
[180.613502] Subtest psr-cursor-mmap-gtt: SUCCESS (1.702s)
[181.486611] [046/132] (838s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[181.590788] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[181.595285] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[181.698261] [047/132] (838s left) syncobj_eventfd (timeline-wait-before-signal)
[181.751331] Starting subtest: timeline-wait-before-signal
[181.781185] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[181.862596] [048/132] (838s left) syncobj_timeline (transfer-timeline-point)
[181.916160] Starting subtest: transfer-timeline-point
[181.918477] Subtest transfer-timeline-point: SUCCESS (0.000s)
[182.033533] [049/132] (838s left) kms_psr (fbc-pr-suspend)
[182.127710] Starting subtest: fbc-pr-suspend
[182.132053] Subtest fbc-pr-suspend: SKIP (0.000s)
[182.200023] [050/132] (837s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[182.303725] Starting subtest: pr-cursor-plane-move-continuous-sf
[182.308110] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[182.383582] [051/132] (837s left) i915_drm_fdinfo (virtual-busy-hang)
[182.422475] Starting subtest: virtual-busy-hang
[182.426400] Subtest virtual-busy-hang: SKIP (0.000s)
[182.484547] [052/132] (837s left) kms_vrr (flip-dpms)
[182.586686] Starting subtest: flip-dpms
[182.592051] Subtest flip-dpms: SKIP (0.000s)
[182.673007] [053/132] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[182.781387] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[186.663824] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.884s)
[187.796658] [054/132] (832s left) gem_ctx_shared (detached-shared-gtt)
[187.850644] Starting subtest: detached-shared-gtt
[190.002797] Subtest detached-shared-gtt: SUCCESS (2.151s)
[190.336384] [055/132] (830s left) gem_exec_gttfill (engines)
[190.390720] Starting subtest: engines
[190.392605] Starting dynamic subtest: rcs0
[213.967904] Dynamic subtest rcs0: SUCCESS (23.576s)
[213.980103] Starting dynamic subtest: bcs0
[237.281332] Dynamic subtest bcs0: SUCCESS (23.312s)
[237.290909] Starting dynamic subtest: vcs0
[260.595437] Dynamic subtest vcs0: SUCCESS (23.311s)
[260.607413] Starting dynamic subtest: vcs1
[283.895492] Dynamic subtest vcs1: SUCCESS (23.299s)
[283.908250] Starting dynamic subtest: vecs0
[307.235121] Dynamic subtest vecs0: SUCCESS (23.338s)
[307.251905] Starting dynamic subtest: ccs0
[330.556940] Dynamic subtest ccs0: SUCCESS (23.318s)
[330.559380] Subtest engines: SUCCESS (140.164s)
[330.747517] [056/132] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[330.883636] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[337.622846] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.742s)
[337.750558] [057/132] (682s left) gem_exec_flush (basic-batch-kernel-default-uc)
[337.814969] Starting subtest: basic-batch-kernel-default-uc
[345.152160] Subtest basic-batch-kernel-default-uc: SUCCESS (7.337s)
[345.339595] [058/132] (675s left) kms_prop_blob (blob-prop-lifetime)
[345.401397] Starting subtest: blob-prop-lifetime
[345.403784] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[345.507757] [059/132] (675s left) gem_watchdog (default-physical)
[345.582039] Starting subtest: default-physical
[347.352276] Subtest default-physical: SUCCESS (1.780s)
[347.455584] [060/132] (673s left) kms_selftest (drm_dp_mst_helper)
[347.502092] Starting subtest: drm_dp_mst_helper
[347.554365] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[347.648732] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.093s)
[347.657996] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[347.744643] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s)
[347.754028] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[347.873343] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s)
[347.875509] Subtest drm_dp_mst_helper: SUCCESS (0.370s)
[348.044221] [061/132] (672s left) kms_atomic_transition (plane-all-transition-nonblocking)
[348.151072] Starting subtest: plane-all-transition-nonblocking
[348.153326] Starting dynamic subtest: pipe-A-eDP-1
[350.644696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[350.965619] Starting dynamic subtest: pipe-B-eDP-1
[354.214257] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[354.516011] Subtest plane-all-transition-nonblocking: SUCCESS (6.364s)
[355.335535] [062/132] (665s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[355.431154] Starting subtest: fbc-rgb101010-draw-mmap-wc
[360.012405] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.583s)
[361.131549] [063/132] (659s left) gem_userptr_blits (sync-unmap-after-close)
[361.201184] Starting subtest: sync-unmap-after-close
[361.209367] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[361.344300] [064/132] (659s left) gem_mmap_offset (partial-mmap)
[361.408362] Starting subtest: partial-mmap
[361.410296] Starting dynamic subtest: smem0
[361.412632] Dynamic subtest smem0: SUCCESS (0.004s)
[361.414910] Subtest partial-mmap: SUCCESS (0.005s)
[361.526766] [065/132] (659s left) perf_pmu (busy-idle-check-all)
[361.570081] Starting subtest: busy-idle-check-all
[361.572293] Starting dynamic subtest: rcs0
[362.221639] Dynamic subtest rcs0: SUCCESS (0.652s)
[362.233277] Starting dynamic subtest: bcs0
[362.872756] Dynamic subtest bcs0: SUCCESS (0.649s)
[362.885584] Starting dynamic subtest: vcs0
[364.220388] Dynamic subtest vcs0: SUCCESS (1.343s)
[364.232856] Starting dynamic subtest: vcs1
[366.267966] Dynamic subtest vcs1: SUCCESS (2.044s)
[366.279764] Starting dynamic subtest: vecs0
[368.252248] Dynamic subtest vecs0: SUCCESS (1.981s)
[368.264916] Starting dynamic subtest: ccs0
[368.909499] Dynamic subtest ccs0: SUCCESS (0.656s)
[368.911978] Subtest busy-idle-check-all: SUCCESS (7.342s)
[369.016636] [066/132] (651s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[369.125900] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[370.171366] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[370.307738] [067/132] (650s left) kms_plane_cursor (viewport)
[370.410395] Starting subtest: viewport
[370.414188] Starting dynamic subtest: pipe-A-eDP-1-size-64
[372.976187] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s)
[373.035462] Starting dynamic subtest: pipe-A-eDP-1-size-128
[375.554701] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[375.613287] Starting dynamic subtest: pipe-A-eDP-1-size-256
[378.144863] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[378.490959] Starting dynamic subtest: pipe-B-eDP-1-size-64
[381.750468] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.270s)
[381.810289] Starting dynamic subtest: pipe-B-eDP-1-size-128
[384.362424] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[384.423105] Starting dynamic subtest: pipe-B-eDP-1-size-256
[387.030031] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.615s)
[387.392585] Starting dynamic subtest: pipe-C-eDP-1-size-64
[390.225319] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.842s)
[390.261471] Starting dynamic subtest: pipe-C-eDP-1-size-128
[392.446026] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[392.485623] Starting dynamic subtest: pipe-C-eDP-1-size-256
[394.678953] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[395.012258] Starting dynamic subtest: pipe-D-eDP-1-size-64
[397.826388] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.826s)
[397.865977] Starting dynamic subtest: pipe-D-eDP-1-size-128
[400.016376] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[400.054357] Starting dynamic subtest: pipe-D-eDP-1-size-256
[402.238297] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[402.560989] Subtest viewport: SUCCESS (32.150s)
[403.442325] [068/132] (617s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[403.553128] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[404.522012] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.968s)
[404.645823] [069/132] (616s left) kms_lease (atomic-implicit-crtc)
[404.737376] Starting subtest: atomic-implicit-crtc
[404.739715] Starting dynamic subtest: pipe-A-eDP-1
[404.751404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[404.765732] Starting dynamic subtest: pipe-B-eDP-1
[404.776950] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[404.786860] Starting dynamic subtest: pipe-C-eDP-1
[404.797340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[404.807967] Starting dynamic subtest: pipe-D-eDP-1
[404.816815] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[404.818663] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[404.865781] [070/132] (616s left) gem_exec_schedule (noreorder)
[405.044224] Starting subtest: noreorder
[405.046942] Starting dynamic subtest: rcs0
[405.104274] Dynamic subtest rcs0: SUCCESS (0.060s)
[405.116697] Starting dynamic subtest: vcs0
[406.241291] Dynamic subtest vcs0: SUCCESS (1.134s)
[406.257502] Starting dynamic subtest: vcs1
[408.162544] Dynamic subtest vcs1: SUCCESS (1.919s)
[408.177696] Starting dynamic subtest: vecs0
[410.178342] Dynamic subtest vecs0: SUCCESS (2.013s)
[410.191082] Starting dynamic subtest: ccs0
[410.260928] Dynamic subtest ccs0: SUCCESS (0.081s)
[410.263854] Subtest noreorder: SUCCESS (5.218s)
[410.447564] [071/132] (610s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[410.557939] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[410.559842] Starting dynamic subtest: pipe-A-eDP-1
[411.317329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[411.327979] Starting dynamic subtest: pipe-B-eDP-1
[413.173551] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.855s)
[413.184082] Starting dynamic subtest: pipe-C-eDP-1
[415.000780] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.826s)
[415.011291] Starting dynamic subtest: pipe-D-eDP-1
[416.848329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.845s)
[416.850543] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.284s)
[417.982442] [072/132] (603s left) gem_exercise_blt (fast-copy-emit)
[418.044437] Starting subtest: fast-copy-emit
[418.046636] Starting dynamic subtest: linear-smem-smem-emit
[418.066540] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[418.079928] Starting dynamic subtest: xmajor-smem-smem-emit
[418.084769] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[418.094367] Starting dynamic subtest: tile4-smem-smem-emit
[418.100095] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[418.109496] Starting dynamic subtest: tile64-smem-smem-emit
[418.116771] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[418.119021] Subtest fast-copy-emit: SUCCESS (0.073s)
[418.234169] [073/132] (602s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[418.357163] Starting subtest: cursorB-vs-flipB-varying-size
[418.361481] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[418.515962] [074/132] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[418.609023] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[425.659166] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.053s)
[425.773576] [075/132] (595s left) kms_psr (fbc-pr-cursor-blt)
[425.877073] Starting subtest: fbc-pr-cursor-blt
[425.881593] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[425.949635] [076/132] (595s left) kms_debugfs (display-off-read-all)
[426.039104] Starting subtest: display-off-read-all
[426.336313] Subtest display-off-read-all: SUCCESS (0.297s)
[427.139481] [077/132] (594s left) kms_cursor_edge_walk (64x64-left-edge)
[427.232387] Starting subtest: 64x64-left-edge
[427.234749] Starting dynamic subtest: pipe-A-eDP-1
[430.704279] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[430.713755] Starting dynamic subtest: pipe-D-eDP-1
[433.832043] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[433.834243] Subtest 64x64-left-edge: SUCCESS (6.601s)
[434.628765] [078/132] (586s left) prime_busy (hang)
[434.690412] Starting subtest: hang
[434.692589] Starting dynamic subtest: rcs0
[460.756775] Dynamic subtest rcs0: SUCCESS (26.062s)
[460.765933] Starting dynamic subtest: bcs0
[467.912751] Dynamic subtest bcs0: SUCCESS (7.155s)
[467.921933] Starting dynamic subtest: vcs0
[474.888931] Dynamic subtest vcs0: SUCCESS (6.978s)
[474.898374] Starting dynamic subtest: vcs1
[481.926156] Dynamic subtest vcs1: SUCCESS (7.036s)
[481.935577] Starting dynamic subtest: vecs0
[488.898078] Dynamic subtest vecs0: SUCCESS (6.971s)
[488.907675] Starting dynamic subtest: ccs0
[502.740792] Dynamic subtest ccs0: SUCCESS (13.838s)
[502.742955] Subtest hang: SUCCESS (68.046s)
[502.868272] [079/132] (518s left) syncobj_wait (invalid-reset-zero-handles)
[502.919546] Starting subtest: invalid-reset-zero-handles
[502.922265] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[503.012600] [080/132] (518s left) gem_exec_reloc (basic-cpu-wc-active)
[503.063831] Subtest basic-cpu-wc-active: SKIP (0.000s)
[503.140583] [081/132] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[503.245161] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[503.249378] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[503.348131] [082/132] (518s left) gem_mmap_wc (fault-concurrent)
[503.407072] Subtest fault-concurrent: SKIP (0.000s)
[503.472363] [083/132] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[503.566354] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[503.570665] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[503.656307] [084/132] (517s left) dmabuf_sync_file (export-multiwait)
[503.699484] Starting subtest: export-multiwait
[503.701789] Subtest export-multiwait: SUCCESS (0.000s)
[503.759954] [085/132] (517s left) gem_create (create-valid-nonaligned)
[503.816426] Starting subtest: create-valid-nonaligned
[503.818307] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[504.013906] [086/132] (517s left) gem_fence_thrash (bo-write-verify-none)
[504.056055] Starting subtest: bo-write-verify-none
[504.086773] Subtest bo-write-verify-none: SKIP (0.027s)
[504.150327] [087/132] (517s left) kms_plane_alpha_blend (constant-alpha-max)
[504.250974] Starting subtest: constant-alpha-max
[504.560281] Starting dynamic subtest: pipe-A-eDP-1
[505.580975] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.021s)
[505.591178] Starting dynamic subtest: pipe-D-eDP-1
[507.318482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.736s)
[507.321200] Subtest constant-alpha-max: SUCCESS (3.070s)
[508.188612] [088/132] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[508.294824] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[508.299300] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[508.395044] [089/132] (513s left) kms_rmfb (rmfb-ioctl)
[508.495189] Starting subtest: rmfb-ioctl
[508.497473] Starting dynamic subtest: pipe-A-eDP-1
[508.598390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[508.609672] Starting dynamic subtest: pipe-B-eDP-1
[509.744664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[509.756353] Starting dynamic subtest: pipe-C-eDP-1
[510.889789] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.141s)
[510.899735] Starting dynamic subtest: pipe-D-eDP-1
[512.022332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[512.024716] Subtest rmfb-ioctl: SUCCESS (3.530s)
[513.143871] [090/132] (508s left) syncobj_wait (reset-during-wait-for-submit)
[513.208245] Starting subtest: reset-during-wait-for-submit
[513.311767] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[513.400940] [091/132] (508s left) kms_chamelium_edid (dp-mode-timings)
[513.786043] Subtest dp-mode-timings: SKIP (0.000s)
[514.563448] [092/132] (507s left) gem_userptr_blits (sync-unmap-cycles)
[514.633926] Starting subtest: sync-unmap-cycles
[520.008484] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[520.160217] [093/132] (501s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[520.276713] Starting subtest: extended-modeset-hang-oldfb-with-reset
[520.278700] Starting dynamic subtest: pipe-A
[531.847989] Dynamic subtest pipe-A: SUCCESS (11.570s)
[531.862407] Starting dynamic subtest: pipe-D
[544.119530] Dynamic subtest pipe-D: SUCCESS (12.266s)
[544.121951] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.841s)
[544.923452] [094/132] (477s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[544.991778] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[544.996378] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[545.179232] [095/132] (476s left) api_intel_bb (lot-of-buffers)
[545.237648] Starting subtest: lot-of-buffers
[546.295433] Subtest lot-of-buffers: SUCCESS (1.059s)
[546.685682] [096/132] (475s left) gem_exec_fence (syncobj-timeline-repeat)
[547.276781] Starting subtest: syncobj-timeline-repeat
[547.527264] Subtest syncobj-timeline-repeat: SUCCESS (0.250s)
[548.303206] [097/132] (473s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[548.378532] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[548.488166] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[548.565954] [098/132] (473s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[548.672930] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[548.675108] Starting dynamic subtest: pipe-A-eDP-1
[548.694849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[548.711116] Starting dynamic subtest: pipe-B-eDP-1
[548.730180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[548.743304] Starting dynamic subtest: pipe-C-eDP-1
[548.762097] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[548.771894] Starting dynamic subtest: pipe-D-eDP-1
[548.791031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[548.792924] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[550.989402] [099/132] (471s left) kms_pm_rpm (dpms-lpsp)
[552.524308] Starting subtest: dpms-lpsp
[553.166116] Subtest dpms-lpsp: SUCCESS (0.642s)
[553.255507] [100/132] (469s left) syncobj_wait (invalid-reset-bad-pad)
[553.315505] Starting subtest: invalid-reset-bad-pad
[553.317844] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[553.423361] [101/132] (468s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[553.520831] Starting subtest: bad-pixel-format-yf-tiled-ccs
[553.523248] Starting dynamic subtest: pipe-A-eDP-1
[553.544820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[553.555035] Starting dynamic subtest: pipe-B-eDP-1
[553.575164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[553.584334] Starting dynamic subtest: pipe-C-eDP-1
[553.604909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[553.614513] Starting dynamic subtest: pipe-D-eDP-1
[553.635303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[553.639441] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[555.785725] [102/132] (466s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[555.876159] Starting subtest: psr-rgb101010-draw-mmap-cpu
[562.973550] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.100s)
[563.089744] [103/132] (459s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[563.183998] Starting subtest: invalidate-primary-flip-overlay
[573.988221] Subtest invalidate-primary-flip-overlay: SUCCESS (10.807s)
[574.105882] [104/132] (448s left) gem_exec_reloc (basic-cpu-read)
[574.169236] Subtest basic-cpu-read: SKIP (0.000s)
[574.246218] [105/132] (448s left) syncobj_wait (invalid-signal-illegal-handle)
[574.301585] Starting subtest: invalid-signal-illegal-handle
[574.303603] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[574.414887] [106/132] (448s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[574.505346] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[574.507205] Starting dynamic subtest: pipe-A-default-mode
[575.663041] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[575.667545] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.156s)
[575.799612] [107/132] (446s left) syncobj_timeline (multi-wait-all-signaled)
[575.868342] Starting subtest: multi-wait-all-signaled
[575.870278] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[575.980408] [108/132] (446s left) gem_eio (execbuf)
[576.209622] Starting subtest: execbuf
[576.551455] Subtest execbuf: SUCCESS (0.341s)
[576.702538] [109/132] (445s left) gem_set_tiling_vs_pwrite
[576.827282] [110/132] (445s left) i915_hangman (engine-error-state-capture)
[576.884251] Starting subtest: engine-error-state-capture
[576.885793] Starting dynamic subtest: rcs0
[580.185190] Dynamic subtest rcs0: SUCCESS (3.300s)
[580.198628] Starting dynamic subtest: bcs0
[586.202980] Dynamic subtest bcs0: SUCCESS (6.014s)
[586.216392] Starting dynamic subtest: vcs0
[592.153963] Dynamic subtest vcs0: SUCCESS (5.947s)
[592.167625] Starting dynamic subtest: vcs1
[598.170937] Dynamic subtest vcs1: SUCCESS (6.013s)
[598.184108] Starting dynamic subtest: vecs0
[604.186599] Dynamic subtest vecs0: SUCCESS (6.013s)
[604.200497] Starting dynamic subtest: ccs0
[610.201774] Dynamic subtest ccs0: SUCCESS (6.012s)
[610.204765] Subtest engine-error-state-capture: SUCCESS (33.317s)
[610.285173] [111/132] (412s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[610.383847] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[616.966737] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.587s)
[617.106933] [112/132] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[617.211811] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[617.216282] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.313755] [113/132] (405s left) gen7_exec_parse (oacontrol-tracking)
[617.370280] Subtest oacontrol-tracking: SKIP (0.000s)
[617.440045] [114/132] (405s left) syncobj_timeline (invalid-transfer-non-existent-point)
[617.491385] Starting subtest: invalid-transfer-non-existent-point
[617.493706] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[617.582160] [115/132] (405s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[617.671270] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[617.675693] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[617.746678] [116/132] (405s left) gem_exec_balancer (semaphore)
[617.813719] Starting subtest: semaphore
[619.250381] Subtest semaphore: SUCCESS (1.435s)
[619.569020] [117/132] (403s left) kms_async_flips (async-flip-hang)
[619.665770] Starting subtest: async-flip-hang
[620.053796] Starting dynamic subtest: pipe-A-eDP-1
[635.735909] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.679s)
[636.129651] Starting dynamic subtest: pipe-B-eDP-1
[651.736319] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.611s)
[652.127370] Starting dynamic subtest: pipe-C-eDP-1
[667.731129] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.609s)
[668.108159] Starting dynamic subtest: pipe-D-eDP-1
[683.732767] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.629s)
[683.735453] Subtest async-flip-hang: SUCCESS (64.064s)
[684.956458] [118/132] (338s left) kms_color (ctm-red-to-blue)
[685.040227] Starting subtest: ctm-red-to-blue
[685.042372] Starting dynamic subtest: pipe-A-eDP-1
[685.750862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[685.761351] Starting dynamic subtest: pipe-B-eDP-1
[687.152159] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[687.162258] Starting dynamic subtest: pipe-C-eDP-1
[688.526206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[688.537655] Starting dynamic subtest: pipe-D-eDP-1
[689.883941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[689.886384] Subtest ctm-red-to-blue: SUCCESS (4.845s)
[690.768202] [119/132] (332s left) gem_exec_balancer (parallel)
[691.022971] Starting subtest: parallel
[691.998588] Subtest parallel: SUCCESS (0.976s)
[692.274417] [120/132] (330s left) gem_mmap_wc (write-wc-read-gtt)
[692.332912] Subtest write-wc-read-gtt: SKIP (0.000s)
[692.404369] [121/132] (330s left) kms_plane_scaling (planes-upscale-factor-0-25)
[692.496951] Starting subtest: planes-upscale-factor-0-25
[692.499225] Starting dynamic subtest: pipe-A
[692.558775] Dynamic subtest pipe-A: SUCCESS (0.063s)
[692.570935] Starting dynamic subtest: pipe-B
[693.695120] Dynamic subtest pipe-B: SUCCESS (1.135s)
[693.708093] Starting dynamic subtest: pipe-C
[694.820637] Dynamic subtest pipe-C: SUCCESS (1.123s)
[694.836866] Starting dynamic subtest: pipe-D
[695.933917] Dynamic subtest pipe-D: SUCCESS (1.113s)
[695.936230] Subtest planes-upscale-factor-0-25: SUCCESS (3.439s)
[697.143824] [122/132] (326s left) gem_eio (in-flight-suspend)
[697.352424] Starting subtest: in-flight-suspend
[740.920049] Subtest in-flight-suspend: SUCCESS (14.042s)
[741.064132] [123/132] (282s left) gem_ctx_exec (basic-norecovery)
[741.127940] Starting subtest: basic-norecovery
[741.427565] Subtest basic-norecovery: SUCCESS (0.299s)
[741.540241] [124/132] (281s left) kms_big_fb (4-tiled-addfb)
[741.632359] Starting subtest: 4-tiled-addfb
[741.634616] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[741.736355] [125/132] (281s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[741.847355] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[741.851310] Starting dynamic subtest: pipe-A
[742.075240] Dynamic subtest pipe-A: SUCCESS (0.230s)
[742.085481] Starting dynamic subtest: pipe-B
[743.424307] Dynamic subtest pipe-B: SUCCESS (1.347s)
[743.435732] Starting dynamic subtest: pipe-C
[744.735586] Dynamic subtest pipe-C: SUCCESS (1.309s)
[744.745924] Starting dynamic subtest: pipe-D
[746.067396] Dynamic subtest pipe-D: SUCCESS (1.330s)
[746.069707] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.219s)
[747.251481] [126/132] (276s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[747.363805] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[753.954036] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.588s)
[754.081967] [127/132] (269s left) sysfs_timeslice_duration (invalid)
[754.152229] Starting subtest: invalid
[754.154808] Starting dynamic subtest: vecs0
[754.157313] Dynamic subtest vecs0: SUCCESS (0.000s)
[754.169646] Starting dynamic subtest: ccs0
[754.171659] Dynamic subtest ccs0: SUCCESS (0.000s)
[754.181409] Starting dynamic subtest: vcs0
[754.183344] Dynamic subtest vcs0: SUCCESS (0.000s)
[754.193231] Starting dynamic subtest: bcs0
[754.195216] Dynamic subtest bcs0: SUCCESS (0.000s)
[754.205725] Starting dynamic subtest: rcs0
[754.207907] Dynamic subtest rcs0: SUCCESS (0.000s)
[754.217827] Starting dynamic subtest: vcs1
[754.219726] Dynamic subtest vcs1: SUCCESS (0.000s)
[754.221658] Subtest invalid: SUCCESS (0.006s)
[754.282801] [128/132] (269s left) gem_exec_schedule (semaphore-codependency)
[754.347986] Starting subtest: semaphore-codependency
[754.352395] Subtest semaphore-codependency: SUCCESS (0.012s)
[754.710597] [129/132] (268s left) syncobj_timeline (etime-single-wait-submitted)
[754.772723] Starting subtest: etime-single-wait-submitted
[754.876245] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[754.958588] [130/132] (268s left) perf_pmu (busy-accuracy-2)
[755.000943] Starting subtest: busy-accuracy-2
[755.003162] Starting dynamic subtest: rcs0
[758.048214] Dynamic subtest rcs0: SUCCESS (3.043s)
[758.061069] Starting dynamic subtest: bcs0
[761.107963] Dynamic subtest bcs0: SUCCESS (3.057s)
[761.120662] Starting dynamic subtest: vcs0
[764.155839] Dynamic subtest vcs0: SUCCESS (3.044s)
[764.168373] Starting dynamic subtest: vcs1
[767.204204] Dynamic subtest vcs1: SUCCESS (3.045s)
[767.216923] Starting dynamic subtest: vecs0
[770.250524] Dynamic subtest vecs0: SUCCESS (3.043s)
[770.263124] Starting dynamic subtest: ccs0
[773.309254] Dynamic subtest ccs0: SUCCESS (3.055s)
[773.311699] Subtest busy-accuracy-2: SUCCESS (18.303s)
[773.427018] [131/132] (250s left) syncobj_wait (single-wait-signaled)
[773.488904] Starting subtest: single-wait-signaled
[773.491277] Subtest single-wait-signaled: SUCCESS (0.000s)
[773.592103] [132/132] (250s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[773.684345] Starting subtest: y-tiled-16bpp-rotate-0
[773.688339] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[773.774283] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: kms_pipe_b_c_ivb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: i915_pm_freq_mult
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: gem_exec_store
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_vrr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: gem_exec_gttfill
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_flush
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: gem_watchdog
results: parsing output: 59/ for test: kms_selftest
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_plane_cursor
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_exercise_blt
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_debugfs
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: dmabuf_sync_file
results: parsing output: 84/ for test: gem_create
results: parsing output: 85/ for test: gem_fence_thrash
results: parsing output: 86/ for test: kms_plane_alpha_blend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rmfb
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr_stress_test
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 109/ for test: i915_hangman
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: gem_ctx_exec
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_big_fb
Done.