[58.977498] Initializing watchdogs
[58.977563]   /dev/watchdog0
[58.997766] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.008908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.012656] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.015288] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[59.204639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[59.206385] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[59.386862] [002/134] (960s left) kms_draw_crc (draw-method-render)
[59.567955] Starting subtest: draw-method-render
[59.569067] Starting dynamic subtest: xrgb8888-untiled
[59.974345] Dynamic subtest xrgb8888-untiled: SUCCESS (0.408s)
[60.005543] Starting dynamic subtest: rgb565-untiled
[60.324251] Dynamic subtest rgb565-untiled: SUCCESS (0.350s)
[60.336526] Starting dynamic subtest: xrgb2101010-untiled
[60.621804] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[60.654154] Starting dynamic subtest: xbgr16161616f-untiled
[60.985256] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.365s)
[60.993808] Starting dynamic subtest: xrgb8888-xtiled
[61.151504] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.167s)
[61.165293] Starting dynamic subtest: rgb565-xtiled
[61.318848] Dynamic subtest rgb565-xtiled: SUCCESS (0.166s)
[61.349556] Starting dynamic subtest: xrgb2101010-xtiled
[61.501236] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.182s)
[61.532657] Starting dynamic subtest: xbgr16161616f-xtiled
[61.682354] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.182s)
[61.692085] Starting dynamic subtest: xrgb8888-4tiled
[61.849994] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.167s)
[61.882075] Starting dynamic subtest: rgb565-4tiled
[62.033102] Dynamic subtest rgb565-4tiled: SUCCESS (0.182s)
[62.066520] Starting dynamic subtest: xrgb2101010-4tiled
[62.215094] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.182s)
[62.245450] Starting dynamic subtest: xbgr16161616f-4tiled
[62.397923] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.182s)
[62.399985] Subtest draw-method-render: SUCCESS (2.842s)
[62.608843] [003/134] (957s left) kms_rmfb (close-fd)
[62.790947] Starting subtest: close-fd
[62.791888] Starting dynamic subtest: pipe-A-DP-3
[62.946435] Dynamic subtest pipe-A-DP-3: SUCCESS (0.156s)
[62.957640] Starting dynamic subtest: pipe-B-DP-3
[63.242189] Dynamic subtest pipe-B-DP-3: SUCCESS (0.295s)
[63.249971] Starting dynamic subtest: pipe-C-DP-3
[63.507184] Dynamic subtest pipe-C-DP-3: SUCCESS (0.264s)
[63.515513] Starting dynamic subtest: pipe-D-DP-3
[63.770477] Dynamic subtest pipe-D-DP-3: SUCCESS (0.263s)
[63.771433] Subtest close-fd: SUCCESS (0.984s)
[64.099628] [004/134] (955s left) fbdev (info)
[64.144538] Starting subtest: info
[64.145436] Subtest info: SUCCESS (0.000s)
[64.279133] [005/134] (955s left) gem_exec_reloc (basic-cpu-wc-active)
[64.361094] Subtest basic-cpu-wc-active: SKIP (0.000s)
[64.450601] [006/134] (955s left) gem_pxp (display-protected-crc)
[67.045940] Starting subtest: display-protected-crc
[67.050236] Subtest display-protected-crc: SKIP (0.000s)
[67.211707] [007/134] (952s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[67.581968] Starting subtest: etime-single-wait-all-for-submit-submitted
[67.685229] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[67.994014] [008/134] (951s left) gem_ctx_shared (q-smoketest-all)
[68.144153] Starting subtest: Q-smoketest-all
[100.440070] Subtest Q-smoketest-all: SUCCESS (32.296s)
[100.809480] [009/134] (919s left) gem_tiled_swapping (non-threaded)
[100.878124] Subtest non-threaded: SKIP (0.000s)
[100.946203] [010/134] (919s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[101.135583] Starting subtest: fbc-rgb565-draw-pwrite
[103.906771] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.771s)
[104.069476] [011/134] (916s left) i915_hangman (engine-engine-hang)
[104.159799] Starting subtest: engine-engine-hang
[104.160706] Starting dynamic subtest: rcs0
[105.037033] Dynamic subtest rcs0: SUCCESS (0.877s)
[105.047567] Starting dynamic subtest: bcs0
[105.855311] Dynamic subtest bcs0: SUCCESS (0.818s)
[105.864686] Starting dynamic subtest: vcs0
[106.696681] Dynamic subtest vcs0: SUCCESS (0.841s)
[106.708131] Starting dynamic subtest: vcs1
[107.541734] Dynamic subtest vcs1: SUCCESS (0.845s)
[107.552335] Starting dynamic subtest: vecs0
[108.298395] Dynamic subtest vecs0: SUCCESS (0.756s)
[108.307127] Starting dynamic subtest: vecs1
[109.138646] Dynamic subtest vecs1: SUCCESS (0.840s)
[109.149382] Starting dynamic subtest: ccs0
[109.966537] Dynamic subtest ccs0: SUCCESS (0.827s)
[109.967545] Subtest engine-engine-hang: SUCCESS (5.808s)
[110.150461] [012/134] (910s left) gem_mmap_offset (partial-unmap)
[110.221045] Starting subtest: partial-unmap
[110.222135] Starting dynamic subtest: lmem0
[110.234263] Dynamic subtest lmem0: SUCCESS (0.013s)
[110.243574] Starting dynamic subtest: smem0
[110.244825] Dynamic subtest smem0: SUCCESS (0.005s)
[110.246037] Subtest partial-unmap: SUCCESS (0.018s)
[110.465469] [013/134] (909s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[110.651598] Starting subtest: fbc-indfb-scaledprimary
[112.257749] Subtest fbc-indfb-scaledprimary: SUCCESS (1.606s)
[112.519925] [014/134] (907s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[112.776503] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[112.828454] [015/134] (907s left) kms_addfb_basic (invalid-get-prop-any)
[112.907997] Starting subtest: invalid-get-prop-any
[112.908955] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[113.222605] [016/134] (907s left) gem_ctx_isolation (preservation-reset)
[113.408466] Starting subtest: preservation-reset
[113.409429] Starting dynamic subtest: rcs0
[114.007992] Dynamic subtest rcs0: SUCCESS (0.599s)
[114.017439] Starting dynamic subtest: bcs0
[114.650394] Dynamic subtest bcs0: SUCCESS (0.642s)
[114.659501] Starting dynamic subtest: vcs0
[115.304917] Dynamic subtest vcs0: SUCCESS (0.654s)
[115.313894] Starting dynamic subtest: vcs1
[115.945893] Dynamic subtest vcs1: SUCCESS (0.641s)
[115.954938] Starting dynamic subtest: vecs0
[116.595496] Dynamic subtest vecs0: SUCCESS (0.650s)
[116.604474] Starting dynamic subtest: vecs1
[117.224780] Dynamic subtest vecs1: SUCCESS (0.629s)
[117.233915] Starting dynamic subtest: ccs0
[117.860144] Dynamic subtest ccs0: SUCCESS (0.635s)
[117.861182] Subtest preservation-reset: SUCCESS (4.452s)
[118.137794] [017/134] (902s left) kms_properties (plane-properties-legacy)
[118.317570] Starting subtest: plane-properties-legacy
[118.318449] Starting dynamic subtest: pipe-A-DP-3
[118.831889] Dynamic subtest pipe-A-DP-3: SUCCESS (0.513s)
[118.845238] Starting dynamic subtest: pipe-B-DP-3
[119.356135] Dynamic subtest pipe-B-DP-3: SUCCESS (0.522s)
[119.365371] Starting dynamic subtest: pipe-C-DP-3
[119.895295] Dynamic subtest pipe-C-DP-3: SUCCESS (0.538s)
[119.904445] Starting dynamic subtest: pipe-D-DP-3
[120.433186] Dynamic subtest pipe-D-DP-3: SUCCESS (0.537s)
[120.434200] Subtest plane-properties-legacy: SUCCESS (2.116s)
[120.705204] [018/134] (899s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[120.882367] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[120.883322] Starting dynamic subtest: pipe-A-DP-3
[120.905505] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[120.914483] Starting dynamic subtest: pipe-B-DP-3
[120.936319] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[120.945215] Starting dynamic subtest: pipe-C-DP-3
[120.971309] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[120.980361] Starting dynamic subtest: pipe-D-DP-3
[121.003453] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[121.004989] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.012s)
[121.363928] [019/134] (899s left) prime_vgem (basic-read)
[121.529523] Starting subtest: basic-read
[121.535998] Subtest basic-read: SKIP (0.006s)
[121.685611] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[121.687465] [020/134] (899s left) gem_ppgtt (blt-vs-render-ctxn)
[121.775920] Starting subtest: blt-vs-render-ctxN
[154.739601] Subtest blt-vs-render-ctxN: SUCCESS (32.962s)
[154.963183] [021/134] (865s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[155.200166] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[155.201130] Starting dynamic subtest: pipe-A-DP-3
[155.209890] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[155.219535] Starting dynamic subtest: pipe-B-DP-3
[155.227997] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[155.237458] Starting dynamic subtest: pipe-C-DP-3
[155.246026] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[155.255319] Starting dynamic subtest: pipe-D-DP-3
[155.264905] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[155.267205] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[155.676122] [022/134] (865s left) syncobj_timeline (multi-wait-signaled)
[155.769190] Starting subtest: multi-wait-signaled
[155.770129] Subtest multi-wait-signaled: SUCCESS (0.001s)
[155.906718] [023/134] (865s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[156.101169] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[156.156309] [024/134] (864s left) gem_exec_schedule (preempt-other-chain)
[156.264714] Starting subtest: preempt-other-chain
[156.265626] Starting dynamic subtest: rcs0
[156.905487] Dynamic subtest rcs0: SUCCESS (0.640s)
[156.915517] Starting dynamic subtest: bcs0
[157.524618] Dynamic subtest bcs0: SUCCESS (0.619s)
[157.534788] Starting dynamic subtest: vcs0
[158.155223] Dynamic subtest vcs0: SUCCESS (0.630s)
[158.165510] Starting dynamic subtest: vcs1
[158.777352] Dynamic subtest vcs1: SUCCESS (0.622s)
[158.787490] Starting dynamic subtest: vecs0
[159.700718] Dynamic subtest vecs0: SUCCESS (0.923s)
[159.710635] Starting dynamic subtest: vecs1
[160.338657] Dynamic subtest vecs1: SUCCESS (0.638s)
[160.348565] Starting dynamic subtest: ccs0
[160.963339] Dynamic subtest ccs0: SUCCESS (0.624s)
[160.964666] Subtest preempt-other-chain: SUCCESS (4.698s)
[161.406800] [025/134] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[161.601887] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[161.603539] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[161.791620] [026/134] (859s left) kms_plane_alpha_blend (constant-alpha-mid)
[161.979661] Starting subtest: constant-alpha-mid
[162.250261] Starting dynamic subtest: pipe-A-DP-3
[162.971573] Dynamic subtest pipe-A-DP-3: SUCCESS (0.721s)
[162.983296] Starting dynamic subtest: pipe-D-DP-3
[163.736426] Dynamic subtest pipe-D-DP-3: SUCCESS (0.764s)
[163.737355] Subtest constant-alpha-mid: SUCCESS (1.757s)
[164.067953] [027/134] (857s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[164.263956] Starting subtest: fbc-shrfb-scaledprimary
[165.932890] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.669s)
[166.128712] [028/134] (855s left) kms_pm_dc (dc3co-vpb-simulation)
[167.327136] Starting subtest: dc3co-vpb-simulation
[167.329259] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[167.477850] [029/134] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[167.671570] Starting subtest: fbcpsr-2p-rte
[167.673322] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[167.881811] [030/134] (853s left) kms_chamelium_hpd (vga-hpd)
[168.161254] Subtest vga-hpd: SKIP (0.000s)
[168.345703] [031/134] (853s left) perf (sysctl-defaults)
[168.478165] Starting subtest: sysctl-defaults
[168.479145] Subtest sysctl-defaults: SUCCESS (0.000s)
[168.820616] [032/134] (852s left) gem_sync (basic-all)
[168.920963] Starting subtest: basic-all
[172.018244] Subtest basic-all: SUCCESS (3.090s)
[172.255147] [033/134] (849s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[172.447058] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[172.447969] Starting dynamic subtest: pipe-A-valid-mode
[172.534677] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[172.536499] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.088s)
[172.787870] [034/134] (849s left) kms_pipe_crc_basic (read-crc)
[172.976442] Starting subtest: read-crc
[172.978433] Starting dynamic subtest: pipe-A-DP-3
[173.651057] Dynamic subtest pipe-A-DP-3: SUCCESS (0.673s)
[173.666590] Starting dynamic subtest: pipe-B-DP-3
[174.242009] Dynamic subtest pipe-B-DP-3: SUCCESS (0.589s)
[174.253801] Starting dynamic subtest: pipe-C-DP-3
[174.833295] Dynamic subtest pipe-C-DP-3: SUCCESS (0.590s)
[174.846455] Starting dynamic subtest: pipe-D-DP-3
[175.413253] Dynamic subtest pipe-D-DP-3: SUCCESS (0.578s)
[175.414278] Subtest read-crc: SUCCESS (2.436s)
[175.754224] [035/134] (846s left) gem_create (create-clear)
[175.835207] Starting subtest: create-clear
[175.836186] Starting dynamic subtest: lmem0
[212.004364] Dynamic subtest lmem0: SUCCESS (36.165s)
[212.014442] Starting dynamic subtest: smem0
[248.836009] Dynamic subtest smem0: SUCCESS (36.829s)
[248.836942] Subtest create-clear: SUCCESS (72.996s)
[249.302532] [036/134] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[249.508574] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[251.605449] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.098s)
[251.836649] [037/134] (770s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[252.033185] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[252.082819] [038/134] (770s left) syncobj_eventfd (invalid-illegal-handle)
[252.165060] Starting subtest: invalid-illegal-handle
[252.166111] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[252.337469] [039/134] (769s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[252.548977] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[252.550965] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[252.707351] [040/134] (769s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[252.901209] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[252.902978] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[253.072203] [041/134] (769s left) kms_psr (pr-primary-render)
[253.260621] Subtest pr-primary-render: SKIP (0.000s)
[253.315788] [042/134] (769s left) gen9_exec_parse (bb-start-far)
[253.403477] Subtest bb-start-far: SKIP (0.000s)
[253.528512] [043/134] (768s left) kms_flip (2x-modeset-vs-vblank-race)
[253.720355] Starting subtest: 2x-modeset-vs-vblank-race
[253.735967] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s)
[253.882917] [044/134] (768s left) gem_exec_balancer (invalid-bonds)
[253.973758] Starting subtest: invalid-bonds
[253.975653] Subtest invalid-bonds: SKIP (0.000s)
[254.416060] [045/134] (768s left) gem_sync (basic-store-each)
[254.518184] Starting subtest: basic-store-each
[257.189492] Subtest basic-store-each: SUCCESS (2.672s)
[257.470427] [046/134] (765s left) kms_properties (connector-properties-atomic)
[257.664351] Starting subtest: connector-properties-atomic
[257.665280] Starting dynamic subtest: pipe-A-DP-3
[259.219684] Dynamic subtest pipe-A-DP-3: SUCCESS (1.555s)
[259.229689] Starting dynamic subtest: pipe-None-DP-1
[259.231432] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[259.241642] Starting dynamic subtest: pipe-None-DP-2
[259.243920] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[259.253635] Starting dynamic subtest: pipe-None-HDMI-A-1
[259.255938] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[259.265322] Starting dynamic subtest: pipe-None-HDMI-A-2
[259.267166] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[259.277165] Starting dynamic subtest: pipe-None-DP-4
[259.279082] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[259.288806] Starting dynamic subtest: pipe-None-HDMI-A-3
[259.290530] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.001s)
[259.291419] Subtest connector-properties-atomic: SUCCESS (1.570s)
[259.521093] [047/134] (763s left) kms_content_protection (atomic)
[259.775382] Starting subtest: atomic
[259.799246] Starting dynamic subtest: pipe-A-DP-3
[382.421993] Dynamic subtest pipe-A-DP-3: FAIL (122.457s)
[382.422998] Subtest atomic: FAIL (122.585s)
[382.624336] [048/134] (640s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[382.826466] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[384.005454] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.179s)
[384.277636] [049/134] (638s left) gem_spin_batch (legacy-resubmit)
[384.374229] Starting subtest: legacy-resubmit
[384.375200] Starting dynamic subtest: default
[384.404931] Dynamic subtest default: SUCCESS (0.030s)
[384.415435] Starting dynamic subtest: render
[384.416403] Dynamic subtest render: SUCCESS (0.001s)
[384.426973] Starting dynamic subtest: bsd
[384.428242] Dynamic subtest bsd: SUCCESS (0.002s)
[384.438533] Starting dynamic subtest: bsd1
[384.439657] Dynamic subtest bsd1: SUCCESS (0.003s)
[384.449666] Starting dynamic subtest: bsd2
[384.450731] Dynamic subtest bsd2: SUCCESS (0.002s)
[384.460728] Starting dynamic subtest: blt
[384.461757] Dynamic subtest blt: SUCCESS (0.002s)
[384.471468] Starting dynamic subtest: vebox
[384.472484] Dynamic subtest vebox: SUCCESS (0.002s)
[384.473594] Subtest legacy-resubmit: SUCCESS (0.047s)
[384.761416] [050/134] (638s left) kms_flip (basic-flip-vs-wf_vblank)
[384.955013] Starting subtest: basic-flip-vs-wf_vblank
[384.959468] Starting dynamic subtest: A-DP3
[386.080627] Dynamic subtest A-DP3: SUCCESS (1.121s)
[386.092997] Starting dynamic subtest: B-DP3
[387.134628] Dynamic subtest B-DP3: SUCCESS (1.053s)
[387.147394] Starting dynamic subtest: C-DP3
[388.179628] Dynamic subtest C-DP3: SUCCESS (1.044s)
[388.190264] Starting dynamic subtest: D-DP3
[389.232503] Dynamic subtest D-DP3: SUCCESS (1.052s)
[389.234589] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.280s)
[389.616418] [051/134] (633s left) perf_pmu (multi-client)
[389.691190] Starting subtest: multi-client
[389.692157] Starting dynamic subtest: rcs0
[390.791485] Dynamic subtest rcs0: SUCCESS (1.100s)
[390.806073] Starting dynamic subtest: bcs0
[391.848403] Dynamic subtest bcs0: SUCCESS (1.053s)
[391.863265] Starting dynamic subtest: vcs0
[392.906577] Dynamic subtest vcs0: SUCCESS (1.054s)
[392.921357] Starting dynamic subtest: vcs1
[393.964156] Dynamic subtest vcs1: SUCCESS (1.054s)
[393.978167] Starting dynamic subtest: vecs0
[395.018197] Dynamic subtest vecs0: SUCCESS (1.051s)
[395.032397] Starting dynamic subtest: vecs1
[396.074193] Dynamic subtest vecs1: SUCCESS (1.053s)
[396.088164] Starting dynamic subtest: ccs0
[397.129038] Dynamic subtest ccs0: SUCCESS (1.052s)
[397.131053] Subtest multi-client: SUCCESS (7.439s)
[397.315255] [052/134] (625s left) kms_psr (fbc-psr2-sprite-plane-move)
[397.503610] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[397.559506] [053/134] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[397.752966] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[397.754681] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.948524] [054/134] (625s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[398.141928] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[398.142836] Starting dynamic subtest: pipe-A
[398.729455] Dynamic subtest pipe-A: SUCCESS (0.587s)
[398.743309] Starting dynamic subtest: pipe-B
[399.361553] Dynamic subtest pipe-B: SUCCESS (0.631s)
[399.378914] Starting dynamic subtest: pipe-C
[400.007197] Dynamic subtest pipe-C: SUCCESS (0.645s)
[400.028630] Starting dynamic subtest: pipe-D
[400.653496] Dynamic subtest pipe-D: SUCCESS (0.645s)
[400.654636] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.512s)
[401.003828] [055/134] (622s left) kms_atomic (test-only)
[401.189726] Starting subtest: test-only
[401.636247] Starting dynamic subtest: pipe-A-DP-3
[402.508333] Dynamic subtest pipe-A-DP-3: SUCCESS (0.872s)
[402.509313] Subtest test-only: SUCCESS (1.318s)
[402.808401] [056/134] (620s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[403.004894] Starting subtest: psr-rgb101010-draw-mmap-gtt
[403.006646] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[403.181886] [057/134] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[403.374912] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[403.376640] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[403.573506] [058/134] (620s left) gem_exercise_blt (fast-copy)
[403.662997] Starting subtest: fast-copy
[403.663937] Starting dynamic subtest: linear-smem-smem
[403.712294] Dynamic subtest linear-smem-smem: SUCCESS (0.049s)
[403.723383] Starting dynamic subtest: linear-smem-lmem0
[403.729967] Dynamic subtest linear-smem-lmem0: SUCCESS (0.017s)
[403.740996] Starting dynamic subtest: linear-lmem0-smem
[403.850897] Dynamic subtest linear-lmem0-smem: SUCCESS (0.119s)
[403.861904] Starting dynamic subtest: linear-lmem0-lmem0
[403.963235] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.113s)
[403.974046] Starting dynamic subtest: xmajor-smem-smem
[403.980592] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[403.991511] Starting dynamic subtest: xmajor-smem-lmem0
[403.997382] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s)
[404.008315] Starting dynamic subtest: xmajor-lmem0-smem
[404.093924] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.096s)
[404.104786] Starting dynamic subtest: xmajor-lmem0-lmem0
[404.191262] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.097s)
[404.201936] Starting dynamic subtest: tile4-smem-smem
[404.208446] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[404.219266] Starting dynamic subtest: tile4-smem-lmem0
[404.225221] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s)
[404.236189] Starting dynamic subtest: tile4-lmem0-smem
[404.328220] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.102s)
[404.338804] Starting dynamic subtest: tile4-lmem0-lmem0
[404.429592] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.101s)
[404.440422] Starting dynamic subtest: tile64-smem-smem
[404.447045] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[404.457968] Starting dynamic subtest: tile64-smem-lmem0
[404.463439] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[404.474286] Starting dynamic subtest: tile64-lmem0-smem
[404.570561] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.106s)
[404.581182] Starting dynamic subtest: tile64-lmem0-lmem0
[404.684328] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.113s)
[404.685470] Subtest fast-copy: SUCCESS (1.022s)
[404.861427] [059/134] (618s left) kms_cursor_crc (cursor-onscreen-128x128)
[405.242334] Starting subtest: cursor-onscreen-128x128
[405.247076] Starting dynamic subtest: pipe-A-DP-3
[407.991131] Dynamic subtest pipe-A-DP-3: SUCCESS (2.743s)
[408.047321] Starting dynamic subtest: pipe-D-DP-3
[410.760641] Dynamic subtest pipe-D-DP-3: SUCCESS (2.724s)
[410.761686] Subtest cursor-onscreen-128x128: SUCCESS (5.518s)
[411.220461] [060/134] (612s left) kms_addfb_basic (basic-y-tiled-legacy)
[411.299484] Starting subtest: basic-y-tiled-legacy
[411.301259] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[411.611734] [061/134] (612s left) gem_ctx_persistence (legacy-engines-hang)
[411.701182] Starting subtest: legacy-engines-hang
[411.702196] Starting dynamic subtest: render
[411.772281] Dynamic subtest render: SUCCESS (0.071s)
[411.784794] Starting dynamic subtest: bsd1
[411.882362] Dynamic subtest bsd1: SUCCESS (0.108s)
[411.899182] Starting dynamic subtest: bsd2
[411.986198] Dynamic subtest bsd2: SUCCESS (0.099s)
[412.031825] Starting dynamic subtest: blt
[412.054496] Dynamic subtest blt: SUCCESS (0.064s)
[412.074613] Starting dynamic subtest: vebox
[412.157332] Dynamic subtest vebox: SUCCESS (0.100s)
[412.163093] Subtest legacy-engines-hang: SUCCESS (0.458s)
[412.332928] [062/134] (611s left) vgem_basic (bad-fence)
[412.396027] Starting subtest: bad-fence
[412.396978] Subtest bad-fence: SUCCESS (0.000s)
[412.534775] [063/134] (611s left) kms_flip (blocking-wf_vblank)
[412.726088] Starting subtest: blocking-wf_vblank
[412.729685] Starting dynamic subtest: A-DP3
[420.864428] Dynamic subtest A-DP3: SUCCESS (8.133s)
[420.878967] Starting dynamic subtest: B-DP3
[428.919922] Dynamic subtest B-DP3: SUCCESS (8.052s)
[428.933373] Starting dynamic subtest: C-DP3
[436.974989] Dynamic subtest C-DP3: SUCCESS (8.054s)
[436.988123] Starting dynamic subtest: D-DP3
[445.025785] Dynamic subtest D-DP3: SUCCESS (8.050s)
[445.028184] Subtest blocking-wf_vblank: SUCCESS (32.302s)
[445.391913] [064/134] (578s left) gem_pxp (verify-pxp-stale-buf-execution)
[448.004542] Starting subtest: verify-pxp-stale-buf-execution
[448.006361] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[448.140562] [065/134] (576s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[448.330358] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[448.386576] [066/134] (575s left) kms_colorop (plane-xr30-xr30-multiply_inv_125)
[448.692054] Subtest plane-XR30-XR30-multiply_inv_125: SKIP (0.000s)
[448.830784] [067/134] (575s left) kms_psr (psr2-sprite-mmap-gtt)
[449.022503] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[449.085973] [068/134] (575s left) gem_lmem_swapping (verify-ccs)
[452.023743] Starting subtest: verify-ccs
[452.026042] Starting dynamic subtest: lmem0
[498.534203] Dynamic subtest lmem0: SUCCESS (46.509s)
[498.536892] Subtest verify-ccs: SUCCESS (46.510s)
[500.512697] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[500.513681] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[500.515578] [069/134] (523s left) api_intel_bb (reset-flags)
[502.123199] Starting subtest: reset-flags
[502.170559] Subtest reset-flags: SUCCESS (0.048s)
[502.292187] [FACT api_intel_bb (reset-flags)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[502.294581] [FACT api_intel_bb (reset-flags)] new: kernel.kmod_is_loaded.i915: true
[502.297562] [070/134] (522s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[502.489427] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[502.490340] Starting dynamic subtest: pipe-A-valid-mode
[508.079944] Dynamic subtest pipe-A-valid-mode: SUCCESS (5.588s)
[508.081433] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (5.591s)
[508.413993] [071/134] (516s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[508.611182] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[508.672559] [072/134] (515s left) kms_flip (absolute-wf_vblank-interruptible)
[508.865920] Starting subtest: absolute-wf_vblank-interruptible
[508.870910] Starting dynamic subtest: A-DP3
[516.703677] Dynamic subtest A-DP3: SUCCESS (7.832s)
[516.718269] Starting dynamic subtest: B-DP3
[524.449634] Dynamic subtest B-DP3: SUCCESS (7.744s)
[524.462371] Starting dynamic subtest: C-DP3
[532.197732] Dynamic subtest C-DP3: SUCCESS (7.746s)
[532.210488] Starting dynamic subtest: D-DP3
[539.946485] Dynamic subtest D-DP3: SUCCESS (7.747s)
[539.948921] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.082s)
[540.299095] [073/134] (484s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[540.495299] Starting subtest: psr-shrfb-scaledprimary
[540.496994] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[540.677234] [074/134] (484s left) kms_psr (psr-cursor-plane-move)
[540.866319] Subtest psr-cursor-plane-move: SKIP (0.000s)
[540.923836] [075/134] (483s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[541.019592] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[541.110200] [076/134] (483s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[541.200175] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[541.298762] [077/134] (483s left) kms_feature_discovery (psr1)
[541.490054] Starting subtest: psr1
[541.491840] Subtest psr1: SKIP (0.000s)
[541.643256] [078/134] (483s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[541.735144] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[541.737177] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[541.969461] [079/134] (483s left) i915_pm_rps (waitboost)
[542.060550] Starting subtest: waitboost
[545.658122] Subtest waitboost: SUCCESS (3.599s)
[545.834383] [080/134] (479s left) gem_madvise (dontneed-after-mmap)
[545.884813] Starting subtest: dontneed-after-mmap
[545.933480] Subtest dontneed-after-mmap: SUCCESS (0.049s)
[546.073981] [081/134] (479s left) i915_pm_rpm (reg-read-ioctl)
[548.109872] Starting subtest: reg-read-ioctl
[548.911197] Subtest reg-read-ioctl: SUCCESS (0.801s)
[549.360917] [082/134] (475s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[549.562043] Starting subtest: x-tiled-16bpp-rotate-180
[551.435219] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.872s)
[551.617483] [083/134] (473s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[551.896498] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[552.049744] [084/134] (473s left) gem_exec_schedule (fairslice)
[552.145008] Starting subtest: fairslice
[552.145948] Starting dynamic subtest: rcs0
[554.196723] Dynamic subtest rcs0: SUCCESS (2.050s)
[554.207547] Starting dynamic subtest: bcs0
[556.217344] Dynamic subtest bcs0: SUCCESS (2.019s)
[556.228449] Starting dynamic subtest: vcs0
[558.239399] Dynamic subtest vcs0: SUCCESS (2.021s)
[558.250579] Starting dynamic subtest: vcs1
[560.260298] Dynamic subtest vcs1: SUCCESS (2.019s)
[560.271238] Starting dynamic subtest: vecs0
[562.281886] Dynamic subtest vecs0: SUCCESS (2.021s)
[562.292792] Starting dynamic subtest: vecs1
[564.302287] Dynamic subtest vecs1: SUCCESS (2.019s)
[564.313266] Starting dynamic subtest: ccs0
[566.323342] Dynamic subtest ccs0: SUCCESS (2.020s)
[566.324337] Subtest fairslice: SUCCESS (14.177s)
[566.711744] [085/134] (458s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[566.791564] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[566.792458] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[566.977990] [086/134] (458s left) gem_exec_whisper (basic-fds-forked-all)
[567.070734] Starting subtest: basic-fds-forked-all
[589.752634] Subtest basic-fds-forked-all: SUCCESS (22.680s)
[590.020300] [087/134] (435s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[590.209476] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[590.210427] Starting dynamic subtest: pipe-A-DP-3
[590.219248] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[590.230358] Starting dynamic subtest: pipe-B-DP-3
[590.238908] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[590.249683] Starting dynamic subtest: pipe-C-DP-3
[590.258552] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[590.269076] Starting dynamic subtest: pipe-D-DP-3
[590.279279] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[590.281123] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[590.688304] [088/134] (435s left) gem_basic (create-close)
[590.770583] Starting subtest: create-close
[590.772572] Subtest create-close: SUCCESS (0.000s)
[590.926792] [089/134] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[591.133062] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[591.134876] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[591.338675] [090/134] (434s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[591.527299] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[591.528229] Starting dynamic subtest: pipe-A-DP-3
[591.537679] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[591.548705] Starting dynamic subtest: pipe-B-DP-3
[591.558212] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[591.569171] Starting dynamic subtest: pipe-C-DP-3
[591.578207] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[591.589348] Starting dynamic subtest: pipe-D-DP-3
[591.602109] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[591.604090] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[592.010015] [091/134] (433s left) gem_mmap_gtt (basic-small-bo-tiledx)
[592.090296] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[592.183795] [092/134] (433s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[592.383219] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[593.662101] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.278s)
[593.860393] [093/134] (432s left) gem_mmap (short-mmap)
[593.946260] Subtest short-mmap: SKIP (0.000s)
[594.024798] [094/134] (432s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[594.236533] Starting subtest: y-tiled-16bpp-rotate-90
[594.238335] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[594.451036] [095/134] (431s left) gem_exec_fence (basic-busy-all)
[594.542467] Starting subtest: basic-busy-all
[594.699522] Subtest basic-busy-all: SUCCESS (0.156s)
[595.581054] [096/134] (430s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[595.772305] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[595.773215] Starting dynamic subtest: pipe-A-DP-3
[595.776591] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[595.787635] Starting dynamic subtest: pipe-B-DP-3
[595.791143] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[595.801989] Starting dynamic subtest: pipe-C-DP-3
[595.805441] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[595.816205] Starting dynamic subtest: pipe-D-DP-3
[595.819694] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[595.821298] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[596.237824] [097/134] (430s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[596.431317] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[596.433039] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[596.622457] [098/134] (429s left) gem_exec_fence (submit-chain)
[596.830217] Starting subtest: submit-chain
[596.881089] Subtest submit-chain: SUCCESS (0.051s)
[597.621566] [099/134] (428s left) gem_mmap_gtt (basic-small-bo-tiledy)
[597.701290] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[597.766950] [100/134] (428s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[598.061974] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[598.187870] [101/134] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[598.380292] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[598.381985] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[598.538663] [102/134] (428s left) gen9_exec_parse (unaligned-access)
[598.623653] Subtest unaligned-access: SKIP (0.000s)
[598.699130] [103/134] (428s left) kms_properties (get_properties-sanity-atomic)
[598.892303] Starting subtest: get_properties-sanity-atomic
[598.895148] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[599.055380] [104/134] (427s left) i915_query (query-topology-matches-eu-total)
[599.143897] Starting subtest: query-topology-matches-eu-total
[599.144868] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[599.280319] [105/134] (427s left) gem_vm_create (isolation)
[599.367691] Starting subtest: isolation
[599.382357] Subtest isolation: SUCCESS (0.015s)
[599.586467] [106/134] (427s left) kms_vblank (wait-forked)
[599.777822] Starting subtest: wait-forked
[599.780335] Starting dynamic subtest: pipe-A-DP-3
[602.137531] Dynamic subtest pipe-A-DP-3: SUCCESS (2.356s)
[602.165206] Starting dynamic subtest: pipe-D-DP-3
[604.468121] Dynamic subtest pipe-D-DP-3: SUCCESS (2.323s)
[604.469239] Subtest wait-forked: SUCCESS (4.691s)
[604.740509] [107/134] (422s left) gem_mmap_gtt (fault-concurrent)
[604.826529] Subtest fault-concurrent: SKIP (0.000s)
[604.898565] [108/134] (422s left) syncobj_wait (invalid-reset-illegal-handle)
[604.978564] Starting subtest: invalid-reset-illegal-handle
[604.979459] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[605.121632] [109/134] (422s left) gem_exec_fence (basic-await)
[605.368532] Starting subtest: basic-await
[605.369819] Starting dynamic subtest: rcs0
[605.489841] Dynamic subtest rcs0: SUCCESS (0.123s)
[605.503172] Starting dynamic subtest: bcs0
[605.576243] Dynamic subtest bcs0: SUCCESS (0.085s)
[605.593698] Starting dynamic subtest: vcs0
[605.669961] Dynamic subtest vcs0: SUCCESS (0.092s)
[605.685694] Starting dynamic subtest: vcs1
[605.760362] Dynamic subtest vcs1: SUCCESS (0.089s)
[605.776939] Starting dynamic subtest: vecs0
[605.852450] Dynamic subtest vecs0: SUCCESS (0.091s)
[605.867480] Starting dynamic subtest: vecs1
[605.942362] Dynamic subtest vecs1: SUCCESS (0.089s)
[605.957602] Starting dynamic subtest: ccs0
[606.031791] Dynamic subtest ccs0: SUCCESS (0.088s)
[606.032840] Subtest basic-await: SUCCESS (0.667s)
[606.808790] [110/134] (420s left) gem_exec_flush (basic-wb-pro-default)
[606.895407] Subtest basic-wb-pro-default: SKIP (0.000s)
[606.990670] [111/134] (420s left) kms_cursor_crc (cursor-random-64x64)
[607.328503] Starting subtest: cursor-random-64x64
[607.333955] Starting dynamic subtest: pipe-A-DP-3
[611.881937] Dynamic subtest pipe-A-DP-3: SUCCESS (4.548s)
[611.918185] Starting dynamic subtest: pipe-D-DP-3
[616.481316] Dynamic subtest pipe-D-DP-3: SUCCESS (4.573s)
[616.482213] Subtest cursor-random-64x64: SUCCESS (9.152s)
[616.994849] [112/134] (410s left) api_intel_allocator (alloc-simple)
[617.080434] Starting subtest: alloc-simple
[617.109919] Subtest alloc-simple: SUCCESS (0.029s)
[617.287095] [113/134] (410s left) gem_exec_schedule (preempt-user)
[617.379759] Starting subtest: preempt-user
[617.380653] Starting dynamic subtest: rcs0
[617.449986] Dynamic subtest rcs0: SUCCESS (0.070s)
[617.463234] Starting dynamic subtest: bcs0
[617.488597] Dynamic subtest bcs0: SUCCESS (0.038s)
[617.501939] Starting dynamic subtest: vcs0
[617.525869] Dynamic subtest vcs0: SUCCESS (0.036s)
[617.539203] Starting dynamic subtest: vcs1
[617.562900] Dynamic subtest vcs1: SUCCESS (0.036s)
[617.576171] Starting dynamic subtest: vecs0
[617.600135] Dynamic subtest vecs0: SUCCESS (0.036s)
[617.613210] Starting dynamic subtest: vecs1
[617.636639] Dynamic subtest vecs1: SUCCESS (0.035s)
[617.649904] Starting dynamic subtest: ccs0
[617.674044] Dynamic subtest ccs0: SUCCESS (0.036s)
[617.675052] Subtest preempt-user: SUCCESS (0.295s)
[618.174535] [114/134] (409s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[618.369279] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[618.371063] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[618.570910] [115/134] (409s left) kms_plane (plane-panning-bottom-right)
[618.763626] Starting subtest: plane-panning-bottom-right
[618.765999] Starting dynamic subtest: pipe-A
[619.529179] Dynamic subtest pipe-A: SUCCESS (0.763s)
[619.542139] Starting dynamic subtest: pipe-B
[620.183223] Dynamic subtest pipe-B: SUCCESS (0.653s)
[620.184171] Subtest plane-panning-bottom-right: SUCCESS (1.420s)
[620.491394] [116/134] (407s left) drm_mm (drm_mm)
[620.543023] Starting subtest: drm_mm
[620.567559] Starting dynamic subtest: drm_test_mm_init
[620.691154] Dynamic subtest drm_test_mm_init: SUCCESS (0.118s)
[620.702718] Starting dynamic subtest: drm_test_mm_debug
[620.785689] Dynamic subtest drm_test_mm_debug: SUCCESS (0.092s)
[620.832435] Starting dynamic subtest: drm_test_mm_align32
[620.883791] Dynamic subtest drm_test_mm_align32: SUCCESS (0.093s)
[620.924490] Starting dynamic subtest: drm_test_mm_align64
[621.000834] Dynamic subtest drm_test_mm_align64: SUCCESS (0.110s)
[621.042612] Starting dynamic subtest: drm_test_mm_lowest
[621.094095] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.091s)
[621.135580] Starting dynamic subtest: drm_test_mm_highest
[621.201054] Dynamic subtest drm_test_mm_highest: SUCCESS (0.099s)
[621.203080] Subtest drm_mm: SUCCESS (0.656s)
[621.454914] [117/134] (406s left) gem_userptr_blits (coherency-sync)
[621.547718] Starting subtest: coherency-sync
[621.774419] Subtest coherency-sync: SKIP (0.211s)
[621.930167] [118/134] (405s left) gem_userptr_blits (access-control)
[622.080387] Starting subtest: access-control
[622.082216] Subtest access-control: SKIP (0.000s)
[622.287776] [119/134] (405s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[622.597629] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[622.750898] [120/134] (405s left) kms_pm_rpm (fences)
[625.089316] Starting subtest: fences
[625.091994] Subtest fences: SKIP (0.000s)
[625.501928] [121/134] (402s left) gem_close_race (basic-process)
[625.628487] Starting subtest: basic-process
[625.695556] Subtest basic-process: SUCCESS (0.067s)
[625.995974] [122/134] (402s left) kms_vrr (flipline)
[626.185376] Starting subtest: flipline
[626.188035] Subtest flipline: SKIP (0.000s)
[626.342180] [123/134] (401s left) perf_pmu (busy)
[626.414595] Starting subtest: busy
[626.415501] Starting dynamic subtest: rcs0
[627.065239] Dynamic subtest rcs0: SUCCESS (0.650s)
[627.080965] Starting dynamic subtest: bcs0
[627.627438] Dynamic subtest bcs0: SUCCESS (0.561s)
[627.642750] Starting dynamic subtest: vcs0
[628.189795] Dynamic subtest vcs0: SUCCESS (0.560s)
[628.205271] Starting dynamic subtest: vcs1
[628.754907] Dynamic subtest vcs1: SUCCESS (0.560s)
[628.770403] Starting dynamic subtest: vecs0
[629.319876] Dynamic subtest vecs0: SUCCESS (0.560s)
[629.335443] Starting dynamic subtest: vecs1
[629.885752] Dynamic subtest vecs1: SUCCESS (0.561s)
[629.901191] Starting dynamic subtest: ccs0
[630.449751] Dynamic subtest ccs0: SUCCESS (0.559s)
[630.454437] Subtest busy: SUCCESS (4.037s)
[630.605192] [124/134] (397s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[630.803250] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[630.804876] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[631.014567] [125/134] (397s left) gem_render_linear_blits (basic)
[631.100379] Starting subtest: basic
[631.180079] Subtest basic: SUCCESS (0.080s)
[631.278445] [126/134] (397s left) kms_busy (extended-modeset-hang-newfb)
[631.474572] Starting subtest: extended-modeset-hang-newfb
[631.476909] Starting dynamic subtest: pipe-A
[647.232611] Dynamic subtest pipe-A: SUCCESS (15.755s)
[647.260515] Starting dynamic subtest: pipe-D
[662.998301] Dynamic subtest pipe-D: SUCCESS (15.756s)
[662.999433] Subtest extended-modeset-hang-newfb: SUCCESS (31.523s)
[663.354034] [127/134] (365s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[663.540541] Starting subtest: modeset-atomic-cursor-hotspot
[663.542294] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[663.695703] [128/134] (364s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[663.903140] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[663.905141] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[664.101296] [129/134] (364s left) gem_flink_basic (basic)
[664.187639] Starting subtest: basic
[664.188687] Subtest basic: SUCCESS (0.000s)
[664.382565] [130/134] (364s left) syncobj_timeline (wait-all-snapshot)
[664.470517] Starting subtest: wait-all-snapshot
[664.554183] Subtest wait-all-snapshot: SUCCESS (0.082s)
[664.736094] [131/134] (364s left) kms_getfb (getfb2-handle-not-fb)
[664.928430] Starting subtest: getfb2-handle-not-fb
[664.929347] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[665.151434] [132/134] (363s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[665.351591] Starting subtest: 4-tiled-8bpp-rotate-0
[666.947747] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.595s)
[667.202200] [133/134] (361s left) syncobj_timeline (etime-single-wait-submitted)
[667.286531] Starting subtest: etime-single-wait-submitted
[667.390191] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[667.516800] [134/134] (361s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[667.711129] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[667.712913] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[667.916591] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: kms_rmfb
results: parsing output: 3/ for test: fbdev
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_tiled_display
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_ctx_isolation
results: parsing output: 16/ for test: kms_properties
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: gem_ppgtt
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_pm_dc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_pipe_crc_basic
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: syncobj_eventfd
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exercise_blt
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_colorop
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_madvise
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_edid
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_mmap
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_colorop
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: gem_vm_create
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: drm_mm
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_colorop
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_render_linear_blits
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_flink_basic
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_timeline
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.