[56.571497] Initializing watchdogs
[56.571544]   /dev/watchdog0
[56.586921] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.591571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.594984] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.599907] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[56.733545] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[56.737658] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[56.842210] [002/133] (960s left) gem_ppgtt (blt-vs-render-ctxn)
[56.906191] Starting subtest: blt-vs-render-ctxN
[89.783063] Subtest blt-vs-render-ctxN: SUCCESS (32.874s)
[89.914263] [003/133] (927s left) gem_create (create-ext-placement-sanity-check)
[90.122075] Starting subtest: create-ext-placement-sanity-check
[90.124881] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[90.236809] [004/133] (926s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[90.352238] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[90.389648] Starting dynamic subtest: pipe-A-plane-0
[91.055962] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s)
[91.065846] Starting dynamic subtest: pipe-A-plane-3
[91.478522] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[92.568477] Starting dynamic subtest: pipe-B-plane-0
[93.182581] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[93.191986] Starting dynamic subtest: pipe-B-plane-3
[93.604498] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[93.913782] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.563s)
[94.747039] [005/133] (922s left) dmabuf_sync_file (export-wait-after-attach)
[94.895528] Starting subtest: export-wait-after-attach
[94.897979] Subtest export-wait-after-attach: SUCCESS (0.001s)
[94.985158] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[94.988651] [006/133] (922s left) i915_drm_fdinfo (busy-idle)
[95.034060] Starting subtest: busy-idle
[95.036272] Starting dynamic subtest: rcs0
[95.069949] Dynamic subtest rcs0: SKIP (0.035s)
[95.080669] Starting dynamic subtest: bcs0
[95.085306] Dynamic subtest bcs0: SKIP (0.001s)
[95.093393] Starting dynamic subtest: vcs0
[95.097770] Dynamic subtest vcs0: SKIP (0.001s)
[95.105436] Starting dynamic subtest: vcs1
[95.109470] Dynamic subtest vcs1: SKIP (0.000s)
[95.119639] Starting dynamic subtest: vecs0
[95.123655] Dynamic subtest vecs0: SKIP (0.000s)
[95.131270] Starting dynamic subtest: ccs0
[95.135217] Dynamic subtest ccs0: SKIP (0.000s)
[95.139168] Subtest busy-idle: SKIP (0.039s)
[95.175275] [007/133] (922s left) kms_draw_crc (draw-method-blt)
[95.275053] Starting subtest: draw-method-blt
[95.277245] Starting dynamic subtest: xrgb8888-untiled
[95.539620] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[95.549063] Starting dynamic subtest: rgb565-untiled
[95.761135] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[95.769320] Starting dynamic subtest: xrgb2101010-untiled
[95.983345] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[95.991250] Starting dynamic subtest: xbgr16161616f-untiled
[96.205794] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[96.214126] Starting dynamic subtest: xrgb8888-xtiled
[96.327935] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[96.336849] Starting dynamic subtest: rgb565-xtiled
[96.450070] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[96.458747] Starting dynamic subtest: xrgb2101010-xtiled
[96.561141] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[96.570080] Starting dynamic subtest: xbgr16161616f-xtiled
[96.672454] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[96.681062] Starting dynamic subtest: xrgb8888-4tiled
[96.783664] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[96.792790] Starting dynamic subtest: rgb565-4tiled
[96.883527] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[96.892611] Starting dynamic subtest: xrgb2101010-4tiled
[96.994749] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[97.003308] Starting dynamic subtest: xbgr16161616f-4tiled
[97.094732] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s)
[97.096634] Subtest draw-method-blt: SUCCESS (1.822s)
[97.212089] [008/133] (920s left) kms_vblank (ts-continuation-idle)
[97.304941] Starting subtest: ts-continuation-idle
[97.306827] Starting dynamic subtest: pipe-A-eDP-1
[97.708331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[97.725302] Starting dynamic subtest: pipe-D-eDP-1
[98.837845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[98.840184] Subtest ts-continuation-idle: SUCCESS (1.532s)
[99.725935] [009/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[99.830979] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[99.834942] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[99.939657] [010/133] (917s left) gem_exec_schedule (implicit-read-write)
[100.005714] Starting subtest: implicit-read-write
[100.007612] Starting dynamic subtest: rcs0
[100.102213] Dynamic subtest rcs0: SUCCESS (0.106s)
[100.115149] Starting dynamic subtest: vcs0
[100.193092] Dynamic subtest vcs0: SUCCESS (0.091s)
[100.202396] Starting dynamic subtest: vcs1
[100.279217] Dynamic subtest vcs1: SUCCESS (0.086s)
[100.289785] Starting dynamic subtest: vecs0
[100.357534] Dynamic subtest vecs0: SUCCESS (0.078s)
[100.368980] Starting dynamic subtest: ccs0
[100.471978] Dynamic subtest ccs0: SUCCESS (0.113s)
[100.474568] Subtest implicit-read-write: SUCCESS (0.476s)
[101.360786] [011/133] (916s left) gem_ctx_param (invalid-get-ringsize)
[101.420852] Starting subtest: invalid-get-ringsize
[101.423252] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[101.525950] [012/133] (916s left) gem_ctx_persistence (heartbeat-many)
[101.594037] Starting subtest: heartbeat-many
[101.598522] Subtest heartbeat-many: SKIP (0.000s)
[101.713936] [013/133] (915s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[101.820750] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[101.825121] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[101.889516] [014/133] (915s left) gem_ccs (ctrl-surf-copy)
[101.965656] Starting subtest: ctrl-surf-copy
[101.970126] Subtest ctrl-surf-copy: SKIP (0.000s)
[102.058095] [015/133] (915s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[102.153017] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[102.157142] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[102.255189] [016/133] (915s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[102.346931] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[102.358931] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[102.461655] [017/133] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[102.560527] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[102.563993] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[102.645388] [018/133] (915s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[102.733523] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[102.737151] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[102.809821] [019/133] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[102.901862] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[107.435897] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.538s)
[108.637988] [020/133] (909s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[108.735264] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[108.739955] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[108.833693] [021/133] (909s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[110.493653] Starting subtest: dpms-mode-unset-lpsp
[114.562090] Subtest dpms-mode-unset-lpsp: SUCCESS (4.072s)
[114.957930] [022/133] (903s left) kms_chamelium_frames (dp-crc-single)
[115.348985] Subtest dp-crc-single: SKIP (0.000s)
[116.165796] [023/133] (901s left) kms_atomic_interruptible (universal-setplane-cursor)
[116.257192] Starting subtest: universal-setplane-cursor
[116.259609] Starting dynamic subtest: pipe-A-eDP-1
[123.715205] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.457s)
[123.717620] Subtest universal-setplane-cursor: SUCCESS (7.458s)
[124.580386] [024/133] (893s left) sysfs_timeslice_duration (timeout)
[124.650779] Starting subtest: timeout
[124.652733] Starting dynamic subtest: vecs0
[134.300883] Dynamic subtest vecs0: SUCCESS (9.649s)
[134.311752] Starting dynamic subtest: ccs0
[135.591931] Dynamic subtest ccs0: SUCCESS (1.291s)
[135.603564] Starting dynamic subtest: vcs0
[145.308667] Dynamic subtest vcs0: SUCCESS (9.714s)
[145.318760] Starting dynamic subtest: bcs0
[145.923047] Dynamic subtest bcs0: SUCCESS (0.615s)
[145.936137] Starting dynamic subtest: rcs0
[147.181855] Dynamic subtest rcs0: SUCCESS (1.258s)
[147.192805] Starting dynamic subtest: vcs1
[156.315377] Dynamic subtest vcs1: SUCCESS (9.129s)
[156.317745] Subtest timeout: SUCCESS (31.664s)
[156.389027] [025/133] (861s left) gem_render_linear_blits (basic)
[156.444676] Starting subtest: basic
[156.479167] Subtest basic: SUCCESS (0.036s)
[156.576825] [026/133] (861s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[156.629722] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[156.632126] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[156.735172] [027/133] (861s left) kms_psr (fbc-psr-sprite-blt)
[156.831986] Starting subtest: fbc-psr-sprite-blt
[156.834258] Starting dynamic subtest: eDP-1
[156.838814] Dynamic subtest eDP-1: SKIP (0.000s)
[156.843436] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[156.918636] [028/133] (861s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[157.020759] Starting subtest: pr-plane-move-sf-dmg-area
[157.025232] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[157.122341] [029/133] (861s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[157.242456] Starting subtest: yf-tiled-64bpp-rotate-0
[157.246488] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[157.336357] [030/133] (861s left) gem_userptr_blits (forbidden-operations)
[157.397922] Starting subtest: forbidden-operations
[157.401320] Subtest forbidden-operations: SKIP (0.000s)
[157.525160] [031/133] (860s left) api_intel_allocator (reloc-allocator)
[157.577434] Starting subtest: reloc-allocator
[157.579370] Starting dynamic subtest: basic
[157.580981] Dynamic subtest basic: SUCCESS (0.003s)
[157.590722] Starting dynamic subtest: parallel-one
[157.592624] Dynamic subtest parallel-one: SUCCESS (0.008s)
[157.600905] Starting dynamic subtest: print
[157.602719] Dynamic subtest print: SUCCESS (0.000s)
[157.610152] Starting dynamic subtest: reuse
[157.611720] Dynamic subtest reuse: SUCCESS (0.000s)
[157.619189] Starting dynamic subtest: fork-reopen-allocator
[157.620716] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[157.622310] Subtest reloc-allocator: SUCCESS (0.024s)
[157.722272] [032/133] (860s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[157.822167] Starting subtest: x-tiled-32bpp-rotate-90
[157.841848] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[157.942841] [033/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[158.029425] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[165.393036] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.366s)
[165.515885] [034/133] (853s left) gem_exec_create (legacy)
[165.574908] Starting subtest: legacy
[165.577252] Starting dynamic subtest: smem
[169.250922] Dynamic subtest smem: SUCCESS (3.676s)
[169.253605] Subtest legacy: SUCCESS (3.678s)
[169.439667] [035/133] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[169.549489] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[176.110250] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.563s)
[176.245228] [036/133] (842s left) gem_exec_whisper (basic-fds-all)
[176.317942] Starting subtest: basic-fds-all
[188.289881] Subtest basic-fds-all: SUCCESS (11.970s)
[188.476755] [037/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[188.576831] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[188.581085] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[188.692984] [038/133] (829s left) perf_pmu (invalid-open)
[188.730719] Starting subtest: invalid-open
[188.732629] Subtest invalid-open: SUCCESS (0.000s)
[188.842779] [039/133] (829s left) perf_pmu (busy-accuracy-2)
[188.888743] Starting subtest: busy-accuracy-2
[188.890974] Starting dynamic subtest: rcs0
[191.932068] Dynamic subtest rcs0: SUCCESS (3.042s)
[191.941991] Starting dynamic subtest: bcs0
[195.044621] Dynamic subtest bcs0: SUCCESS (3.060s)
[195.054610] Starting dynamic subtest: vcs0
[198.085360] Dynamic subtest vcs0: SUCCESS (3.043s)
[198.094605] Starting dynamic subtest: vcs1
[201.134523] Dynamic subtest vcs1: SUCCESS (3.049s)
[201.144089] Starting dynamic subtest: vecs0
[204.184119] Dynamic subtest vecs0: SUCCESS (3.045s)
[204.194832] Starting dynamic subtest: ccs0
[207.246521] Dynamic subtest ccs0: SUCCESS (3.059s)
[207.248572] Subtest busy-accuracy-2: SUCCESS (18.309s)
[207.314896] [040/133] (811s left) kms_content_protection (srm)
[207.471206] Starting subtest: srm
[207.475825] Subtest srm: SKIP (0.005s)
[207.604289] [041/133] (811s left) gem_ctx_param (invalid-param-get)
[207.654240] Starting subtest: invalid-param-get
[207.656752] Subtest invalid-param-get: SUCCESS (0.001s)
[207.756297] [042/133] (811s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[207.847664] Starting subtest: psr-rgb565-draw-mmap-gtt
[207.852073] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[207.963175] [043/133] (810s left) kms_psr (fbc-psr-suspend)
[208.064145] Starting subtest: fbc-psr-suspend
[208.066360] Starting dynamic subtest: eDP-1
[208.070438] Dynamic subtest eDP-1: SKIP (0.000s)
[208.074586] Subtest fbc-psr-suspend: SKIP (0.001s)
[208.151144] [044/133] (810s left) kms_setmode (basic-clone-single-crtc)
[208.204279] Starting subtest: basic-clone-single-crtc
[208.209521] Subtest basic-clone-single-crtc: SKIP (0.000s)
[208.285316] [045/133] (810s left) kms_flip (flip-vs-wf_vblank-interruptible)
[208.369467] Starting subtest: flip-vs-wf_vblank-interruptible
[208.373481] Starting dynamic subtest: A-eDP1
[210.266645] Dynamic subtest A-eDP1: SUCCESS (1.895s)
[210.276281] Starting dynamic subtest: B-eDP1
[212.197553] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[212.212054] Starting dynamic subtest: C-eDP1
[214.118900] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[214.130053] Starting dynamic subtest: D-eDP1
[215.964458] Dynamic subtest D-eDP1: SUCCESS (1.843s)
[215.966466] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.596s)
[217.201890] [046/133] (801s left) kms_psr (psr-primary-mmap-cpu)
[217.303327] Starting subtest: psr-primary-mmap-cpu
[217.305682] Starting dynamic subtest: eDP-1
[218.993283] Dynamic subtest eDP-1: SUCCESS (1.689s)
[218.995671] Subtest psr-primary-mmap-cpu: SUCCESS (1.690s)
[219.871734] [047/133] (799s left) gem_pread (bench)
[219.933994] Subtest bench: SKIP (0.000s)
[220.029658] [048/133] (799s left) gen9_exec_parse (basic-rejected)
[220.104439] Subtest basic-rejected: SKIP (0.000s)
[220.174774] [049/133] (799s left) gem_exec_whisper (basic-queues-forked-all)
[220.240090] Starting subtest: basic-queues-forked-all
[240.532540] Subtest basic-queues-forked-all: SUCCESS (20.233s)
[240.656086] [050/133] (778s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[240.763499] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[245.422659] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.663s)
[246.567337] [051/133] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[246.666283] Starting subtest: psr-1p-primscrn-cur-indfb-move
[254.014339] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.350s)
[254.138205] [052/133] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[254.226407] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[254.230813] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[254.331593] [053/133] (765s left) kms_universal_plane (disable-primary-vs-flip)
[254.434420] Starting subtest: disable-primary-vs-flip
[254.436694] Starting dynamic subtest: pipe-A-eDP-1
[255.943640] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.508s)
[255.955634] Starting dynamic subtest: pipe-B-eDP-1
[258.148487] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.204s)
[258.158457] Starting dynamic subtest: pipe-C-eDP-1
[260.402754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[260.413526] Starting dynamic subtest: pipe-D-eDP-1
[262.567481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.163s)
[262.569790] Subtest disable-primary-vs-flip: SUCCESS (8.134s)
[263.382442] [054/133] (756s left) kms_psr (psr-cursor-plane-move)
[263.475173] Starting subtest: psr-cursor-plane-move
[263.477425] Starting dynamic subtest: eDP-1
[265.166335] Dynamic subtest eDP-1: SUCCESS (1.690s)
[265.168245] Subtest psr-cursor-plane-move: SUCCESS (1.691s)
[266.037217] [055/133] (753s left) gem_exec_params (readonly)
[266.091823] Starting subtest: readonly
[266.094297] Subtest readonly: SUCCESS (0.002s)
[266.215793] [056/133] (753s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[266.306668] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[266.941997] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[267.144394] [057/133] (752s left) kms_cursor_crc (cursor-onscreen-max-size)
[267.439398] Starting subtest: cursor-onscreen-max-size
[267.445733] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[267.560088] [058/133] (752s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[267.665638] Starting subtest: cursorA-vs-flipB-atomic-transitions
[267.670190] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[267.838421] [059/133] (751s left) gen3_render_linear_blits
[267.949056] [060/133] (751s left) gem_ctx_param (invalid-param-set)
[267.998351] Starting subtest: invalid-param-set
[268.000253] Subtest invalid-param-set: SUCCESS (0.000s)
[268.081752] [061/133] (751s left) gem_exec_fence (syncobj-invalid-wait)
[268.539420] Starting subtest: syncobj-invalid-wait
[268.541867] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[270.395432] [062/133] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[270.492141] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[274.797555] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.308s)
[275.933497] [063/133] (743s left) kms_plane (plane-position-hole-dpms)
[276.033424] Starting subtest: plane-position-hole-dpms
[276.559238] Starting dynamic subtest: pipe-A-plane-1
[278.945303] Dynamic subtest pipe-A-plane-1: SUCCESS (2.386s)
[278.956026] Starting dynamic subtest: pipe-A-plane-2
[281.401677] Dynamic subtest pipe-A-plane-2: SUCCESS (2.455s)
[281.411576] Starting dynamic subtest: pipe-A-plane-3
[283.756970] Dynamic subtest pipe-A-plane-3: SUCCESS (2.353s)
[283.767469] Starting dynamic subtest: pipe-A-plane-4
[286.114081] Dynamic subtest pipe-A-plane-4: SUCCESS (2.353s)
[286.131295] Starting dynamic subtest: pipe-A-plane-5
[286.141867] Dynamic subtest pipe-A-plane-5: SUCCESS (0.031s)
[287.299938] Starting dynamic subtest: pipe-B-plane-1
[289.732968] Dynamic subtest pipe-B-plane-1: SUCCESS (2.441s)
[289.742869] Starting dynamic subtest: pipe-B-plane-2
[292.176424] Dynamic subtest pipe-B-plane-2: SUCCESS (2.443s)
[292.186346] Starting dynamic subtest: pipe-B-plane-3
[294.539223] Dynamic subtest pipe-B-plane-3: SUCCESS (2.360s)
[294.558032] Starting dynamic subtest: pipe-B-plane-4
[296.917842] Dynamic subtest pipe-B-plane-4: SUCCESS (2.379s)
[296.928631] Starting dynamic subtest: pipe-B-plane-5
[296.945464] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[296.947813] Subtest plane-position-hole-dpms: SUCCESS (20.911s)
[297.724720] [064/133] (722s left) gem_exec_reloc (basic-gtt-wc)
[297.789050] Subtest basic-gtt-wc: SKIP (0.000s)
[297.859998] [065/133] (722s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[297.965050] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[297.967474] Starting dynamic subtest: pipe-A-eDP-1
[297.990074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[298.002150] Starting dynamic subtest: pipe-B-eDP-1
[298.023564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.032946] Starting dynamic subtest: pipe-C-eDP-1
[298.055234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.065249] Starting dynamic subtest: pipe-D-eDP-1
[298.086391] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.090687] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[300.318653] [066/133] (719s left) syncobj_timeline (device-signal-unordered)
[300.374290] Starting subtest: device-signal-unordered
[300.376479] Subtest device-signal-unordered: SUCCESS (0.001s)
[300.468101] [067/133] (719s left) kms_properties (connector-properties-atomic)
[300.555118] Starting subtest: connector-properties-atomic
[300.557311] Starting dynamic subtest: pipe-A-eDP-1
[308.628876] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.073s)
[308.638198] Starting dynamic subtest: pipe-None-DP-1
[308.642426] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[308.650733] Starting dynamic subtest: pipe-None-HDMI-A-1
[308.654693] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[308.663563] Starting dynamic subtest: pipe-None-DP-2
[308.667784] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[308.676688] Starting dynamic subtest: pipe-None-HDMI-A-2
[308.681078] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[308.689853] Starting dynamic subtest: pipe-None-DP-3
[308.694311] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[308.702864] Starting dynamic subtest: pipe-None-DP-4
[308.707158] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[308.709241] Subtest connector-properties-atomic: SUCCESS (8.085s)
[309.505798] [068/133] (710s left) kms_color (ctm-blue-to-red)
[309.601776] Starting subtest: ctm-blue-to-red
[309.603995] Starting dynamic subtest: pipe-A-eDP-1
[310.278629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.677s)
[310.288777] Starting dynamic subtest: pipe-B-eDP-1
[311.711972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[311.722855] Starting dynamic subtest: pipe-C-eDP-1
[313.076422] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[313.086435] Starting dynamic subtest: pipe-D-eDP-1
[314.386843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[314.388883] Subtest ctm-blue-to-red: SUCCESS (4.784s)
[315.247449] [069/133] (704s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[315.335675] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[315.338041] Starting dynamic subtest: pipe-A-eDP-1
[315.347348] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.358528] Starting dynamic subtest: pipe-B-eDP-1
[315.367630] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.376783] Starting dynamic subtest: pipe-C-eDP-1
[315.385260] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.394234] Starting dynamic subtest: pipe-D-eDP-1
[315.402403] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.406410] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[317.606877] [070/133] (702s left) gem_spin_batch (legacy-resubmit)
[317.661637] Starting subtest: legacy-resubmit
[317.663753] Starting dynamic subtest: default
[317.668676] Dynamic subtest default: SUCCESS (0.006s)
[317.678761] Starting dynamic subtest: render
[317.680882] Dynamic subtest render: SUCCESS (0.001s)
[317.690069] Starting dynamic subtest: bsd
[317.692163] Dynamic subtest bsd: SUCCESS (0.004s)
[317.700965] Starting dynamic subtest: bsd1
[317.703074] Dynamic subtest bsd1: SUCCESS (0.001s)
[317.711823] Starting dynamic subtest: bsd2
[317.713959] Dynamic subtest bsd2: SUCCESS (0.003s)
[317.722646] Starting dynamic subtest: blt
[317.724728] Dynamic subtest blt: SUCCESS (0.002s)
[317.733609] Starting dynamic subtest: vebox
[317.735678] Dynamic subtest vebox: SUCCESS (0.003s)
[317.737781] Subtest legacy-resubmit: SUCCESS (0.027s)
[317.904535] [071/133] (702s left) gem_mmap_offset (open-flood)
[317.953931] Starting subtest: open-flood
[339.442341] Subtest open-flood: SUCCESS (21.490s)
[339.556445] [072/133] (680s left) gem_userptr_blits (set-cache-level)
[339.630191] Starting subtest: set-cache-level
[339.633690] Subtest set-cache-level: SKIP (0.000s)
[339.789357] [073/133] (680s left) i915_pm_rc6_residency (rc6-fence)
[339.849687] Starting subtest: rc6-fence
[339.880222] Starting dynamic subtest: gt0
[352.219211] Dynamic subtest gt0: SUCCESS (12.318s)
[352.229042] Starting dynamic subtest: gt1
[367.267087] Dynamic subtest gt1: SUCCESS (15.063s)
[367.269824] Subtest rc6-fence: SUCCESS (27.417s)
[367.345395] [074/133] (652s left) gem_exec_reloc (basic-cpu-read-noreloc)
[367.420641] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[367.490995] [075/133] (652s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[367.757210] Starting subtest: cursor-rapid-movement-256x85
[367.812960] Subtest cursor-rapid-movement-256x85: SKIP (0.049s)
[367.990349] [076/133] (652s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[368.128263] Starting subtest: 2x-flip-vs-cursor-atomic
[368.132676] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[368.274539] [077/133] (652s left) gem_pxp (protected-raw-src-copy-not-readible)
[368.387334] Starting subtest: protected-raw-src-copy-not-readible
[368.446494] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[368.579854] [078/133] (651s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[368.687205] Starting subtest: cursorB-vs-flipA-atomic
[368.690825] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[368.842364] [079/133] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[368.934742] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[368.937921] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[369.036453] [080/133] (651s left) syncobj_timeline (single-wait-for-submit-signaled)
[369.085957] Starting subtest: single-wait-for-submit-signaled
[369.087863] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[369.175268] [081/133] (651s left) kms_chamelium_audio (dp-audio)
[369.566511] Subtest dp-audio: SKIP (0.000s)
[370.422770] [082/133] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[370.528230] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[377.246848] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.724s)
[377.363524] [083/133] (643s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[377.415617] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[377.473708] [084/133] (643s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[377.582867] Starting subtest: basic-flip-before-cursor-varying-size
[378.510518] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s)
[379.376396] [085/133] (641s left) i915_hangman (detector)
[379.436861] Starting subtest: detector
[379.438863] Starting dynamic subtest: rcs0
[390.337859] Dynamic subtest rcs0: SUCCESS (10.900s)
[390.350936] Starting dynamic subtest: bcs0
[401.281340] Dynamic subtest bcs0: SUCCESS (10.941s)
[401.293786] Starting dynamic subtest: vcs0
[413.250240] Dynamic subtest vcs0: SUCCESS (11.966s)
[413.263241] Starting dynamic subtest: vcs1
[424.257351] Dynamic subtest vcs1: SUCCESS (11.004s)
[424.270057] Starting dynamic subtest: vecs0
[436.288581] Dynamic subtest vecs0: SUCCESS (12.028s)
[436.300885] Starting dynamic subtest: ccs0
[447.297450] Dynamic subtest ccs0: SUCCESS (11.006s)
[447.300357] Subtest detector: SUCCESS (67.860s)
[447.440601] [086/133] (573s left) api_intel_bb (object-noreloc-keep-cache-simple)
[447.492945] Starting subtest: object-noreloc-keep-cache-simple
[447.501489] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.011s)
[447.649886] [087/133] (573s left) kms_cursor_crc (cursor-sliding-512x512)
[447.920536] Starting subtest: cursor-sliding-512x512
[447.925093] Subtest cursor-sliding-512x512: SKIP (0.001s)
[448.066842] [088/133] (572s left) kms_psr (fbc-pr-sprite-plane-onoff)
[448.145744] Starting subtest: fbc-pr-sprite-plane-onoff
[448.149659] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[448.222389] [089/133] (572s left) kms_big_fb (y-tiled-addfb)
[448.323900] Starting subtest: y-tiled-addfb
[448.327648] Subtest y-tiled-addfb: SKIP (0.000s)
[448.406824] [090/133] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[448.502124] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[448.505687] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[448.613688] [091/133] (572s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[448.711055] Starting subtest: blocking-absolute-wf_vblank-interruptible
[448.713055] Starting dynamic subtest: A-eDP1
[457.462939] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[457.475514] Starting dynamic subtest: B-eDP1
[466.172306] Dynamic subtest B-eDP1: SUCCESS (8.740s)
[466.191513] Starting dynamic subtest: C-eDP1
[474.929238] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[474.940726] Starting dynamic subtest: D-eDP1
[483.611144] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[483.616430] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.903s)
[484.828713] [092/133] (536s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[484.924963] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[484.927247] Starting dynamic subtest: pipe-A-eDP-1
[484.947231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[484.958906] Starting dynamic subtest: pipe-B-eDP-1
[484.977676] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[484.987103] Starting dynamic subtest: pipe-C-eDP-1
[485.005225] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[485.014452] Starting dynamic subtest: pipe-D-eDP-1
[485.033416] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[485.035300] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[487.100806] [093/133] (533s left) syncobj_wait (wait-for-submit-delayed-submit)
[487.165480] Starting subtest: wait-for-submit-delayed-submit
[487.270861] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[487.347685] [094/133] (533s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[487.442266] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[487.446548] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[487.513169] [095/133] (533s left) kms_atomic_interruptible (legacy-pageflip)
[487.607174] Starting subtest: legacy-pageflip
[487.609282] Starting dynamic subtest: pipe-A-eDP-1
[495.025898] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[495.028144] Subtest legacy-pageflip: SUCCESS (7.419s)
[495.870165] [096/133] (525s left) kms_pm_rpm (universal-planes)
[497.506403] Starting subtest: universal-planes
[497.508541] Starting dynamic subtest: plane-35
[505.797248] Dynamic subtest plane-35: SUCCESS (8.293s)
[505.809948] Starting dynamic subtest: plane-65
[514.088804] Dynamic subtest plane-65: SUCCESS (8.289s)
[514.100772] Starting dynamic subtest: plane-95
[522.443726] Dynamic subtest plane-95: SUCCESS (8.352s)
[522.456742] Starting dynamic subtest: plane-125
[530.736381] Dynamic subtest plane-125: SUCCESS (8.290s)
[530.748873] Starting dynamic subtest: plane-135
[539.028876] Dynamic subtest plane-135: SUCCESS (8.289s)
[539.041781] Starting dynamic subtest: plane-145
[547.344892] Dynamic subtest plane-145: SUCCESS (8.312s)
[547.348235] Subtest universal-planes: SUCCESS (49.841s)
[547.728219] [097/133] (473s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[547.785227] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[547.789623] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[547.981170] [098/133] (473s left) kms_atomic (plane-cursor-legacy)
[548.069899] Starting subtest: plane-cursor-legacy
[548.071724] Starting dynamic subtest: pipe-A-eDP-1
[548.462984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s)
[548.465199] Subtest plane-cursor-legacy: SUCCESS (0.394s)
[549.259747] [099/133] (472s left) kms_force_connector_basic (prune-stale-modes)
[549.325847] Starting subtest: prune-stale-modes
[549.766724] Subtest prune-stale-modes: SUCCESS (0.441s)
[549.917494] [100/133] (471s left) kms_lease (simple-lease)
[550.005260] Starting subtest: simple-lease
[550.007627] Starting dynamic subtest: pipe-A-eDP-1
[550.506356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[550.516554] Starting dynamic subtest: pipe-B-eDP-1
[551.999131] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[552.011771] Starting dynamic subtest: pipe-C-eDP-1
[553.413800] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s)
[553.424973] Starting dynamic subtest: pipe-D-eDP-1
[554.877544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.462s)
[554.879815] Subtest simple-lease: SUCCESS (4.873s)
[555.698435] [101/133] (465s left) gem_exec_schedule (submit-golden-slice)
[555.763823] Starting subtest: submit-golden-slice
[555.765746] Starting dynamic subtest: rcs0
[555.796199] Dynamic subtest rcs0: SUCCESS (0.039s)
[555.812886] Starting dynamic subtest: bcs0
[555.835173] Dynamic subtest bcs0: SUCCESS (0.038s)
[555.849417] Starting dynamic subtest: vcs0
[555.872928] Dynamic subtest vcs0: SUCCESS (0.037s)
[555.886842] Starting dynamic subtest: vcs1
[555.910553] Dynamic subtest vcs1: SUCCESS (0.037s)
[555.920871] Starting dynamic subtest: vecs0
[555.946244] Dynamic subtest vecs0: SUCCESS (0.035s)
[555.960209] Starting dynamic subtest: ccs0
[555.992548] Dynamic subtest ccs0: SUCCESS (0.044s)
[555.994867] Subtest submit-golden-slice: SUCCESS (0.237s)
[557.441649] [102/133] (464s left) prime_self_import (export-vs-gem_close-race)
[557.476878] Starting subtest: export-vs-gem_close-race
[562.566110] Subtest export-vs-gem_close-race: SUCCESS (5.052s)
[562.657392] [103/133] (458s left) vgem_basic (dmabuf-fence)
[562.699583] Starting subtest: dmabuf-fence
[562.701753] Subtest dmabuf-fence: SUCCESS (0.000s)
[562.758607] [104/133] (458s left) syncobj_wait (invalid-signal-bad-pad)
[562.817148] Starting subtest: invalid-signal-bad-pad
[562.819470] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[562.929611] [105/133] (458s left) kms_plane_alpha_blend (coverage-7efc)
[563.033985] Starting subtest: coverage-7efc
[563.323628] Starting dynamic subtest: pipe-A-eDP-1
[563.909292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[563.939322] Starting dynamic subtest: pipe-D-eDP-1
[565.279626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[565.282206] Subtest coverage-7efc: SUCCESS (2.247s)
[566.092053] [106/133] (455s left) prime_mmap (test_invalid_sync_flags)
[566.150025] Starting subtest: test_invalid_sync_flags
[566.152029] Starting dynamic subtest: test_invalid_sync_flags-smem
[566.154033] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[566.155987] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[566.251066] [107/133] (455s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[566.348105] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[566.350230] Starting dynamic subtest: pipe-A-default-mode
[567.509801] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[567.514252] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.160s)
[567.665670] [108/133] (454s left) syncobj_timeline (invalid-query-zero-handles)
[567.719414] Starting subtest: invalid-query-zero-handles
[567.721572] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[567.808833] [109/133] (453s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[567.935631] Starting subtest: cursor-vs-flip-atomic
[597.619886] Subtest cursor-vs-flip-atomic: SUCCESS (29.680s)
[598.498173] [110/133] (423s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[598.604069] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[598.606271] Starting dynamic subtest: pipe-A-eDP-1
[604.332619] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.733s)
[604.350311] Starting dynamic subtest: pipe-B-eDP-1
[610.844210] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.509s)
[610.846481] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.244s)
[611.691436] [111/133] (410s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[611.786852] Starting subtest: primary-yf-tiled-reflect-x-0
[611.846380] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[611.967418] [112/133] (409s left) perf_pmu (semaphore-wait)
[612.007784] Starting subtest: semaphore-wait
[612.009909] Starting dynamic subtest: rcs0
[612.520094] Dynamic subtest rcs0: SUCCESS (0.513s)
[612.532276] Starting dynamic subtest: bcs0
[613.033805] Dynamic subtest bcs0: SUCCESS (0.510s)
[613.045055] Starting dynamic subtest: vcs0
[613.547337] Dynamic subtest vcs0: SUCCESS (0.510s)
[613.559806] Starting dynamic subtest: vcs1
[614.060956] Dynamic subtest vcs1: SUCCESS (0.510s)
[614.072815] Starting dynamic subtest: vecs0
[614.574637] Dynamic subtest vecs0: SUCCESS (0.510s)
[614.589024] Starting dynamic subtest: ccs0
[615.092412] Dynamic subtest ccs0: SUCCESS (0.514s)
[615.095348] Subtest semaphore-wait: SUCCESS (3.087s)
[616.368085] [113/133] (405s left) gem_eio (in-flight-internal-10ms)
[616.578621] Starting subtest: in-flight-internal-10ms
[618.354817] Subtest in-flight-internal-10ms: SUCCESS (1.774s)
[618.482989] [114/133] (403s left) prime_mmap (test_correct_cpu_write)
[618.542946] Starting subtest: test_correct_cpu_write
[618.545145] Starting dynamic subtest: test_correct_cpu_write-smem
[618.546981] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[618.548803] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[618.656649] [115/133] (403s left) kms_chamelium_hpd (vga-hpd)
[619.059818] Subtest vga-hpd: SKIP (0.000s)
[619.860514] [116/133] (402s left) kms_properties (invalid-properties-atomic)
[619.947505] Starting subtest: invalid-properties-atomic
[620.255269] Subtest invalid-properties-atomic: SUCCESS (0.309s)
[620.329358] [117/133] (401s left) syncobj_timeline (host-signal-ordered)
[620.383119] Starting subtest: host-signal-ordered
[620.385407] Subtest host-signal-ordered: SUCCESS (0.000s)
[620.473069] [118/133] (401s left) kms_addfb_basic (invalid-set-prop)
[620.525100] Starting subtest: invalid-set-prop
[620.527052] Subtest invalid-set-prop: SUCCESS (0.000s)
[620.660445] [119/133] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[620.749240] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[620.753156] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[620.849597] [120/133] (401s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[620.935174] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[620.937486] Starting dynamic subtest: pipe-A-default-mode
[623.649431] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[623.651644] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.714s)
[624.480764] [121/133] (397s left) i915_suspend (basic-s2idle-without-i915)
[624.516859] Starting subtest: basic-s2idle-without-i915
[643.873389] Subtest basic-s2idle-without-i915: SUCCESS (4.646s)
[648.046559] [122/133] (378s left) kms_busy (extended-pageflip-hang-newfb)
[648.181270] Starting subtest: extended-pageflip-hang-newfb
[648.183598] Starting dynamic subtest: pipe-A
[675.830144] Dynamic subtest pipe-A: SUCCESS (27.625s)
[675.841134] Starting dynamic subtest: pipe-D
[690.868701] Dynamic subtest pipe-D: SUCCESS (15.037s)
[690.870966] Subtest extended-pageflip-hang-newfb: SUCCESS (42.667s)
[691.666387] [123/133] (334s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[691.785594] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[691.790337] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[691.902688] [124/133] (334s left) gem_exec_alignment (forked)
[691.960100] Starting subtest: forked
[733.929065] Subtest forked: SUCCESS (41.913s)
[734.114877] [125/133] (292s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[734.235253] Starting subtest: map-fixed-invalidate-overlap
[734.239486] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[734.363987] [126/133] (292s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[734.476291] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[734.567044] [127/133] (292s left) gem_exec_balancer (full-late-pulse)
[734.629132] Starting subtest: full-late-pulse
[738.945916] Subtest full-late-pulse: SUCCESS (4.316s)
[739.287446] [128/133] (287s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[739.376144] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[739.378428] Starting dynamic subtest: pipe-A
[739.399024] Dynamic subtest pipe-A: SKIP (0.018s)
[739.409384] Starting dynamic subtest: pipe-B
[739.440943] Dynamic subtest pipe-B: SKIP (0.041s)
[739.451351] Starting dynamic subtest: pipe-C
[739.474236] Dynamic subtest pipe-C: SKIP (0.035s)
[739.484370] Starting dynamic subtest: pipe-D
[739.506488] Dynamic subtest pipe-D: SKIP (0.031s)
[739.510606] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.127s)
[739.609956] [129/133] (287s left) kms_invalid_mode (int-max-clock)
[739.702632] Starting subtest: int-max-clock
[739.704940] Starting dynamic subtest: pipe-A-eDP-1
[739.983129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[739.995587] Starting dynamic subtest: pipe-B-eDP-1
[739.997937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[740.008124] Starting dynamic subtest: pipe-C-eDP-1
[740.010652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[740.020567] Starting dynamic subtest: pipe-D-eDP-1
[740.023073] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[740.025536] Subtest int-max-clock: SUCCESS (0.290s)
[740.813913] [130/133] (285s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[740.922604] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[740.924874] Starting dynamic subtest: pipe-A-eDP-1
[740.983401] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[740.994431] Starting dynamic subtest: pipe-B-eDP-1
[741.052552] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[741.064469] Starting dynamic subtest: pipe-C-eDP-1
[741.121500] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[741.132781] Starting dynamic subtest: pipe-D-eDP-1
[741.190063] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[741.194597] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[743.164919] [131/133] (283s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[743.269460] Starting subtest: drrs-dirtyfb-ioctl
[743.281967] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[743.368289] [132/133] (283s left) kms_big_fb (linear-64bpp-rotate-270)
[743.467273] Starting subtest: linear-64bpp-rotate-270
[743.489374] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[743.591971] [133/133] (283s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[743.684567] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[744.330736] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[744.491378] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ppgtt
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: dmabuf_sync_file
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_draw_crc
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: kms_atomic_interruptible
results: parsing output: 23/ for test: sysfs_timeslice_duration
results: parsing output: 24/ for test: gem_render_linear_blits
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_create
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_setmode
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_pread
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gen3_render_linear_blits
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: i915_pm_rc6_residency
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_chamelium_audio
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_atomic_interruptible
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_force_connector_basic
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: prime_self_import
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_plane_alpha_blend
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: i915_suspend
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_alignment
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_dirtyfb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_big_fb
Done.