[57.486637] Initializing watchdogs
[57.486705]   /dev/watchdog0
[57.506402] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.517614] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.521163] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.523695] [001/131] (960s left) gem_exec_schedule (preempt)
[57.627791] Starting subtest: preempt
[57.628683] Starting dynamic subtest: rcs0
[57.702014] Dynamic subtest rcs0: SUCCESS (0.074s)
[57.710213] Starting dynamic subtest: bcs0
[57.737915] Dynamic subtest bcs0: SUCCESS (0.035s)
[57.745701] Starting dynamic subtest: vcs0
[57.775213] Dynamic subtest vcs0: SUCCESS (0.037s)
[57.783368] Starting dynamic subtest: vcs1
[57.814102] Dynamic subtest vcs1: SUCCESS (0.039s)
[57.821986] Starting dynamic subtest: vecs0
[57.854351] Dynamic subtest vecs0: SUCCESS (0.040s)
[57.862161] Starting dynamic subtest: vecs1
[57.889494] Dynamic subtest vecs1: SUCCESS (0.035s)
[57.897472] Starting dynamic subtest: ccs0
[57.925935] Dynamic subtest ccs0: SUCCESS (0.036s)
[57.926839] Subtest preempt: SUCCESS (0.297s)
[58.414874] [002/131] (959s left) gen7_exec_parse (load-register-reg)
[58.494729] Subtest load-register-reg: SKIP (0.000s)
[58.594024] [003/131] (959s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[58.779252] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[58.780186] Starting dynamic subtest: pipe-A-DP-3
[58.788912] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[58.796615] Starting dynamic subtest: pipe-B-DP-3
[58.805015] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[58.812527] Starting dynamic subtest: pipe-C-DP-3
[58.820955] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[58.828510] Starting dynamic subtest: pipe-D-DP-3
[58.838843] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[58.841110] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[59.267504] [004/131] (958s left) gem_close_race (basic-threads)
[59.377512] Starting subtest: basic-threads
[60.588619] Subtest basic-threads: SUCCESS (1.208s)
[60.894505] [005/131] (957s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[61.077808] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[61.078596] Starting dynamic subtest: pipe-A
[61.475143] Dynamic subtest pipe-A: SUCCESS (0.396s)
[61.493545] Starting dynamic subtest: pipe-B
[61.959618] Dynamic subtest pipe-B: SUCCESS (0.483s)
[61.978911] Starting dynamic subtest: pipe-C
[62.444428] Dynamic subtest pipe-C: SUCCESS (0.484s)
[62.460586] Starting dynamic subtest: pipe-D
[62.926409] Dynamic subtest pipe-D: SUCCESS (0.481s)
[62.927389] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.846s)
[63.235127] [006/131] (955s left) kms_chamelium_color (gamma)
[63.414950] Subtest gamma: SKIP (0.000s)
[63.494993] [007/131] (954s left) kms_lease (atomic-implicit-crtc)
[63.680456] Starting subtest: atomic-implicit-crtc
[63.681401] Starting dynamic subtest: pipe-A-DP-3
[63.685788] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[63.693821] Starting dynamic subtest: pipe-B-DP-3
[63.698244] Dynamic subtest pipe-B-DP-3: SUCCESS (0.010s)
[63.706447] Starting dynamic subtest: pipe-C-DP-3
[63.710866] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[63.718897] Starting dynamic subtest: pipe-D-DP-3
[63.723306] Dynamic subtest pipe-D-DP-3: SUCCESS (0.010s)
[63.724343] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[63.904485] [008/131] (954s left) gem_ctx_persistence (engines-mixed-process)
[63.981246] Starting subtest: engines-mixed-process
[63.982181] Starting dynamic subtest: rcs0
[65.863059] Dynamic subtest rcs0: SUCCESS (1.880s)
[65.875223] Starting dynamic subtest: bcs0
[67.913819] Dynamic subtest bcs0: SUCCESS (2.049s)
[67.922865] Starting dynamic subtest: vcs0
[69.893023] Dynamic subtest vcs0: SUCCESS (1.978s)
[69.902761] Starting dynamic subtest: vcs1
[71.871765] Dynamic subtest vcs1: SUCCESS (1.978s)
[71.881023] Starting dynamic subtest: vecs0
[73.852024] Dynamic subtest vecs0: SUCCESS (1.979s)
[73.861584] Starting dynamic subtest: vecs1
[75.905980] Dynamic subtest vecs1: SUCCESS (2.053s)
[75.916108] Starting dynamic subtest: ccs0
[77.875660] Dynamic subtest ccs0: SUCCESS (1.969s)
[77.876744] Subtest engines-mixed-process: SUCCESS (13.887s)
[77.963774] [009/131] (940s left) gem_flink_race (flink_close)
[78.007142] Starting subtest: flink_close
[83.083296] Subtest flink_close: SUCCESS (5.075s)
[83.207203] [010/131] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[83.433661] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[83.435408] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[83.609825] [011/131] (935s left) kms_frontbuffer_tracking (psr-suspend)
[83.802881] Starting subtest: psr-suspend
[83.805369] Subtest psr-suspend: SKIP (0.000s)
[83.951718] [012/131] (934s left) kms_psr2_su (frontbuffer-xrgb8888)
[84.023198] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[84.096434] [013/131] (934s left) gem_mmap_gtt (cpuset-big-copy)
[84.172041] Subtest cpuset-big-copy: SKIP (0.000s)
[84.250912] [014/131] (934s left) kms_plane (pixel-format)
[84.429973] Starting subtest: pixel-format
[84.453230] Starting dynamic subtest: pipe-A-plane-0
[92.587956] Dynamic subtest pipe-A-plane-0: SUCCESS (8.134s)
[92.597914] Starting dynamic subtest: pipe-A-plane-3
[96.671815] Dynamic subtest pipe-A-plane-3: SUCCESS (4.083s)
[96.681745] Starting dynamic subtest: pipe-A-plane-5
[96.888399] Dynamic subtest pipe-A-plane-5: SUCCESS (0.216s)
[97.112888] Starting dynamic subtest: pipe-B-plane-0
[104.983890] Dynamic subtest pipe-B-plane-0: SUCCESS (7.884s)
[104.992854] Starting dynamic subtest: pipe-B-plane-3
[109.350897] Dynamic subtest pipe-B-plane-3: SUCCESS (4.366s)
[109.360545] Starting dynamic subtest: pipe-B-plane-5
[109.618088] Dynamic subtest pipe-B-plane-5: SUCCESS (0.266s)
[109.707346] Subtest pixel-format: SUCCESS (25.275s)
[109.965811] [015/131] (909s left) gem_eio (throttle)
[110.240224] Starting subtest: throttle
[110.819267] Subtest throttle: SUCCESS (0.580s)
[111.088560] [016/131] (907s left) kms_flip (2x-wf_vblank-ts-check)
[111.271600] Starting subtest: 2x-wf_vblank-ts-check
[111.286497] Subtest 2x-wf_vblank-ts-check: SKIP (0.014s)
[111.462895] [017/131] (907s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[111.650612] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[111.651509] Starting dynamic subtest: pipe-A-DP-3
[112.227156] Dynamic subtest pipe-A-DP-3: SUCCESS (0.572s)
[112.236190] Starting dynamic subtest: pipe-B-DP-3
[112.909917] Dynamic subtest pipe-B-DP-3: SUCCESS (0.681s)
[112.918783] Starting dynamic subtest: pipe-C-DP-3
[113.590889] Dynamic subtest pipe-C-DP-3: SUCCESS (0.679s)
[113.599817] Starting dynamic subtest: pipe-D-DP-3
[114.273421] Dynamic subtest pipe-D-DP-3: SUCCESS (0.681s)
[114.274472] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (2.619s)
[114.533709] [018/131] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[114.721588] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[119.720341] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.999s)
[119.904009] [019/131] (899s left) syncobj_wait (wait-all-snapshot)
[119.978372] Starting subtest: wait-all-snapshot
[120.062106] Subtest wait-all-snapshot: SUCCESS (0.083s)
[120.229303] [020/131] (899s left) kms_flip (modeset-vs-vblank-race)
[120.413242] Starting subtest: modeset-vs-vblank-race
[120.417261] Starting dynamic subtest: A-DP3
[123.605875] Dynamic subtest A-DP3: SUCCESS (3.187s)
[123.642258] Starting dynamic subtest: B-DP3
[126.810190] Dynamic subtest B-DP3: SUCCESS (3.201s)
[126.847141] Starting dynamic subtest: C-DP3
[130.013477] Dynamic subtest C-DP3: SUCCESS (3.198s)
[130.051880] Starting dynamic subtest: D-DP3
[133.270364] Dynamic subtest D-DP3: SUCCESS (3.254s)
[133.278722] Subtest modeset-vs-vblank-race: SUCCESS (12.865s)
[133.669405] [021/131] (885s left) gem_exec_reloc (basic-wc-noreloc)
[133.753378] Subtest basic-wc-noreloc: SKIP (0.000s)
[133.838751] [022/131] (885s left) kms_big_fb (x-tiled-addfb)
[134.033903] Starting subtest: x-tiled-addfb
[134.034878] Subtest x-tiled-addfb: SUCCESS (0.000s)
[134.198773] [023/131] (885s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[134.268435] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[134.269379] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[134.469541] [024/131] (885s left) i915_drm_fdinfo (memory-info-idle)
[134.531208] Starting subtest: memory-info-idle
[134.532143] Starting dynamic subtest: lmem0
[134.610104] Dynamic subtest lmem0: SUCCESS (0.078s)
[134.619713] Starting dynamic subtest: smem0
[134.664248] Dynamic subtest smem0: SUCCESS (0.053s)
[134.665290] Subtest memory-info-idle: SUCCESS (0.134s)
[134.785543] [025/131] (884s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[134.970527] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[135.027191] [026/131] (884s left) kms_cursor_crc (cursor-offscreen-max-size)
[135.528925] Starting subtest: cursor-offscreen-max-size
[135.532481] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[135.768765] [027/131] (884s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[135.961443] Starting subtest: yf-tiled-64bpp-rotate-90
[135.963257] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[136.149322] [028/131] (883s left) kms_universal_plane (universal-plane-sanity)
[136.335346] Starting subtest: universal-plane-sanity
[136.336258] Starting dynamic subtest: pipe-A-DP-3
[136.978602] Dynamic subtest pipe-A-DP-3: SUCCESS (0.641s)
[136.989191] Starting dynamic subtest: pipe-B-DP-3
[137.477260] Dynamic subtest pipe-B-DP-3: SUCCESS (0.497s)
[137.491337] Starting dynamic subtest: pipe-C-DP-3
[137.930134] Dynamic subtest pipe-C-DP-3: SUCCESS (0.451s)
[137.942132] Starting dynamic subtest: pipe-D-DP-3
[138.404105] Dynamic subtest pipe-D-DP-3: SUCCESS (0.472s)
[138.405025] Subtest universal-plane-sanity: SUCCESS (2.070s)
[138.700194] [029/131] (881s left) kms_flip (basic-plain-flip)
[138.889934] Starting subtest: basic-plain-flip
[138.894477] Starting dynamic subtest: A-DP3
[139.731548] Dynamic subtest A-DP3: SUCCESS (0.836s)
[139.770281] Starting dynamic subtest: B-DP3
[140.530194] Dynamic subtest B-DP3: SUCCESS (0.794s)
[140.541375] Starting dynamic subtest: C-DP3
[141.298600] Dynamic subtest C-DP3: SUCCESS (0.766s)
[141.315857] Starting dynamic subtest: D-DP3
[142.063619] Dynamic subtest D-DP3: SUCCESS (0.759s)
[142.072264] Subtest basic-plain-flip: SUCCESS (3.182s)
[142.427017] [030/131] (877s left) kms_invalid_mode (bad-vsync-start)
[142.607415] Starting subtest: bad-vsync-start
[142.608328] Starting dynamic subtest: pipe-A-DP-3
[142.685620] Dynamic subtest pipe-A-DP-3: SUCCESS (0.077s)
[142.698767] Starting dynamic subtest: pipe-B-DP-3
[142.699998] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[142.711059] Starting dynamic subtest: pipe-C-DP-3
[142.712292] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[142.722992] Starting dynamic subtest: pipe-D-DP-3
[142.723963] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[142.724955] Subtest bad-vsync-start: SUCCESS (0.088s)
[142.970412] [031/131] (877s left) gem_exec_reloc (basic-scanout)
[143.048401] Subtest basic-scanout: SKIP (0.000s)
[143.179580] [032/131] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[143.369491] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[143.371239] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[143.565662] [033/131] (876s left) kms_psr (psr-primary-mmap-cpu)
[143.745643] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[143.809150] [034/131] (876s left) gem_softpin (noreloc-interruptible)
[143.886847] Starting subtest: noreloc-interruptible
[149.415839] Subtest noreloc-interruptible: SUCCESS (5.529s)
[149.595036] [035/131] (870s left) i915_suspend (forcewake)
[149.675243] Starting subtest: forcewake
[188.497750] Subtest forcewake: SUCCESS (7.121s)
[188.607049] [036/131] (831s left) sriov_basic (enable-vfs-bind-unbind-each)
[188.683264] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[188.750255] [037/131] (831s left) prime_mmap_coherency (read)
[188.827980] Starting subtest: read
[194.233904] Subtest read: SUCCESS (5.404s)
[194.425091] [038/131] (826s left) kms_color (legacy-gamma)
[194.608462] Starting subtest: legacy-gamma
[194.609370] Starting dynamic subtest: pipe-A-DP-3
[195.298272] Dynamic subtest pipe-A-DP-3: SUCCESS (0.688s)
[195.326914] Starting dynamic subtest: pipe-B-DP-3
[195.937069] Dynamic subtest pipe-B-DP-3: SUCCESS (0.637s)
[195.954103] Starting dynamic subtest: pipe-C-DP-3
[196.534426] Dynamic subtest pipe-C-DP-3: SUCCESS (0.595s)
[196.551697] Starting dynamic subtest: pipe-D-DP-3
[197.160564] Dynamic subtest pipe-D-DP-3: SUCCESS (0.624s)
[197.161557] Subtest legacy-gamma: SUCCESS (2.553s)
[197.477444] [039/131] (823s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[197.658364] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[197.659152] Starting dynamic subtest: pipe-A
[197.756308] Dynamic subtest pipe-A: SUCCESS (0.098s)
[197.778402] Starting dynamic subtest: pipe-B
[197.988657] Dynamic subtest pipe-B: SUCCESS (0.231s)
[198.003010] Starting dynamic subtest: pipe-C
[198.203639] Dynamic subtest pipe-C: SUCCESS (0.214s)
[198.217490] Starting dynamic subtest: pipe-D
[198.422332] Dynamic subtest pipe-D: SUCCESS (0.217s)
[198.423351] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.766s)
[198.778386] [040/131] (821s left) prime_mmap (test_dup)
[198.847888] Starting subtest: test_dup
[198.848846] Starting dynamic subtest: test_dup-smem
[198.896855] Dynamic subtest test_dup-smem: SUCCESS (0.048s)
[198.909184] Starting dynamic subtest: test_dup-lmem0
[199.095530] Dynamic subtest test_dup-lmem0: SUCCESS (0.197s)
[199.096519] Subtest test_dup: SUCCESS (0.248s)
[199.224814] [041/131] (821s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[199.411722] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[199.413385] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[199.607811] [042/131] (821s left) kms_addfb_basic (addfb25-modifier-no-flag)
[199.792952] Starting subtest: addfb25-modifier-no-flag
[199.793946] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[199.996157] [043/131] (820s left) gem_wait (write-wait)
[200.079411] Starting subtest: write-wait
[200.080517] Starting dynamic subtest: all-engines
[201.282466] Dynamic subtest all-engines: SUCCESS (1.202s)
[201.328478] Starting dynamic subtest: rcs0
[202.359602] Dynamic subtest rcs0: SUCCESS (1.072s)
[202.379736] Starting dynamic subtest: bcs0
[203.425519] Dynamic subtest bcs0: SUCCESS (1.061s)
[203.445879] Starting dynamic subtest: vcs0
[204.490717] Dynamic subtest vcs0: SUCCESS (1.060s)
[204.510742] Starting dynamic subtest: vcs1
[205.555722] Dynamic subtest vcs1: SUCCESS (1.060s)
[205.571408] Starting dynamic subtest: vecs0
[206.616528] Dynamic subtest vecs0: SUCCESS (1.056s)
[206.662670] Starting dynamic subtest: vecs1
[207.692505] Dynamic subtest vecs1: SUCCESS (1.071s)
[207.712501] Starting dynamic subtest: ccs0
[208.757613] Dynamic subtest ccs0: SUCCESS (1.060s)
[208.760683] Subtest write-wait: SUCCESS (8.680s)
[209.021250] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[209.023595] [044/131] (812s left) i915_drm_fdinfo (virtual-idle)
[209.095009] Starting subtest: virtual-idle
[212.701285] Subtest virtual-idle: SUCCESS (3.606s)
[212.823016] [045/131] (808s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[213.011414] Starting subtest: bad-rotation-90-y-tiled-ccs
[213.012335] Starting dynamic subtest: pipe-A-DP-3
[213.021003] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[213.032206] Starting dynamic subtest: pipe-B-DP-3
[213.040925] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[213.051910] Starting dynamic subtest: pipe-C-DP-3
[213.060241] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[213.071104] Starting dynamic subtest: pipe-D-DP-3
[213.080948] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[213.083050] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[213.489665] [046/131] (807s left) gem_exec_reloc (basic-gtt-read-noreloc)
[213.578697] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[213.668226] [047/131] (807s left) gem_ringfill (engines-basic)
[214.088316] Starting subtest: engines-basic
[214.089859] Starting dynamic subtest: rcs0
[214.209453] Dynamic subtest rcs0: SUCCESS (0.120s)
[214.230086] Starting dynamic subtest: bcs0
[214.253826] Dynamic subtest bcs0: SUCCESS (0.042s)
[214.287268] Starting dynamic subtest: vcs0
[214.303476] Dynamic subtest vcs0: SUCCESS (0.047s)
[214.323175] Starting dynamic subtest: vcs1
[214.347522] Dynamic subtest vcs1: SUCCESS (0.042s)
[214.364907] Starting dynamic subtest: vecs0
[214.390476] Dynamic subtest vecs0: SUCCESS (0.041s)
[214.409546] Starting dynamic subtest: vecs1
[214.433777] Dynamic subtest vecs1: SUCCESS (0.041s)
[214.457643] Starting dynamic subtest: ccs0
[214.478800] Dynamic subtest ccs0: SUCCESS (0.043s)
[214.480114] Subtest engines-basic: SUCCESS (0.392s)
[214.670818] [048/131] (806s left) gem_exec_params (no-blt)
[214.755400] Starting subtest: no-blt
[214.757127] Subtest no-blt: SUCCESS (0.003s)
[214.922763] [049/131] (806s left) syncobj_eventfd (invalid-bad-pad)
[214.998437] Starting subtest: invalid-bad-pad
[214.999469] Subtest invalid-bad-pad: SUCCESS (0.000s)
[215.187767] [050/131] (806s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[215.267438] Starting subtest: invalid-single-wait-all-unsubmitted
[215.268451] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[215.472549] [051/131] (806s left) syncobj_wait (invalid-signal-bad-pad)
[215.550385] Starting subtest: invalid-signal-bad-pad
[215.551329] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[215.683866] [052/131] (805s left) perf_pmu (busy-double-start)
[215.755509] Starting subtest: busy-double-start
[215.756475] Starting dynamic subtest: rcs0
[219.378404] Dynamic subtest rcs0: SUCCESS (3.622s)
[219.394717] Starting dynamic subtest: bcs0
[222.985543] Dynamic subtest bcs0: SUCCESS (3.604s)
[223.001214] Starting dynamic subtest: vcs0
[226.570173] Dynamic subtest vcs0: SUCCESS (3.580s)
[226.585621] Starting dynamic subtest: vcs1
[230.179480] Dynamic subtest vcs1: SUCCESS (3.607s)
[230.195243] Starting dynamic subtest: vecs0
[233.781099] Dynamic subtest vecs0: SUCCESS (3.597s)
[233.797375] Starting dynamic subtest: vecs1
[237.368201] Dynamic subtest vecs1: SUCCESS (3.582s)
[237.384488] Starting dynamic subtest: ccs0
[240.970545] Dynamic subtest ccs0: SUCCESS (3.597s)
[240.975405] Subtest busy-double-start: SUCCESS (25.216s)
[241.138803] [053/131] (780s left) gem_exec_balancer (parallel-balancer)
[241.487490] Starting subtest: parallel-balancer
[243.026838] Subtest parallel-balancer: SUCCESS (1.539s)
[243.202467] [054/131] (778s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[243.290539] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[243.368503] [055/131] (778s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[243.569285] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[244.840176] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.270s)
[245.106035] [056/131] (776s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[245.312554] Starting subtest: fbc-rgb101010-draw-blt
[248.173770] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.861s)
[248.341618] [057/131] (773s left) kms_fence_pin_leak
[248.658473] [058/131] (773s left) kms_feature_discovery (display-2x)
[248.848908] Starting subtest: display-2x
[248.850715] Subtest display-2x: SKIP (0.000s)
[248.967913] [059/131] (773s left) perf_pmu (semaphore-wait)
[249.039265] Starting subtest: semaphore-wait
[249.040264] Starting dynamic subtest: rcs0
[249.583188] Dynamic subtest rcs0: SUCCESS (0.542s)
[249.601458] Starting dynamic subtest: bcs0
[250.099754] Dynamic subtest bcs0: SUCCESS (0.511s)
[250.120553] Starting dynamic subtest: vcs0
[250.619171] Dynamic subtest vcs0: SUCCESS (0.513s)
[250.634407] Starting dynamic subtest: vcs1
[251.132596] Dynamic subtest vcs1: SUCCESS (0.508s)
[251.152799] Starting dynamic subtest: vecs0
[251.650123] Dynamic subtest vecs0: SUCCESS (0.513s)
[251.664907] Starting dynamic subtest: vecs1
[252.163178] Dynamic subtest vecs1: SUCCESS (0.510s)
[252.178674] Starting dynamic subtest: ccs0
[252.677060] Dynamic subtest ccs0: SUCCESS (0.509s)
[252.681541] Subtest semaphore-wait: SUCCESS (3.639s)
[252.872107] [060/131] (769s left) gem_exec_schedule (u-submit-golden-slice)
[252.971605] Starting subtest: u-submit-golden-slice
[252.972533] Starting dynamic subtest: rcs0
[253.051410] Dynamic subtest rcs0: SUCCESS (0.079s)
[253.064962] Starting dynamic subtest: bcs0
[253.102049] Dynamic subtest bcs0: SUCCESS (0.049s)
[253.116007] Starting dynamic subtest: vcs0
[253.153568] Dynamic subtest vcs0: SUCCESS (0.050s)
[253.167131] Starting dynamic subtest: vcs1
[253.204616] Dynamic subtest vcs1: SUCCESS (0.050s)
[253.218774] Starting dynamic subtest: vecs0
[253.257961] Dynamic subtest vecs0: SUCCESS (0.052s)
[253.271573] Starting dynamic subtest: vecs1
[253.309400] Dynamic subtest vecs1: SUCCESS (0.050s)
[253.323020] Starting dynamic subtest: ccs0
[253.359666] Dynamic subtest ccs0: SUCCESS (0.049s)
[253.360557] Subtest u-submit-golden-slice: SUCCESS (0.389s)
[253.841479] [061/131] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[254.035452] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[254.037212] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[254.190082] [062/131] (767s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[254.385463] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[254.386415] Starting dynamic subtest: pipe-A-valid-mode
[258.875035] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.486s)
[258.876856] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.490s)
[259.210499] [063/131] (763s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[259.399478] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[259.401294] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[259.560003] [064/131] (762s left) gem_ctx_persistence (smoketest)
[259.648414] Starting subtest: smoketest
[298.398389] Subtest smoketest: SUCCESS (38.749s)
[298.560769] [065/131] (723s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[298.760452] Starting subtest: y-tiled-64bpp-rotate-90
[298.762261] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[298.963910] [066/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[299.157332] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[299.159121] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[299.363705] [067/131] (723s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[299.554392] Starting subtest: bo-too-small-due-to-tiling
[299.556173] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[299.762389] [068/131] (722s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[299.973082] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[300.021948] [069/131] (722s left) kms_cursor_edge_walk (128x128-top-bottom)
[300.212374] Starting subtest: 128x128-top-bottom
[300.213296] Starting dynamic subtest: pipe-A-DP-3
[303.679505] Dynamic subtest pipe-A-DP-3: SUCCESS (3.465s)
[303.699802] Starting dynamic subtest: pipe-D-DP-3
[307.012555] Dynamic subtest pipe-D-DP-3: SUCCESS (3.330s)
[307.013580] Subtest 128x128-top-bottom: SUCCESS (6.800s)
[307.330556] [070/131] (715s left) gem_sync (basic-store-all)
[307.422270] Starting subtest: basic-store-all
[312.044977] Subtest basic-store-all: SUCCESS (4.622s)
[312.284594] [071/131] (710s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[312.481132] Starting subtest: 4-tiled-64bpp-rotate-90
[312.543599] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.062s)
[312.765093] [072/131] (710s left) gem_ctx_create (basic-files)
[312.853172] Starting subtest: basic-files
[314.897228] Subtest basic-files: SUCCESS (2.044s)
[315.318159] [073/131] (707s left) kms_selftest (drm_format_helper)
[315.367532] Starting subtest: drm_format_helper
[315.399521] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[315.502410] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.099s)
[315.535126] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[315.590244] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.087s)
[315.625571] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[315.682153] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.084s)
[315.725138] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[315.775720] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.092s)
[315.812549] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[315.877126] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.096s)
[315.915635] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[315.964433] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.085s)
[315.992894] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[316.079460] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.112s)
[316.125620] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[316.165787] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.082s)
[316.191118] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[316.270385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.099s)
[316.311436] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[316.386353] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.110s)
[316.426835] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[316.465134] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.078s)
[316.484792] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[316.561104] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s)
[316.606386] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[316.655054] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.090s)
[316.691153] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[316.737724] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.078s)
[316.780859] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[316.816057] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.076s)
[316.839194] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[316.922442] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.103s)
[316.967384] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[317.011007] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.085s)
[317.011928] Subtest drm_format_helper: SUCCESS (1.644s)
[317.286813] [074/131] (705s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[317.479400] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[317.480292] Starting dynamic subtest: pipe-A-valid-mode
[319.346901] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.867s)
[319.347889] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.868s)
[319.682846] [075/131] (703s left) gem_softpin (allocator-fork)
[319.782586] Starting subtest: allocator-fork
[322.083451] Subtest allocator-fork: SUCCESS (2.301s)
[322.293497] [076/131] (701s left) kms_psr (fbc-psr-primary-mmap-cpu)
[322.487954] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[322.558590] [077/131] (700s left) kms_force_connector_basic (prune-stale-modes)
[322.665960] Starting subtest: prune-stale-modes
[322.689213] Subtest prune-stale-modes: SUCCESS (0.023s)
[323.065940] [078/131] (700s left) kms_atomic_transition (modeset-transition)
[323.262415] Starting subtest: modeset-transition
[323.263314] Starting dynamic subtest: 1x-outputs
[325.826352] Dynamic subtest 1x-outputs: SUCCESS (2.564s)
[325.881687] Subtest modeset-transition: SUCCESS (2.620s)
[326.169793] [079/131] (697s left) kms_busy (extended-pageflip-hang-newfb)
[326.367390] Starting subtest: extended-pageflip-hang-newfb
[326.368305] Starting dynamic subtest: pipe-A
[334.262908] Dynamic subtest pipe-A: SUCCESS (7.894s)
[334.285591] Starting dynamic subtest: pipe-D
[342.148431] Dynamic subtest pipe-D: SUCCESS (7.876s)
[342.149455] Subtest extended-pageflip-hang-newfb: SUCCESS (15.782s)
[342.416638] [080/131] (681s left) gem_mmap_offset (partial-mmap)
[342.499951] Starting subtest: partial-mmap
[342.500856] Starting dynamic subtest: lmem0
[342.504213] Dynamic subtest lmem0: SUCCESS (0.005s)
[342.519386] Starting dynamic subtest: smem0
[342.520511] Dynamic subtest smem0: SUCCESS (0.005s)
[342.521588] Subtest partial-mmap: SUCCESS (0.012s)
[342.729772] [081/131] (681s left) gem_pxp (reject-modify-context-protection-off-2)
[345.338518] Starting subtest: reject-modify-context-protection-off-2
[345.340278] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[345.503541] [082/131] (678s left) gem_userptr_blits (unsync-unmap-after-close)
[345.599862] Subtest unsync-unmap-after-close: SKIP (0.000s)
[345.827329] [083/131] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[346.032461] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[346.034232] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[346.224817] [084/131] (677s left) gem_exec_reloc (basic-write-gtt-active)
[346.307198] Subtest basic-write-gtt-active: SKIP (0.000s)
[346.389443] [085/131] (677s left) syncobj_timeline (single-wait-all-signaled)
[346.467402] Starting subtest: single-wait-all-signaled
[346.468292] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[346.608227] [086/131] (677s left) gem_ctx_engines (independent)
[346.702426] Starting subtest: independent
[346.703295] Starting dynamic subtest: rcs0
[346.867531] Dynamic subtest rcs0: SUCCESS (0.166s)
[346.880193] Starting dynamic subtest: bcs0
[347.032836] Dynamic subtest bcs0: SUCCESS (0.164s)
[347.045351] Starting dynamic subtest: vcs0
[347.203752] Dynamic subtest vcs0: SUCCESS (0.170s)
[347.216345] Starting dynamic subtest: vcs1
[347.376207] Dynamic subtest vcs1: SUCCESS (0.171s)
[347.389284] Starting dynamic subtest: vecs0
[347.542217] Dynamic subtest vecs0: SUCCESS (0.165s)
[347.554669] Starting dynamic subtest: vecs1
[347.707899] Dynamic subtest vecs1: SUCCESS (0.164s)
[347.720504] Starting dynamic subtest: ccs0
[347.877070] Dynamic subtest ccs0: SUCCESS (0.168s)
[347.889685] Starting dynamic subtest: all-engines
[348.269041] Dynamic subtest all-engines: SUCCESS (0.391s)
[348.270025] Subtest independent: SUCCESS (1.568s)
[349.257944] [087/131] (674s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[349.335334] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[349.336273] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[349.470800] [088/131] (674s left) gem_exec_reloc (basic-cpu-active)
[349.552467] Subtest basic-cpu-active: SKIP (0.000s)
[349.620364] [089/131] (674s left) gem_lmem_swapping (massive)
[352.472378] Starting subtest: massive
[352.473306] Starting dynamic subtest: lmem0
[365.933912] Dynamic subtest lmem0: SUCCESS (13.461s)
[365.934951] Subtest massive: SUCCESS (13.462s)
[367.774920] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[367.775895] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[367.778527] [090/131] (656s left) gem_exec_reloc (basic-gtt-cpu-active)
[369.369482] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[369.454950] [FACT gem_exec_reloc (basic-gtt-cpu-active)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[369.457347] [FACT gem_exec_reloc (basic-gtt-cpu-active)] new: kernel.kmod_is_loaded.i915: true
[369.460734] [091/131] (654s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[369.654605] Starting subtest: crc-primary-basic-y-tiled-ccs
[369.657180] Starting dynamic subtest: pipe-A-DP-3
[369.665977] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[369.676947] Starting dynamic subtest: pipe-B-DP-3
[369.685278] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[369.696751] Starting dynamic subtest: pipe-C-DP-3
[369.704985] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[369.715688] Starting dynamic subtest: pipe-D-DP-3
[369.725752] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[369.727716] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.010s)
[370.164225] [092/131] (654s left) dmabuf_sync_file (import-multiple-read-write)
[370.230366] Starting subtest: import-multiple-read-write
[370.234284] Subtest import-multiple-read-write: SUCCESS (0.004s)
[370.339018] [093/131] (654s left) kms_color (ctm-0-50)
[370.530771] Starting subtest: ctm-0-50
[370.531618] Starting dynamic subtest: pipe-A-DP-3
[372.330297] Dynamic subtest pipe-A-DP-3: SUCCESS (1.796s)
[372.355043] Starting dynamic subtest: pipe-B-DP-3
[374.063452] Dynamic subtest pipe-B-DP-3: SUCCESS (1.733s)
[374.077777] Starting dynamic subtest: pipe-C-DP-3
[375.692171] Dynamic subtest pipe-C-DP-3: SUCCESS (1.627s)
[375.704071] Starting dynamic subtest: pipe-D-DP-3
[377.371341] Dynamic subtest pipe-D-DP-3: SUCCESS (1.678s)
[377.372421] Subtest ctm-0-50: SUCCESS (6.840s)
[377.707490] [094/131] (646s left) gem_ctx_sseu (mmap-args)
[377.794301] Subtest mmap-args: SKIP (0.000s)
[377.910231] [095/131] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[378.103458] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[378.105242] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[378.311518] [096/131] (646s left) kms_pm_rpm (cursor)
[380.742646] Starting subtest: cursor
[380.744568] Subtest cursor: SKIP (0.000s)
[381.147819] [097/131] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[381.342418] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[381.344130] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[381.547133] [098/131] (643s left) gem_exec_gttfill (basic)
[381.636769] Starting subtest: basic
[387.302986] Subtest basic: SUCCESS (5.666s)
[387.578702] [099/131] (637s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[387.703589] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[387.812654] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[387.942052] [100/131] (637s left) kms_cursor_crc (cursor-onscreen-64x64)
[388.278164] Starting subtest: cursor-onscreen-64x64
[388.282552] Starting dynamic subtest: pipe-A-DP-3
[391.090772] Dynamic subtest pipe-A-DP-3: SUCCESS (2.808s)
[391.146044] Starting dynamic subtest: pipe-D-DP-3
[393.789422] Dynamic subtest pipe-D-DP-3: SUCCESS (2.656s)
[393.790385] Subtest cursor-onscreen-64x64: SUCCESS (5.511s)
[394.299660] [101/131] (630s left) gem_exec_fence (syncobj-export)
[394.875290] Starting subtest: syncobj-export
[394.911604] Subtest syncobj-export: SUCCESS (0.038s)
[395.331564] [102/131] (629s left) kms_big_fb (linear-addfb)
[395.535856] Starting subtest: linear-addfb
[395.536728] Subtest linear-addfb: SUCCESS (0.000s)
[395.731887] [103/131] (629s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[395.944475] Starting subtest: fbc-rgb565-draw-render
[398.715396] Subtest fbc-rgb565-draw-render: SUCCESS (2.772s)
[398.981503] [104/131] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[399.178400] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[399.180157] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[399.389209] [105/131] (626s left) kms_psr (pr-primary-mmap-cpu)
[399.586231] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[399.643844] [106/131] (625s left) kms_rotation_crc (bad-tiling)
[399.834428] Starting subtest: bad-tiling
[399.836241] Subtest bad-tiling: SKIP (0.001s)
[399.970440] [107/131] (625s left) i915_pm_freq_mult (media-freq)
[400.056572] Starting subtest: media-freq
[400.057460] Starting dynamic subtest: gt0
[400.564363] Dynamic subtest gt0: SUCCESS (0.508s)
[400.565553] Subtest media-freq: SUCCESS (0.510s)
[400.764122] [108/131] (624s left) sysfs_heartbeat_interval (idempotent)
[400.856218] Starting subtest: idempotent
[400.858518] Starting dynamic subtest: vecs0
[400.859433] Dynamic subtest vecs0: SUCCESS (0.001s)
[400.872593] Starting dynamic subtest: ccs0
[400.873488] Dynamic subtest ccs0: SUCCESS (0.001s)
[400.886392] Starting dynamic subtest: vcs0
[400.887624] Dynamic subtest vcs0: SUCCESS (0.001s)
[400.900320] Starting dynamic subtest: bcs0
[400.901470] Dynamic subtest bcs0: SUCCESS (0.001s)
[400.913718] Starting dynamic subtest: vecs1
[400.914742] Dynamic subtest vecs1: SUCCESS (0.001s)
[400.927045] Starting dynamic subtest: rcs0
[400.928179] Dynamic subtest rcs0: SUCCESS (0.001s)
[400.943476] Starting dynamic subtest: vcs1
[400.944424] Dynamic subtest vcs1: SUCCESS (0.001s)
[400.945546] Subtest idempotent: SUCCESS (0.015s)
[400.994109] [109/131] (624s left) kms_cursor_legacy (forked-move)
[401.191464] Starting subtest: forked-move
[401.192416] Starting dynamic subtest: pipe-A
[406.626538] Dynamic subtest pipe-A: SUCCESS (5.434s)
[406.651615] Starting dynamic subtest: pipe-B
[412.054240] Dynamic subtest pipe-B: SUCCESS (5.424s)
[412.081812] Starting dynamic subtest: pipe-C
[417.490124] Dynamic subtest pipe-C: SUCCESS (5.434s)
[417.519989] Starting dynamic subtest: pipe-D
[422.922034] Dynamic subtest pipe-D: SUCCESS (5.429s)
[422.950862] Starting dynamic subtest: all-pipes
[428.345388] Dynamic subtest all-pipes: SUCCESS (5.421s)
[428.346341] Subtest forked-move: SUCCESS (27.154s)
[428.536985] [110/131] (597s left) kms_prime (basic-modeset-hybrid)
[428.731490] Subtest basic-modeset-hybrid: SKIP (0.000s)
[428.944362] [111/131] (596s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[429.031910] Starting subtest: invalid-smem-bo-on-discrete
[429.032848] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[429.295071] [112/131] (596s left) kms_plane_alpha_blend (constant-alpha-mid)
[429.482890] Starting subtest: constant-alpha-mid
[429.742449] Starting dynamic subtest: pipe-A-DP-3
[430.490044] Dynamic subtest pipe-A-DP-3: SUCCESS (0.748s)
[430.508295] Starting dynamic subtest: pipe-D-DP-3
[431.272998] Dynamic subtest pipe-D-DP-3: SUCCESS (0.780s)
[431.273962] Subtest constant-alpha-mid: SUCCESS (1.790s)
[431.574910] [113/131] (594s left) api_intel_bb (blit-noreloc-keep-cache)
[431.653948] Starting subtest: blit-noreloc-keep-cache
[431.691277] Subtest blit-noreloc-keep-cache: SUCCESS (0.037s)
[431.894680] [114/131] (594s left) api_intel_bb (reset-bb)
[431.973811] Starting subtest: reset-bb
[432.001571] Subtest reset-bb: SUCCESS (0.029s)
[432.210802] [115/131] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[432.409451] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[432.411155] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.604649] [116/131] (593s left) gem_pread (bench)
[432.681343] Subtest bench: SKIP (0.000s)
[432.783549] [117/131] (593s left) gem_exec_schedule (u-fairslice)
[432.874358] Starting subtest: u-fairslice
[432.875349] Starting dynamic subtest: rcs0
[434.927448] Dynamic subtest rcs0: SUCCESS (2.052s)
[434.940217] Starting dynamic subtest: bcs0
[436.949303] Dynamic subtest bcs0: SUCCESS (2.020s)
[436.962497] Starting dynamic subtest: vcs0
[438.969226] Dynamic subtest vcs0: SUCCESS (2.019s)
[438.982232] Starting dynamic subtest: vcs1
[440.988287] Dynamic subtest vcs1: SUCCESS (2.018s)
[441.001559] Starting dynamic subtest: vecs0
[443.009925] Dynamic subtest vecs0: SUCCESS (2.020s)
[443.023399] Starting dynamic subtest: vecs1
[445.029332] Dynamic subtest vecs1: SUCCESS (2.019s)
[445.042629] Starting dynamic subtest: ccs0
[447.051197] Dynamic subtest ccs0: SUCCESS (2.021s)
[447.052235] Subtest u-fairslice: SUCCESS (14.176s)
[447.503493] [118/131] (578s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[447.703563] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[447.758013] [119/131] (578s left) gem_exec_capture (capture-recoverable)
[447.846387] Starting subtest: capture-recoverable
[447.850340] Subtest capture-recoverable: SUCCESS (0.004s)
[448.057617] [120/131] (578s left) syncobj_wait (reset-during-wait-for-submit)
[448.134490] Starting subtest: reset-during-wait-for-submit
[448.236897] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[448.430689] [121/131] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[448.626419] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[448.628148] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[448.810395] [122/131] (577s left) gem_tiled_pread_pwrite
[448.957475] [123/131] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[449.152403] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[449.154113] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.346849] [124/131] (577s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[449.547472] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[449.549233] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[449.743403] [125/131] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[449.944062] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[449.945830] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[450.148575] [126/131] (576s left) kms_flip (wf_vblank-ts-check)
[450.335125] Starting subtest: wf_vblank-ts-check
[450.339764] Starting dynamic subtest: A-DP3
[458.450794] Dynamic subtest A-DP3: SUCCESS (8.111s)
[458.466691] Starting dynamic subtest: B-DP3
[466.503888] Dynamic subtest B-DP3: SUCCESS (8.051s)
[466.519236] Starting dynamic subtest: C-DP3
[474.562017] Dynamic subtest C-DP3: SUCCESS (8.057s)
[474.577269] Starting dynamic subtest: D-DP3
[482.615919] Dynamic subtest D-DP3: SUCCESS (8.052s)
[482.618609] Subtest wf_vblank-ts-check: SUCCESS (32.282s)
[482.982061] [127/131] (544s left) gem_ctx_param (set-priority-range)
[483.070116] Starting subtest: set-priority-range
[483.089372] Subtest set-priority-range: SUCCESS (0.019s)
[483.285971] [128/131] (543s left) gem_ccs (block-multicopy-compressed)
[483.374534] Starting subtest: block-multicopy-compressed
[483.377007] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[483.425427] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.050s)
[483.439853] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[483.526369] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s)
[483.540677] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[483.545684] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.018s)
[483.559587] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[483.653917] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[483.667810] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[483.671117] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[483.685224] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[483.771422] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[483.785506] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[483.788857] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[483.803021] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[483.888919] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[483.889851] Subtest block-multicopy-compressed: SUCCESS (0.515s)
[484.103472] [129/131] (543s left) gem_exec_reloc (basic-cpu-noreloc)
[484.190286] Subtest basic-cpu-noreloc: SKIP (0.000s)
[484.308088] [130/131] (543s left) kms_chamelium_edid (dp-edid-read)
[484.575176] Subtest dp-edid-read: SKIP (0.000s)
[484.727930] [131/131] (542s left) kms_vblank (wait-idle-hang)
[484.920446] Starting subtest: wait-idle-hang
[484.921412] Starting dynamic subtest: pipe-A-DP-3
[511.246423] Dynamic subtest pipe-A-DP-3: SUCCESS (26.324s)
[511.262182] Starting dynamic subtest: pipe-D-DP-3
[536.256711] Dynamic subtest pipe-D-DP-3: SUCCESS (25.006s)
[536.257571] Subtest wait-idle-hang: SUCCESS (51.337s)
[536.566929] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gen7_exec_parse
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_close_race
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: gem_flink_race
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_su
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_universal_plane
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: i915_suspend
results: parsing output: 35/ for test: sriov_basic
results: parsing output: 36/ for test: prime_mmap_coherency
results: parsing output: 37/ for test: kms_color
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: prime_mmap
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_wait
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_ringfill
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_fence_pin_leak
results: parsing output: 57/ for test: kms_feature_discovery
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gem_sync
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_ctx_create
results: parsing output: 72/ for test: kms_selftest
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_force_connector_basic
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: kms_busy
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_ctx_engines
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: gem_lmem_swapping
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: dmabuf_sync_file
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_ctx_sseu
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_gttfill
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: i915_pm_freq_mult
results: parsing output: 107/ for test: sysfs_heartbeat_interval
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_prime
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_plane_alpha_blend
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_pread
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gem_exec_capture
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_tiled_pread_pwrite
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: gem_ccs
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_vblank
Done.