Cannot remove snap, when it has change in progress

gao270615179 · June 4, 2021, 9:45am

I try remove edgexfoundry when I run sudo snap remove edgexfoundry, but it returns:

error: snap "edgexfoundry" has "auto-refresh" change in progress

Then, I run sudo snap changes and get task id of the process.

ID   Status   Spawn                   Ready               Summary
74   Undoing  yesterday at 09:53 CST  -                   Auto-refresh snap "edgexfoundry"

Trying to abort this via sudo snap abort 74 has no results and the process is still there, and still cannot remove the snap.

sudo snap tasks 74 and return:

Status   Spawn                   Ready                   Summary
Undo     yesterday at 09:53 CST  yesterday at 09:53 CST  Ensure prerequisites for "edgexfoundry" are available
Undo     yesterday at 09:53 CST  yesterday at 09:54 CST  Download snap "edgexfoundry" (3020) from channel "latest/edge"
Undo     yesterday at 09:53 CST  yesterday at 09:54 CST  Fetch and check assertions for snap "edgexfoundry" (3020)
Undo     yesterday at 09:53 CST  yesterday at 09:54 CST  Mount snap "edgexfoundry" (3020)
Undo     yesterday at 09:53 CST  yesterday at 09:54 CST  Run pre-refresh hook of "edgexfoundry" snap if present
Undoing  yesterday at 09:53 CST  yesterday at 09:54 CST  Stop snap "edgexfoundry" services
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Remove aliases for snap "edgexfoundry"
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Make current revision for snap "edgexfoundry" unavailable
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Copy snap "edgexfoundry" data
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Setup snap "edgexfoundry" (3020) security profiles
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Make snap "edgexfoundry" (3020) available to the system
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Automatically connect eligible plugs and slots of snap "edgexfoundry"
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Set automatic aliases for snap "edgexfoundry"
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Setup snap "edgexfoundry" aliases
Undone   yesterday at 09:53 CST  yesterday at 10:09 CST  Run post-refresh hook of "edgexfoundry" snap if present
Error    yesterday at 09:53 CST  yesterday at 10:09 CST  Start snap "edgexfoundry" (3020) services
Hold     yesterday at 09:53 CST  yesterday at 10:09 CST  Clean up "edgexfoundry" (3020) install
Hold     yesterday at 09:53 CST  yesterday at 10:09 CST  Run configure hook of "edgexfoundry" snap if present
Hold     yesterday at 09:53 CST  yesterday at 10:09 CST  Run health check of "edgexfoundry" snap
Hold     yesterday at 09:53 CST  today at 16:35 CST      Consider re-refresh of "edgexfoundry"

......................................................................
Start snap "edgexfoundry" (3020) services

2021-06-03T10:09:42+08:00 ERROR [start snap.edgexfoundry.kong-daemon.service] failed with exit status 1: Job for snap.edgexfoundry.kong-daemon.service failed because a timeout was exceeded.
See "systemctl status snap.edgexfoundry.kong-daemon.service" and "journalctl -xe" for details.

Maybe it’s because I force shutdown ubuntu when the snap auto-refresh in background.

How can I remove this snap?

ogra · June 4, 2021, 10:08am

you can try to abort the task it is doing with snap abort 74 and then try the uninstall again

gao270615179 · June 4, 2021, 11:22am

@ogra

I have tried this, but it doesn’t work.

ogra · June 4, 2021, 11:59am

i have moved your post into the snapd category, so the snapd team sees it … this looks like some issue they would like to debug …

ijohnson · June 4, 2021, 7:00pm

Can you detail what happens when you run snap abort 74 ? how does it not work ?

gao270615179 · June 5, 2021, 1:50am

After I run snap abort 74, it returns nothing. The task is still on “Undoing” status. When I run journalctl -f -u snapd, There is no log about this abort.
Then I run snap remove edgexfoundry, it returns the same result as before:

error: snap "edgexfoundry" has "auto-refresh" change in progress

This is shell info:

xxx@xxx:~$ sudo snap changes
ID   Status   Spawn                     Ready                   Summary
74   Undoing  2 days ago, at 09:53 CST  -                       Auto-refresh snap "edgexfoundry"
75   Done     yesterday at 16:31 CST    yesterday at 16:31 CST  Install "edgex-device-audio" snap from file "edgex-device-audio_0.0.0_amd64.snap"
76   Done     yesterday at 16:31 CST    yesterday at 16:31 CST  Running service command for snap "edgex-device-audio"

