Charm blocked after bind service fails to start
Affects | Status | Importance | Assigned to | Milestone | |
---|---|---|---|---|---|
OpenStack Designate-Bind Charm |
Fix Released
|
Medium
|
James Page |
Bug Description
During a foundation cloud deployment designate-bind units are blocked waiting for bind.
The syslog from the designate-bind unit reports that bind failed to start.
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: -------
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: BIND 9 is maintained by Internet Systems Consortium,
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: Inc. (ISC), a non-profit 501(c)(3) public-benefit
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: corporation. Support and training for BIND 9 are
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: available at https:/
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: -------
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: found 20 CPUs, using 20 worker threads
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: using 10 UDP listeners per interface
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: using up to 4096 sockets
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: loading configuration from '/etc/bind/
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: open: /etc/bind/
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: loading configuration: permission denied
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: exiting (due to fatal error)
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 systemd[1]: bind9.service: Main process exited, code=exited, status=1/FAILURE
The test run details are available at https:/
Changed in charm-designate-bind: | |
milestone: | none → 18.08 |
Changed in charm-designate-bind: | |
status: | Fix Committed → Fix Released |
This failure is surprising: named.conf: permission denied
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: open: /etc/bind/
Jul 19 07:43:58 juju-f3de6a-1-lxd-3 named[28676]: loading configuration: permission denied
Crashdump doesn't seem to capture those files (it grabs /etc/netplan and /etc/network but not /etc/bind).
There is a warning in the unit log:
2018-07-19 07:43:50 WARNING juju-log cluster:6: Request for sync sent but remote sync time is too old, defering until a more up-to-date target is available
I'm not sure where that is coming from.
We can see the charm writing the files here: named.conf. options root:root 640 named.conf root:root 640
2018-07-19 07:43:58 DEBUG juju-log dns-backend:76: Writing file /etc/bind/
2018-07-19 07:43:58 DEBUG worker.uniter.jujuc server.go:181 running hook tool "juju-log"
2018-07-19 07:43:58 DEBUG worker.uniter.jujuc server.go:181 running hook tool "network-get"
2018-07-19 07:43:58 DEBUG worker.uniter.jujuc server.go:181 running hook tool "juju-log"
2018-07-19 07:43:58 DEBUG juju-log dns-backend:76: Writing file /etc/bind/
Those both seem to be happening in 07:43:58. So it seems we just wrote the file, but bind is failing to read it?