snapd.seeded.service has considerably slowed down
Affects | Status | Importance | Assigned to | Milestone | |
---|---|---|---|---|---|
snapd |
Fix Committed
|
Critical
|
Unassigned |
Bug Description
[SRU] 2.68.5: https:/
[ Impact ]
Missing preseed files when performing preseeding in a LXD container. This also results in the sense that preseeding is slowed down, which is a side effect and not the actual bug.
[ Test Plan ]
1. Produce error with snapd 2.67.1+20.04 deb (existing evidence is fine)
2. Switch to snapd 2.68.5 deb
3. Proof the preseeding works and preseeding files are not missing.
Repeat for all targeted Ubuntu releases.
---original---
In both Jammy and Focal CPC (cloud) images we are seeing failures across the latest serials. Closer inspection seems to point at the `snapd.
GCE, focal image serial 20250501 [AMD64], snapd: 2.68.4 24505 [latest/stable], snapd .deb: 2.67.1+20.04
```
ubuntu@
7min 45.546s snapd.seeded.
2min 19.838s dev-loop4.device
5.765s accounts-
...
...
...
```
GCE, jammy image serial 20250501 [ARM64], snapd: 2.68.4 24509 [latest/stable], snapd .deb: 2.67.1+22.04
```
ubuntu@
7min 30.139s snapd.seeded.
2min 18.601s dev-loop4.device
5.576s google-
5.140s cloud-init.service
2.962s nvidia-imex.service
...
...
...
```
AWS, focal image serial 20250502 [AMD64], snapd: 2.68.4 24505 [latest/stable], snapd .deb: 2.67.1+20.04
```
root@ip-
The time when unit became active or started is printed after the "@" character.
The time the unit took to start is printed after the "+" character.
graphical.target @7min 48.781s
└─multi-user.target @7min 48.779s
└─snapd.
└─basic.target @12.576s
└
```
Download image, serial 20250501 [AMD64], snap:snapd stable 24505, https:/
```
$ sudo systemd-analyze critical-chain
The time when unit became active or started is printed after the "@" character.
The time the unit took to start is printed after the "+" character.
graphical.target @7min 19.569s
└─multi-user.target @7min 19.569s
└─snapd.
└─basic.target @4.036s
└
```
### More verbose information
This particular system (Jammy GCE image serial 20250501) has currently 4 IDs according to `snap changes`. Here's the verbose output for each ID's `debug timings`:
```
ubuntu@
ID Status Doing Undoing Label Summary
36 Hold - - run-hook Run default-configure hook of "lxd" snap if present
37 Hold - - start-snap-services Start snap "lxd" (31335) services
38 Hold - - run-hook Run configure hook of "lxd" snap if present
39 Hold - - run-hook Run health check of "lxd" snap
61 Hold - - run-hook Run install hook of "google-cloud-cli" snap if present
62 Hold - - run-hook Run default-configure hook of "google-cloud-cli" snap if present
63 Hold - - start-snap-services Start snap "google-cloud-cli" (329) services
64 Hold - - run-hook Run configure hook of "google-cloud-cli" snap if present
65 Hold - - run-hook Run health check of "google-cloud-cli" snap
66 Hold - - mark-seeded Mark system seeded
35 Error 120070ms - run-hook Run install hook of "lxd" snap if present
51 Undone 4ms 4ms run-hook Run health check of "core22" snap
50 Undone 9ms 10ms start-snap-services Start snap "core22" (1912) services
49 Undone 5ms 4ms run-hook Run install hook of "core22" snap if present
25 Undone 4ms 4ms run-hook Run health check of "core20" snap
24 Undone 14ms 10ms start-snap-services Start snap "core20" (2503) services
23 Undone 4ms 5ms run-hook Run install hook of "core20" snap if present
2 Undone 18ms 5ms run-hook Run configure hook of "core" snap if present
13 Undone 10ms 10ms start-snap-services Start snap "snapd" (24509) services
12 Undone 4ms 4ms run-hook Run install hook of "snapd" snap if present
60 Undone 25ms 5ms setup-aliases Setup snap "google-cloud-cli" aliases
59 Undone 32ms 4ms set-auto-aliases Set automatic aliases for snap "google-cloud-cli"
58 Undone 62ms 0ms auto-connect Automatically connect eligible plugs and slots of snap "google-cloud-cli"
57 Undone 82ms 22ms link-snap Make snap "google-cloud-cli" (329) available to the system
^ 23ms - generate-wrappers generate wrappers for snap google-cloud-cli
56 Undone 181ms 8ms setup-profiles Setup snap "google-cloud-cli" (329) security profiles
^ 78ms - setup-security-
^ 74ms - setup-security-
^ 23ms - load-profiles[
55 Undone 21ms 6ms copy-snap-data Copy snap "google-cloud-cli" data
54 Undone 740ms 183ms mount-snap Mount snap "google-cloud-cli" (329)
^ 665ms - check-snap check snap "google-cloud-cli"
^ 38ms - setup-snap setup snap "google-cloud-cli"
53 Undone 20ms 0ms prepare-snap Prepare snap "/var/lib/
34 Undone 24ms 5ms setup-aliases Setup snap "lxd" aliases
33 Undone 26ms 4ms set-auto-aliases Set automatic aliases for snap "lxd"
67 Undone 1013ms 225ms setup-profiles Setup snap "lxd" (31335) security profiles for auto-connections
^ 150ms - setup-security-
^ 823ms - setup-security-
^ 599ms - load-profiles[
^ - 7ms setup-security-
^ - 142ms setup-security-
^ - 49ms setup-security-
^ - 26ms load-profiles[
71 Undone 35ms 10ms connect Connect lxd:network-bind to snapd:network-bind
69 Undone 23ms 10ms connect Connect lxd:lxd-support to snapd:lxd-support
70 Undone 22ms 10ms connect Connect lxd:network to snapd:network
68 Undone 25ms 10ms connect Connect lxd:system-observe to snapd:system-
32 Undone 30ms 0ms auto-connect Automatically connect eligible plugs and slots of snap "lxd"
31 Undone 154ms 188ms link-snap Make snap "lxd" (31335) available to the system
^ 63ms - generate-wrappers generate wrappers for snap lxd
30 Undone 846ms 7ms setup-profiles Setup snap "lxd" (31335) security profiles
^ 235ms - setup-security-
^ 8ms - setup-security-
^ 576ms - setup-security-
^ 450ms - load-profiles[
29 Undone 26ms 7ms copy-snap-data Copy snap "lxd" data
28 Undone 120ms 176ms mount-snap Mount snap "lxd" (31335)
^ 36ms - check-snap check snap "lxd"
^ 43ms - setup-snap setup snap "lxd"
27 Undone 24ms 0ms prepare-snap Prepare snap "/var/lib/
48 Undone 27ms 5ms setup-aliases Setup snap "core22" aliases
47 Undone 22ms 5ms set-auto-aliases Set automatic aliases for snap "core22"
46 Undone 23ms 0ms auto-connect Automatically connect eligible plugs and slots of snap "core22"
45 Undone 69ms 15ms link-snap Make snap "core22" (1912) available to the system
44 Undone 18ms 5ms setup-profiles Setup snap "core22" (1912) security profiles
43 Undone 21ms 6ms copy-snap-data Copy snap "core22" data
42 Undone 287ms 173ms mount-snap Mount snap "core22" (1912)
^ 207ms - check-snap check snap "core22"
^ 39ms - setup-snap setup snap "core22"
41 Undone 28ms 0ms prepare-snap Prepare snap "/var/lib/
22 Undone 19ms 4ms setup-aliases Setup snap "core20" aliases
21 Undone 20ms 4ms set-auto-aliases Set automatic aliases for snap "core20"
20 Undone 21ms 0ms auto-connect Automatically connect eligible plugs and slots of snap "core20"
19 Undone 62ms 15ms link-snap Make snap "core20" (2503) available to the system
18 Undone 21ms 5ms setup-profiles Setup snap "core20" (2503) security profiles
17 Undone 23ms 6ms copy-snap-data Copy snap "core20" data
16 Undone 265ms 178ms mount-snap Mount snap "core20" (2503)
^ 175ms - check-snap check snap "core20"
^ 38ms - setup-snap setup snap "core20"
15 Undone 20ms 0ms prepare-snap Prepare snap "/var/lib/
11 Undone 22ms 4ms setup-aliases Setup snap "snapd" aliases
10 Undone 24ms 4ms set-auto-aliases Set automatic aliases for snap "snapd"
9 Undone 26ms 0ms auto-connect Automatically connect eligible plugs and slots of snap "snapd"
8 Undone 65ms 15ms link-snap Make snap "snapd" (24509) available to the system
7 Error 152ms 27ms setup-profiles Setup snap "snapd" (24509) security profiles
^ 124ms - setup-security-
52 Done 22ms - prerequisites Ensure prerequisites for "google-cloud-cli" are available
40 Done 10ms - prerequisites Ensure prerequisites for "core22" are available
14 Done 10ms - prerequisites Ensure prerequisites for "core20" are available
1 Done 51ms - mark-preseeded Mark system pre-seeded
26 Done 24ms - prerequisites Ensure prerequisites for "lxd" are available
6 Undone 23ms 8ms copy-snap-data Copy snap "snapd" data
5 Undone 106ms 173ms mount-snap Mount snap "snapd" (24509)
^ 23ms - check-snap check snap "snapd"
^ 44ms - setup-snap setup snap "snapd"
4 Undone 16ms 0ms prepare-snap Prepare snap "/var/lib/
3 Done 11ms - prerequisites Ensure prerequisites for "snapd" are available
$ snap debug timings 2 --verbose
ID Status Doing Undoing Label Summary
72 Done 3336ms - generate-device-key Generate device key
^ 3319ms - generate-rsa-key generating device key pair
73 Done 292ms - request-serial Request device serial
^ 233ms - get-serial get device serial
^ 121ms - prepare-
^ 111ms - submit-
^ 45ms - fetch-keys fetch signing key chain
$ snap debug timings 3 --verbose
ID Status Doing Undoing Label Summary
75 Done 5ms - prerequisites Ensure prerequisites for "snapd" are available
76 Done 12ms - prepare-snap Prepare snap "/var/lib/
77 Done 222ms - mount-snap Mount snap "snapd" (24509)
^ 14ms - check-snap check snap "snapd"
^ 188ms - setup-snap setup snap "snapd"
78 Done 12ms - copy-snap-data Copy snap "snapd" data
79 Done 209ms - setup-profiles Setup snap "snapd" (24509) security profiles
^ 194ms - setup-security-
80 Done 24ms - link-snap Make snap "snapd" (24509) available to the system
81 Done 25ms - auto-connect Automatically connect eligible plugs and slots of snap "snapd"
82 Done 13ms - set-auto-aliases Set automatic aliases for snap "snapd"
83 Done 13ms - setup-aliases Setup snap "snapd" aliases
84 Done 6ms - run-hook Run install hook of "snapd" snap if present
85 Done 13ms - start-snap-services Start snap "snapd" (24509) services
74 Done 16ms - run-hook Run configure hook of "core" snap if present
86 Done 6ms - prerequisites Ensure prerequisites for "core20" are available
87 Done 12ms - prepare-snap Prepare snap "/var/lib/
88 Done 345ms - mount-snap Mount snap "core20" (2503)
^ 138ms - check-snap check snap "core20"
^ 183ms - setup-snap setup snap "core20"
89 Done 12ms - copy-snap-data Copy snap "core20" data
90 Done 16ms - setup-profiles Setup snap "core20" (2503) security profiles
91 Done 26ms - link-snap Make snap "core20" (2503) available to the system
92 Done 12ms - auto-connect Automatically connect eligible plugs and slots of snap "core20"
93 Done 13ms - set-auto-aliases Set automatic aliases for snap "core20"
94 Done 12ms - setup-aliases Setup snap "core20" aliases
95 Done 6ms - run-hook Run install hook of "core20" snap if present
96 Done 13ms - start-snap-services Start snap "core20" (2503) services
97 Done 6ms - run-hook Run health check of "core20" snap
112 Done 6ms - prerequisites Ensure prerequisites for "core22" are available
113 Done 13ms - prepare-snap Prepare snap "/var/lib/
114 Done 370ms - mount-snap Mount snap "core22" (1912)
^ 165ms - check-snap check snap "core22"
^ 183ms - setup-snap setup snap "core22"
115 Done 14ms - copy-snap-data Copy snap "core22" data
116 Done 16ms - setup-profiles Setup snap "core22" (1912) security profiles
117 Done 28ms - link-snap Make snap "core22" (1912) available to the system
118 Done 13ms - auto-connect Automatically connect eligible plugs and slots of snap "core22"
119 Done 13ms - set-auto-aliases Set automatic aliases for snap "core22"
120 Done 13ms - setup-aliases Setup snap "core22" aliases
121 Done 6ms - run-hook Run install hook of "core22" snap if present
122 Done 13ms - start-snap-services Start snap "core22" (1912) services
123 Done 6ms - run-hook Run health check of "core22" snap
98 Done 13ms - prerequisites Ensure prerequisites for "lxd" are available
99 Done 14ms - prepare-snap Prepare snap "/var/lib/
100 Done 231ms - mount-snap Mount snap "lxd" (31335)
^ 18ms - check-snap check snap "lxd"
^ 190ms - setup-snap setup snap "lxd"
101 Done 13ms - copy-snap-data Copy snap "lxd" data
102 Done 864ms - setup-profiles Setup snap "lxd" (31335) security profiles
^ 106ms - setup-security-
^ 736ms - setup-security-
^ 688ms - load-profiles[
103 Done 214ms - link-snap Make snap "lxd" (31335) available to the system
^ 187ms - generate-wrappers generate wrappers for snap lxd
104 Done 18ms - auto-connect Automatically connect eligible plugs and slots of snap "lxd"
143 Done 14ms - connect Connect lxd:network-bind to snapd:network-bind
141 Done 16ms - connect Connect lxd:lxd-support to snapd:lxd-support
142 Done 14ms - connect Connect lxd:network to snapd:network
140 Done 15ms - connect Connect lxd:system-observe to snapd:system-
139 Done 1006ms - setup-profiles Setup snap "lxd" (31335) security profiles for auto-connections
^ 65ms - setup-security-
^ 913ms - setup-security-
^ 841ms - load-profiles[
105 Done 14ms - set-auto-aliases Set automatic aliases for snap "lxd"
106 Done 14ms - setup-aliases Setup snap "lxd" aliases
107 Done 516ms - run-hook Run install hook of "lxd" snap if present
108 Done 7ms - run-hook Run default-configure hook of "lxd" snap if present
109 Done 615ms - start-snap-services Start snap "lxd" (31335) services
^ 189ms - enable-services enable services ["snap.
^ 403ms - start-services start services
^ 5ms - start-service start service "snap.lxd.
^ 5ms - start-service start service "snap.lxd.
^ 393ms - start-service start service "snap.lxd.
110 Done 124ms - run-hook Run configure hook of "lxd" snap if present
111 Done 7ms - run-hook Run health check of "lxd" snap
124 Done 13ms - prerequisites Ensure prerequisites for "google-cloud-cli" are available
125 Done 13ms - prepare-snap Prepare snap "/var/lib/
126 Done 746ms - mount-snap Mount snap "google-cloud-cli" (329)
^ 520ms - check-snap check snap "google-cloud-cli"
^ 203ms - setup-snap setup snap "google-cloud-cli"
127 Done 13ms - copy-snap-data Copy snap "google-cloud-cli" data
128 Done 87ms - setup-profiles Setup snap "google-cloud-cli" (329) security profiles
^ 30ms - setup-security-
^ 38ms - setup-security-
^ 17ms - load-profiles[
129 Done 37ms - link-snap Make snap "google-cloud-cli" (329) available to the system
^ 9ms - generate-wrappers generate wrappers for snap google-cloud-cli
130 Done 13ms - auto-connect Automatically connect eligible plugs and slots of snap "google-cloud-cli"
131 Done 15ms - set-auto-aliases Set automatic aliases for snap "google-cloud-cli"
132 Done 14ms - setup-aliases Setup snap "google-cloud-cli" aliases
133 Done 7ms - run-hook Run install hook of "google-cloud-cli" snap if present
134 Done 7ms - run-hook Run default-configure hook of "google-cloud-cli" snap if present
135 Done 14ms - start-snap-services Start snap "google-cloud-cli" (329) services
136 Done 7ms - run-hook Run configure hook of "google-cloud-cli" snap if present
137 Done 7ms - run-hook Run health check of "google-cloud-cli" snap
138 Done 13ms - mark-seeded Mark system seeded
$ snap debug timings 4 --verbose
ID Status Doing Undoing Label Summary
144 Done 16ms - prerequisites Ensure prerequisites for "go" are available
145 Done 2965ms - download-snap Download snap "go" (10881) from channel "stable"
^ 2949ms - download download snap "go"
146 Done 483ms - validate-snap Fetch and check assertions for snap "go" (10881)
147 Done 406ms - mount-snap Mount snap "go" (10881)
^ 181ms - check-snap check snap "go"
^ 200ms - setup-snap setup snap "go"
148 Done 15ms - copy-snap-data Copy snap "go" data
149 Done 57ms - setup-profiles Setup snap "go" (10881) security profiles
^ 13ms - setup-security-
^ 20ms - setup-security-
^ 9ms - load-profiles[
150 Done 35ms - link-snap Make snap "go" (10881) available to the system
151 Done 15ms - auto-connect Automatically connect eligible plugs and slots of snap "go"
152 Done 15ms - set-auto-aliases Set automatic aliases for snap "go"
153 Done 15ms - setup-aliases Setup snap "go" aliases
154 Done 8ms - run-hook Run install hook of "go" snap if present
155 Done 7ms - run-hook Run default-configure hook of "go" snap if present
156 Done 15ms - start-snap-services Start snap "go" (10881) services
157 Done 7ms - run-hook Run configure hook of "go" snap if present
158 Done 7ms - run-hook Run health check of "go" snap
```
description: | updated |
Changed in snapd: | |
status: | New → In Progress |
Changed in snapd: | |
importance: | Undecided → High |
importance: | High → Critical |
Changed in snapd: | |
status: | In Progress → Fix Committed |
This seems to be isolated to just Focal and Jammy at the moment, I don't have the privs to change the series though unfortunately.