[109.997894] Initializing watchdogs
[109.997961]   /dev/watchdog0
[110.019421] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[110.030736] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[110.034756] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[110.037545] [001/133] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[111.552935] Starting subtest: psr-rgb101010-draw-mmap-cpu
[111.554727] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[111.719838] [002/133] (958s left) kms_plane_cursor (primary)
[113.255048] Starting subtest: primary
[113.256951] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[116.389218] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.133s)
[116.450960] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[119.539439] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.099s)
[119.617875] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[122.706210] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.117s)
[122.789507] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[125.946390] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.165s)
[125.984954] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[129.046494] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.067s)
[129.085087] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[132.163221] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.084s)
[132.228626] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[135.381743] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.160s)
[135.420294] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[138.531812] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.117s)
[138.575228] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[141.681868] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.117s)
[141.746484] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[144.882379] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.143s)
[144.926699] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[148.034306] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.117s)
[148.098937] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[151.233300] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.166s)
[151.327377] Subtest primary: SUCCESS (38.071s)
[151.491650] [003/133] (919s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[152.989961] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[152.990876] Starting dynamic subtest: pipe-A-HDMI-A-3
[152.999398] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[153.007127] Starting dynamic subtest: pipe-B-HDMI-A-3
[153.015929] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[153.023286] Starting dynamic subtest: pipe-C-HDMI-A-3
[153.031785] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[153.039150] Starting dynamic subtest: pipe-D-HDMI-A-3
[153.048761] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[153.050871] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[153.260306] [004/133] (917s left) gem_pipe_control_store_loop (reused-buffer)
[153.341875] Starting subtest: reused-buffer
[155.522337] Subtest reused-buffer: SUCCESS (2.180s)
[155.654513] [005/133] (915s left) prime_busy (hang)
[155.730908] Starting subtest: hang
[155.731812] Starting dynamic subtest: rcs0
[181.481581] Dynamic subtest rcs0: SUCCESS (25.749s)
[181.489307] Starting dynamic subtest: bcs0
[188.635352] Dynamic subtest bcs0: SUCCESS (7.153s)
[188.643185] Starting dynamic subtest: vcs0
[195.608237] Dynamic subtest vcs0: SUCCESS (6.972s)
[195.615771] Starting dynamic subtest: vcs1
[202.654685] Dynamic subtest vcs1: SUCCESS (7.047s)
[202.662397] Starting dynamic subtest: vecs0
[209.627601] Dynamic subtest vecs0: SUCCESS (6.971s)
[209.635414] Starting dynamic subtest: vecs1
[216.605195] Dynamic subtest vecs1: SUCCESS (6.978s)
[216.612799] Starting dynamic subtest: ccs0
[230.504988] Dynamic subtest ccs0: SUCCESS (13.899s)
[230.505997] Subtest hang: SUCCESS (74.774s)
[230.653274] [006/133] (840s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[232.156434] Starting subtest: plane-lut1d-pre-ctm3x4
[232.357531] Starting dynamic subtest: pipe-A-plane-0
[232.590616] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s)
[232.617784] Starting dynamic subtest: pipe-A-plane-1
[232.789631] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[232.797562] Starting dynamic subtest: pipe-A-plane-2
[232.957550] Dynamic subtest pipe-A-plane-2: SUCCESS (0.167s)
[233.234207] Starting dynamic subtest: pipe-B-plane-0
[233.389918] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[233.419499] Starting dynamic subtest: pipe-B-plane-1
[233.590037] Dynamic subtest pipe-B-plane-1: SUCCESS (0.199s)
[233.619235] Starting dynamic subtest: pipe-B-plane-2
[233.788637] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[234.050866] Starting dynamic subtest: pipe-C-plane-0
[234.206487] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[234.236515] Starting dynamic subtest: pipe-C-plane-1
[234.423117] Dynamic subtest pipe-C-plane-1: SUCCESS (0.216s)
[234.452259] Starting dynamic subtest: pipe-C-plane-2
[234.639640] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[234.948769] Starting dynamic subtest: pipe-D-plane-0
[235.138551] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s)
[235.159554] Starting dynamic subtest: pipe-D-plane-1
[235.322129] Dynamic subtest pipe-D-plane-1: SUCCESS (0.182s)
[235.334038] Starting dynamic subtest: pipe-D-plane-2
[235.488350] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s)
[235.543468] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.388s)
[235.724884] [007/133] (835s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[237.244367] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[238.552263] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.307s)
[238.725638] [008/133] (832s left) i915_pm_rps (basic-api)
[238.806530] Starting subtest: basic-api
[238.808262] Subtest basic-api: SKIP (0.001s)
[238.937431] [009/133] (832s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[240.444802] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[240.446319] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[240.599518] [010/133] (830s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[242.153155] Starting subtest: fbc-farfromfence-mmap-gtt
[242.154810] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[242.292618] [011/133] (828s left) kms_addfb_basic (addfb25-modifier-no-flag)
[243.828844] Starting subtest: addfb25-modifier-no-flag
[243.829729] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[243.938705] [012/133] (827s left) gem_exercise_blt (fast-copy)
[244.042316] Starting subtest: fast-copy
[244.043352] Starting dynamic subtest: linear-smem-smem
[244.095125] Dynamic subtest linear-smem-smem: SUCCESS (0.053s)
[244.103111] Starting dynamic subtest: linear-smem-lmem0
[244.111336] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s)
[244.119133] Starting dynamic subtest: linear-lmem0-smem
[244.210604] Dynamic subtest linear-lmem0-smem: SUCCESS (0.099s)
[244.218376] Starting dynamic subtest: linear-lmem0-lmem0
[244.313259] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.102s)
[244.320951] Starting dynamic subtest: xmajor-smem-smem
[244.330551] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[244.338262] Starting dynamic subtest: xmajor-smem-lmem0
[244.346494] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s)
[244.354263] Starting dynamic subtest: xmajor-lmem0-smem
[244.446640] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.100s)
[244.454367] Starting dynamic subtest: xmajor-lmem0-lmem0
[244.544248] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.097s)
[244.551887] Starting dynamic subtest: tile4-smem-smem
[244.560122] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[244.567807] Starting dynamic subtest: tile4-smem-lmem0
[244.575379] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.015s)
[244.583245] Starting dynamic subtest: tile4-lmem0-smem
[244.682888] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.107s)
[244.690601] Starting dynamic subtest: tile4-lmem0-lmem0
[244.781929] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.099s)
[244.789591] Starting dynamic subtest: tile64-smem-smem
[244.799154] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[244.807599] Starting dynamic subtest: tile64-smem-lmem0
[244.815048] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[244.822811] Starting dynamic subtest: tile64-lmem0-smem
[244.905827] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.090s)
[244.913486] Starting dynamic subtest: tile64-lmem0-lmem0
[244.996904] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.091s)
[244.997839] Subtest fast-copy: SUCCESS (0.955s)
[245.115191] [013/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[246.618878] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[246.620467] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[246.755669] [014/133] (824s left) kms_big_fb (linear-64bpp-rotate-0)
[248.300198] Starting subtest: linear-64bpp-rotate-0
[250.635167] Subtest linear-64bpp-rotate-0: SUCCESS (2.335s)
[250.767505] [015/133] (820s left) gem_exec_capture (capture-recoverable)
[250.844891] Starting subtest: capture-recoverable
[250.850960] Subtest capture-recoverable: SUCCESS (0.006s)
[251.035262] [016/133] (820s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[251.111480] Starting subtest: yf-tiled-to-vebox-y-tiled
[251.113628] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[251.398584] [017/133] (820s left) kms_plane (pixel-format-yf-tiled-modifier)
[252.904476] Starting subtest: pixel-format-yf-tiled-modifier
[252.906260] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[253.004657] [018/133] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[254.533957] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[254.535750] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[254.666185] [019/133] (817s left) gem_exec_reloc (basic-write-wc)
[254.775916] Subtest basic-write-wc: SKIP (0.000s)
[254.873039] [020/133] (816s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[254.943039] Starting subtest: multi-wait-available-submitted-signaled
[254.944044] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[255.069831] [021/133] (816s left) gem_wait (await)
[255.154577] Starting subtest: await
[255.155466] Starting dynamic subtest: all-engines
[256.328036] Dynamic subtest all-engines: SUCCESS (1.173s)
[256.339494] Starting dynamic subtest: rcs0
[257.385725] Dynamic subtest rcs0: SUCCESS (1.056s)
[257.397389] Starting dynamic subtest: bcs0
[258.445382] Dynamic subtest bcs0: SUCCESS (1.058s)
[258.457974] Starting dynamic subtest: vcs0
[259.504564] Dynamic subtest vcs0: SUCCESS (1.058s)
[259.517059] Starting dynamic subtest: vcs1
[260.565916] Dynamic subtest vcs1: SUCCESS (1.060s)
[260.578977] Starting dynamic subtest: vecs0
[261.628127] Dynamic subtest vecs0: SUCCESS (1.061s)
[261.641006] Starting dynamic subtest: vecs1
[262.688708] Dynamic subtest vecs1: SUCCESS (1.059s)
[262.701262] Starting dynamic subtest: ccs0
[263.749888] Dynamic subtest ccs0: SUCCESS (1.059s)
[263.752204] Subtest await: SUCCESS (8.595s)
[264.030199] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[264.031949] [022/133] (807s left) kms_psr (psr-cursor-blt)
[265.546505] Subtest psr-cursor-blt: SKIP (0.000s)
[265.609622] [023/133] (806s left) gem_softpin (noreloc-interruptible)
[265.702800] Starting subtest: noreloc-interruptible
[271.115161] Subtest noreloc-interruptible: SUCCESS (5.412s)
[271.276940] [024/133] (800s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[271.354288] Starting subtest: etime-single-wait-for-submit-unsubmitted
[271.462823] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[271.600605] [025/133] (800s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[273.115473] Starting subtest: short-flip-after-cursor-toggle
[274.108322] Subtest short-flip-after-cursor-toggle: SUCCESS (0.993s)
[274.290828] [026/133] (797s left) gem_eio (create-ext)
[274.581687] Starting subtest: create-ext
[275.039359] Subtest create-ext: SUCCESS (0.458s)
[276.563726] [027/133] (795s left) i915_drm_fdinfo (busy-idle)
[276.652761] Starting subtest: busy-idle
[276.653731] Starting dynamic subtest: rcs0
[276.666484] Dynamic subtest rcs0: SKIP (0.013s)
[276.675834] Starting dynamic subtest: bcs0
[276.680220] Dynamic subtest bcs0: SKIP (0.013s)
[276.689379] Starting dynamic subtest: vcs0
[276.691310] Dynamic subtest vcs0: SKIP (0.000s)
[276.700617] Starting dynamic subtest: vcs1
[276.702727] Dynamic subtest vcs1: SKIP (0.000s)
[276.711590] Starting dynamic subtest: vecs0
[276.713550] Dynamic subtest vecs0: SKIP (0.000s)
[276.722734] Starting dynamic subtest: vecs1
[276.725022] Dynamic subtest vecs1: SKIP (0.000s)
[276.733625] Starting dynamic subtest: ccs0
[276.735864] Dynamic subtest ccs0: SKIP (0.000s)
[276.738069] Subtest busy-idle: SKIP (0.030s)
[276.815449] [028/133] (795s left) kms_cursor_crc (cursor-sliding-max-size)
[278.652013] Starting subtest: cursor-sliding-max-size
[278.654526] Subtest cursor-sliding-max-size: SKIP (0.000s)
[278.802436] [029/133] (793s left) kms_vblank (ts-continuation-suspend)
[280.315571] Starting subtest: ts-continuation-suspend
[280.316436] Starting dynamic subtest: pipe-A-HDMI-A-3
[299.331547] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.133s)
[299.343387] Starting dynamic subtest: pipe-D-HDMI-A-3
[318.295207] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.606s)
[318.296026] Subtest ts-continuation-suspend: SUCCESS (7.744s)
[327.453031] [030/133] (753s left) prime_self_import (basic-with_two_bos)
[327.503297] Starting subtest: basic-with_two_bos
[327.554738] Subtest basic-with_two_bos: SUCCESS (0.052s)
[327.684326] [031/133] (753s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[329.246170] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[329.260228] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.013s)
[329.448301] [032/133] (752s left) gem_mmap_gtt (medium-copy)
[329.548849] Subtest medium-copy: SKIP (0.000s)
[329.658355] [033/133] (751s left) syncobj_timeline (invalid-query-bad-pad)
[329.742894] Starting subtest: invalid-query-bad-pad
[329.743922] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[329.858839] [034/133] (751s left) drm_mm (drm_mm)
[329.909464] Starting subtest: drm_mm
[329.937839] Starting dynamic subtest: drm_test_mm_init
[330.002087] Dynamic subtest drm_test_mm_init: SUCCESS (0.062s)
[330.014099] Starting dynamic subtest: drm_test_mm_debug
[330.070780] Dynamic subtest drm_test_mm_debug: SUCCESS (0.065s)
[330.110396] Starting dynamic subtest: drm_test_mm_align32
[330.138932] Dynamic subtest drm_test_mm_align32: SUCCESS (0.066s)
[330.156756] Starting dynamic subtest: drm_test_mm_align64
[330.210561] Dynamic subtest drm_test_mm_align64: SUCCESS (0.067s)
[330.225686] Starting dynamic subtest: drm_test_mm_lowest
[330.279304] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.067s)
[330.309789] Starting dynamic subtest: drm_test_mm_highest
[330.358588] Dynamic subtest drm_test_mm_highest: SUCCESS (0.075s)
[330.360370] Subtest drm_mm: SUCCESS (0.438s)
[330.559682] [035/133] (751s left) gem_mmap_wc (bad-object)
[330.641664] Subtest bad-object: SKIP (0.000s)
[330.705334] [036/133] (751s left) gem_userptr_blits (usage-restrictions)
[330.797771] Starting subtest: usage-restrictions
[330.798725] Subtest usage-restrictions: SUCCESS (0.000s)
[330.974066] [037/133] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[332.521049] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[332.522836] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[332.661757] [038/133] (749s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[334.227136] Starting subtest: cursor-vs-flip-atomic
[365.369394] Subtest cursor-vs-flip-atomic: SUCCESS (31.026s)
[365.544560] [039/133] (716s left) kms_psr (pr-sprite-mmap-gtt)
[367.061101] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[367.128181] [040/133] (714s left) kms_fbcon_fbt (psr)
[367.209850] Starting subtest: psr
[367.211650] Subtest psr: SKIP (0.000s)
[367.412613] [041/133] (714s left) kms_hdmi_inject (inject-audio)
[367.541258] Starting subtest: inject-audio
[367.659627] Subtest inject-audio: SUCCESS (0.119s)
[368.600731] [042/133] (713s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[370.132037] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[370.132944] Starting dynamic subtest: pipe-A-HDMI-A-3
[370.142264] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[370.152936] Starting dynamic subtest: pipe-B-HDMI-A-3
[370.162189] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[370.172625] Starting dynamic subtest: pipe-C-HDMI-A-3
[370.181604] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[370.191791] Starting dynamic subtest: pipe-D-HDMI-A-3
[370.202757] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[370.205144] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[370.371670] [043/133] (711s left) gem_exec_balancer (parallel-balancer)
[370.762049] Starting subtest: parallel-balancer
[372.394598] Subtest parallel-balancer: SUCCESS (1.631s)
[372.525243] [044/133] (709s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[374.039464] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[374.040373] Starting dynamic subtest: pipe-A-valid-mode
[375.598813] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.559s)
[375.599715] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (1.560s)
[375.793245] [045/133] (706s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[377.318736] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[377.320718] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[377.522722] [046/133] (705s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[379.039048] Starting subtest: basic-flip-after-cursor-atomic
[380.045906] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.005s)
[380.298855] [047/133] (702s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[381.813942] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[381.875211] [048/133] (700s left) sysfs_timeslice_duration (invalid)
[381.965444] Starting subtest: invalid
[381.966360] Starting dynamic subtest: vecs0
[381.967302] Dynamic subtest vecs0: SUCCESS (0.000s)
[381.979488] Starting dynamic subtest: ccs0
[381.980754] Dynamic subtest ccs0: SUCCESS (0.000s)
[381.992587] Starting dynamic subtest: vcs0
[381.993756] Dynamic subtest vcs0: SUCCESS (0.000s)
[382.005765] Starting dynamic subtest: bcs0
[382.007026] Dynamic subtest bcs0: SUCCESS (0.001s)
[382.018466] Starting dynamic subtest: vecs1
[382.019725] Dynamic subtest vecs1: SUCCESS (0.000s)
[382.030711] Starting dynamic subtest: rcs0
[382.031614] Dynamic subtest rcs0: SUCCESS (0.000s)
[382.042122] Starting dynamic subtest: vcs1
[382.043334] Dynamic subtest vcs1: SUCCESS (0.001s)
[382.044473] Subtest invalid: SUCCESS (0.008s)
[382.090835] [049/133] (700s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[383.604045] Starting subtest: dsc-fractional-bpp-with-bpc
[383.615523] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[383.779469] [050/133] (699s left) gem_mmap_gtt (big-copy-xy)
[383.871708] Subtest big-copy-XY: SKIP (0.000s)
[383.943029] [051/133] (698s left) gen9_exec_parse (cmd-crossing-page)
[384.028085] Subtest cmd-crossing-page: SKIP (0.000s)
[384.114804] [052/133] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[385.631996] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[385.633680] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[385.778406] [053/133] (697s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[387.358832] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[387.461473] [054/133] (695s left) gem_exec_gttfill (multigpu-basic)
[387.669800] Starting subtest: multigpu-basic
[401.710828] Subtest multigpu-basic: SUCCESS (14.035s)
[401.801116] [055/133] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[403.364463] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[403.366084] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[403.491196] [056/133] (679s left) prime_mmap_coherency (read)
[403.596017] Starting subtest: read
[409.010281] Subtest read: SUCCESS (5.411s)
[409.176203] [057/133] (674s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[410.690138] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[410.691851] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[410.795475] [058/133] (672s left) gem_mmap_gtt (bad-object)
[410.889690] Subtest bad-object: SKIP (0.000s)
[410.970963] [059/133] (672s left) api_intel_bb (object-noreloc-purge-cache-simple)
[411.050792] Starting subtest: object-noreloc-purge-cache-simple
[411.081182] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.030s)
[411.304756] [060/133] (672s left) syncobj_timeline (wait-any-interrupted)
[411.394938] Starting subtest: wait-any-interrupted
[411.496606] Subtest wait-any-interrupted: SUCCESS (0.101s)
[411.621160] [061/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[413.147795] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[413.149512] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[413.279036] [062/133] (670s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[414.016779] Starting subtest: syncobj-backward-timeline-chain-engines
[414.197742] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.181s)
[414.538625] [063/133] (669s left) api_intel_bb (blit-noreloc-purge-cache)
[414.616828] Starting subtest: blit-noreloc-purge-cache
[414.651195] Subtest blit-noreloc-purge-cache: SUCCESS (0.034s)
[414.859592] [064/133] (668s left) kms_pm_rpm (pm-tiling)
[419.340176] Starting subtest: pm-tiling
[419.342459] Subtest pm-tiling: SKIP (0.000s)
[420.250317] [065/133] (663s left) kms_lease (lease-uevent)
[421.771025] Starting subtest: lease-uevent
[422.805298] Subtest lease-uevent: SUCCESS (1.035s)
[422.906453] [066/133] (661s left) gem_tiled_blits (basic)
[422.996003] Subtest basic: SKIP (0.000s)
[423.062602] [067/133] (660s left) syncobj_wait (invalid-single-wait-unsubmitted)
[423.144757] Starting subtest: invalid-single-wait-unsubmitted
[423.145763] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[423.286436] [068/133] (660s left) kms_psr (fbc-psr-cursor-render)
[424.800367] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[424.944540] [069/133] (659s left) gem_create (create-ext-placement-sanity-check)
[425.132920] Starting subtest: create-ext-placement-sanity-check
[425.138724] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[425.291482] [070/133] (658s left) kms_panel_fitting (atomic-fastset)
[426.810082] Starting subtest: atomic-fastset
[426.811806] Subtest atomic-fastset: SKIP (0.000s)
[426.903377] [071/133] (657s left) gem_ccs (block-multicopy-inplace)
[427.002795] Starting subtest: block-multicopy-inplace
[427.003781] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[427.046943] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.044s)
[427.058554] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[427.144716] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[427.156258] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[427.160665] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[427.172186] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[427.258997] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[427.270368] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[427.273508] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[427.285240] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[427.378559] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[427.389779] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[427.392753] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[427.404337] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[427.490040] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[427.490993] Subtest block-multicopy-inplace: SUCCESS (0.489s)
[427.642416] [072/133] (656s left) perf (gen12-unprivileged-single-ctx-counters)
[428.025935] Starting subtest: gen12-unprivileged-single-ctx-counters
[428.026773] Starting dynamic subtest: rcs0
[428.124024] Dynamic subtest rcs0: SUCCESS (0.098s)
[428.124972] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.099s)
[428.181766] [073/133] (656s left) gem_render_copy (linear)
[428.299986] Starting subtest: linear
[428.300971] Starting dynamic subtest: smem
[428.414910] Dynamic subtest smem: SUCCESS (0.112s)
[428.425995] Starting dynamic subtest: lmem0
[428.641826] Dynamic subtest lmem0: SUCCESS (0.228s)
[428.642754] Subtest linear: SUCCESS (0.342s)
[428.902521] [074/133] (655s left) kms_content_protection (mei-interface)
[430.484528] Starting subtest: mei-interface
[430.493773] Subtest mei-interface: SKIP (0.007s)
[430.678857] [075/133] (653s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[430.758722] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[430.759591] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[430.946711] [076/133] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[432.460833] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[432.462485] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.622434] [077/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[434.162912] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[434.164696] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[434.394164] [078/133] (650s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[435.913582] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[435.915374] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[436.069001] [079/133] (648s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[437.598116] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[437.598969] Starting dynamic subtest: pipe-A
[437.980064] Dynamic subtest pipe-A: SUCCESS (0.382s)
[437.996818] Starting dynamic subtest: pipe-B
[438.372867] Dynamic subtest pipe-B: SUCCESS (0.392s)
[438.387786] Starting dynamic subtest: pipe-C
[438.764163] Dynamic subtest pipe-C: SUCCESS (0.390s)
[438.792865] Starting dynamic subtest: pipe-D
[439.172986] Dynamic subtest pipe-D: SUCCESS (0.407s)
[439.174145] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.576s)
[439.430816] [080/133] (645s left) kms_selftest (drm_plane_helper)
[439.486784] Starting subtest: drm_plane_helper
[439.496631] Starting dynamic subtest: drm_test_check_plane_state
[439.567105] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.070s)
[439.587491] Starting dynamic subtest: drm_test_check_invalid_plane_state
[439.648799] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.078s)
[439.650398] Subtest drm_plane_helper: SUCCESS (0.161s)
[439.849688] [081/133] (645s left) gem_workarounds (reset-context)
[439.952305] Starting subtest: reset-context
[440.180834] Subtest reset-context: SUCCESS (0.229s)
[440.349057] [082/133] (644s left) gem_exec_schedule (timeslicing)
[440.446315] Starting subtest: timeslicing
[440.447191] Starting dynamic subtest: rcs0
[440.468353] Dynamic subtest rcs0: SUCCESS (0.021s)
[440.480499] Starting dynamic subtest: bcs0
[440.489977] Dynamic subtest bcs0: SUCCESS (0.021s)
[440.501970] Starting dynamic subtest: vcs0
[440.512137] Dynamic subtest vcs0: SUCCESS (0.021s)
[440.524155] Starting dynamic subtest: vcs1
[440.536314] Dynamic subtest vcs1: SUCCESS (0.023s)
[440.548299] Starting dynamic subtest: vecs0
[440.558547] Dynamic subtest vecs0: SUCCESS (0.021s)
[440.570484] Starting dynamic subtest: vecs1
[440.580630] Dynamic subtest vecs1: SUCCESS (0.021s)
[440.592711] Starting dynamic subtest: ccs0
[440.602599] Dynamic subtest ccs0: SUCCESS (0.021s)
[440.603536] Subtest timeslicing: SUCCESS (0.157s)
[440.976345] [083/133] (644s left) sw_sync (alloc_merge_fence)
[441.026732] Starting subtest: alloc_merge_fence
[441.027554] Subtest alloc_merge_fence: SUCCESS (0.000s)
[441.113052] [084/133] (644s left) kms_big_fb (4-tiled-addfb)
[442.639734] Starting subtest: 4-tiled-addfb
[442.640845] Subtest 4-tiled-addfb: SUCCESS (0.001s)
[442.902330] [085/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[444.429073] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[444.430759] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[444.577251] [086/133] (641s left) kms_dirtyfb (default-dirtyfb-ioctl)
[446.115248] Starting subtest: default-dirtyfb-ioctl
[446.116083] Starting dynamic subtest: A-HDMI-A-3
[447.552798] Dynamic subtest A-HDMI-A-3: SUCCESS (1.437s)
[447.553805] Subtest default-dirtyfb-ioctl: SUCCESS (1.438s)
[447.763042] [087/133] (637s left) kms_cursor_crc (cursor-onscreen-128x42)
[449.493706] Starting subtest: cursor-onscreen-128x42
[449.497026] Starting dynamic subtest: pipe-A-HDMI-A-3
[452.165831] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.668s)
[452.199856] Starting dynamic subtest: pipe-D-HDMI-A-3
[454.821801] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.632s)
[454.822731] Subtest cursor-onscreen-128x42: SUCCESS (5.328s)
[455.171028] [088/133] (630s left) gem_pxp (verify-pxp-stale-buf-execution)
[457.779986] Starting subtest: verify-pxp-stale-buf-execution
[457.782030] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[457.893632] [089/133] (627s left) gem_ctx_persistence (heartbeat-hang)
[457.981079] Starting subtest: heartbeat-hang
[457.983040] Subtest heartbeat-hang: SKIP (0.000s)
[458.125440] [090/133] (627s left) syncobj_eventfd (binary-wait-before-signal)
[458.205991] Starting subtest: binary-wait-before-signal
[458.236971] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[458.423334] [091/133] (627s left) syncobj_wait (reset-unsignaled)
[458.503932] Starting subtest: reset-unsignaled
[458.505008] Subtest reset-unsignaled: SUCCESS (0.000s)
[458.640639] [092/133] (627s left) kms_psr (psr-primary-mmap-cpu)
[460.152772] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[460.209514] [093/133] (625s left) gem_spin_batch (legacy-resubmit)
[460.301204] Starting subtest: legacy-resubmit
[460.302101] Starting dynamic subtest: default
[460.335627] Dynamic subtest default: SUCCESS (0.034s)
[460.347640] Starting dynamic subtest: render
[460.348604] Dynamic subtest render: SUCCESS (0.002s)
[460.360711] Starting dynamic subtest: bsd
[460.361944] Dynamic subtest bsd: SUCCESS (0.002s)
[460.373540] Starting dynamic subtest: bsd1
[460.374719] Dynamic subtest bsd1: SUCCESS (0.002s)
[460.385982] Starting dynamic subtest: bsd2
[460.386896] Dynamic subtest bsd2: SUCCESS (0.003s)
[460.398183] Starting dynamic subtest: blt
[460.399309] Dynamic subtest blt: SUCCESS (0.004s)
[460.410705] Starting dynamic subtest: vebox
[460.411897] Dynamic subtest vebox: SUCCESS (0.002s)
[460.413134] Subtest legacy-resubmit: SUCCESS (0.055s)
[460.680174] [094/133] (625s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[462.205188] Starting subtest: x-tiled-64bpp-rotate-270
[462.264837] Subtest x-tiled-64bpp-rotate-270: SKIP (0.059s)
[462.472852] [095/133] (623s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[463.995454] Starting subtest: yf-tiled-8bpp-rotate-90
[463.997492] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[464.234818] [096/133] (622s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[465.755792] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[465.757558] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[465.854034] [097/133] (620s left) kms_hdr (bpc-switch-suspend)
[467.386531] Starting subtest: bpc-switch-suspend
[467.389139] Subtest bpc-switch-suspend: SKIP (0.001s)
[467.488611] [098/133] (619s left) i915_module_load (reload-no-display)
[467.547700] Starting subtest: reload-no-display
[473.440531] Subtest reload-no-display: SUCCESS (5.892s)
[473.470644] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[473.471600] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[473.473498] [099/133] (613s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[478.375728] Starting subtest: fbcpsr-rgb565-draw-pwrite
[478.377512] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[478.591674] [FACT kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[478.596211] [FACT kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[478.600910] [100/133] (608s left) gem_exec_flush (basic-uc-pro-default)
[478.697654] Subtest basic-uc-pro-default: SKIP (0.000s)
[478.775285] [101/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[480.291976] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[480.293781] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[480.436277] [102/133] (606s left) gem_ctx_exec (basic)
[480.543027] Starting subtest: basic
[480.559023] Subtest basic: SUCCESS (0.016s)
[480.776057] [103/133] (606s left) kms_3d (basic)
[480.858066] Starting subtest: basic
[482.839984] Subtest basic: SUCCESS (1.982s)
[483.840763] [104/133] (603s left) kms_flip (2x-blocking-wf_vblank)
[485.363897] Starting subtest: 2x-blocking-wf_vblank
[485.377068] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[485.544438] [105/133] (601s left) kms_atomic (plane-invalid-params)
[487.076540] Starting subtest: plane-invalid-params
[487.077629] Starting dynamic subtest: pipe-A-HDMI-A-3
[487.930241] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.853s)
[487.931113] Subtest plane-invalid-params: SUCCESS (0.855s)
[488.133955] [106/133] (599s left) kms_hdr (static-toggle)
[489.645548] Starting subtest: static-toggle
[489.648200] Subtest static-toggle: SKIP (0.000s)
[489.752118] [107/133] (597s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[491.295141] Starting subtest: y-tiled-16bpp-rotate-270
[491.296963] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[491.435436] [108/133] (595s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[492.976861] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[493.037334] [109/133] (594s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[494.558567] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[494.559527] Starting dynamic subtest: pipe-A-HDMI-A-3
[494.568072] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[494.578986] Starting dynamic subtest: pipe-B-HDMI-A-3
[494.587460] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[494.598167] Starting dynamic subtest: pipe-C-HDMI-A-3
[494.606478] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[494.617315] Starting dynamic subtest: pipe-D-HDMI-A-3
[494.627468] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[494.629066] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[494.836462] [110/133] (592s left) gem_ctx_persistence (engines-cleanup)
[494.924263] Starting subtest: engines-cleanup
[494.925145] Starting dynamic subtest: rcs0
[495.022801] Dynamic subtest rcs0: SUCCESS (0.098s)
[495.037664] Starting dynamic subtest: bcs0
[495.040199] Dynamic subtest bcs0: SUCCESS (0.015s)
[495.054412] Starting dynamic subtest: vcs0
[495.100053] Dynamic subtest vcs0: SUCCESS (0.060s)
[495.129036] Starting dynamic subtest: vcs1
[495.155137] Dynamic subtest vcs1: SUCCESS (0.053s)
[495.178686] Starting dynamic subtest: vecs0
[495.198994] Dynamic subtest vecs0: SUCCESS (0.042s)
[495.222392] Starting dynamic subtest: vecs1
[495.248829] Dynamic subtest vecs1: SUCCESS (0.048s)
[495.267884] Starting dynamic subtest: ccs0
[495.271920] Dynamic subtest ccs0: SUCCESS (0.022s)
[495.272917] Subtest engines-cleanup: SUCCESS (0.348s)
[495.489996] [111/133] (592s left) kms_setmode (clone-exclusive-crtc)
[495.567155] Starting subtest: clone-exclusive-crtc
[495.570070] Subtest clone-exclusive-crtc: SKIP (0.000s)
[495.690913] [112/133] (591s left) kms_chamelium_color (ctm-red-to-blue)
[497.207840] Subtest ctm-red-to-blue: SKIP (0.000s)
[497.270059] [113/133] (590s left) perf_pmu (init-busy)
[497.344527] Starting subtest: init-busy
[497.345456] Starting dynamic subtest: rcs0
[497.347662] Dynamic subtest rcs0: SUCCESS (0.002s)
[497.358762] Starting dynamic subtest: bcs0
[497.359732] Dynamic subtest bcs0: SUCCESS (0.001s)
[497.370164] Starting dynamic subtest: vcs0
[497.371053] Dynamic subtest vcs0: SUCCESS (0.001s)
[497.381746] Starting dynamic subtest: vcs1
[497.382940] Dynamic subtest vcs1: SUCCESS (0.000s)
[497.393794] Starting dynamic subtest: vecs0
[497.395020] Dynamic subtest vecs0: SUCCESS (0.001s)
[497.405055] Starting dynamic subtest: vecs1
[497.405932] Dynamic subtest vecs1: SUCCESS (0.001s)
[497.416821] Starting dynamic subtest: ccs0
[497.418092] Dynamic subtest ccs0: SUCCESS (0.000s)
[497.419176] Subtest init-busy: SUCCESS (0.014s)
[497.543151] [114/133] (590s left) kms_addfb_basic (invalid-set-prop-any)
[497.622934] Starting subtest: invalid-set-prop-any
[497.623818] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[499.205042] [115/133] (588s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[500.745726] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[500.747598] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[500.950039] [116/133] (586s left) gem_exec_schedule (noreorder)
[501.172937] Starting subtest: noreorder
[501.173891] Starting dynamic subtest: rcs0
[501.270989] Dynamic subtest rcs0: SUCCESS (0.097s)
[501.288835] Starting dynamic subtest: bcs0
[501.330660] Dynamic subtest bcs0: SUCCESS (0.058s)
[501.344952] Starting dynamic subtest: vcs0
[501.391147] Dynamic subtest vcs0: SUCCESS (0.058s)
[501.412271] Starting dynamic subtest: vcs1
[501.451597] Dynamic subtest vcs1: SUCCESS (0.058s)
[501.484547] Starting dynamic subtest: vecs0
[501.526156] Dynamic subtest vecs0: SUCCESS (0.072s)
[501.550161] Starting dynamic subtest: vecs1
[501.597788] Dynamic subtest vecs1: SUCCESS (0.069s)
[501.638251] Starting dynamic subtest: ccs0
[501.671957] Dynamic subtest ccs0: SUCCESS (0.071s)
[501.672962] Subtest noreorder: SUCCESS (0.500s)
[501.965601] [117/133] (585s left) i915_suspend (sysfs-reader)
[502.058077] Starting subtest: sysfs-reader
[523.296297] Subtest sysfs-reader: SUCCESS (5.755s)
[533.418682] [118/133] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[534.977982] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[534.979861] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[535.114330] [119/133] (563s left) gem_exec_reloc (basic-write-gtt)
[535.227094] Subtest basic-write-gtt: SKIP (0.000s)
[535.310998] [120/133] (562s left) kms_flip (basic-flip-vs-dpms)
[536.859394] Starting subtest: basic-flip-vs-dpms
[536.865529] Starting dynamic subtest: A-HDMI-A3
[537.652134] Dynamic subtest A-HDMI-A3: SUCCESS (0.769s)
[537.663654] Starting dynamic subtest: B-HDMI-A3
[538.310137] Dynamic subtest B-HDMI-A3: SUCCESS (0.643s)
[538.321742] Starting dynamic subtest: C-HDMI-A3
[538.969997] Dynamic subtest C-HDMI-A3: SUCCESS (0.646s)
[538.982017] Starting dynamic subtest: D-HDMI-A3
[539.631738] Dynamic subtest D-HDMI-A3: SUCCESS (0.649s)
[539.632642] Subtest basic-flip-vs-dpms: SUCCESS (2.718s)
[539.829239] [121/133] (558s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[541.368247] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[541.382094] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.013s)
[541.486814] [122/133] (556s left) gem_mmap_offset (isolation)
[541.576474] Starting subtest: isolation
[541.585215] Subtest isolation: SUCCESS (0.007s)
[541.734377] [123/133] (556s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[541.817669] Starting subtest: framebuffer-vs-set-tiling
[541.819360] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[543.402349] [124/133] (555s left) kms_plane_alpha_blend (coverage-7efc)
[544.953085] Starting subtest: coverage-7efc
[545.206718] Starting dynamic subtest: pipe-A-HDMI-A-3
[545.661859] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.451s)
[545.696541] Starting dynamic subtest: pipe-D-HDMI-A-3
[546.276961] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.586s)
[546.277890] Subtest coverage-7efc: SUCCESS (1.315s)
[546.464352] [125/133] (552s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[547.988093] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[547.989015] Starting dynamic subtest: pipe-A-HDMI-A-3
[547.997468] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[548.009031] Starting dynamic subtest: pipe-B-HDMI-A-3
[548.017400] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[548.028625] Starting dynamic subtest: pipe-C-HDMI-A-3
[548.036882] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[548.047889] Starting dynamic subtest: pipe-D-HDMI-A-3
[548.057285] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[548.059259] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[548.282013] [126/133] (550s left) kms_psr (fbc-psr2-primary-page-flip)
[549.805318] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[549.864922] [127/133] (548s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[551.718397] Starting subtest: cursor-rapid-movement-max-size
[551.721066] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[551.905218] [128/133] (546s left) kms_pm_dc (dc6-dpms)
[554.432408] Starting subtest: dc6-dpms
[554.434170] Subtest dc6-dpms: SKIP (0.000s)
[554.620834] [129/133] (544s left) kms_psr (fbc-pr-primary-mmap-cpu)
[556.153219] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[556.220207] [130/133] (542s left) gem_exec_params (sol-reset-invalid)
[556.306164] Starting subtest: sol-reset-invalid
[556.308368] Subtest sol-reset-invalid: SUCCESS (0.002s)
[556.521951] [131/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[558.043881] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[558.045742] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[558.242629] [132/133] (540s left) gem_exec_whisper (basic-contexts-all)
[558.348383] Starting subtest: basic-contexts-all
[580.395131] Subtest basic-contexts-all: SUCCESS (22.032s)
[580.595832] [133/133] (518s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[580.685513] Starting subtest: y-tiled-ccs-to-x-tiled
[580.687386] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[580.936117] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_plane_cursor
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_pipe_control_store_loop
results: parsing output: 4/ for test: prime_busy
results: parsing output: 5/ for test: kms_color_pipeline
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: i915_pm_rps
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_exercise_blt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_capture
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_wait
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: i915_drm_fdinfo
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: prime_self_import
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: drm_mm
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_fbcon_fbt
results: parsing output: 40/ for test: kms_hdmi_inject
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: sysfs_timeslice_duration
results: parsing output: 48/ for test: kms_dsc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: gem_exec_gttfill
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: prime_mmap_coherency
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_tiled_blits
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_panel_fitting
results: parsing output: 70/ for test: gem_ccs
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_content_protection
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_selftest
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_dirtyfb
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_eventfd
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_hdr
results: parsing output: 97/ for test: i915_module_load
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_exec
results: parsing output: 102/ for test: kms_3d
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_atomic
results: parsing output: 105/ for test: kms_hdr
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_setmode
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: i915_suspend
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_whisper
results: parsing output: 132/ for test: gem_render_copy
Done.