[61.715632] Initializing watchdogs
[61.715697]   /dev/watchdog0
[61.736076] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.747156] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.751221] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.753521] [001/133] (960s left) api_intel_allocator (fork-simple-once)
[61.822501] Starting subtest: fork-simple-once
[61.868902] Subtest fork-simple-once: SUCCESS (0.046s)
[62.093535] [002/133] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[62.269891] Starting subtest: plane-downscale-factor-0-5-with-rotation
[62.270686] Starting dynamic subtest: pipe-A
[62.651591] Dynamic subtest pipe-A: SUCCESS (0.383s)
[62.670932] Starting dynamic subtest: pipe-B
[63.132227] Dynamic subtest pipe-B: SUCCESS (0.481s)
[63.148702] Starting dynamic subtest: pipe-C
[63.610114] Dynamic subtest pipe-C: SUCCESS (0.478s)
[63.628651] Starting dynamic subtest: pipe-D
[64.088072] Dynamic subtest pipe-D: SUCCESS (0.478s)
[64.089217] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.823s)
[64.444151] [003/133] (957s left) gem_pxp (create-regular-context-1)
[67.044052] Starting subtest: create-regular-context-1
[67.046537] Subtest create-regular-context-1: SKIP (0.000s)
[67.218300] [004/133] (955s left) kms_psr (fbc-psr2-sprite-render)
[67.577706] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[67.856428] [005/133] (954s left) gem_softpin (allocator-basic-reserve)
[67.956473] Starting subtest: allocator-basic-reserve
[68.191436] Subtest allocator-basic-reserve: SUCCESS (0.235s)
[68.419595] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[68.601595] Starting subtest: fbcpsr-suspend
[68.603246] Subtest fbcpsr-suspend: SKIP (0.000s)
[68.789629] [007/133] (953s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[68.968321] Starting subtest: sprite-rotation-90-pos-100-0
[68.971027] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[69.119394] [008/133] (953s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[69.297906] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[69.299721] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[69.461224] [009/133] (953s left) kms_lease (setcrtc-implicit-plane)
[69.644368] Starting subtest: setcrtc-implicit-plane
[69.645283] Starting dynamic subtest: pipe-A-DP-3
[70.069091] Dynamic subtest pipe-A-DP-3: SUCCESS (0.424s)
[70.081731] Starting dynamic subtest: pipe-B-DP-3
[70.411177] Dynamic subtest pipe-B-DP-3: SUCCESS (0.339s)
[70.425699] Starting dynamic subtest: pipe-C-DP-3
[70.720361] Dynamic subtest pipe-C-DP-3: SUCCESS (0.308s)
[70.729054] Starting dynamic subtest: pipe-D-DP-3
[71.025340] Dynamic subtest pipe-D-DP-3: SUCCESS (0.305s)
[71.026259] Subtest setcrtc-implicit-plane: SUCCESS (1.382s)
[71.305953] [010/133] (951s left) kms_atomic_transition (plane-all-transition-fencing)
[71.483941] Starting subtest: plane-all-transition-fencing
[71.484889] Starting dynamic subtest: pipe-A-DP-3
[75.243169] Dynamic subtest pipe-A-DP-3: SUCCESS (3.759s)
[75.378237] Starting dynamic subtest: pipe-B-DP-3
[79.242941] Dynamic subtest pipe-B-DP-3: SUCCESS (3.875s)
[79.332804] Subtest plane-all-transition-fencing: SUCCESS (7.851s)
[79.633490] [011/133] (943s left) gem_exec_fence (basic-busy-all)
[79.715225] Starting subtest: basic-busy-all
[79.866069] Subtest basic-busy-all: SUCCESS (0.151s)
[80.748534] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[80.750451] [012/133] (942s left) perf_pmu (enable-race)
[80.820545] Starting subtest: enable-race
[80.821476] Starting dynamic subtest: rcs0
[93.601519] Dynamic subtest rcs0: SUCCESS (12.781s)
[93.609876] Starting dynamic subtest: bcs0
[106.340331] Dynamic subtest bcs0: SUCCESS (12.738s)
[106.348938] Starting dynamic subtest: vcs0
[119.082575] Dynamic subtest vcs0: SUCCESS (12.742s)
[119.090865] Starting dynamic subtest: vcs1
[131.817580] Dynamic subtest vcs1: SUCCESS (12.735s)
[131.826056] Starting dynamic subtest: vecs0
[144.560089] Dynamic subtest vecs0: SUCCESS (12.742s)
[144.568679] Starting dynamic subtest: vecs1
[157.299530] Dynamic subtest vecs1: SUCCESS (12.738s)
[157.307959] Starting dynamic subtest: ccs0
[170.040117] Dynamic subtest ccs0: SUCCESS (12.740s)
[170.041107] Subtest enable-race: SUCCESS (89.219s)
[170.232776] [013/133] (852s left) gem_userptr_blits (readonly-pwrite-unsync)
[170.315915] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[170.519801] [014/133] (852s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[170.722443] Starting subtest: psr-rgb101010-draw-mmap-gtt
[170.724156] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[170.920485] [015/133] (852s left) gem_userptr_blits (unsync-unmap-cycles)
[171.008055] Subtest unsync-unmap-cycles: SKIP (0.000s)
[171.219617] [016/133] (852s left) gem_mmap_gtt (basic-write-gtt)
[171.301161] Subtest basic-write-gtt: SKIP (0.000s)
[171.361612] [017/133] (852s left) gem_exec_schedule (u-semaphore-codependency)
[171.456526] Starting subtest: u-semaphore-codependency
[171.499970] Subtest u-semaphore-codependency: SUCCESS (0.043s)
[171.900594] [018/133] (851s left) kms_vrr (flip-basic)
[172.085399] Starting subtest: flip-basic
[172.087947] Subtest flip-basic: SKIP (0.000s)
[172.263715] [019/133] (851s left) kms_big_fb (linear-8bpp-rotate-0)
[172.464714] Starting subtest: linear-8bpp-rotate-0
[174.205564] Subtest linear-8bpp-rotate-0: SUCCESS (1.740s)
[174.390864] [020/133] (849s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[174.474504] Starting subtest: y-tiled-to-vebox-yf-tiled
[174.476393] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[174.772395] [021/133] (848s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[174.959503] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[174.960413] Starting dynamic subtest: pipe-A-DP-3
[174.968852] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[174.977301] Starting dynamic subtest: pipe-B-DP-3
[174.985616] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[174.993979] Starting dynamic subtest: pipe-C-DP-3
[175.001938] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[175.010682] Starting dynamic subtest: pipe-D-DP-3
[175.020355] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[175.022393] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[175.446055] [022/133] (848s left) gem_exec_balancer (parallel-contexts)
[175.795491] Starting subtest: parallel-contexts
[182.649996] Subtest parallel-contexts: SUCCESS (6.854s)
[182.824171] [023/133] (840s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[185.020648] Starting subtest: dpms-mode-unset-lpsp
[185.371485] Subtest dpms-mode-unset-lpsp: SKIP (0.351s)
[185.835692] [024/133] (838s left) gem_close_race (basic-process)
[185.952381] Starting subtest: basic-process
[186.018480] Subtest basic-process: SUCCESS (0.066s)
[186.320138] [025/133] (837s left) i915_drm_fdinfo (virtual-busy-hang)
[186.390253] Starting subtest: virtual-busy-hang
[186.392132] Subtest virtual-busy-hang: SKIP (0.000s)
[186.561118] [026/133] (837s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[186.637385] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[186.741576] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[186.918487] [027/133] (837s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[187.106248] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[187.110416] Starting dynamic subtest: A-DP3
[187.926174] Dynamic subtest A-DP3: SUCCESS (0.814s)
[187.948261] Starting dynamic subtest: B-DP3
[188.709422] Dynamic subtest B-DP3: SUCCESS (0.782s)
[188.729717] Starting dynamic subtest: C-DP3
[189.479044] Dynamic subtest C-DP3: SUCCESS (0.768s)
[189.497672] Starting dynamic subtest: D-DP3
[190.241236] Dynamic subtest D-DP3: SUCCESS (0.760s)
[190.243870] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.137s)
[190.589631] [028/133] (833s left) kms_busy (extended-modeset-hang-newfb)
[190.780371] Starting subtest: extended-modeset-hang-newfb
[190.782421] Starting dynamic subtest: pipe-A
[206.471765] Dynamic subtest pipe-A: SUCCESS (15.689s)
[206.490681] Starting dynamic subtest: pipe-D
[222.157062] Dynamic subtest pipe-D: SUCCESS (15.677s)
[222.159547] Subtest extended-modeset-hang-newfb: SUCCESS (31.377s)
[222.493242] [029/133] (801s left) kms_flip (flip-vs-fences-interruptible)
[222.681150] Starting subtest: flip-vs-fences-interruptible
[222.682903] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[222.881690] [030/133] (801s left) kms_vblank (ts-continuation-suspend)
[223.064364] Starting subtest: ts-continuation-suspend
[223.066498] Starting dynamic subtest: pipe-A-DP-3
[242.616788] Dynamic subtest pipe-A-DP-3: SUCCESS (4.108s)
[242.630663] Starting dynamic subtest: pipe-D-DP-3
[262.587953] Dynamic subtest pipe-D-DP-3: SUCCESS (3.890s)
[262.588788] Subtest ts-continuation-suspend: SUCCESS (8.003s)
[262.851111] [031/133] (761s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[263.039259] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[263.040209] Starting dynamic subtest: pipe-A-valid-mode
[263.148370] Dynamic subtest pipe-A-valid-mode: SKIP (0.106s)
[263.150613] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.108s)
[263.400461] [032/133] (761s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[263.592475] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[263.593367] Starting dynamic subtest: pipe-A-valid-mode
[263.666750] Dynamic subtest pipe-A-valid-mode: SKIP (0.072s)
[263.668464] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.074s)
[263.912340] [033/133] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[264.104164] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[264.105711] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[264.326697] [034/133] (760s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[264.524748] Starting subtest: 4-tiled-64bpp-rotate-0
[266.446539] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.922s)
[266.666980] [035/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[266.858187] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[270.297890] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.440s)
[270.532053] [036/133] (754s left) kms_chamelium_hpd (dp-hpd-storm)
[270.806960] Subtest dp-hpd-storm: SKIP (0.000s)
[270.956406] [037/133] (753s left) i915_pm_rpm (gem-idle)
[272.575976] Starting subtest: gem-idle
[278.105302] Subtest gem-idle: SUCCESS (5.533s)
[278.407401] [038/133] (746s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[278.598991] Starting subtest: fbc-abgr161616f-draw-render
[278.600707] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[278.794056] [039/133] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[278.983630] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[278.985381] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[279.178760] [040/133] (746s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[279.373093] Starting subtest: fbc-indfb-scaledprimary
[280.881226] Subtest fbc-indfb-scaledprimary: SUCCESS (1.509s)
[281.131285] [041/133] (744s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[281.326473] Starting subtest: primary-yf-tiled-reflect-x-90
[281.328300] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[281.476200] [042/133] (743s left) device_reset (unbind-cold-reset-rebind)
[281.559703] Starting subtest: unbind-cold-reset-rebind
[281.561692] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[281.685008] [043/133] (743s left) syncobj_timeline (wait-any-interrupted)
[281.763516] Starting subtest: wait-any-interrupted
[281.865773] Subtest wait-any-interrupted: SUCCESS (0.101s)
[282.038550] [044/133] (743s left) syncobj_timeline (invalid-transfer-illegal-handle)
[282.120555] Starting subtest: invalid-transfer-illegal-handle
[282.121497] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[282.313920] [045/133] (743s left) kms_psr (pr-basic)
[282.502894] Subtest pr-basic: SKIP (0.000s)
[282.564068] [046/133] (743s left) kms_getfb (getfb-handle-zero)
[282.748881] Starting subtest: getfb-handle-zero
[282.749694] Subtest getfb-handle-zero: SUCCESS (0.000s)
[282.967286] [047/133] (742s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[283.158014] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[283.231002] [048/133] (742s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[283.316526] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[283.317449] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[283.516189] [049/133] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[283.707142] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[283.708730] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[283.912660] [050/133] (742s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[284.108038] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[284.109663] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[284.298062] [051/133] (741s left) kms_chamelium_frames (dp-crc-fast)
[284.554570] Subtest dp-crc-fast: SKIP (0.000s)
[284.699497] [052/133] (741s left) kms_psr (fbc-pr-sprite-plane-move)
[284.884331] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[284.954154] [053/133] (741s left) kms_psr (psr2-sprite-plane-move)
[285.139497] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[285.231782] [054/133] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[285.422261] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[285.423939] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[285.609898] [055/133] (740s left) perf_pmu (semaphore-wait-idle)
[285.679887] Starting subtest: semaphore-wait-idle
[285.680757] Starting dynamic subtest: rcs0
[286.229123] Dynamic subtest rcs0: SUCCESS (0.540s)
[286.241785] Starting dynamic subtest: bcs0
[286.734615] Dynamic subtest bcs0: SUCCESS (0.509s)
[286.749930] Starting dynamic subtest: vcs0
[287.247665] Dynamic subtest vcs0: SUCCESS (0.509s)
[287.263154] Starting dynamic subtest: vcs1
[287.760617] Dynamic subtest vcs1: SUCCESS (0.509s)
[287.776036] Starting dynamic subtest: vecs0
[288.273648] Dynamic subtest vecs0: SUCCESS (0.509s)
[288.289114] Starting dynamic subtest: vecs1
[288.786815] Dynamic subtest vecs1: SUCCESS (0.509s)
[288.802470] Starting dynamic subtest: ccs0
[289.299738] Dynamic subtest ccs0: SUCCESS (0.509s)
[289.301893] Subtest semaphore-wait-idle: SUCCESS (3.621s)
[289.494926] [056/133] (736s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[289.574404] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[289.688544] [057/133] (736s left) i915_pm_rps (thresholds-idle-park)
[289.779701] Starting subtest: thresholds-idle-park
[289.781477] Subtest thresholds-idle-park: SKIP (0.000s)
[289.929239] [058/133] (736s left) kms_addfb_basic (invalid-set-prop)
[290.008789] Starting subtest: invalid-set-prop
[290.009722] Subtest invalid-set-prop: SUCCESS (0.000s)
[290.343862] [059/133] (736s left) gem_mmap_offset (bad-object)
[290.420569] Starting subtest: bad-object
[290.421487] Subtest bad-object: SUCCESS (0.000s)
[290.580414] [060/133] (736s left) gem_ctx_param (invalid-ctx-get)
[290.656982] Starting subtest: invalid-ctx-get
[290.657812] Subtest invalid-ctx-get: SUCCESS (0.000s)
[290.847988] [061/133] (735s left) sw_sync (sync_merge_invalid)
[290.895582] Starting subtest: sync_merge_invalid
[290.944642] Subtest sync_merge_invalid: SUCCESS (0.049s)
[291.053989] [062/133] (735s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[291.240230] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[291.242592] Starting dynamic subtest: pipe-A-valid-mode
[291.319917] Dynamic subtest pipe-A-valid-mode: SKIP (0.077s)
[291.321747] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.079s)
[291.577215] [063/133] (735s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[291.764487] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[302.753206] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.987s)
[303.083249] [064/133] (723s left) kms_properties (get_properties-sanity-non-atomic)
[303.275593] Starting subtest: get_properties-sanity-non-atomic
[303.276542] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[303.459993] [065/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[303.663472] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[303.665176] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[303.844832] [066/133] (723s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[304.033636] Starting subtest: plane-downscale-factor-0-75-with-rotation
[304.034361] Starting dynamic subtest: pipe-A
[304.411413] Dynamic subtest pipe-A: SUCCESS (0.378s)
[304.436436] Starting dynamic subtest: pipe-B
[304.874904] Dynamic subtest pipe-B: SUCCESS (0.461s)
[304.903674] Starting dynamic subtest: pipe-C
[305.354943] Dynamic subtest pipe-C: SUCCESS (0.478s)
[305.383341] Starting dynamic subtest: pipe-D
[305.835698] Dynamic subtest pipe-D: SUCCESS (0.479s)
[305.836705] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.804s)
[306.184830] [067/133] (721s left) gem_ctx_persistence (engines-hang)
[306.270796] Starting subtest: engines-hang
[306.271902] Starting dynamic subtest: rcs0
[306.359585] Dynamic subtest rcs0: SUCCESS (0.088s)
[306.374551] Starting dynamic subtest: bcs0
[306.453579] Dynamic subtest bcs0: SUCCESS (0.092s)
[306.502276] Starting dynamic subtest: vcs0
[306.514563] Dynamic subtest vcs0: SUCCESS (0.057s)
[306.533197] Starting dynamic subtest: vcs1
[306.613534] Dynamic subtest vcs1: SUCCESS (0.096s)
[306.662377] Starting dynamic subtest: vecs0
[306.677552] Dynamic subtest vecs0: SUCCESS (0.059s)
[306.696499] Starting dynamic subtest: vecs1
[306.766875] Dynamic subtest vecs1: SUCCESS (0.087s)
[306.811149] Starting dynamic subtest: ccs0
[306.821535] Dynamic subtest ccs0: SUCCESS (0.052s)
[306.822555] Subtest engines-hang: SUCCESS (0.551s)
[307.006555] [068/133] (720s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[307.193726] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[307.194594] Starting dynamic subtest: pipe-A-DP-3
[307.202741] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[307.215201] Starting dynamic subtest: pipe-B-DP-3
[307.223211] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[307.234984] Starting dynamic subtest: pipe-C-DP-3
[307.243093] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[307.254917] Starting dynamic subtest: pipe-D-DP-3
[307.264954] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[307.266888] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[307.660756] [069/133] (719s left) gem_vm_create (isolation)
[307.746506] Starting subtest: isolation
[307.759375] Subtest isolation: SUCCESS (0.013s)
[307.924854] [070/133] (719s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[308.010799] Starting subtest: x-tiled-to-vebox-y-tiled
[308.012791] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[308.295904] [071/133] (719s left) gem_exec_reloc (basic-range-active)
[308.382757] Subtest basic-range-active: SKIP (0.000s)
[308.470705] [072/133] (719s left) syncobj_basic (bad-flags-fd-to-handle)
[308.549928] Starting subtest: bad-flags-fd-to-handle
[308.550810] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[308.742301] [073/133] (718s left) gem_lmem_swapping (heavy-verify-random)
[311.552144] Starting subtest: heavy-verify-random
[311.553432] Starting dynamic subtest: lmem0
[327.286747] Dynamic subtest lmem0: SUCCESS (15.736s)
[327.287714] Subtest heavy-verify-random: SUCCESS (15.739s)
[329.082640] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[329.083857] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[329.086008] [074/133] (698s left) gem_ctx_persistence (hostile)
[330.646613] Starting subtest: hostile
[340.159885] Subtest hostile: SUCCESS (9.509s)
[340.254647] [FACT gem_ctx_persistence (hostile)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[340.256983] [FACT gem_ctx_persistence (hostile)] new: kernel.kmod_is_loaded.i915: true
[340.259603] [075/133] (687s left) kms_big_fb (y-tiled-addfb)
[340.463615] Starting subtest: y-tiled-addfb
[340.465346] Subtest y-tiled-addfb: SKIP (0.000s)
[340.658414] [076/133] (687s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[340.855258] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[342.107427] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.251s)
[342.377518] [077/133] (685s left) kms_joiner (basic-max-non-joiner)
[342.563757] Starting subtest: basic-max-non-joiner
[342.565511] Subtest basic-max-non-joiner: SKIP (0.000s)
[342.723948] [078/133] (685s left) syncobj_wait (wait-any-snapshot)
[342.799770] Starting subtest: wait-any-snapshot
[342.882563] Subtest wait-any-snapshot: SUCCESS (0.082s)
[343.072790] [079/133] (685s left) kms_cursor_crc (cursor-offscreen-512x170)
[343.560849] Starting subtest: cursor-offscreen-512x170
[343.564006] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[343.842135] [080/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[344.034184] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[344.035811] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[344.243195] [081/133] (684s left) gem_exec_alignment (pi)
[344.340697] Starting subtest: pi
[361.835436] Subtest pi: SUCCESS (17.493s)
[362.385399] [082/133] (666s left) syncobj_timeline (single-wait-available-submitted)
[362.517851] Starting subtest: single-wait-available-submitted
[362.518777] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[362.691619] [083/133] (665s left) kms_addfb_basic (addfb25-4-tiled)
[362.886981] Starting subtest: addfb25-4-tiled
[362.887825] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[363.100114] [084/133] (665s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[363.295227] Starting subtest: stress-xrgb8888-yftiled
[363.296919] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[363.370873] [085/133] (665s left) gem_ctx_param (invalid-param-get)
[363.449118] Starting subtest: invalid-param-get
[363.451452] Subtest invalid-param-get: SUCCESS (0.001s)
[363.642439] [086/133] (665s left) kms_pm_dc (dc5-dpms)
[364.834633] Starting subtest: dc5-dpms
[366.234960] Subtest dc5-dpms: SUCCESS (1.400s)
[366.379716] [087/133] (662s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[366.565773] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[366.626956] [088/133] (662s left) kms_rotation_crc (exhaust-fences)
[366.817876] Starting subtest: exhaust-fences
[366.819682] Subtest exhaust-fences: SKIP (0.000s)
[366.993342] [089/133] (661s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[367.180737] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[367.181606] Starting dynamic subtest: pipe-A-DP-3
[367.189950] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[367.202351] Starting dynamic subtest: pipe-B-DP-3
[367.210471] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[367.223280] Starting dynamic subtest: pipe-C-DP-3
[367.231428] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[367.243902] Starting dynamic subtest: pipe-D-DP-3
[367.254845] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[367.256777] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[367.642784] [090/133] (661s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[367.841701] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[367.843503] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[368.050690] [091/133] (661s left) kms_draw_crc (draw-method-blt)
[368.244584] Starting subtest: draw-method-blt
[368.245490] Starting dynamic subtest: xrgb8888-untiled
[368.592872] Dynamic subtest xrgb8888-untiled: SUCCESS (0.347s)
[368.638358] Starting dynamic subtest: rgb565-untiled
[368.928201] Dynamic subtest rgb565-untiled: SUCCESS (0.330s)
[368.975443] Starting dynamic subtest: xrgb2101010-untiled
[369.242824] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.310s)
[369.289056] Starting dynamic subtest: xbgr16161616f-untiled
[369.543068] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.295s)
[369.589499] Starting dynamic subtest: xrgb8888-xtiled
[369.709946] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.162s)
[369.752343] Starting dynamic subtest: rgb565-xtiled
[369.876682] Dynamic subtest rgb565-xtiled: SUCCESS (0.162s)
[369.922500] Starting dynamic subtest: xrgb2101010-xtiled
[370.026596] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.145s)
[370.074948] Starting dynamic subtest: xbgr16161616f-xtiled
[370.194200] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.162s)
[370.235200] Starting dynamic subtest: xrgb8888-4tiled
[370.360797] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.161s)
[370.376259] Starting dynamic subtest: rgb565-4tiled
[370.509981] Dynamic subtest rgb565-4tiled: SUCCESS (0.146s)
[370.556184] Starting dynamic subtest: xrgb2101010-4tiled
[370.659837] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.145s)
[370.676583] Starting dynamic subtest: xbgr16161616f-4tiled
[370.793292] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.129s)
[370.798100] Subtest draw-method-blt: SUCCESS (2.551s)
[371.030004] [092/133] (658s left) kms_atomic_interruptible (legacy-cursor)
[371.224599] Starting subtest: legacy-cursor
[371.226750] Starting dynamic subtest: pipe-A-DP-3
[377.505473] Dynamic subtest pipe-A-DP-3: SUCCESS (6.279s)
[377.506359] Subtest legacy-cursor: SUCCESS (6.280s)
[377.792374] [093/133] (651s left) kms_selftest (drm_plane_helper)
[377.849224] Starting subtest: drm_plane_helper
[377.897726] Starting dynamic subtest: drm_test_check_plane_state
[378.013218] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.112s)
[378.051876] Starting dynamic subtest: drm_test_check_invalid_plane_state
[378.098351] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.085s)
[378.101629] Subtest drm_plane_helper: SUCCESS (0.250s)
[378.349543] [094/133] (651s left) gem_busy (extended)
[378.588864] Starting subtest: extended
[378.590435] Starting dynamic subtest: rcs0
[378.683977] Dynamic subtest rcs0: SUCCESS (0.093s)
[378.703863] Starting dynamic subtest: bcs0
[378.729642] Dynamic subtest bcs0: SUCCESS (0.041s)
[378.748068] Starting dynamic subtest: vcs0
[378.770613] Dynamic subtest vcs0: SUCCESS (0.040s)
[378.794075] Starting dynamic subtest: vcs1
[378.812705] Dynamic subtest vcs1: SUCCESS (0.040s)
[378.837233] Starting dynamic subtest: vecs0
[378.856839] Dynamic subtest vecs0: SUCCESS (0.042s)
[378.878142] Starting dynamic subtest: vecs1
[378.899844] Dynamic subtest vecs1: SUCCESS (0.041s)
[378.918997] Starting dynamic subtest: ccs0
[378.943828] Dynamic subtest ccs0: SUCCESS (0.043s)
[378.944873] Subtest extended: SUCCESS (0.356s)
[379.282215] [095/133] (650s left) i915_hangman (engine-engine-hang)
[379.377933] Starting subtest: engine-engine-hang
[379.378779] Starting dynamic subtest: rcs0
[380.260474] Dynamic subtest rcs0: SUCCESS (0.881s)
[380.277939] Starting dynamic subtest: bcs0
[381.067610] Dynamic subtest bcs0: SUCCESS (0.805s)
[381.081904] Starting dynamic subtest: vcs0
[381.896976] Dynamic subtest vcs0: SUCCESS (0.828s)
[381.916260] Starting dynamic subtest: vcs1
[382.734981] Dynamic subtest vcs1: SUCCESS (0.837s)
[382.752448] Starting dynamic subtest: vecs0
[383.549942] Dynamic subtest vecs0: SUCCESS (0.813s)
[383.564546] Starting dynamic subtest: vecs1
[384.333797] Dynamic subtest vecs1: SUCCESS (0.783s)
[384.350380] Starting dynamic subtest: ccs0
[385.157603] Dynamic subtest ccs0: SUCCESS (0.822s)
[385.158618] Subtest engine-engine-hang: SUCCESS (5.780s)
[385.347110] [096/133] (644s left) gen9_exec_parse (batch-invalid-length)
[385.431784] Subtest batch-invalid-length: SKIP (0.000s)
[385.511592] [097/133] (644s left) kms_psr (psr-sprite-render)
[385.700362] Subtest psr-sprite-render: SKIP (0.000s)
[385.758210] [098/133] (643s left) kms_cursor_crc (cursor-random-max-size)
[386.280913] Starting subtest: cursor-random-max-size
[386.284413] Subtest cursor-random-max-size: SKIP (0.000s)
[386.570257] [099/133] (643s left) gem_exec_reloc (basic-cpu-noreloc)
[386.673627] Subtest basic-cpu-noreloc: SKIP (0.000s)
[386.747690] [100/133] (643s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[386.935737] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[386.937480] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[387.283192] [101/133] (642s left) kms_async_flips (invalid-async-flip)
[387.469585] Starting subtest: invalid-async-flip
[387.690276] Starting dynamic subtest: pipe-A-DP-3
[388.065845] Dynamic subtest pipe-A-DP-3: SUCCESS (0.375s)
[388.278057] Starting dynamic subtest: pipe-B-DP-3
[388.401870] Dynamic subtest pipe-B-DP-3: SUCCESS (0.136s)
[388.609968] Starting dynamic subtest: pipe-C-DP-3
[388.759057] Dynamic subtest pipe-C-DP-3: SUCCESS (0.162s)
[389.000066] Starting dynamic subtest: pipe-D-DP-3
[389.141789] Dynamic subtest pipe-D-DP-3: SUCCESS (0.157s)
[389.142876] Subtest invalid-async-flip: SUCCESS (1.674s)
[389.693864] [102/133] (640s left) kms_cursor_legacy (single-move)
[389.888680] Starting subtest: single-move
[389.889608] Starting dynamic subtest: pipe-A
[395.268754] Dynamic subtest pipe-A: SUCCESS (5.379s)
[395.281799] Starting dynamic subtest: pipe-B
[400.648602] Dynamic subtest pipe-B: SUCCESS (5.378s)
[400.661307] Starting dynamic subtest: pipe-C
[406.028423] Dynamic subtest pipe-C: SUCCESS (5.379s)
[406.041171] Starting dynamic subtest: pipe-D
[411.408787] Dynamic subtest pipe-D: SUCCESS (5.379s)
[411.422430] Starting dynamic subtest: all-pipes
[416.791421] Dynamic subtest all-pipes: SUCCESS (5.381s)
[416.792368] Subtest single-move: SUCCESS (26.903s)
[416.926382] [103/133] (613s left) kms_fbcon_fbt (psr)
[417.015114] Starting subtest: psr
[417.016813] Subtest psr: SKIP (0.000s)
[417.232250] [104/133] (612s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[417.424438] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[417.426180] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[417.620358] [105/133] (612s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[417.697779] Starting subtest: multi-wait-for-submit-submitted-signaled
[417.698747] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[417.887653] [106/133] (612s left) gem_exec_schedule (preempt-hang)
[418.093462] Starting subtest: preempt-hang
[418.094428] Starting dynamic subtest: rcs0
[418.452115] Dynamic subtest rcs0: SUCCESS (0.358s)
[418.465524] Starting dynamic subtest: bcs0
[418.776254] Dynamic subtest bcs0: SUCCESS (0.323s)
[418.789428] Starting dynamic subtest: vcs0
[419.107703] Dynamic subtest vcs0: SUCCESS (0.330s)
[419.120870] Starting dynamic subtest: vcs1
[419.439111] Dynamic subtest vcs1: SUCCESS (0.330s)
[419.452239] Starting dynamic subtest: vecs0
[419.778448] Dynamic subtest vecs0: SUCCESS (0.338s)
[419.791651] Starting dynamic subtest: vecs1
[420.106894] Dynamic subtest vecs1: SUCCESS (0.327s)
[420.120308] Starting dynamic subtest: ccs0
[420.437517] Dynamic subtest ccs0: SUCCESS (0.330s)
[420.438442] Subtest preempt-hang: SUCCESS (2.344s)
[420.809205] [107/133] (609s left) gem_exec_schedule (u-submit-late-slice)
[420.901813] Starting subtest: u-submit-late-slice
[420.902781] Starting dynamic subtest: rcs0
[420.977156] Dynamic subtest rcs0: SUCCESS (0.074s)
[420.992024] Starting dynamic subtest: bcs0
[421.026445] Dynamic subtest bcs0: SUCCESS (0.048s)
[421.041502] Starting dynamic subtest: vcs0
[421.077076] Dynamic subtest vcs0: SUCCESS (0.049s)
[421.091867] Starting dynamic subtest: vcs1
[421.127179] Dynamic subtest vcs1: SUCCESS (0.049s)
[421.141913] Starting dynamic subtest: vecs0
[421.177532] Dynamic subtest vecs0: SUCCESS (0.049s)
[421.192369] Starting dynamic subtest: vecs1
[421.229942] Dynamic subtest vecs1: SUCCESS (0.051s)
[421.244867] Starting dynamic subtest: ccs0
[421.281879] Dynamic subtest ccs0: SUCCESS (0.051s)
[421.282757] Subtest u-submit-late-slice: SUCCESS (0.381s)
[421.775924] [108/133] (608s left) api_intel_bb (delta-check)
[421.855869] Starting subtest: delta-check
[421.883286] Subtest delta-check: SUCCESS (0.029s)
[422.071985] [109/133] (608s left) kms_cursor_crc (cursor-tearing-position-change)
[422.305741] Starting subtest: cursor-tearing-position-change
[422.308054] Starting dynamic subtest: pipe-A-DP-3
[422.820560] Dynamic subtest pipe-A-DP-3: SUCCESS (0.512s)
[422.849935] Starting dynamic subtest: pipe-D-DP-3
[423.259262] Dynamic subtest pipe-D-DP-3: SUCCESS (0.434s)
[423.260168] Subtest cursor-tearing-position-change: SUCCESS (0.953s)
[423.881124] [110/133] (606s left) gem_exec_suspend (basic-s4-devices)
[423.973560] Starting subtest: basic-S4-devices
[423.974475] Starting dynamic subtest: smem
[434.544214] Dynamic subtest smem: SUCCESS (10.571s)
[434.558512] Starting dynamic subtest: lmem0
[445.180184] Dynamic subtest lmem0: SUCCESS (10.635s)
[445.181134] Subtest basic-S4-devices: SUCCESS (21.208s)
[455.526592] [111/133] (585s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[455.733603] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[455.734505] Starting dynamic subtest: pipe-A-DP-3
[455.742956] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[455.757033] Starting dynamic subtest: pipe-B-DP-3
[455.765367] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[455.779164] Starting dynamic subtest: pipe-C-DP-3
[455.787320] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[455.801288] Starting dynamic subtest: pipe-D-DP-3
[455.811038] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[455.812777] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[456.203233] [112/133] (584s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[456.399264] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[458.880688] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.482s)
[459.120206] [113/133] (581s left) gem_exec_fence (syncobj-invalid-wait)
[459.676524] Starting subtest: syncobj-invalid-wait
[459.677306] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[460.083192] [114/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[460.272251] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[460.273915] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[460.468068] [115/133] (580s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[460.654594] Starting subtest: fbc-2p-pri-indfb-multidraw
[460.656253] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[460.870244] [116/133] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[461.070359] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[461.072063] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[461.267988] [117/133] (579s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[461.464549] Starting subtest: x-tiled-8bpp-rotate-0
[463.031012] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.565s)
[463.285264] [118/133] (578s left) gem_madvise (dontneed-before-pwrite)
[463.333284] Starting subtest: dontneed-before-pwrite
[463.365845] Subtest dontneed-before-pwrite: SKIP (0.032s)
[463.443737] [119/133] (577s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[463.525545] Starting subtest: multi-wait-all-available-submitted-signaled
[463.526455] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[463.657917] [120/133] (577s left) kms_getfb (getfb2-handle-protection)
[463.875856] Starting subtest: getfb2-handle-protection
[463.897004] Subtest getfb2-handle-protection: SUCCESS (0.022s)
[464.119763] [121/133] (577s left) kms_color (deep-color)
[464.322826] Starting subtest: deep-color
[467.605055] Starting dynamic subtest: pipe-A-DP-3-gamma
[473.459802] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.854s)
[473.475084] Starting dynamic subtest: pipe-A-DP-3-degamma
[479.367844] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (5.907s)
[479.383289] Starting dynamic subtest: pipe-A-DP-3-ctm
[485.275780] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (5.907s)
[488.505113] Starting dynamic subtest: pipe-B-DP-3-gamma
[494.363804] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (5.898s)
[494.381566] Starting dynamic subtest: pipe-B-DP-3-degamma
[500.297205] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (5.932s)
[500.312109] Starting dynamic subtest: pipe-B-DP-3-ctm
[506.242714] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (5.944s)
[509.398804] Starting dynamic subtest: pipe-C-DP-3-gamma
[515.335556] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (5.956s)
[515.357989] Starting dynamic subtest: pipe-C-DP-3-degamma
[521.246813] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (5.910s)
[521.264539] Starting dynamic subtest: pipe-C-DP-3-ctm
[527.149808] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (5.902s)
[530.404465] Starting dynamic subtest: pipe-D-DP-3-gamma
[536.319267] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (5.937s)
[536.333682] Starting dynamic subtest: pipe-D-DP-3-degamma
[542.240296] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (5.920s)
[542.255891] Starting dynamic subtest: pipe-D-DP-3-ctm
[548.145769] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (5.904s)
[548.146723] Subtest deep-color: SUCCESS (83.821s)
[548.448955] [122/133] (493s left) gem_exec_balancer (bonded-semaphore)
[548.537679] Starting subtest: bonded-semaphore
[548.539939] Subtest bonded-semaphore: SKIP (0.000s)
[548.981732] [123/133] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[549.174223] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[549.175934] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[549.373841] [124/133] (492s left) syncobj_timeline (device-submit-unordered)
[549.462250] Starting subtest: device-submit-unordered
[549.463231] Subtest device-submit-unordered: SUCCESS (0.000s)
[549.658212] [125/133] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[549.849402] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[549.851145] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[550.043338] [126/133] (491s left) kms_content_protection (suspend-resume)
[550.295005] Starting subtest: suspend-resume
[550.321104] Starting dynamic subtest: pipe-A-DP-3
[671.934049] Dynamic subtest pipe-A-DP-3: FAIL (121.424s)
[671.934819] Subtest suspend-resume: FAIL (121.538s)
[672.162146] [127/133] (369s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[672.247101] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[672.347022] [128/133] (369s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[672.541371] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[672.543093] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[672.745845] [129/133] (369s left) gem_ctx_engines (execute-oneforall)
[672.832597] Starting subtest: execute-oneforall
[673.583384] Subtest execute-oneforall: SUCCESS (0.750s)
[674.275171] [130/133] (367s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[674.468492] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[674.536150] [131/133] (367s left) gem_exec_params (readonly)
[674.621249] Starting subtest: readonly
[674.623528] Subtest readonly: SUCCESS (0.002s)
[674.838881] [132/133] (367s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[675.029195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[675.030816] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[675.228541] [133/133] (367s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[675.426794] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[677.372659] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.947s)
[677.625661] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_vrr
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_pm_rpm
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_busy
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: i915_pm_rpm
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: device_reset
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: i915_pm_rps
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_vm_create
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: gem_lmem_swapping
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_joiner
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_alignment
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_pipe_stress
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_draw_crc
results: parsing output: 91/ for test: kms_atomic_interruptible
results: parsing output: 92/ for test: kms_selftest
results: parsing output: 93/ for test: gem_busy
results: parsing output: 94/ for test: i915_hangman
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_fbcon_fbt
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: gem_exec_suspend
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_madvise
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_color
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ctx_engines
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.