[27.974162] Initializing watchdogs [27.974201] /dev/watchdog0 [27.978564] [001/131] (960s left) gem_exec_schedule (smoketest) [28.144238] Starting subtest: smoketest [28.145406] Starting dynamic subtest: rcs0 [33.586213] Dynamic subtest rcs0: SUCCESS (5.408s) [33.590312] Starting dynamic subtest: bcs0 [38.958379] Dynamic subtest bcs0: SUCCESS (5.397s) [38.962871] Starting dynamic subtest: vcs0 [44.298189] Dynamic subtest vcs0: SUCCESS (5.402s) [44.302636] Starting dynamic subtest: vcs1 [49.610763] Dynamic subtest vcs1: SUCCESS (5.398s) [49.614974] Starting dynamic subtest: vecs0 [54.971416] Dynamic subtest vecs0: SUCCESS (5.402s) [54.972190] Subtest smoketest: SUCCESS (27.007s) [55.108654] [002/131] (933s left) kms_flip (flip-vs-fences-interruptible) [55.204932] Starting subtest: flip-vs-fences-interruptible [55.207834] Starting dynamic subtest: A-HDMI-A1 [62.905377] Dynamic subtest A-HDMI-A1: SUCCESS (7.701s) [62.909118] Starting dynamic subtest: B-HDMI-A1 [70.538471] Dynamic subtest B-HDMI-A1: SUCCESS (7.642s) [70.542368] Starting dynamic subtest: C-HDMI-A1 [78.197708] Dynamic subtest C-HDMI-A1: SUCCESS (7.649s) [78.201431] Starting dynamic subtest: D-HDMI-A1 [85.823146] Dynamic subtest D-HDMI-A1: SUCCESS (7.631s) [85.824256] Subtest flip-vs-fences-interruptible: SUCCESS (30.629s) [85.941949] [003/131] (902s left) gem_softpin (allocator-basic) [85.976019] Starting subtest: allocator-basic [86.031183] Subtest allocator-basic: SUCCESS (0.055s) [86.132102] [004/131] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [86.231496] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [86.232915] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [86.286718] [005/131] (902s left) gem_exercise_blt (fast-copy) [86.316192] Starting subtest: fast-copy [86.317042] Starting dynamic subtest: linear-smem-smem [86.337043] Dynamic subtest linear-smem-smem: SUCCESS (0.021s) [86.341673] Starting dynamic subtest: ymajor-smem-smem [86.356279] Dynamic subtest ymajor-smem-smem: SUCCESS (0.019s) [86.359820] Starting dynamic subtest: tile4-smem-smem [86.372780] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [86.376297] Starting dynamic subtest: tile64-smem-smem [86.389447] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s) [86.390254] Subtest fast-copy: SUCCESS (0.073s) [86.474827] [006/131] (901s left) kms_big_fb (linear-16bpp-rotate-0) [86.572831] Starting subtest: linear-16bpp-rotate-0 [87.546137] Subtest linear-16bpp-rotate-0: SUCCESS (0.973s) [87.657424] [007/131] (900s left) gem_bad_reloc (negative-reloc) [87.690113] Starting subtest: negative-reloc [87.692265] Subtest negative-reloc: SUCCESS (0.000s) [87.783815] [008/131] (900s left) kms_big_fb (4-tiled-32bpp-rotate-180) [87.883025] Starting subtest: 4-tiled-32bpp-rotate-180 [87.884482] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [87.924109] [009/131] (900s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [88.008584] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [88.009324] Starting dynamic subtest: pipe-A-valid-mode [88.062054] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s) [88.063503] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.053s) [88.132487] [010/131] (900s left) api_intel_allocator (reloc-allocator) [88.163818] Starting subtest: reloc-allocator [88.164595] Starting dynamic subtest: basic [88.165343] Dynamic subtest basic: SUCCESS (0.001s) [88.170447] Starting dynamic subtest: parallel-one [88.171126] Dynamic subtest parallel-one: SUCCESS (0.004s) [88.174976] Starting dynamic subtest: print [88.175667] Dynamic subtest print: SUCCESS (0.000s) [88.179272] Starting dynamic subtest: reuse [88.179978] Dynamic subtest reuse: SUCCESS (0.000s) [88.183464] Starting dynamic subtest: fork-reopen-allocator [88.184191] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [88.185013] Subtest reloc-allocator: SUCCESS (0.016s) [88.255804] [011/131] (900s left) gen3_mixed_blits [88.307719] [012/131] (900s left) gem_exec_params (rel-constants-invalid-ring) [88.338762] Starting subtest: rel-constants-invalid-ring [88.339548] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [88.404647] [013/131] (900s left) kms_addfb_basic (too-high) [88.488856] Starting subtest: too-high [88.489607] Subtest too-high: SUCCESS (0.000s) [88.553819] [014/131] (899s left) syncobj_timeline (invalid-query-zero-handles) [88.586876] Starting subtest: invalid-query-zero-handles [88.587617] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [88.628523] [015/131] (899s left) kms_chamelium_hpd (vga-hpd-after-suspend) [88.752228] Subtest vga-hpd-after-suspend: SKIP (0.000s) [88.804692] [016/131] (899s left) core_setmaster (master-drop-set-shared-fd) [89.365736] Starting subtest: master-drop-set-shared-fd [89.381468] Subtest master-drop-set-shared-fd: SUCCESS (0.016s) [89.394731] [017/131] (899s left) kms_plane_alpha_blend (alpha-7efc) [89.476825] Starting subtest: alpha-7efc [89.544143] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.845432] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.301s) [89.867238] Starting dynamic subtest: pipe-D-HDMI-A-1 [90.261411] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.398s) [90.262200] Subtest alpha-7efc: SUCCESS (0.786s) [90.354023] [018/131] (898s left) gem_mmap_wc (close) [90.385967] Starting subtest: close [90.388870] Subtest close: SUCCESS (0.003s) [90.440734] [019/131] (898s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [90.671808] Starting subtest: parallel-dmabuf-import-out-fence [91.433151] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.761s) [91.461639] [020/131] (897s left) gem_exec_big (single) [91.489847] Starting subtest: single [93.801267] Subtest single: SUCCESS (2.303s) [93.955329] [021/131] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [94.079914] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [94.081413] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [94.144136] [022/131] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [94.235617] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [94.237349] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [94.289896] [023/131] (894s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [94.374631] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [94.375382] Starting dynamic subtest: pipe-A-HDMI-A-1 [94.381473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [94.385642] Starting dynamic subtest: pipe-B-HDMI-A-1 [94.392222] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [94.398044] Starting dynamic subtest: pipe-C-HDMI-A-1 [94.404748] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [94.409818] Starting dynamic subtest: pipe-D-HDMI-A-1 [94.416719] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [94.417603] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.005s) [94.585058] [024/131] (893s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [94.685965] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [94.687452] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [94.747574] [025/131] (893s left) gem_mmap_gtt (medium-copy-odd) [94.780760] Starting subtest: medium-copy-odd [98.266960] Subtest medium-copy-odd: SUCCESS (3.486s) [98.307677] [026/131] (890s left) kms_atomic_transition (plane-toggle-modeset-transition) [98.428612] Starting subtest: plane-toggle-modeset-transition [98.430245] Starting dynamic subtest: pipe-A-HDMI-A-1 [99.345815] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.916s) [99.351703] Starting dynamic subtest: pipe-B-HDMI-A-1 [100.058589] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.711s) [100.059331] Subtest plane-toggle-modeset-transition: SUCCESS (1.631s) [100.186558] [027/131] (888s left) kms_sequence (queue-busy) [100.283838] Starting subtest: queue-busy [100.285617] Starting dynamic subtest: pipe-A-HDMI-A-1 [101.573642] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.289s) [101.578887] Starting dynamic subtest: pipe-B-HDMI-A-1 [102.837589] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.263s) [102.843037] Starting dynamic subtest: pipe-C-HDMI-A-1 [104.089042] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.250s) [104.094445] Starting dynamic subtest: pipe-D-HDMI-A-1 [105.343617] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.253s) [105.344383] Subtest queue-busy: SUCCESS (5.060s) [105.412648] [028/131] (883s left) syncobj_wait (multi-wait-submitted-signaled) [105.444436] Starting subtest: multi-wait-submitted-signaled [105.445190] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [105.485491] [029/131] (883s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [105.517597] Starting subtest: multi-wait-for-submit-unsubmitted [105.623740] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [105.673169] [030/131] (882s left) gem_mmap_gtt (basic) [105.710145] Starting subtest: basic [105.711058] Subtest basic: SUCCESS (0.000s) [105.740436] [031/131] (882s left) i915_suspend (fence-restore-untiled) [105.775732] Starting subtest: fence-restore-untiled [126.589953] Subtest fence-restore-untiled: SUCCESS (5.221s) [129.666204] [032/131] (877s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [129.755965] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [129.756904] Starting dynamic subtest: pipe-A [129.883504] Dynamic subtest pipe-A: SUCCESS (0.128s) [129.889945] Starting dynamic subtest: pipe-B [130.022681] Dynamic subtest pipe-B: SUCCESS (0.141s) [130.028973] Starting dynamic subtest: pipe-C [130.152427] Dynamic subtest pipe-C: SUCCESS (0.133s) [130.158461] Starting dynamic subtest: pipe-D [130.289171] Dynamic subtest pipe-D: SUCCESS (0.140s) [130.290428] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.543s) [130.422846] [033/131] (876s left) kms_prop_blob (invalid-get-prop-any) [130.446726] Starting subtest: invalid-get-prop-any [130.447541] Subtest invalid-get-prop-any: SUCCESS (0.000s) [130.480608] [034/131] (876s left) kms_psr (pr-primary-blt) [130.560299] Subtest pr-primary-blt: SKIP (0.000s) [130.580065] [035/131] (876s left) kms_psr (psr2-primary-mmap-cpu) [130.657260] Subtest psr2-primary-mmap-cpu: SKIP (0.000s) [130.679028] [036/131] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [130.760234] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [130.761526] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [130.821687] [037/131] (876s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [130.915360] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [131.150291] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.241s) [131.272423] [038/131] (876s left) kms_psr (psr-primary-mmap-gtt) [131.362262] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [131.376664] [039/131] (875s left) perf_pmu (busy-accuracy-98) [131.402314] Starting subtest: busy-accuracy-98 [131.403001] Starting dynamic subtest: rcs0 [134.425042] Dynamic subtest rcs0: SUCCESS (3.077s) [134.433434] Starting dynamic subtest: bcs0 [137.447351] Dynamic subtest bcs0: SUCCESS (3.062s) [137.455584] Starting dynamic subtest: vcs0 [140.468561] Dynamic subtest vcs0: SUCCESS (3.047s) [140.477187] Starting dynamic subtest: vcs1 [143.489443] Dynamic subtest vcs1: SUCCESS (3.039s) [143.497574] Starting dynamic subtest: vecs0 [146.509283] Dynamic subtest vecs0: SUCCESS (3.030s) [146.510378] Subtest busy-accuracy-98: SUCCESS (15.256s) [146.560386] [040/131] (860s left) gem_ppgtt (flink-and-close-vma-leak) [146.598335] Starting subtest: flink-and-close-vma-leak [146.601601] Subtest flink-and-close-vma-leak: SUCCESS (0.003s) [146.688586] [041/131] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [146.772869] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [146.774383] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [146.858515] [042/131] (860s left) gem_exec_alignment (forked) [146.894871] Starting subtest: forked [191.192895] Subtest forked: SUCCESS (44.318s) [191.265946] [043/131] (815s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [191.399490] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [191.409589] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [191.449040] [044/131] (815s left) kms_cursor_crc (cursor-random-64x64) [191.539436] Starting subtest: cursor-random-64x64 [191.544582] Starting dynamic subtest: pipe-A-HDMI-A-1 [193.459420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.916s) [193.488826] Starting dynamic subtest: pipe-D-HDMI-A-1 [195.357394] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.876s) [195.358189] Subtest cursor-random-64x64: SUCCESS (3.820s) [195.462413] [045/131] (811s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [195.545894] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [195.546699] Starting dynamic subtest: pipe-A-valid-mode [196.350996] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.804s) [196.351712] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.805s) [196.485784] [046/131] (810s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [196.565592] Starting subtest: basic-flip-before-cursor-legacy [197.088313] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.523s) [197.179302] [047/131] (810s left) gem_reg_read (bad-register) [197.202707] Starting subtest: bad-register [197.203558] Subtest bad-register: SUCCESS (0.000s) [197.243560] [048/131] (810s left) kms_flip (2x-flip-vs-suspend-interruptible) [197.329512] Starting subtest: 2x-flip-vs-suspend-interruptible [197.340958] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s) [197.386137] [049/131] (809s left) kms_cursor_edge_walk (256x256-top-edge) [197.464789] Starting subtest: 256x256-top-edge [197.465623] Starting dynamic subtest: pipe-A-HDMI-A-1 [199.198181] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.733s) [199.203461] Starting dynamic subtest: pipe-D-HDMI-A-1 [200.858767] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.660s) [200.859546] Subtest 256x256-top-edge: SUCCESS (3.395s) [200.929091] [050/131] (806s left) kms_flip (2x-nonexisting-fb-interruptible) [201.011934] Starting subtest: 2x-nonexisting-fb-interruptible [201.023261] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [201.062460] [051/131] (806s left) syncobj_eventfd (invalid-bad-flags) [201.094624] Starting subtest: invalid-bad-flags [201.095339] Subtest invalid-bad-flags: SUCCESS (0.000s) [201.129855] [052/131] (806s left) prime_vgem (basic-fence-read) [201.230283] Starting subtest: basic-fence-read [201.268933] Subtest basic-fence-read: SUCCESS (0.039s) [201.323491] [053/131] (806s left) kms_plane (plane-position-hole-dpms) [201.409601] Starting subtest: plane-position-hole-dpms [201.608190] Starting dynamic subtest: pipe-A-plane-1 [201.920171] Dynamic subtest pipe-A-plane-1: SUCCESS (0.312s) [201.925694] Starting dynamic subtest: pipe-A-plane-2 [202.232977] Dynamic subtest pipe-A-plane-2: SUCCESS (0.313s) [202.239227] Starting dynamic subtest: pipe-A-plane-3 [202.554128] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s) [202.560312] Starting dynamic subtest: pipe-A-plane-4 [202.866165] Dynamic subtest pipe-A-plane-4: SUCCESS (0.312s) [202.873365] Starting dynamic subtest: pipe-A-plane-5 [203.178150] Dynamic subtest pipe-A-plane-5: SUCCESS (0.312s) [203.185360] Starting dynamic subtest: pipe-A-plane-6 [203.473604] Dynamic subtest pipe-A-plane-6: SUCCESS (0.295s) [203.480812] Starting dynamic subtest: pipe-A-plane-7 [203.481596] Dynamic subtest pipe-A-plane-7: SUCCESS (0.004s) [203.655293] Starting dynamic subtest: pipe-B-plane-1 [203.946267] Dynamic subtest pipe-B-plane-1: SUCCESS (0.297s) [203.953818] Starting dynamic subtest: pipe-B-plane-2 [204.240297] Dynamic subtest pipe-B-plane-2: SUCCESS (0.295s) [204.247407] Starting dynamic subtest: pipe-B-plane-3 [204.542701] Dynamic subtest pipe-B-plane-3: SUCCESS (0.302s) [204.548236] Starting dynamic subtest: pipe-B-plane-4 [204.840311] Dynamic subtest pipe-B-plane-4: SUCCESS (0.298s) [204.847240] Starting dynamic subtest: pipe-B-plane-5 [205.144439] Dynamic subtest pipe-B-plane-5: SUCCESS (0.304s) [205.151336] Starting dynamic subtest: pipe-B-plane-6 [205.431579] Dynamic subtest pipe-B-plane-6: SUCCESS (0.287s) [205.440495] Starting dynamic subtest: pipe-B-plane-7 [205.441273] Dynamic subtest pipe-B-plane-7: SUCCESS (0.005s) [205.441997] Subtest plane-position-hole-dpms: SUCCESS (4.029s) [205.528271] [054/131] (801s left) gem_ctx_shared (exec-shared-gtt) [205.561519] Starting subtest: exec-shared-gtt [205.562377] Starting dynamic subtest: rcs0 [205.564899] Dynamic subtest rcs0: SUCCESS (0.003s) [205.570792] Starting dynamic subtest: bcs0 [205.571514] Dynamic subtest bcs0: SUCCESS (0.002s) [205.577698] Starting dynamic subtest: vcs0 [205.578390] Dynamic subtest vcs0: SUCCESS (0.002s) [205.583606] Starting dynamic subtest: vcs1 [205.584299] Dynamic subtest vcs1: SUCCESS (0.002s) [205.589556] Starting dynamic subtest: vecs0 [205.590323] Dynamic subtest vecs0: SUCCESS (0.002s) [205.591045] Subtest exec-shared-gtt: SUCCESS (0.014s) [205.729295] [055/131] (801s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [205.828441] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [205.839800] [056/131] (801s left) gem_ctx_exec (basic-close-race) [205.865682] Starting subtest: basic-close-race [211.401674] Subtest basic-close-race: SUCCESS (5.504s) [211.465159] [057/131] (795s left) kms_writeback (writeback-fb-id-xrgb2101010) [211.557448] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [211.583728] [058/131] (795s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [211.660610] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [211.661345] Starting dynamic subtest: pipe-A-HDMI-A-1 [228.715584] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.193s) [228.721505] Starting dynamic subtest: pipe-B-HDMI-A-1 [244.723433] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.196s) [244.730443] Starting dynamic subtest: pipe-C-HDMI-A-1 [260.716065] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.175s) [260.721662] Starting dynamic subtest: pipe-D-HDMI-A-1 [276.724530] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.200s) [276.725352] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (4.769s) [282.889431] [059/131] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [282.988171] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [282.989701] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [283.037182] [060/131] (790s left) kms_flip (flip-vs-expired-vblank-interruptible) [283.117872] Starting subtest: flip-vs-expired-vblank-interruptible [283.120887] Starting dynamic subtest: A-HDMI-A1 [290.780161] Dynamic subtest A-HDMI-A1: SUCCESS (7.773s) [290.785828] Starting dynamic subtest: B-HDMI-A1 [298.414849] Dynamic subtest B-HDMI-A1: SUCCESS (7.673s) [298.421639] Starting dynamic subtest: C-HDMI-A1 [306.015773] Dynamic subtest C-HDMI-A1: SUCCESS (7.646s) [306.026391] Starting dynamic subtest: D-HDMI-A1 [313.669674] Dynamic subtest D-HDMI-A1: SUCCESS (7.637s) [313.670901] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.738s) [313.803567] [061/131] (759s left) i915_pm_freq_api (freq-suspend) [313.834035] Subtest freq-suspend: SKIP (0.000s) [313.856715] [062/131] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [313.942306] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [313.943753] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [314.014906] [063/131] (759s left) device_reset (unbind-cold-reset-rebind) [314.058644] Starting subtest: unbind-cold-reset-rebind [314.060188] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [314.104235] [064/131] (759s left) gem_mmap (bad-size) [314.132528] Starting subtest: bad-size [314.133347] Subtest bad-size: SUCCESS (0.000s) [314.191997] [065/131] (759s left) kms_rotation_crc (bad-pixel-format) [314.278520] Starting subtest: bad-pixel-format [315.241741] Subtest bad-pixel-format: SUCCESS (0.964s) [315.406486] [066/131] (758s left) perf_pmu (module-unload) [315.441566] Starting subtest: module-unload [349.246631] Subtest module-unload: SUCCESS (33.796s) [349.258279] [067/131] (724s left) gem_exec_fence (syncobj-signal) [350.052836] Starting subtest: syncobj-signal [350.055477] Subtest syncobj-signal: SUCCESS (0.003s) [350.309473] [068/131] (723s left) syncobj_timeline (wait-all-complex) [350.347082] Starting subtest: wait-all-complex [350.571078] Subtest wait-all-complex: SUCCESS (0.215s) [350.610065] [069/131] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [350.695692] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [350.697205] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [350.745448] [070/131] (722s left) gem_mmap_offset (pf-nonblock) [350.781356] Starting subtest: pf-nonblock [350.786119] Subtest pf-nonblock: SUCCESS (0.004s) [350.862477] [071/131] (722s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [350.952839] Starting subtest: flip-vs-cursor-busy-crc-atomic [351.377807] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.425s) [351.497343] [072/131] (722s left) syncobj_timeline (invalid-signal-zero-handles) [351.523096] Starting subtest: invalid-signal-zero-handles [351.524004] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [351.569852] [073/131] (722s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [351.651993] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [351.652741] Starting dynamic subtest: pipe-A-HDMI-A-1 [351.660334] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [351.666916] Starting dynamic subtest: pipe-B-HDMI-A-1 [351.674351] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [351.680693] Starting dynamic subtest: pipe-C-HDMI-A-1 [351.687996] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [351.694274] Starting dynamic subtest: pipe-D-HDMI-A-1 [351.701899] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [351.703711] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [351.841978] [074/131] (721s left) kms_frontbuffer_tracking (basic) [351.933129] Starting subtest: basic [353.432829] Subtest basic: SUCCESS (1.501s) [353.525997] [075/131] (720s left) kms_cursor_crc (cursor-offscreen-256x256) [353.613189] Starting subtest: cursor-offscreen-256x256 [353.617620] Starting dynamic subtest: pipe-A-HDMI-A-1 [354.846141] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.229s) [354.874066] Starting dynamic subtest: pipe-D-HDMI-A-1 [356.071421] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.202s) [356.072141] Subtest cursor-offscreen-256x256: SUCCESS (2.459s) [356.179416] [076/131] (717s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [356.264103] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [356.265564] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [356.314277] [077/131] (717s left) i915_pm_rps (min-max-config-idle) [356.352362] Starting subtest: min-max-config-idle [356.489550] Subtest min-max-config-idle: SUCCESS (0.137s) [356.581198] [078/131] (717s left) syncobj_wait (wait-any-snapshot) [356.618102] Starting subtest: wait-any-snapshot [356.700202] Subtest wait-any-snapshot: SUCCESS (0.082s) [356.744313] [079/131] (717s left) kms_content_protection (dp-mst-type-1) [356.828528] Starting subtest: dp-mst-type-1 [356.830111] Subtest dp-mst-type-1: SKIP (0.000s) [356.893862] [080/131] (716s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [356.985573] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [356.987373] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [357.045310] [081/131] (716s left) syncobj_timeline (signal) [357.076773] Starting subtest: signal [357.077644] Subtest signal: SUCCESS (0.000s) [357.120971] [082/131] (716s left) gem_mmap_wc (read-write) [357.156288] Starting subtest: read-write [357.158084] Subtest read-write: SUCCESS (0.002s) [357.219043] [083/131] (716s left) kms_vblank (invalid) [357.310870] Starting subtest: invalid [357.311684] Starting dynamic subtest: pipe-A-HDMI-A-1 [357.460607] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.149s) [357.461355] Subtest invalid: SUCCESS (0.151s) [357.552199] [084/131] (716s left) gem_userptr_blits (dmabuf-sync) [357.584049] Starting subtest: dmabuf-sync [357.586560] Subtest dmabuf-sync: SKIP (0.002s) [357.689553] [085/131] (716s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [357.781863] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [358.783306] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (1.002s) [358.880962] [086/131] (715s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [358.970276] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [359.531480] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.561s) [359.636425] [087/131] (714s left) gem_mmap_offset (mmap-unmap) [359.668866] Starting subtest: mmap-unmap [359.669728] Starting dynamic subtest: smem0 [379.948014] Dynamic subtest smem0: SUCCESS (20.252s) [379.949035] Subtest mmap-unmap: SUCCESS (20.252s) [379.990146] [088/131] (693s left) kms_legacy_colorkey (invalid-plane) [380.078983] Starting subtest: invalid-plane [380.079774] Starting dynamic subtest: zero-id [380.080582] Dynamic subtest zero-id: SUCCESS (0.000s) [380.086380] Starting dynamic subtest: outrange-id [380.087168] Dynamic subtest outrange-id: SUCCESS (0.000s) [380.087965] Subtest invalid-plane: SUCCESS (0.001s) [380.114888] [089/131] (693s left) gem_ctx_param (vm) [380.147217] Starting subtest: vm [380.162123] Subtest vm: SUCCESS (0.015s) [380.271239] [090/131] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [380.363908] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [380.365494] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [380.421078] [091/131] (693s left) gem_spin_batch (spin-all) [380.461614] Starting subtest: spin-all [380.469499] Subtest spin-all: SUCCESS (0.008s) [380.628257] [092/131] (693s left) kms_psr (fbc-pr-primary-render) [380.718474] Subtest fbc-pr-primary-render: SKIP (0.000s) [380.744017] [093/131] (693s left) kms_flip (flip-vs-modeset-vs-hang) [380.821571] Starting subtest: flip-vs-modeset-vs-hang [380.822350] Starting dynamic subtest: A-HDMI-A1 [408.543408] Dynamic subtest A-HDMI-A1: SUCCESS (27.708s) [408.548852] Starting dynamic subtest: D-HDMI-A1 [436.703702] Dynamic subtest D-HDMI-A1: SUCCESS (28.161s) [436.704940] Subtest flip-vs-modeset-vs-hang: SUCCESS (55.873s) [436.834725] [094/131] (637s left) kms_big_fb (4-tiled-8bpp-rotate-0) [436.919811] Starting subtest: 4-tiled-8bpp-rotate-0 [436.921300] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [436.980412] [095/131] (637s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [437.070731] Starting subtest: psr-shrfb-scaledprimary [437.072227] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [437.153555] [096/131] (636s left) kms_pm_rpm (modeset-lpsp) [438.548233] Starting subtest: modeset-lpsp [439.839139] Subtest modeset-lpsp: SUCCESS (1.290s) [439.928495] [097/131] (634s left) kms_getfb (getfb-handle-closed) [439.955439] Starting subtest: getfb-handle-closed [439.956275] Subtest getfb-handle-closed: SUCCESS (0.000s) [440.014294] [098/131] (634s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [440.097873] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [440.098690] Starting dynamic subtest: pipe-A-HDMI-A-1 [440.106677] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [440.112476] Starting dynamic subtest: pipe-B-HDMI-A-1 [440.120773] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [440.126428] Starting dynamic subtest: pipe-C-HDMI-A-1 [440.134132] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [440.139917] Starting dynamic subtest: pipe-D-HDMI-A-1 [440.148020] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [440.149661] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s) [440.287090] [099/131] (633s left) kms_psr2_su (frontbuffer-xrgb8888) [440.312027] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [440.337198] [100/131] (633s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [440.367155] Starting subtest: yf-tiled-to-vebox-x-tiled [440.367962] Starting dynamic subtest: smem [440.461148] Dynamic subtest smem: SUCCESS (0.094s) [440.461915] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.094s) [440.614330] [101/131] (633s left) gem_render_copy_redux (flink-interruptible) [440.652786] Starting subtest: flink-interruptible [441.551993] Subtest flink-interruptible: SUCCESS (0.899s) [441.659411] [102/131] (632s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [441.754926] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [441.990824] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.236s) [442.097017] [103/131] (632s left) gem_workarounds (suspend-resume) [442.133891] Starting subtest: suspend-resume [458.635103] Subtest suspend-resume: SUCCESS (1.052s) [466.751446] [104/131] (630s left) kms_invalid_mode (clock-too-high) [466.837302] Starting subtest: clock-too-high [466.837997] Starting dynamic subtest: pipe-A-HDMI-A-1 [466.889754] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s) [466.897566] Starting dynamic subtest: pipe-B-HDMI-A-1 [466.898342] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.006s) [466.906634] Starting dynamic subtest: pipe-C-HDMI-A-1 [466.907682] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.006s) [466.915352] Starting dynamic subtest: pipe-D-HDMI-A-1 [466.916226] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.007s) [466.917073] Subtest clock-too-high: SUCCESS (0.076s) [467.014966] [105/131] (630s left) syncobj_wait (multi-wait-all-for-submit-signaled) [467.041001] Starting subtest: multi-wait-all-for-submit-signaled [467.041771] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [467.079428] [106/131] (630s left) kms_busy (extended-pageflip-hang-oldfb) [467.161606] Starting subtest: extended-pageflip-hang-oldfb [467.163215] Starting dynamic subtest: pipe-A [467.281043] Dynamic subtest pipe-A: SUCCESS (0.121s) [467.290899] Starting dynamic subtest: pipe-D [467.422087] Dynamic subtest pipe-D: SUCCESS (0.140s) [467.422830] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.268s) [467.502626] [107/131] (630s left) gen9_exec_parse (bb-large) [467.529516] Subtest bb-large: SKIP (0.000s) [467.552636] [108/131] (630s left) gem_mmap_gtt (basic-small-copy-xy) [467.576652] Starting subtest: basic-small-copy-XY [470.166563] Subtest basic-small-copy-XY: SUCCESS (2.648s) [470.203212] [109/131] (627s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [470.268385] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [470.375163] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [470.420582] [110/131] (627s left) gem_render_copy (linear-to-vebox-yf-tiled) [470.450666] Starting subtest: linear-to-vebox-yf-tiled [470.451496] Starting dynamic subtest: smem [470.520016] Dynamic subtest smem: SUCCESS (0.070s) [470.520816] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.071s) [470.677841] [111/131] (627s left) kms_psr (fbc-psr2-primary-render) [470.766834] Subtest fbc-psr2-primary-render: SKIP (0.000s) [470.785093] [112/131] (626s left) kms_flip (2x-dpms-vs-vblank-race) [470.862522] Starting subtest: 2x-dpms-vs-vblank-race [470.872589] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [470.910430] [113/131] (626s left) kms_chamelium_audio (dp-audio-edid) [471.044600] Subtest dp-audio-edid: SKIP (0.000s) [471.104023] [114/131] (626s left) gem_exec_store (cachelines) [471.133758] Starting subtest: cachelines [471.134567] Starting dynamic subtest: rcs0 [471.210529] Dynamic subtest rcs0: SUCCESS (0.077s) [471.226037] Starting dynamic subtest: bcs0 [471.258535] Dynamic subtest bcs0: SUCCESS (0.048s) [471.273056] Starting dynamic subtest: vcs0 [471.299605] Dynamic subtest vcs0: SUCCESS (0.040s) [471.314116] Starting dynamic subtest: vcs1 [471.339540] Dynamic subtest vcs1: SUCCESS (0.040s) [471.353613] Starting dynamic subtest: vecs0 [471.377515] Dynamic subtest vecs0: SUCCESS (0.037s) [471.378722] Subtest cachelines: SUCCESS (0.248s) [471.538650] [115/131] (626s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [471.624537] Starting subtest: fbc-dirtyfb-ioctl [471.625203] Starting dynamic subtest: A-HDMI-A-1 [472.817016] Dynamic subtest A-HDMI-A-1: SUCCESS (1.208s) [472.817758] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.210s) [472.890533] [116/131] (624s left) drm_mm (drm_mm) [472.921297] Starting subtest: drm_mm [472.925480] Starting dynamic subtest: drm_test_mm_init [473.012113] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s) [473.027288] Starting dynamic subtest: drm_test_mm_debug [473.081394] Dynamic subtest drm_test_mm_debug: SUCCESS (0.068s) [473.096572] Starting dynamic subtest: drm_test_mm_align32 [473.164831] Dynamic subtest drm_test_mm_align32: SUCCESS (0.083s) [473.179640] Starting dynamic subtest: drm_test_mm_align64 [473.259852] Dynamic subtest drm_test_mm_align64: SUCCESS (0.094s) [473.274903] Starting dynamic subtest: drm_test_mm_lowest [473.340483] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.079s) [473.355728] Starting dynamic subtest: drm_test_mm_highest [473.405915] Dynamic subtest drm_test_mm_highest: SUCCESS (0.064s) [473.406942] Subtest drm_mm: SUCCESS (0.489s) [473.532547] [117/131] (624s left) perf (invalid-create-userspace-config) [473.612635] Starting subtest: invalid-create-userspace-config [473.613353] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [473.631725] [118/131] (624s left) kms_chamelium_frames (dp-frame-dump) [473.760752] Subtest dp-frame-dump: SKIP (0.000s) [473.830069] [119/131] (623s left) perf (create-destroy-userspace-config) [473.887805] Starting subtest: create-destroy-userspace-config [473.902121] Subtest create-destroy-userspace-config: SUCCESS (0.013s) [473.922194] [120/131] (623s left) gem_exec_schedule (in-order) [473.953211] Starting subtest: in-order [473.953992] Starting dynamic subtest: rcs0 [474.003466] Dynamic subtest rcs0: SUCCESS (0.050s) [474.014196] Starting dynamic subtest: bcs0 [474.059956] Dynamic subtest bcs0: SUCCESS (0.056s) [474.073202] Starting dynamic subtest: vcs0 [474.117183] Dynamic subtest vcs0: SUCCESS (0.057s) [474.129412] Starting dynamic subtest: vcs1 [474.172679] Dynamic subtest vcs1: SUCCESS (0.055s) [474.184238] Starting dynamic subtest: vecs0 [474.234783] Dynamic subtest vecs0: SUCCESS (0.062s) [474.236414] Subtest in-order: SUCCESS (0.285s) [474.506260] [121/131] (623s left) kms_getfb (getfb2-handle-zero) [474.538929] Starting subtest: getfb2-handle-zero [474.539743] Subtest getfb2-handle-zero: SUCCESS (0.000s) [474.586418] [122/131] (623s left) gem_exec_fence (syncobj-timeline-chain-engines) [475.009575] Starting subtest: syncobj-timeline-chain-engines [475.059326] Subtest syncobj-timeline-chain-engines: SUCCESS (0.059s) [475.211234] [123/131] (622s left) prime_mmap (test_reprime) [475.238007] Starting subtest: test_reprime [475.238724] Starting dynamic subtest: test_reprime-smem [475.239566] Dynamic subtest test_reprime-smem: SUCCESS (0.001s) [475.240344] Subtest test_reprime: SUCCESS (0.002s) [475.306334] [124/131] (622s left) gem_mmap_gtt (big-bo-tiledy) [475.343916] Starting subtest: big-bo-tiledY [475.408713] Subtest big-bo-tiledY: SUCCESS (0.067s) [475.496992] [125/131] (622s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [475.607804] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [475.608615] Starting dynamic subtest: pipe-A [475.725604] Dynamic subtest pipe-A: SUCCESS (0.119s) [475.731879] Starting dynamic subtest: pipe-B [475.857712] Dynamic subtest pipe-B: SUCCESS (0.133s) [475.865084] Starting dynamic subtest: pipe-C [475.989883] Dynamic subtest pipe-C: SUCCESS (0.133s) [475.996328] Starting dynamic subtest: pipe-D [476.131053] Dynamic subtest pipe-D: SUCCESS (0.142s) [476.132306] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.528s) [476.277393] [126/131] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [476.364767] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [476.366230] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [476.423137] [127/131] (621s left) kms_tv_load_detect (load-detect) [476.455815] Subtest load-detect: SKIP (0.000s) [476.477970] [128/131] (621s left) gem_exec_reloc (basic-gtt-noreloc) [476.503870] Starting subtest: basic-gtt-noreloc [476.507930] Subtest basic-gtt-noreloc: SUCCESS (0.004s) [476.598372] [129/131] (621s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [476.678845] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [476.690355] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [476.732635] [130/131] (621s left) sysfs_timeslice_duration (invalid) [476.763533] Starting subtest: invalid [476.764347] Starting dynamic subtest: vecs0 [476.765096] Dynamic subtest vecs0: SUCCESS (0.000s) [476.772579] Starting dynamic subtest: vcs0 [476.773264] Dynamic subtest vcs0: SUCCESS (0.000s) [476.779167] Starting dynamic subtest: bcs0 [476.779920] Dynamic subtest bcs0: SUCCESS (0.000s) [476.785673] Starting dynamic subtest: rcs0 [476.786466] Dynamic subtest rcs0: SUCCESS (0.000s) [476.791979] Starting dynamic subtest: vcs1 [476.792780] Dynamic subtest vcs1: SUCCESS (0.000s) [476.793748] Subtest invalid: SUCCESS (0.004s) [476.805419] [131/131] (621s left) i915_hangman (engine-error-state-capture) [476.837982] Starting subtest: engine-error-state-capture [476.838654] Starting dynamic subtest: rcs0 [480.968463] Dynamic subtest rcs0: SUCCESS (4.156s) [480.978759] Starting dynamic subtest: bcs0 [485.006628] Dynamic subtest bcs0: SUCCESS (4.052s) [485.016052] Starting dynamic subtest: vcs0 [488.979659] Dynamic subtest vcs0: SUCCESS (3.982s) [488.989012] Starting dynamic subtest: vcs1 [491.987730] Dynamic subtest vcs1: SUCCESS (3.012s) [491.997682] Starting dynamic subtest: vecs0 [496.033028] Dynamic subtest vecs0: SUCCESS (4.049s) [496.034568] Subtest engine-error-state-capture: SUCCESS (19.256s) [496.085510] Closing watchdogs Done.