xxx@xxx:~$ sudo snap abort 74
xxx@xxx:~$ journalctl -f -u snapd
-- Reboot --
6月 05 09:08:40 xxx systemd[1]: Starting Snap Daemon...
6月 05 09:08:41 xxx snapd[695]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:08:42 xxx snapd[695]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:08:42 xxx snapd[695]: daemon.go:347: started snapd/2.50.1 (series 16; classic) ubuntu/20.04 (amd64) linux/5.8.0-53-generic.
6月 05 09:08:42 xxx snapd[695]: daemon.go:440: adjusting startup timeout by 1m10s (pessimistic estimate of 30s plus 5s per snap)
6月 05 09:08:42 xxx systemd[1]: Started Snap Daemon.
6月 05 09:09:21 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"
6月 05 09:09:24 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"
6月 05 09:10:08 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"

xxx@xxx:~$ sudo snap changes
ID   Status   Spawn                     Ready                   Summary
74   Undoing  2 days ago, at 09:53 CST  -                       Auto-refresh snap "edgexfoundry"
75   Done     yesterday at 16:31 CST    yesterday at 16:31 CST  Install "edgex-device-audio" snap from file "edgex-device-audio_0.0.0_amd64.snap"
76   Done     yesterday at 16:31 CST    yesterday at 16:31 CST  Running service command for snap "edgex-device-audio"

xxx@xxx:~$ sudo snap remove edgexfoundry
error: snap "edgexfoundry" has "auto-refresh" change in progress

gao270615179 · June 5, 2021, 2:07am

By the way, I find error log in snapd logs, which leads to snapd exit. The snap environment is here:

snap    2.50.1
snapd   2.50.1
series  16
ubuntu  20.04
kernel  5.8.0-53-generic

error logs:

