[64.660623] Initializing watchdogs
[64.660689]   /dev/watchdog0
[64.681525] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.692871] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.696759] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.699160] [001/133] (960s left) gem_exec_params (dr4-dirt)
[64.794707] Starting subtest: DR4-dirt
[64.795592] Subtest DR4-dirt: SUCCESS (0.000s)
[65.004675] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[66.509833] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[66.511462] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.635756] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[68.193924] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[68.195636] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.397037] [004/133] (957s left) prime_mmap (test_correct)
[68.481777] Starting subtest: test_correct
[68.482625] Starting dynamic subtest: test_correct-smem
[68.530934] Dynamic subtest test_correct-smem: SUCCESS (0.049s)
[68.538274] Starting dynamic subtest: test_correct-lmem0
[68.731266] Dynamic subtest test_correct-lmem0: SUCCESS (0.200s)
[68.732236] Subtest test_correct: SUCCESS (0.249s)
[68.860690] [005/133] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[70.363046] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[70.364598] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[70.525642] [006/133] (955s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[70.635572] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[70.637509] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[70.877554] [007/133] (954s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[72.393541] Starting subtest: x-tiled-64bpp-rotate-90
[72.473238] Subtest x-tiled-64bpp-rotate-90: SKIP (0.079s)
[72.646847] [008/133] (953s left) gem_lmem_swapping (heavy-verify-random)
[76.972245] Starting subtest: heavy-verify-random
[76.973193] Starting dynamic subtest: lmem0
[91.937480] Dynamic subtest lmem0: SUCCESS (14.970s)
[91.938429] Subtest heavy-verify-random: SUCCESS (14.970s)
[93.075954] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[93.077556] [009/133] (932s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[97.893735] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[97.894579] Starting dynamic subtest: pipe-A-HDMI-A-3
[97.903178] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[97.910583] Starting dynamic subtest: pipe-B-HDMI-A-3
[97.919531] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[97.928292] Starting dynamic subtest: pipe-C-HDMI-A-3
[97.936912] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[97.944143] Starting dynamic subtest: pipe-D-HDMI-A-3
[97.952997] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[97.955159] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[98.192562] [FACT kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[98.194948] [010/133] (927s left) i915_pm_rc6_residency (rc6-accuracy)
[98.268386] Starting subtest: rc6-accuracy
[98.269288] Starting dynamic subtest: gt0
[101.483387] Dynamic subtest gt0: FAIL (3.195s)
[101.484354] Subtest rc6-accuracy: FAIL (3.195s)
[101.555915] [011/133] (924s left) perf (whitelisted-registers-userspace-config)
[101.892127] Starting subtest: whitelisted-registers-userspace-config
[101.892993] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[101.951187] [012/133] (924s left) kms_plane_multiple (tiling-x)
[103.452333] Starting subtest: tiling-x
[103.453254] Starting dynamic subtest: pipe-A-HDMI-A-3
[104.272464] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.820s)
[104.282589] Starting dynamic subtest: pipe-B-HDMI-A-3
[104.966960] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.693s)
[104.976265] Starting dynamic subtest: pipe-C-HDMI-A-3
[105.664385] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.696s)
[105.673695] Starting dynamic subtest: pipe-D-HDMI-A-3
[106.333878] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.668s)
[106.334786] Subtest tiling-x: SUCCESS (2.882s)
[106.514728] [013/133] (919s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[106.605980] Starting subtest: y-tiled-ccs-to-y-tiled
[106.608035] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[106.809517] [014/133] (919s left) i915_drm_fdinfo (busy-idle)
[106.872975] Starting subtest: busy-idle
[106.873944] Starting dynamic subtest: rcs0
[106.887304] Dynamic subtest rcs0: SKIP (0.013s)
[106.895173] Starting dynamic subtest: bcs0
[106.903199] Dynamic subtest bcs0: SKIP (0.016s)
[106.911165] Starting dynamic subtest: vcs0
[106.912951] Dynamic subtest vcs0: SKIP (0.000s)
[106.920997] Starting dynamic subtest: vcs1
[106.923165] Dynamic subtest vcs1: SKIP (0.000s)
[106.931372] Starting dynamic subtest: vecs0
[106.933591] Dynamic subtest vecs0: SKIP (0.000s)
[106.941393] Starting dynamic subtest: vecs1
[106.943575] Dynamic subtest vecs1: SKIP (0.000s)
[106.951471] Starting dynamic subtest: ccs0
[106.953565] Dynamic subtest ccs0: SKIP (0.000s)
[106.955410] Subtest busy-idle: SKIP (0.033s)
[107.001648] [015/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[108.520740] Starting subtest: yf-tiled-64bpp-rotate-90
[108.522446] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[108.668948] [016/133] (917s left) gem_userptr_blits (sd-probe)
[108.787282] Starting subtest: sd-probe
[108.789021] Subtest sd-probe: SKIP (0.000s)
[108.998628] [017/133] (917s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[110.500704] Starting subtest: fbcpsr-rgb101010-draw-blt
[110.502405] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[110.623225] [018/133] (915s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[112.163927] Starting subtest: invalid-modeset-force-ultra-joiner
[112.165546] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[112.261570] [019/133] (914s left) gem_busy (parallel)
[112.574204] Starting subtest: parallel
[112.575155] Starting dynamic subtest: rcs0
[112.697640] Dynamic subtest rcs0: SUCCESS (0.123s)
[112.706453] Starting dynamic subtest: bcs0
[112.756869] Dynamic subtest bcs0: SUCCESS (0.059s)
[112.765316] Starting dynamic subtest: vcs0
[112.820839] Dynamic subtest vcs0: SUCCESS (0.063s)
[112.835064] Starting dynamic subtest: vcs1
[112.891394] Dynamic subtest vcs1: SUCCESS (0.070s)
[112.915457] Starting dynamic subtest: vecs0
[112.976980] Dynamic subtest vecs0: SUCCESS (0.085s)
[112.988386] Starting dynamic subtest: vecs1
[113.041961] Dynamic subtest vecs1: SUCCESS (0.064s)
[113.059923] Starting dynamic subtest: ccs0
[113.120517] Dynamic subtest ccs0: SUCCESS (0.078s)
[113.121558] Subtest parallel: SUCCESS (0.547s)
[113.401572] [020/133] (913s left) api_intel_bb (full-batch)
[113.470358] Starting subtest: full-batch
[113.503246] Subtest full-batch: SUCCESS (0.033s)
[113.681543] [021/133] (912s left) syncobj_wait (single-wait-submitted)
[113.750188] Starting subtest: single-wait-submitted
[113.868208] Subtest single-wait-submitted: SUCCESS (0.105s)
[113.990711] [022/133] (912s left) device_reset (unbind-reset-rebind)
[114.068588] Starting subtest: unbind-reset-rebind
[117.695305] Subtest unbind-reset-rebind: SUCCESS (3.626s)
[117.766194] [023/133] (908s left) gem_exec_schedule (pi-userfault)
[117.977768] Starting subtest: pi-userfault
[117.979071] Starting dynamic subtest: rcs0
[117.994923] Dynamic subtest rcs0: SUCCESS (0.017s)
[118.004114] Starting dynamic subtest: bcs0
[118.005085] Dynamic subtest bcs0: SUCCESS (0.008s)
[118.014642] Starting dynamic subtest: vcs0
[118.015510] Dynamic subtest vcs0: SUCCESS (0.009s)
[118.024371] Starting dynamic subtest: vcs1
[118.025315] Dynamic subtest vcs1: SUCCESS (0.008s)
[118.033953] Starting dynamic subtest: vecs0
[118.034886] Dynamic subtest vecs0: SUCCESS (0.010s)
[118.043372] Starting dynamic subtest: vecs1
[118.044279] Dynamic subtest vecs1: SUCCESS (0.008s)
[118.053186] Starting dynamic subtest: ccs0
[118.054387] Dynamic subtest ccs0: SUCCESS (0.008s)
[118.055626] Subtest pi-userfault: SUCCESS (0.072s)
[118.322008] [024/133] (908s left) kms_psr (fbc-psr-sprite-blt)
[119.824524] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[119.870312] [025/133] (906s left) kms_cursor_crc (cursor-random-128x42)
[121.589148] Starting subtest: cursor-random-128x42
[121.601165] Starting dynamic subtest: pipe-A-HDMI-A-3
[126.186228] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.584s)
[126.212773] Starting dynamic subtest: pipe-D-HDMI-A-3
[130.636273] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.430s)
[130.637273] Subtest cursor-random-128x42: SUCCESS (9.046s)
[131.004923] [026/133] (895s left) kms_busy (extended-modeset-hang-newfb)
[132.510289] Starting subtest: extended-modeset-hang-newfb
[132.511232] Starting dynamic subtest: pipe-A
[148.071471] Dynamic subtest pipe-A: SUCCESS (15.560s)
[148.082249] Starting dynamic subtest: pipe-D
[163.580668] Dynamic subtest pipe-D: SUCCESS (15.506s)
[163.581565] Subtest extended-modeset-hang-newfb: SUCCESS (31.071s)
[163.767364] [027/133] (863s left) kms_color (gamma)
[165.269287] Starting subtest: gamma
[165.270228] Starting dynamic subtest: pipe-A-HDMI-A-3
[165.933205] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.664s)
[165.943161] Starting dynamic subtest: pipe-B-HDMI-A-3
[166.423837] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.490s)
[166.432554] Starting dynamic subtest: pipe-C-HDMI-A-3
[166.901529] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.477s)
[166.910234] Starting dynamic subtest: pipe-D-HDMI-A-3
[167.364423] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.463s)
[167.365285] Subtest gamma: SUCCESS (2.096s)
[167.519540] [028/133] (859s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[169.026436] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[169.027296] Starting dynamic subtest: pipe-A-HDMI-A-3
[169.030770] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[169.039830] Starting dynamic subtest: pipe-B-HDMI-A-3
[169.043296] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[169.052216] Starting dynamic subtest: pipe-C-HDMI-A-3
[169.055829] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[169.064453] Starting dynamic subtest: pipe-D-HDMI-A-3
[169.067921] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[169.069517] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[169.318382] [029/133] (857s left) api_intel_bb (add-remove-objects)
[169.388181] Starting subtest: add-remove-objects
[169.420410] Subtest add-remove-objects: SUCCESS (0.033s)
[169.524898] [030/133] (857s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[171.027748] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[173.923184] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.896s)
[174.132283] [031/133] (853s left) kms_lease (lease-again)
[175.639473] Starting subtest: lease-again
[175.640404] Starting dynamic subtest: pipe-A-HDMI-A-3
[175.644046] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.004s)
[175.654364] Starting dynamic subtest: pipe-B-HDMI-A-3
[175.655310] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.004s)
[175.664378] Starting dynamic subtest: pipe-C-HDMI-A-3
[175.665283] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.004s)
[175.673967] Starting dynamic subtest: pipe-D-HDMI-A-3
[175.674937] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.004s)
[175.675890] Subtest lease-again: SUCCESS (0.022s)
[175.782929] [032/133] (851s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[177.303951] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[177.361923] [033/133] (849s left) i915_selftest (perf)
[178.268861] Starting subtest: perf
[178.269944] Starting dynamic subtest: engine_cs
[179.793961] Dynamic subtest engine_cs: SUCCESS (1.525s)
[179.801163] Starting dynamic subtest: request
[184.391859] Dynamic subtest request: SUCCESS (4.597s)
[184.399391] Starting dynamic subtest: migrate
[185.957036] Dynamic subtest migrate: SUCCESS (1.565s)
[185.964431] Starting dynamic subtest: region
[213.594877] Dynamic subtest region: SUCCESS (27.637s)
[213.595782] Subtest perf: SUCCESS (35.326s)
[213.621621] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[213.623287] [034/133] (813s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[218.451874] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[218.453508] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[218.518485] [FACT kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)] new: kernel.kmod_is_loaded.i915: true
[218.521214] [035/133] (808s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[220.029337] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[220.030245] Starting dynamic subtest: pipe-A
[220.128108] Dynamic subtest pipe-A: SUCCESS (0.099s)
[220.137711] Starting dynamic subtest: pipe-B
[220.254520] Dynamic subtest pipe-B: SUCCESS (0.126s)
[220.264542] Starting dynamic subtest: pipe-C
[220.379135] Dynamic subtest pipe-C: SUCCESS (0.124s)
[220.387123] Starting dynamic subtest: pipe-D
[220.486114] Dynamic subtest pipe-D: SUCCESS (0.106s)
[220.487038] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.457s)
[220.726618] [036/133] (806s left) kms_pm_lpsp (kms-lpsp)
[223.242617] Starting subtest: kms-lpsp
[223.244333] Subtest kms-lpsp: SKIP (0.000s)
[223.348260] [037/133] (804s left) gem_exec_balancer (smoke)
[223.457377] Starting subtest: smoke
[247.005903] Subtest smoke: SUCCESS (23.548s)
[247.975415] [038/133] (779s left) kms_async_flips (alternate-sync-async-flip-atomic)
[249.475622] Starting subtest: alternate-sync-async-flip-atomic
[249.658417] Starting dynamic subtest: pipe-A-HDMI-A-3
[251.957235] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.301s)
[252.154772] Starting dynamic subtest: pipe-B-HDMI-A-3
[254.236617] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.089s)
[254.415543] Starting dynamic subtest: pipe-C-HDMI-A-3
[256.465250] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.057s)
[256.668984] Starting dynamic subtest: pipe-D-HDMI-A-3
[258.744688] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.083s)
[258.746309] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.271s)
[259.173160] [039/133] (768s left) syncobj_eventfd (invalid-bad-pad)
[259.247285] Starting subtest: invalid-bad-pad
[259.248215] Subtest invalid-bad-pad: SUCCESS (0.000s)
[259.412063] [040/133] (768s left) gem_ctx_bad_destroy (invalid-ctx)
[259.479761] Starting subtest: invalid-ctx
[259.480634] Subtest invalid-ctx: SUCCESS (0.000s)
[259.615471] [041/133] (768s left) kms_vblank (query-idle)
[261.114090] Starting subtest: query-idle
[261.115160] Starting dynamic subtest: pipe-A-HDMI-A-3
[263.404494] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.290s)
[263.416129] Starting dynamic subtest: pipe-D-HDMI-A-3
[265.572389] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.164s)
[265.573263] Subtest query-idle: SUCCESS (4.460s)
[265.722641] [042/133] (762s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[267.234463] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[267.236430] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[267.357847] [043/133] (760s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[268.897081] Starting subtest: 4-tiled-8bpp-rotate-90
[268.960609] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.063s)
[269.143035] [044/133] (758s left) sysfs_preempt_timeout (timeout)
[269.217106] Starting subtest: timeout
[269.218166] Starting dynamic subtest: vecs0
[271.028289] Dynamic subtest vecs0: SUCCESS (1.810s)
[271.038405] Starting dynamic subtest: ccs0
[272.776308] Dynamic subtest ccs0: SUCCESS (1.746s)
[272.785299] Starting dynamic subtest: vcs0
[274.470341] Dynamic subtest vcs0: SUCCESS (1.693s)
[274.479177] Starting dynamic subtest: bcs0
[276.103383] Dynamic subtest bcs0: SUCCESS (1.632s)
[276.112250] Starting dynamic subtest: vecs1
[277.738586] Dynamic subtest vecs1: SUCCESS (1.634s)
[277.749067] Starting dynamic subtest: rcs0
[279.413328] Dynamic subtest rcs0: SUCCESS (1.673s)
[279.422407] Starting dynamic subtest: vcs1
[281.077327] Dynamic subtest vcs1: SUCCESS (1.663s)
[281.078247] Subtest timeout: SUCCESS (11.860s)
[281.226274] [045/133] (746s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[282.727032] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[282.727965] Starting dynamic subtest: pipe-A-valid-mode
[283.579231] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.851s)
[283.580163] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (0.853s)
[283.772387] [046/133] (744s left) kms_draw_crc (draw-method-render)
[285.274326] Starting subtest: draw-method-render
[285.275239] Starting dynamic subtest: xrgb8888-untiled
[285.675494] Dynamic subtest xrgb8888-untiled: SUCCESS (0.400s)
[285.709032] Starting dynamic subtest: rgb565-untiled
[286.009074] Dynamic subtest rgb565-untiled: SUCCESS (0.330s)
[286.042066] Starting dynamic subtest: xrgb2101010-untiled
[286.308663] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.296s)
[286.344266] Starting dynamic subtest: xbgr16161616f-untiled
[286.657900] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.346s)
[286.670363] Starting dynamic subtest: xrgb8888-xtiled
[286.824905] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[286.842205] Starting dynamic subtest: rgb565-xtiled
[286.992387] Dynamic subtest rgb565-xtiled: SUCCESS (0.165s)
[287.028489] Starting dynamic subtest: xrgb2101010-xtiled
[287.158572] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s)
[287.195040] Starting dynamic subtest: xbgr16161616f-xtiled
[287.342179] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[287.379600] Starting dynamic subtest: xrgb8888-4tiled
[287.542504] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.196s)
[287.579336] Starting dynamic subtest: rgb565-4tiled
[287.725715] Dynamic subtest rgb565-4tiled: SUCCESS (0.179s)
[287.762948] Starting dynamic subtest: xrgb2101010-4tiled
[287.907959] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.179s)
[287.920704] Starting dynamic subtest: xbgr16161616f-4tiled
[288.075490] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[288.080750] Subtest draw-method-render: SUCCESS (2.803s)
[288.254660] [047/133] (740s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[289.758191] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[289.759854] Starting dynamic subtest: pipe-A-HDMI-A-3
[289.768290] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[289.777235] Starting dynamic subtest: pipe-B-HDMI-A-3
[289.785791] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[289.794483] Starting dynamic subtest: pipe-C-HDMI-A-3
[289.802790] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[289.811379] Starting dynamic subtest: pipe-D-HDMI-A-3
[289.821169] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[289.823526] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[290.004678] [048/133] (738s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[291.507116] Starting subtest: cursor-vs-flip-atomic
[322.427386] Subtest cursor-vs-flip-atomic: SUCCESS (30.921s)
[322.600417] [049/133] (705s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[322.672545] Starting subtest: invalid-single-wait-unsubmitted
[322.673402] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[322.792735] [050/133] (705s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[324.299090] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[324.300815] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[324.415579] [051/133] (704s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[325.941180] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[325.942103] Starting dynamic subtest: pipe-A-HDMI-A-3
[325.964033] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[325.973397] Starting dynamic subtest: pipe-B-HDMI-A-3
[325.994890] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[326.003743] Starting dynamic subtest: pipe-C-HDMI-A-3
[326.027112] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[326.036012] Starting dynamic subtest: pipe-D-HDMI-A-3
[326.057532] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[326.059181] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.016s)
[326.176329] [052/133] (702s left) gem_eio (in-flight-external)
[326.458203] Starting subtest: in-flight-external
[327.873415] Subtest in-flight-external: SUCCESS (1.416s)
[329.406148] [053/133] (699s left) kms_force_connector_basic (force-connector-state)
[329.571389] Starting subtest: force-connector-state
[331.277716] Subtest force-connector-state: SUCCESS (1.698s)
[332.958189] [054/133] (695s left) gem_partial_pwrite_pread (write-snoop)
[333.047272] Subtest write-snoop: SKIP (0.000s)
[333.145897] [055/133] (695s left) kms_chamelium_audio (hdmi-audio)
[334.700300] Subtest hdmi-audio: SKIP (0.000s)
[334.794842] [056/133] (694s left) tools_test (sysfs_l3_parity)
[334.850901] Starting subtest: sysfs_l3_parity
[334.916278] Subtest sysfs_l3_parity: SKIP (0.069s)
[335.063294] [057/133] (693s left) sw_sync (sync_merge_same)
[335.108653] Starting subtest: sync_merge_same
[335.109539] Subtest sync_merge_same: SUCCESS (0.000s)
[335.175030] [058/133] (693s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[335.246509] Starting subtest: etime-single-wait-available-unsubmitted
[335.352863] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[335.488574] [059/133] (693s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[336.989558] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[337.039156] [060/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[338.547183] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[338.548963] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[338.697450] [061/133] (690s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[340.252193] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[340.254009] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[340.347396] [062/133] (688s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[341.876480] Starting subtest: x-tiled-addfb-size-offset-overflow
[341.877380] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[342.032173] [063/133] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[343.570960] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[350.149081] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (6.578s)
[350.343417] [064/133] (679s left) kms_pm_rpm (package-g7)
[353.976461] Starting subtest: package-g7
[353.978607] Subtest package-g7: SKIP (0.000s)
[354.936552] [065/133] (674s left) gen7_exec_parse (oacontrol-tracking)
[355.014193] Subtest oacontrol-tracking: SKIP (0.000s)
[355.124572] [066/133] (674s left) gem_exec_schedule (fairslice)
[355.207223] Starting subtest: fairslice
[355.208197] Starting dynamic subtest: rcs0
[357.260269] Dynamic subtest rcs0: SUCCESS (2.051s)
[357.270481] Starting dynamic subtest: bcs0
[359.282524] Dynamic subtest bcs0: SUCCESS (2.020s)
[359.293217] Starting dynamic subtest: vcs0
[361.302550] Dynamic subtest vcs0: SUCCESS (2.019s)
[361.313198] Starting dynamic subtest: vcs1
[363.335335] Dynamic subtest vcs1: SUCCESS (2.032s)
[363.351711] Starting dynamic subtest: vecs0
[365.361176] Dynamic subtest vecs0: SUCCESS (2.024s)
[365.371484] Starting dynamic subtest: vecs1
[367.381153] Dynamic subtest vecs1: SUCCESS (2.019s)
[367.391688] Starting dynamic subtest: ccs0
[369.401177] Dynamic subtest ccs0: SUCCESS (2.019s)
[369.402171] Subtest fairslice: SUCCESS (14.193s)
[369.773547] [067/133] (659s left) gem_exec_fence (submit)
[369.973072] Starting subtest: submit
[369.975319] Subtest submit: SKIP (0.000s)
[370.737916] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[370.739970] [068/133] (658s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[372.257949] Starting subtest: psr-shrfb-scaledprimary
[372.259755] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[372.404918] [069/133] (657s left) gem_tiled_fence_blits (basic)
[372.515516] Subtest basic: SKIP (0.000s)
[372.586574] [070/133] (657s left) kms_psr (psr-sprite-mmap-gtt)
[374.101583] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[374.156672] [071/133] (655s left) syncobj_timeline (single-wait-signaled)
[374.237601] Starting subtest: single-wait-signaled
[374.238486] Subtest single-wait-signaled: SUCCESS (0.001s)
[374.434915] [072/133] (655s left) gem_exec_flush (basic-uc-rw-default)
[374.522200] Subtest basic-uc-rw-default: SKIP (0.000s)
[374.604953] [073/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[376.118087] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[376.119882] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[376.238047] [074/133] (653s left) gem_linear_blits (normal)
[376.761047] Starting subtest: normal
[384.307881] Subtest normal: SUCCESS (7.547s)
[384.693227] [075/133] (645s left) gem_ctx_param (invalid-get-engines)
[384.810772] Starting subtest: invalid-get-engines
[384.813379] Subtest invalid-get-engines: SUCCESS (0.002s)
[384.974244] [076/133] (645s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[385.064741] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[385.065583] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[385.193781] [077/133] (645s left) kms_flip (2x-modeset-vs-vblank-race)
[386.709195] Starting subtest: 2x-modeset-vs-vblank-race
[386.722505] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[386.837196] [078/133] (643s left) kms_psr2_su (page_flip-xrgb8888)
[386.935348] Subtest page_flip-XRGB8888: SKIP (0.000s)
[387.020899] [079/133] (643s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[388.537105] Starting subtest: psr-2p-primscrn-cur-indfb-move
[388.538890] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[388.703366] [080/133] (641s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[390.237233] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[390.238170] Starting dynamic subtest: pipe-A
[390.825198] Dynamic subtest pipe-A: SUCCESS (0.588s)
[390.852929] Starting dynamic subtest: pipe-B
[391.399259] Dynamic subtest pipe-B: SUCCESS (0.572s)
[391.424330] Starting dynamic subtest: pipe-C
[391.973558] Dynamic subtest pipe-C: SUCCESS (0.572s)
[391.997886] Starting dynamic subtest: pipe-D
[392.547335] Dynamic subtest pipe-D: SUCCESS (0.572s)
[392.548385] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.312s)
[392.751406] [081/133] (637s left) kms_flip (2x-plain-flip-ts-check)
[394.266048] Starting subtest: 2x-plain-flip-ts-check
[394.278883] Subtest 2x-plain-flip-ts-check: SKIP (0.013s)
[394.407861] [082/133] (636s left) sw_sync (sync_busy_fork)
[394.486523] Starting subtest: sync_busy_fork
[395.493219] Subtest sync_busy_fork: SUCCESS (1.013s)
[395.572169] [083/133] (635s left) gem_mmap_wc (write-read-distinct)
[395.656163] Subtest write-read-distinct: SKIP (0.000s)
[395.734535] [084/133] (634s left) gem_mmap_gtt (fault-concurrent-y)
[395.816179] Subtest fault-concurrent-Y: SKIP (0.000s)
[395.902076] [085/133] (634s left) gem_exec_parallel (fds)
[395.994187] Starting subtest: fds
[395.995140] Starting dynamic subtest: rcs0
[400.076556] Dynamic subtest rcs0: SUCCESS (4.082s)
[400.087598] Starting dynamic subtest: bcs0
[403.859268] Dynamic subtest bcs0: SUCCESS (3.781s)
[403.870919] Starting dynamic subtest: vcs0
[407.160910] Dynamic subtest vcs0: SUCCESS (3.301s)
[407.172633] Starting dynamic subtest: vcs1
[412.038092] Dynamic subtest vcs1: SUCCESS (4.876s)
[412.050349] Starting dynamic subtest: vecs0
[415.683448] Dynamic subtest vecs0: SUCCESS (3.645s)
[415.694523] Starting dynamic subtest: vecs1
[418.996549] Dynamic subtest vecs1: SUCCESS (3.312s)
[419.007211] Starting dynamic subtest: ccs0
[424.142613] Dynamic subtest ccs0: SUCCESS (5.145s)
[424.143596] Subtest fds: SUCCESS (28.149s)
[424.415944] [086/133] (606s left) kms_universal_plane (disable-primary-vs-flip)
[425.934056] Starting subtest: disable-primary-vs-flip
[425.934986] Starting dynamic subtest: pipe-A-HDMI-A-3
[426.390639] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.456s)
[426.403302] Starting dynamic subtest: pipe-B-HDMI-A-3
[426.661372] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.270s)
[426.674125] Starting dynamic subtest: pipe-C-HDMI-A-3
[426.938587] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.274s)
[426.949683] Starting dynamic subtest: pipe-D-HDMI-A-3
[427.205444] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.266s)
[427.206364] Subtest disable-primary-vs-flip: SUCCESS (1.273s)
[427.390498] [087/133] (603s left) prime_mmap (test_forked_cpu_write)
[427.470559] Starting subtest: test_forked_cpu_write
[427.471446] Starting dynamic subtest: test_forked_cpu_write-smem
[427.479645] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[427.492115] Starting dynamic subtest: test_forked_cpu_write-lmem0
[427.493219] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[427.494294] Subtest test_forked_cpu_write: SUCCESS (0.020s)
[427.655241] [088/133] (603s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[429.165152] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[429.222590] [089/133] (601s left) kms_big_fb (linear-64bpp-rotate-270)
[430.743873] Starting subtest: linear-64bpp-rotate-270
[430.812335] Subtest linear-64bpp-rotate-270: SKIP (0.068s)
[431.003196] [090/133] (600s left) kms_chamelium_hpd (hdmi-hpd)
[432.570259] Subtest hdmi-hpd: SKIP (0.000s)
[432.666536] [091/133] (598s left) kms_dp_link_training (non-uhbr-sst)
[434.183208] Starting subtest: non-uhbr-sst
[434.186728] Subtest non-uhbr-sst: SKIP (0.000s)
[434.372472] [092/133] (596s left) gem_mmap_wc (write-wc-read-gtt)
[434.468027] Subtest write-wc-read-gtt: SKIP (0.000s)
[434.555147] [093/133] (596s left) sw_sync (sync_merge_invalid)
[434.607222] Starting subtest: sync_merge_invalid
[434.656327] Subtest sync_merge_invalid: SUCCESS (0.049s)
[434.746844] [094/133] (596s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[436.260044] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[436.261762] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[436.350786] [095/133] (595s left) gem_ctx_engines (execute-one)
[436.463487] Starting subtest: execute-one
[439.992870] Subtest execute-one: SUCCESS (3.530s)
[440.269732] [096/133] (591s left) kms_async_flips (test-time-stamp)
[441.783107] Starting subtest: test-time-stamp
[442.014851] Starting dynamic subtest: pipe-A-HDMI-A-3
[442.305229] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.290s)
[442.506627] Starting dynamic subtest: pipe-B-HDMI-A-3
[442.596142] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.098s)
[442.776041] Starting dynamic subtest: pipe-C-HDMI-A-3
[442.872027] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.105s)
[443.047805] Starting dynamic subtest: pipe-D-HDMI-A-3
[443.136620] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.098s)
[443.137567] Subtest test-time-stamp: SUCCESS (1.354s)
[443.481142] [097/133] (588s left) kms_content_protection (dp-mst-type-0-hdcp14)
[445.064278] Starting subtest: dp-mst-type-0-hdcp14
[445.066067] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[445.275207] [098/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[446.787893] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[446.789552] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[446.903212] [099/133] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[448.440122] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[448.441900] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[448.588785] [100/133] (583s left) kms_psr (pr-primary-mmap-gtt)
[450.131357] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[450.188375] [101/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[451.706049] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[451.707760] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[451.854532] [102/133] (580s left) gem_render_copy (linear-to-vebox-y-tiled)
[451.977627] Starting subtest: linear-to-vebox-y-tiled
[451.980048] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[452.230868] [103/133] (579s left) gen3_render_tiledx_blits
[452.387405] [104/133] (579s left) gem_exec_balancer (full-pulse)
[452.487519] Starting subtest: full-pulse
[454.601540] Subtest full-pulse: SUCCESS (2.114s)
[455.027080] [105/133] (577s left) kms_psr (psr2-suspend)
[456.538465] Subtest psr2-suspend: SKIP (0.000s)
[456.603648] [106/133] (575s left) gem_mmap_wc (read-write-distinct)
[456.687207] Subtest read-write-distinct: SKIP (0.000s)
[456.755188] [107/133] (575s left) kms_cursor_crc (cursor-sliding-max-size)
[458.607335] Starting subtest: cursor-sliding-max-size
[458.610326] Subtest cursor-sliding-max-size: SKIP (0.000s)
[458.779845] [108/133] (573s left) gem_exec_reloc (basic-cpu-noreloc)
[458.864746] Subtest basic-cpu-noreloc: SKIP (0.000s)
[458.960948] [109/133] (573s left) gem_fenced_exec_thrash (too-many-fences)
[459.049380] Subtest too-many-fences: SKIP (0.000s)
[459.119992] [110/133] (573s left) perf_pmu (busy-no-semaphores)
[459.193847] Starting subtest: busy-no-semaphores
[459.194745] Starting dynamic subtest: rcs0
[459.750330] Dynamic subtest rcs0: SUCCESS (0.555s)
[459.767185] Starting dynamic subtest: bcs0
[460.304498] Dynamic subtest bcs0: SUCCESS (0.550s)
[460.319596] Starting dynamic subtest: vcs0
[460.862632] Dynamic subtest vcs0: SUCCESS (0.554s)
[460.880069] Starting dynamic subtest: vcs1
[461.416615] Dynamic subtest vcs1: SUCCESS (0.550s)
[461.432184] Starting dynamic subtest: vecs0
[461.970649] Dynamic subtest vecs0: SUCCESS (0.550s)
[461.987410] Starting dynamic subtest: vecs1
[462.525738] Dynamic subtest vecs1: SUCCESS (0.551s)
[462.541248] Starting dynamic subtest: ccs0
[463.078917] Dynamic subtest ccs0: SUCCESS (0.549s)
[463.081056] Subtest busy-no-semaphores: SUCCESS (3.886s)
[463.324864] [111/133] (569s left) gem_exec_schedule (u-independent)
[463.419327] Starting subtest: u-independent
[463.420251] Starting dynamic subtest: rcs0
[463.804356] Dynamic subtest rcs0: SUCCESS (0.386s)
[463.821963] Starting dynamic subtest: bcs0
[464.096396] Dynamic subtest bcs0: SUCCESS (0.291s)
[464.111433] Starting dynamic subtest: vcs0
[464.386267] Dynamic subtest vcs0: SUCCESS (0.289s)
[464.403424] Starting dynamic subtest: vcs1
[464.685490] Dynamic subtest vcs1: SUCCESS (0.298s)
[464.701252] Starting dynamic subtest: vecs0
[464.974225] Dynamic subtest vecs0: SUCCESS (0.287s)
[464.991017] Starting dynamic subtest: vecs1
[465.270583] Dynamic subtest vecs1: SUCCESS (0.295s)
[465.304719] Starting dynamic subtest: ccs0
[465.602572] Dynamic subtest ccs0: SUCCESS (0.330s)
[465.603624] Subtest u-independent: SUCCESS (2.185s)
[466.056858] [112/133] (566s left) i915_hangman (engine-engine-error)
[466.153189] Starting subtest: engine-engine-error
[466.154173] Starting dynamic subtest: rcs0
[466.947782] Dynamic subtest rcs0: SUCCESS (0.795s)
[466.962543] Starting dynamic subtest: bcs0
[467.685354] Dynamic subtest bcs0: SUCCESS (0.736s)
[467.698574] Starting dynamic subtest: vcs0
[468.404253] Dynamic subtest vcs0: SUCCESS (0.718s)
[468.418012] Starting dynamic subtest: vcs1
[469.135411] Dynamic subtest vcs1: SUCCESS (0.730s)
[469.150610] Starting dynamic subtest: vecs0
[469.854418] Dynamic subtest vecs0: SUCCESS (0.718s)
[469.867639] Starting dynamic subtest: vecs1
[470.564302] Dynamic subtest vecs1: SUCCESS (0.709s)
[470.577774] Starting dynamic subtest: ccs0
[471.321430] Dynamic subtest ccs0: SUCCESS (0.756s)
[471.322377] Subtest engine-engine-error: SUCCESS (5.170s)
[471.475052] [113/133] (561s left) kms_rotation_crc (sprite-rotation-180)
[472.986392] Starting subtest: sprite-rotation-180
[483.297578] Subtest sprite-rotation-180: SUCCESS (10.311s)
[483.524905] [114/133] (549s left) gem_mmap_wc (write-gtt-read-wc)
[483.606229] Subtest write-gtt-read-wc: SKIP (0.000s)
[483.685849] [115/133] (549s left) prime_vgem (basic-gtt)
[483.790073] Starting subtest: basic-gtt
[483.792054] Subtest basic-gtt: SKIP (0.000s)
[483.988177] [116/133] (548s left) perf (sysctl-defaults)
[484.088666] Starting subtest: sysctl-defaults
[484.089568] Subtest sysctl-defaults: SUCCESS (0.000s)
[484.404886] [117/133] (548s left) gem_exec_schedule (u-submit-late-slice)
[484.500577] Starting subtest: u-submit-late-slice
[484.501490] Starting dynamic subtest: rcs0
[484.580148] Dynamic subtest rcs0: SUCCESS (0.079s)
[484.594230] Starting dynamic subtest: bcs0
[484.634070] Dynamic subtest bcs0: SUCCESS (0.053s)
[484.647538] Starting dynamic subtest: vcs0
[484.681881] Dynamic subtest vcs0: SUCCESS (0.047s)
[484.695756] Starting dynamic subtest: vcs1
[484.735660] Dynamic subtest vcs1: SUCCESS (0.053s)
[484.749465] Starting dynamic subtest: vecs0
[484.785732] Dynamic subtest vecs0: SUCCESS (0.049s)
[484.799214] Starting dynamic subtest: vecs1
[484.840195] Dynamic subtest vecs1: SUCCESS (0.053s)
[484.853732] Starting dynamic subtest: ccs0
[484.890374] Dynamic subtest ccs0: SUCCESS (0.049s)
[484.891278] Subtest u-submit-late-slice: SUCCESS (0.390s)
[485.294927] [118/133] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[486.809117] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[486.810995] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[486.958351] [119/133] (546s left) kms_setmode (clone-exclusive-crtc)
[487.051458] Starting subtest: clone-exclusive-crtc
[487.054364] Subtest clone-exclusive-crtc: SKIP (0.000s)
[487.235071] [120/133] (545s left) gem_mmap_gtt (cpuset-medium-copy)
[487.314148] Subtest cpuset-medium-copy: SKIP (0.000s)
[487.384520] [121/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[488.901998] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[488.903874] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[489.069570] [122/133] (544s left) perf_pmu (busy-hang)
[489.158498] Starting subtest: busy-hang
[489.159456] Starting dynamic subtest: rcs0
[490.455181] Dynamic subtest rcs0: SUCCESS (1.293s)
[490.467593] Starting dynamic subtest: bcs0
[491.693508] Dynamic subtest bcs0: SUCCESS (1.235s)
[491.705476] Starting dynamic subtest: vcs0
[492.950441] Dynamic subtest vcs0: SUCCESS (1.254s)
[492.962491] Starting dynamic subtest: vcs1
[494.206570] Dynamic subtest vcs1: SUCCESS (1.253s)
[494.218432] Starting dynamic subtest: vecs0
[495.462547] Dynamic subtest vecs0: SUCCESS (1.252s)
[495.474499] Starting dynamic subtest: vecs1
[496.713497] Dynamic subtest vecs1: SUCCESS (1.247s)
[496.725382] Starting dynamic subtest: ccs0
[497.956773] Dynamic subtest ccs0: SUCCESS (1.240s)
[497.957606] Subtest busy-hang: SUCCESS (8.797s)
[498.094148] [123/133] (535s left) kms_chamelium_edid (dp-edid-resolution-list)
[499.645946] Subtest dp-edid-resolution-list: SKIP (0.000s)
[499.752958] [124/133] (533s left) gem_eio (create-ext)
[500.077153] Starting subtest: create-ext
[500.561303] Subtest create-ext: SUCCESS (0.485s)
[502.103089] [125/133] (531s left) kms_cursor_crc (cursor-offscreen-64x21)
[503.791716] Starting subtest: cursor-offscreen-64x21
[503.797277] Starting dynamic subtest: pipe-A-HDMI-A-3
[506.318185] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.521s)
[506.356619] Starting dynamic subtest: pipe-D-HDMI-A-3
[508.742569] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.397s)
[508.743514] Subtest cursor-offscreen-64x21: SUCCESS (4.950s)
[509.105348] [126/133] (524s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[510.616181] Starting subtest: cursorB-vs-flipB-varying-size
[510.617992] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[510.728844] [127/133] (522s left) kms_hdr (bpc-switch-dpms)
[512.252403] Starting subtest: bpc-switch-dpms
[512.255147] Subtest bpc-switch-dpms: SKIP (0.001s)
[512.352912] [128/133] (521s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[513.875067] Starting subtest: psr-1p-primscrn-cur-indfb-move
[513.876977] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[514.001208] [129/133] (519s left) perf_pmu (semaphore-wait)
[514.093554] Starting subtest: semaphore-wait
[514.094456] Starting dynamic subtest: rcs0
[514.634888] Dynamic subtest rcs0: SUCCESS (0.540s)
[514.650327] Starting dynamic subtest: bcs0
[515.148503] Dynamic subtest bcs0: SUCCESS (0.510s)
[515.164203] Starting dynamic subtest: vcs0
[515.661648] Dynamic subtest vcs0: SUCCESS (0.509s)
[515.677274] Starting dynamic subtest: vcs1
[516.174897] Dynamic subtest vcs1: SUCCESS (0.509s)
[516.190540] Starting dynamic subtest: vecs0
[516.688098] Dynamic subtest vecs0: SUCCESS (0.509s)
[516.703972] Starting dynamic subtest: vecs1
[517.206198] Dynamic subtest vecs1: SUCCESS (0.509s)
[517.218568] Starting dynamic subtest: ccs0
[517.715167] Dynamic subtest ccs0: SUCCESS (0.509s)
[517.719171] Subtest semaphore-wait: SUCCESS (3.623s)
[517.914859] [130/133] (515s left) gem_ctx_persistence (legacy-engines-mixed)
[518.002274] Starting subtest: legacy-engines-mixed
[518.003211] Starting dynamic subtest: render
[518.104417] Dynamic subtest render: SUCCESS (0.101s)
[518.117657] Starting dynamic subtest: bsd1
[518.149502] Dynamic subtest bsd1: SUCCESS (0.044s)
[518.164176] Starting dynamic subtest: bsd2
[518.196489] Dynamic subtest bsd2: SUCCESS (0.045s)
[518.216545] Starting dynamic subtest: blt
[518.251751] Dynamic subtest blt: SUCCESS (0.053s)
[518.286582] Starting dynamic subtest: vebox
[518.313562] Dynamic subtest vebox: SUCCESS (0.059s)
[518.314611] Subtest legacy-engines-mixed: SUCCESS (0.312s)
[518.515934] [131/133] (515s left) gem_spin_batch (spin-all)
[518.611309] Starting subtest: spin-all
[518.660179] Subtest spin-all: SUCCESS (0.049s)
[518.963762] [132/133] (515s left) kms_plane_alpha_blend (alpha-7efc)
[520.478132] Starting subtest: alpha-7efc
[520.729049] Starting dynamic subtest: pipe-A-HDMI-A-3
[521.218482] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.489s)
[521.249483] Starting dynamic subtest: pipe-D-HDMI-A-3
[521.773585] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.535s)
[521.774519] Subtest alpha-7efc: SUCCESS (1.296s)
[521.975899] [133/133] (512s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[523.485128] Starting subtest: basic-flip-after-cursor-legacy
[524.484781] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.000s)
[524.723106] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_plane_multiple
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: device_reset
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: i915_selftest
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_lpsp
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: syncobj_eventfd
results: parsing output: 39/ for test: gem_ctx_bad_destroy
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sysfs_preempt_timeout
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_force_connector_basic
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: kms_chamelium_audio
results: parsing output: 55/ for test: tools_test
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gen7_exec_parse
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_tiled_fence_blits
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_linear_blits
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_psr2_su
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: kms_universal_plane
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: kms_dp_link_training
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_ctx_engines
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gen3_render_tiledx_blits
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_fenced_exec_thrash
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: prime_vgem
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_setmode
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_chamelium_edid
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: kms_plane_alpha_blend
results: parsing output: 132/ for test: kms_cursor_legacy
Done.