-- Reboot --
6月 05 09:08:40 xxx systemd[1]: Starting Snap Daemon...
6月 05 09:08:41 xxx snapd[695]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:08:42 xxx snapd[695]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:08:42 xxx snapd[695]: daemon.go:347: started snapd/2.50.1 (series 16; classic) ubuntu/20.04 (amd64) linux/5.8.0-53-generic.
6月 05 09:08:42 xxx snapd[695]: daemon.go:440: adjusting startup timeout by 1m10s (pessimistic estimate of 30s plus 5s per snap)
6月 05 09:08:42 xxx systemd[1]: Started Snap Daemon.
6月 05 09:09:21 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"
6月 05 09:09:24 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"
6月 05 09:10:08 xxx snapd[695]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-themes", "snap-store", "snapcraft", "snapd"
6月 05 09:24:08 xxx systemd[1]: snapd.service: Got notification message from PID 3990, but reception only permitted for main PID 695
6月 05 09:24:16 xxx snapd[695]: fatal error: sync: unlock of unlocked mutex
6月 05 09:24:16 xxx snapd[695]: goroutine 84 [running]:
6月 05 09:24:16 xxx snapd[695]: runtime.throw(0x55faf19fed79, 0x1e)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/panic.go:616 +0x83 fp=0xc42068f9f0 sp=0xc42068f9d0 pc=0x55faf11713a3
6月 05 09:24:16 xxx snapd[695]: sync.throw(0x55faf19fed79, 0x1e)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/panic.go:605 +0x37 fp=0xc42068fa10 sp=0xc42068f9f0 pc=0x55faf1171317
6月 05 09:24:16 xxx snapd[695]: sync.(*Mutex).Unlock(0xc42039f3b0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/sync/mutex.go:184 +0xc4 fp=0xc42068fa38 sp=0xc42068fa10 pc=0x55faf11b6264
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*State).unlock(0xc42039f3b0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:162 +0x37 fp=0xc42068fa50 sp=0xc42068fa38 pc=0x55faf173e0a7
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*State).Unlock(0xc42039f3b0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:239 +0x297 fp=0xc42068fb08 sp=0xc42068fa50 pc=0x55faf173e8a7
6月 05 09:24:16 xxx snapd[695]: runtime.call32(0x0, 0x55faf20ba838, 0xc42007c070, 0x800000008)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:573 +0x3d fp=0xc42068fb38 sp=0xc42068fb08 pc=0x55faf119e77d
6月 05 09:24:16 xxx snapd[695]: panic(0x55faf1f433a0, 0x55faf20bcf00)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/panic.go:502 +0x22d fp=0xc42068fbd8 sp=0xc42068fb38 pc=0x55faf1170d6d
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*State).reading(0xc42039f3b0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:149 +0x52 fp=0xc42068fbf8 sp=0xc42068fbd8 pc=0x55faf173e002
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*State).Get(0xc42039f3b0, 0x55faf19dfe8c, 0x7, 0x55faf1f06e40, 0xc4205d6be0, 0x20, 0x55faf1f2af00)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:332 +0x2d fp=0xc42068fc40 sp=0xc42068fbf8 pc=0x55faf173ed8d
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*State).GetMaybeTimings(0xc42039f3b0, 0x55faf1f06e40, 0xc4205d6be0, 0x6, 0xc420040a88)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:518 +0x5a fp=0xc42068fc98 sp=0xc42068fc40 pc=0x55faf174037a
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/timings.(*Timings).Save(0xc42066a180, 0x55faf20c7240, 0xc42039f3b0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/timings/state.go:135 +0x76 fp=0xc42068fd50 sp=0xc42068fc98 pc=0x55faf16727f6
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/snapstate.(*SnapManager).undoStopSnapServices(0xc4203cb090, 0xc420410360, 0xc4202e6e60, 0x55faf20c2880, 0xc42007d000)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/snapstate/handlers.go:2031 +0x464 fp=0xc42068fe30 sp=0xc42068fd50 pc=0x55faf17ee924
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/snapstate.(*SnapManager).(github.com/snapcore/snapd/overlord/snapstate.undoStopSnapServices)-fm(0xc420410360, 0xc4202e6e60, 0x55faf2547380, 0xc42042a6f8)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/snapstate/snapmgr.go:445 +0x40 fp=0xc42068fe68 sp=0xc42068fe30 pc=0x55faf1820040
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/state.(*TaskRunner).run.func1(0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/taskrunner.go:203 +0xbe fp=0xc42068ff98 sp=0xc42068fe68 pc=0x55faf1747a2e
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc4202e6e60, 0xc4205e1c80)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d fp=0xc42068ffd0 sp=0xc42068ff98 pc=0x55faf142456d
6月 05 09:24:16 xxx snapd[695]: runtime.goexit()
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:2361 +0x1 fp=0xc42068ffd8 sp=0xc42068ffd0 pc=0x55faf11a0f81
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:24:16 xxx snapd[695]: goroutine 1 [select, 15 minutes]:
6月 05 09:24:16 xxx snapd[695]: main.run(0xc4203e0840, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:153 +0x501
6月 05 09:24:16 xxx snapd[695]: main.main()
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:64 +0x10d
6月 05 09:24:16 xxx snapd[695]: goroutine 5 [syscall, 15 minutes]:
6月 05 09:24:16 xxx snapd[695]: os/signal.signal_recv(0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/sigqueue.go:139 +0xa8
6月 05 09:24:16 xxx snapd[695]: os/signal.loop()
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/os/signal/signal_unix.go:22 +0x24
6月 05 09:24:16 xxx snapd[695]: created by os/signal.init.0
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/os/signal/signal_unix.go:28 +0x43
6月 05 09:24:16 xxx snapd[695]: goroutine 19 [select, 15 minutes, locked to thread]:
6月 05 09:24:16 xxx snapd[695]: runtime.gopark(0x55faf20bba48, 0x0, 0x55faf19de419, 0x6, 0x18, 0x1)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/proc.go:291 +0x120
6月 05 09:24:16 xxx snapd[695]: runtime.selectgo(0xc42004a750, 0xc4203da240)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/select.go:392 +0xe56
6月 05 09:24:16 xxx snapd[695]: runtime.ensureSigM.func1()
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/signal_unix.go:549 +0x1f6
6月 05 09:24:16 xxx snapd[695]: runtime.goexit()
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:2361 +0x1
6月 05 09:24:16 xxx snapd[695]: goroutine 14 [select, 6 minutes]:
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/standby.(*StandbyOpinions).Start.func1(0xc4200a7400)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/standby/standby.go:104 +0x142
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/overlord/standby.(*StandbyOpinions).Start
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/standby/standby.go:97 +0xb6
6月 05 09:24:16 xxx snapd[695]: goroutine 16 [select]:
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord.(*Overlord).Loop.func1(0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/overlord.go:445 +0x196
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc42029eaa0, 0xc4205d6140)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:24:16 xxx snapd[695]: goroutine 50 [IO wait, 9 minutes]:
6月 05 09:24:16 xxx snapd[695]: internal/poll.runtime_pollWait(0x7f6738dc3e30, 0x72, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/netpoll.go:173 +0x59
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*pollDesc).wait(0xc4203d8798, 0x72, 0xc4203c8000, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:85 +0x9d
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*pollDesc).waitRead(0xc4203d8798, 0xffffffffffffff00, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:90 +0x3f
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*FD).Accept(0xc4203d8780, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_unix.go:372 +0x1aa
6月 05 09:24:16 xxx snapd[695]: net.(*netFD).accept(0xc4203d8780, 0xc4205fddd0, 0xc4202581b0, 0x55faf20bbb78)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/fd_unix.go:238 +0x44
6月 05 09:24:16 xxx snapd[695]: net.(*UnixListener).accept(0xc4203401b0, 0x55faf19c85d0, 0xc420321550, 0xc4203a1170)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/unixsock_posix.go:162 +0x34
6月 05 09:24:16 xxx snapd[695]: net.(*UnixListener).Accept(0xc4203401b0, 0xc420260080, 0xc4205fde50, 0x55faf19d358a, 0xc420321550)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/unixsock.go:253 +0x4b
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/daemon.(*ucrednetListener).Accept(0xc420340210, 0x0, 0x0, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/ucrednet.go:110 +0x4f
6月 05 09:24:16 xxx snapd[695]: net/http.(*Server).Serve(0xc4204ea8f0, 0x55faf20cbbc0, 0xc420340210, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/http/server.go:2773 +0x1a7
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/daemon.(*Daemon).Start.func1(0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/daemon.go:478 +0x58
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420152e50, 0xc420321590)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:24:16 xxx snapd[695]: goroutine 51 [select]:
6月 05 09:24:16 xxx snapd[695]: main.runWatchdog.func1(0xc4200a74f0, 0xc420152e00)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:93 +0xff
6月 05 09:24:16 xxx snapd[695]: created by main.runWatchdog
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:91 +0x22d
6月 05 09:24:16 xxx snapd[695]: goroutine 21 [IO wait, 11 minutes]:
6月 05 09:24:16 xxx snapd[695]: internal/poll.runtime_pollWait(0x7f6738dc3f00, 0x72, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/runtime/netpoll.go:173 +0x59
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*pollDesc).wait(0xc4203d8898, 0x72, 0xc4206b2100, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:85 +0x9d
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*pollDesc).waitRead(0xc4203d8898, 0xffffffffffffff00, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:90 +0x3f
6月 05 09:24:16 xxx snapd[695]: internal/poll.(*FD).Accept(0xc4203d8880, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/internal/poll/fd_unix.go:372 +0x1aa
6月 05 09:24:16 xxx snapd[695]: net.(*netFD).accept(0xc4203d8880, 0xc4205f9dd0, 0xc4202581b0, 0x55faf20bbb78)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/fd_unix.go:238 +0x44
6月 05 09:24:16 xxx snapd[695]: net.(*UnixListener).accept(0xc4203401e0, 0x55faf19c85d0, 0xc420321550, 0xc4203a1170)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/unixsock_posix.go:162 +0x34
6月 05 09:24:16 xxx snapd[695]: net.(*UnixListener).Accept(0xc4203401e0, 0xc420214060, 0xc4205f9e50, 0x55faf19d358a, 0xc420321550)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/unixsock.go:253 +0x4b
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/daemon.(*ucrednetListener).Accept(0xc420340240, 0x0, 0x0, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/ucrednet.go:110 +0x4f
6月 05 09:24:16 xxx snapd[695]: net/http.(*Server).Serve(0xc4204ea8f0, 0x55faf20cbbc0, 0xc420340240, 0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/net/http/server.go:2773 +0x1a7
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/daemon.(*Daemon).Start.func1.1(0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/daemon.go:470 +0x4b
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420152e50, 0xc420348000)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:24:16 xxx snapd[695]: goroutine 64 [syscall]:
6月 05 09:24:16 xxx snapd[695]: syscall.Syscall6(0x17, 0x5, 0xc42005fe38, 0x0, 0x0, 0x0, 0x0, 0xc42042fb00, 0xc42005fdc0, 0x55faf117a0db)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/syscall/asm_linux_amd64.s:44 +0x5
6月 05 09:24:16 xxx snapd[695]: syscall.Select(0x5, 0xc42005fe38, 0x0, 0x0, 0x0, 0x0, 0xc42005fe60, 0x55faf11707b6)
6月 05 09:24:16 xxx snapd[695]:         /usr/lib/go-1.10/src/syscall/zsyscall_linux_amd64.go:1367 +0xb0
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/osutil/udev/netlink.stopperSelectReadable(0x3, 0x4, 0xc420706840, 0x3d, 0xc420381380)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/rawsockstop.go:57 +0x160
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/osutil/udev/netlink.RawSockStopper.func1(0xc4204dc1e0, 0xc4206cca70, 0x6)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/rawsockstop.go:31 +0x43
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/osutil/udev/netlink.(*UEventConn).Monitor.func4(0xc4204dc220, 0xc420096360, 0xc4200963c0, 0xc420096420, 0xc42034ff80, 0x55faf20ce840, 0xc4204dc1e0, 0xc420096300)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/conn.go:139 +0x3e
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/osutil/udev/netlink.(*UEventConn).Monitor
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/conn.go:136 +0x233
6月 05 09:24:16 xxx snapd[695]: goroutine 83 [select, 15 minutes]:
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/overlord/ifacestate/udevmonitor.(*Monitor).Run.func1(0x0, 0x0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/ifacestate/udevmonitor/udevmon.go:147 +0x35a
6月 05 09:24:16 xxx snapd[695]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420258090, 0xc420503dc0)
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:24:16 xxx snapd[695]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:24:16 xxx snapd[695]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:24:16 xxx systemd[1]: snapd.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
6月 05 09:24:16 xxx systemd[1]: snapd.service: Failed with result 'exit-code'.
6月 05 09:24:16 xxx systemd[1]: snapd.service: Scheduled restart job, restart counter is at 1.
6月 05 09:24:16 xxx systemd[1]: Stopped Snap Daemon.
6月 05 09:24:16 xxx systemd[1]: Starting Snap Daemon...
6月 05 09:24:16 xxx snapd[12416]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:24:17 xxx snapd[12416]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:24:17 xxx snapd[12416]: daemon.go:347: started snapd/2.50.1 (series 16; classic) ubuntu/20.04 (amd64) linux/5.8.0-53-generic.
6月 05 09:24:17 xxx snapd[12416]: daemon.go:440: adjusting startup timeout by 1m10s (pessimistic estimate of 30s plus 5s per snap)
6月 05 09:24:17 xxx systemd[1]: Started Snap Daemon.
6月 05 09:39:31 xxx systemd[1]: snapd.service: Got notification message from PID 13096, but reception only permitted for main PID 12416
6月 05 09:39:39 xxx snapd[12416]: fatal error: sync: unlock of unlocked mutex
6月 05 09:39:39 xxx snapd[12416]: goroutine 53 [running]:
6月 05 09:39:39 xxx snapd[12416]: runtime.throw(0x5572b31e7d79, 0x1e)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/panic.go:616 +0x83 fp=0xc4206fb9f0 sp=0xc4206fb9d0 pc=0x5572b295a3a3
6月 05 09:39:39 xxx snapd[12416]: sync.throw(0x5572b31e7d79, 0x1e)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/panic.go:605 +0x37 fp=0xc4206fba10 sp=0xc4206fb9f0 pc=0x5572b295a317
6月 05 09:39:39 xxx snapd[12416]: sync.(*Mutex).Unlock(0xc4203b33b0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/sync/mutex.go:184 +0xc4 fp=0xc4206fba38 sp=0xc4206fba10 pc=0x5572b299f264
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*State).unlock(0xc4203b33b0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:162 +0x37 fp=0xc4206fba50 sp=0xc4206fba38 pc=0x5572b2f270a7
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*State).Unlock(0xc4203b33b0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:239 +0x297 fp=0xc4206fbb08 sp=0xc4206fba50 pc=0x5572b2f278a7
6月 05 09:39:39 xxx snapd[12416]: runtime.call32(0x0, 0x5572b38a3838, 0xc4200b3eb0, 0x800000008)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:573 +0x3d fp=0xc4206fbb38 sp=0xc4206fbb08 pc=0x5572b298777d
6月 05 09:39:39 xxx snapd[12416]: panic(0x5572b372c3a0, 0x5572b38a5f00)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/panic.go:502 +0x22d fp=0xc4206fbbd8 sp=0xc4206fbb38 pc=0x5572b2959d6d
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*State).reading(0xc4203b33b0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:149 +0x52 fp=0xc4206fbbf8 sp=0xc4206fbbd8 pc=0x5572b2f27002
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*State).Get(0xc4203b33b0, 0x5572b31c8e8c, 0x7, 0x5572b36efe40, 0xc4202a3e20, 0x20, 0x5572b3713f00)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:332 +0x2d fp=0xc4206fbc40 sp=0xc4206fbbf8 pc=0x5572b2f27d8d
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*State).GetMaybeTimings(0xc4203b33b0, 0x5572b36efe40, 0xc4202a3e20, 0x6, 0xc420042f88)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/state.go:518 +0x5a fp=0xc4206fbc98 sp=0xc4206fbc40 pc=0x5572b2f2937a
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/timings.(*Timings).Save(0xc4203efb40, 0x5572b38b0240, 0xc4203b33b0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/timings/state.go:135 +0x76 fp=0xc4206fbd50 sp=0xc4206fbc98 pc=0x5572b2e5b7f6
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/snapstate.(*SnapManager).undoStopSnapServices(0xc4200b0d70, 0xc420502240, 0xc4200b0780, 0x5572b38ab880, 0xc42007c7c0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/snapstate/handlers.go:2031 +0x464 fp=0xc4206fbe30 sp=0xc4206fbd50 pc=0x5572b2fd7924
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/snapstate.(*SnapManager).(github.com/snapcore/snapd/overlord/snapstate.undoStopSnapServices)-fm(0xc420502240, 0xc4200b0780, 0x5572b3d30380, 0x3)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/snapstate/snapmgr.go:445 +0x40 fp=0xc4206fbe68 sp=0xc4206fbe30 pc=0x5572b3009040
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/state.(*TaskRunner).run.func1(0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/state/taskrunner.go:203 +0xbe fp=0xc4206fbf98 sp=0xc4206fbe68 pc=0x5572b2f30a2e
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc4200b0780, 0xc420372570)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d fp=0xc4206fbfd0 sp=0xc4206fbf98 pc=0x5572b2c0d56d
6月 05 09:39:39 xxx snapd[12416]: runtime.goexit()
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:2361 +0x1 fp=0xc4206fbfd8 sp=0xc4206fbfd0 pc=0x5572b2989f81
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:39:39 xxx snapd[12416]: goroutine 1 [select, 15 minutes]:
6月 05 09:39:39 xxx snapd[12416]: main.run(0xc4203e28a0, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:153 +0x501
6月 05 09:39:39 xxx snapd[12416]: main.main()
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:64 +0x10d
6月 05 09:39:39 xxx snapd[12416]: goroutine 19 [syscall, 15 minutes]:
6月 05 09:39:39 xxx snapd[12416]: os/signal.signal_recv(0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/sigqueue.go:139 +0xa8
6月 05 09:39:39 xxx snapd[12416]: os/signal.loop()
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/os/signal/signal_unix.go:22 +0x24
6月 05 09:39:39 xxx snapd[12416]: created by os/signal.init.0
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/os/signal/signal_unix.go:28 +0x43
6月 05 09:39:39 xxx snapd[12416]: goroutine 35 [select, 15 minutes, locked to thread]:
6月 05 09:39:39 xxx snapd[12416]: runtime.gopark(0x5572b38a4a48, 0x0, 0x5572b31c7419, 0x6, 0x18, 0x1)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/proc.go:291 +0x120
6月 05 09:39:39 xxx snapd[12416]: runtime.selectgo(0xc420442f50, 0xc4203f8240)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/select.go:392 +0xe56
6月 05 09:39:39 xxx snapd[12416]: runtime.ensureSigM.func1()
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/signal_unix.go:549 +0x1f6
6月 05 09:39:39 xxx snapd[12416]: runtime.goexit()
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/asm_amd64.s:2361 +0x1
6月 05 09:39:39 xxx snapd[12416]: goroutine 44 [select]:
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord.(*Overlord).Loop.func1(0x5572b2c6258b, 0xc420476ba0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/overlord.go:445 +0x196
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc4202b2aa0, 0xc4202642e0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:39:39 xxx snapd[12416]: goroutine 42 [select, 5 minutes]:
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/standby.(*StandbyOpinions).Start.func1(0xc4203ecd70)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/standby/standby.go:104 +0x142
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/overlord/standby.(*StandbyOpinions).Start
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/standby/standby.go:97 +0xb6
6月 05 09:39:39 xxx snapd[12416]: goroutine 45 [IO wait, 8 minutes]:
6月 05 09:39:39 xxx snapd[12416]: internal/poll.runtime_pollWait(0x7ff238560f28, 0x72, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/netpoll.go:173 +0x59
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*pollDesc).wait(0xc4203f6518, 0x72, 0xc42039ba00, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:85 +0x9d
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*pollDesc).waitRead(0xc4203f6518, 0xffffffffffffff00, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:90 +0x3f
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*FD).Accept(0xc4203f6500, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_unix.go:372 +0x1aa
6月 05 09:39:39 xxx snapd[12416]: net.(*netFD).accept(0xc4203f6500, 0xc42059ddd0, 0xc4203b3440, 0x5572b38a4b78)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/fd_unix.go:238 +0x44
6月 05 09:39:39 xxx snapd[12416]: net.(*UnixListener).accept(0xc4200a5ef0, 0x5572b31b15d0, 0xc420371630, 0xc420382a20)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/unixsock_posix.go:162 +0x34
6月 05 09:39:39 xxx snapd[12416]: net.(*UnixListener).Accept(0xc4200a5ef0, 0xc42037ce20, 0xc42059de50, 0x5572b31bc58a, 0xc420371630)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/unixsock.go:253 +0x4b
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/daemon.(*ucrednetListener).Accept(0xc4201b2090, 0x0, 0x0, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/ucrednet.go:110 +0x4f
6月 05 09:39:39 xxx snapd[12416]: net/http.(*Server).Serve(0xc42029ec30, 0x5572b38b4bc0, 0xc4201b2090, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/http/server.go:2773 +0x1a7
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/daemon.(*Daemon).Start.func1(0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/daemon.go:478 +0x58
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420166e50, 0xc420371670)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:39:39 xxx snapd[12416]: goroutine 46 [select]:
6月 05 09:39:39 xxx snapd[12416]: main.runWatchdog.func1(0xc4203ece60, 0xc420166e00)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:93 +0xff
6月 05 09:39:39 xxx snapd[12416]: created by main.runWatchdog
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/cmd/snapd/main.go:91 +0x22d
6月 05 09:39:39 xxx snapd[12416]: goroutine 47 [IO wait, 15 minutes]:
6月 05 09:39:39 xxx snapd[12416]: internal/poll.runtime_pollWait(0x7ff238560ff8, 0x72, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/runtime/netpoll.go:173 +0x59
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*pollDesc).wait(0xc4203f6618, 0x72, 0xc42039ba00, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:85 +0x9d
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*pollDesc).waitRead(0xc4203f6618, 0xffffffffffffff00, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_poll_runtime.go:90 +0x3f
6月 05 09:39:39 xxx snapd[12416]: internal/poll.(*FD).Accept(0xc4203f6600, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/internal/poll/fd_unix.go:372 +0x1aa
6月 05 09:39:39 xxx snapd[12416]: net.(*netFD).accept(0xc4203f6600, 0x30, 0x5572b381fc80, 0xc42039baa0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/fd_unix.go:238 +0x44
6月 05 09:39:39 xxx snapd[12416]: net.(*UnixListener).accept(0xc4200a5f20, 0x0, 0xc420052800, 0xc42043f630)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/unixsock_posix.go:162 +0x34
6月 05 09:39:39 xxx snapd[12416]: net.(*UnixListener).Accept(0xc4200a5f20, 0xc42043f630, 0xc42043f650, 0x5572b293ff3a, 0x30)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/unixsock.go:253 +0x4b
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/daemon.(*ucrednetListener).Accept(0xc4201b2120, 0x0, 0x0, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/ucrednet.go:110 +0x4f
6月 05 09:39:39 xxx snapd[12416]: net/http.(*Server).Serve(0xc42029ec30, 0x5572b38b4bc0, 0xc4201b2120, 0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/net/http/server.go:2773 +0x1a7
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/daemon.(*Daemon).Start.func1.1(0x0, 0x0)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/daemon/daemon.go:470 +0x4b
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420166e50, 0xc420371680)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:39:39 xxx snapd[12416]: goroutine 52 [select, 15 minutes]:
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/overlord/ifacestate/udevmonitor.(*Monitor).Run.func1(0xffffffffffffffff, 0xc4203f8898)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/overlord/ifacestate/udevmonitor/udevmon.go:147 +0x35a
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).run(0xc420426090, 0xc4200b3540)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:163 +0x2d
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/vendor/gopkg.in/tomb%2ev2.(*Tomb).Go
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/vendor/gopkg.in/tomb.v2/tomb.go:159 +0xbb
6月 05 09:39:39 xxx snapd[12416]: goroutine 77 [syscall]:
6月 05 09:39:39 xxx snapd[12416]: syscall.Syscall6(0x17, 0x5, 0xc420063e38, 0x0, 0x0, 0x0, 0x0, 0xc420482a80, 0xc420063dc0, 0x5572b29630db)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/syscall/asm_linux_amd64.s:44 +0x5
6月 05 09:39:39 xxx snapd[12416]: syscall.Select(0x5, 0xc420063e38, 0x0, 0x0, 0x0, 0x0, 0xc420063e60, 0x5572b29597b6)
6月 05 09:39:39 xxx snapd[12416]:         /usr/lib/go-1.10/src/syscall/zsyscall_linux_amd64.go:1367 +0xb0
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/osutil/udev/netlink.stopperSelectReadable(0x3, 0x4, 0xc420406180, 0x3d, 0xc420446030)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/rawsockstop.go:57 +0x160
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/osutil/udev/netlink.RawSockStopper.func1(0xc420577ec0, 0xc42024c020, 0x6)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/rawsockstop.go:31 +0x43
6月 05 09:39:39 xxx snapd[12416]: github.com/snapcore/snapd/osutil/udev/netlink.(*UEventConn).Monitor.func4(0xc420577ee0, 0xc4203f89c0, 0xc4203f8a20, 0xc4203f8a80, 0xc420607d20, 0x5572b38b7840, 0xc420577ec0, 0xc4203f8960)
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/conn.go:139 +0x3e
6月 05 09:39:39 xxx snapd[12416]: created by github.com/snapcore/snapd/osutil/udev/netlink.(*UEventConn).Monitor
6月 05 09:39:39 xxx systemd[1]: snapd.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
6月 05 09:39:39 xxx snapd[12416]:         /build/snapd/parts/snapd-deb/build/_build/src/github.com/snapcore/snapd/osutil/udev/netlink/conn.go:136 +0x233
6月 05 09:39:39 xxx systemd[1]: snapd.service: Failed with result 'exit-code'.
6月 05 09:39:39 xxx systemd[1]: snapd.service: Scheduled restart job, restart counter is at 2.
6月 05 09:39:39 xxx systemd[1]: Stopped Snap Daemon.
6月 05 09:39:39 xxx systemd[1]: Starting Snap Daemon...
6月 05 09:39:39 xxx snapd[20613]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:39:39 xxx snapd[20613]: AppArmor status: apparmor is enabled and all features are available
6月 05 09:39:39 xxx snapd[20613]: daemon.go:347: started snapd/2.50.1 (series 16; classic) ubuntu/20.04 (amd64) linux/5.8.0-53-generic.
6月 05 09:39:40 xxx snapd[20613]: daemon.go:440: adjusting startup timeout by 1m10s (pessimistic estimate of 30s plus 5s per snap)
6月 05 09:39:40 xxx systemd[1]: Started Snap Daemon.

gao270615179 · June 8, 2021, 10:40am

@ijohnson
Is there a way to solve this issue?

mborzecki · June 8, 2021, 10:49am

Thanks for including the log. I’m not sure that the crash is related, but I’m preparing a fix for it anyway.

gao270615179 · June 8, 2021, 11:05am

Thanks! This is the log of snapd when edgexfoundry snap auto-refresh failed.

6月 03 09:53:53 xxx snapd[688]: storehelpers.go:551: cannot refresh: snap has no updates available: "core18", "gnome-3-34-1804", "gtk-common-theme>
6月 03 10:09:33 xxx systemd[1]: snapd.service: Got notification message from PID 247022, but reception only permitted for main PID 688
6月 03 10:09:42 xxx snapd[688]: taskrunner.go:271: [change 74 "Start snap \"edgexfoundry\" (3020) services" task] failed: [start snap.edgexfoundry>
6月 03 10:09:42 xxx snapd[688]: See "systemctl status snap.edgexfoundry.kong-daemon.service" and "journalctl -xe" for details.
6月 03 10:24:58 xxx systemd[1]: snapd.service: Got notification message from PID 255765, but reception only permitted for main PID 688
6月 03 10:25:06 xxx snapd[688]: fatal error: sync: unlock of unlocked mutex
6月 03 10:25:06 xxx snapd[688]: goroutine 2830 [running]:
6月 03 10:25:06 xxx snapd[688]: runtime.throw(0x563350a80d79, 0x1e)
6月 03 10:25:06 xxx snapd[688]:         /usr/lib/go-1.10/src/runtime/panic.go:616 +0x83 fp=0xc42072d9f0 sp=0xc42072d9d0 pc=0x5633501f33a3
6月 03 10:25:06 xxx snapd[688]: sync.throw(0x563350a80d79, 0x1e)