Still seeing this with:
 - juju 2.0.0-xenial-amd64
 - lxd 2.0.8
 - Xenial 16.04.1 LTS

On the controller, /var/log/juju/machine-0.log appears to have the same contents as the juju debug-log output described in the issue, but I'm reproducing the contents here nevertheless:

ubuntu@juju-8c5551-0:~$ sudo cat /var/log/juju/machine-0.log
2017-02-01 01:58:15 INFO juju.cmd supercommand.go:63 running jujud [2.0.0 gc go1.6.2]
2017-02-01 01:58:15 DEBUG juju.cmd supercommand.go:64   args: []string{"/var/lib/juju/tools/machine-0/jujud", "machine", "--data-dir", "/var/lib/juju", "--machine-id", "0", "--debug"}
2017-02-01 01:58:15 DEBUG juju.agent agent.go:509 read agent config, format "2.0"
2017-02-01 01:58:15 INFO juju.cmd.jujud machine.go:404 machine agent machine-0 start (2.0.0 [gc])
2017-02-01 01:58:16 DEBUG juju.wrench wrench.go:112 couldn't read wrench directory: stat /var/lib/juju/wrench: no such file or directory
2017-02-01 01:58:16 INFO juju.worker.upgradesteps worker.go:72 no upgrade steps required or upgrade steps for 2.0.0 have already been run.
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "engine"
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "tools-version-checker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "machine-action-runner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "termination-signal-handler" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "state-config-watcher" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "upgrade-check-gate" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-config-watcher" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "proxy-config-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "reboot-executor" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "disk-manager" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-address-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "machiner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "ssh-identity-writer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "agent" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "state" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "migration-minion" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.introspection socket.go:72 introspection worker listening on "@jujud-machine-0"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "engine" started
2017-02-01 01:58:16 DEBUG juju.worker.introspection socket.go:96 stats worker now servering
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "serving-info-setter" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "unit-agent-deployer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "logging-config-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "mgo-txn-resumer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "host-key-reporter" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "unconverted-state-workers" manifold worker stopped: "state" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.apicaller connect.go:99 connecting with current password
2017-02-01 01:58:16 INFO juju.api apiclient.go:519 dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "upgrade-steps-gate" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "upgrade-steps-runner" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "unconverted-api-workers" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "log-sender" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "upgrade-check-flag" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "upgrade-steps-flag" manifold worker stopped: "upgrade-steps-gate" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "upgrader" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "upgrade-check-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "ssh-authkeys-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 INFO juju.api apiclient.go:528 error dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api": websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 DEBUG juju.worker.apicaller connect.go:139 failed to connect
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-caller" manifold worker stopped: cannot open api: unable to connect to API: websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 ERROR juju.worker.dependency engine.go:539 "api-caller" manifold worker returned unexpected error: cannot open api: unable to connect to API: websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "ssh-identity-writer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "tools-version-checker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "machine-action-runner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "state-config-watcher" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "state" manifold worker stopped: <nil>
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "proxy-config-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "api-config-watcher" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "reboot-executor" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "disk-manager" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-address-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "machiner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-caller" manifold worker stopped: <nil>
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "upgrader" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "upgrade-steps-runner" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not set: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "upgrade-steps-flag" manifold worker started
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: <nil>
2017-02-01 01:58:16 DEBUG juju.worker.apicaller connect.go:99 connecting with current password
2017-02-01 01:58:16 INFO juju.api apiclient.go:519 dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:16 INFO juju.api apiclient.go:528 error dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api": websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 DEBUG juju.service discovery.go:112 discovered init system "systemd" from local host
2017-02-01 01:58:16 DEBUG juju.worker.apicaller connect.go:139 failed to connect
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "api-caller" manifold worker stopped: cannot open api: unable to connect to API: websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 ERROR juju.worker.dependency engine.go:539 "api-caller" manifold worker returned unexpected error: cannot open api: unable to connect to API: websocket.Dial wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api: dial tcp 127.0.0.1:17070: getsockopt: connection refused
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not set: dependency not available
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "upgrade-check-flag" not set: dependency not available
2017-02-01 01:58:16 DEBUG juju.cmd.jujud machine.go:1303 mongodb service is installed
2017-02-01 01:58:16 INFO juju.state open.go:69 opening state, mongo addresses: ["127.0.0.1:37017"]; entity machine-0
2017-02-01 01:58:16 DEBUG juju.state open.go:70 dialing mongo
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:16 DEBUG juju.state open.go:75 connection established
2017-02-01 01:58:16 DEBUG juju.state open.go:82 mongodb login successful
2017-02-01 01:58:16 INFO juju.state state.go:354 starting standard state workers
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:53 starting leadership lease manager
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:59 starting singular lease manager
2017-02-01 01:58:16 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:16.232228611 +0000 UTC
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:65 starting transaction log watcher
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:71 starting presence watcher
2017-02-01 01:58:16 INFO juju.state state.go:370 creating cloud image metadata storage
2017-02-01 01:58:16 INFO juju.state state.go:376 started state for model-fb0f8b26-20d8-46ad-850f-0e846d8c5551 successfully
2017-02-01 01:58:16 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:16.234068553 +0000 UTC
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "state" manifold worker started
2017-02-01 01:58:16 INFO juju.worker.singular singular.go:57 runner created; isMaster true
2017-02-01 01:58:16 DEBUG juju.utils gomaxprocs.go:24 setting GOMAXPROCS to 1
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "peergrouper"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "peergrouper" started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "restore"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "restore" started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "mongoupgrade"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "mongoupgrade" started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "apiserver"
2017-02-01 01:58:16 DEBUG juju.cmd.jujud machine.go:964 opening state for apiserver worker
2017-02-01 01:58:16 INFO juju.state open.go:69 opening state, mongo addresses: ["127.0.0.1:37017"]; entity machine-0
2017-02-01 01:58:16 DEBUG juju.state open.go:70 dialing mongo
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "model worker manager"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "model worker manager" started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "certupdater"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "certupdater" started
2017-02-01 01:58:16 INFO juju.worker.singular singular.go:100 starting "dblogpruner"
2017-02-01 01:58:16 INFO juju.worker.singular singular.go:100 starting "txnpruner"
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:478 "unconverted-state-workers" manifold worker started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "dblogpruner"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "dblogpruner" started
2017-02-01 01:58:16 INFO juju.worker runner.go:256 start "txnpruner"
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "txnpruner" started
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:16 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not set: dependency not available
2017-02-01 01:58:16 DEBUG juju.state open.go:75 connection established
2017-02-01 01:58:16 DEBUG juju.state open.go:82 mongodb login successful
2017-02-01 01:58:16 INFO juju.state state.go:354 starting standard state workers
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:53 starting leadership lease manager
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:59 starting singular lease manager
2017-02-01 01:58:16 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:16.28521202 +0000 UTC
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:65 starting transaction log watcher
2017-02-01 01:58:16 DEBUG juju.state.workers dumb.go:71 starting presence watcher
2017-02-01 01:58:16 INFO juju.state state.go:370 creating cloud image metadata storage
2017-02-01 01:58:16 INFO juju.state state.go:376 started state for model-fb0f8b26-20d8-46ad-850f-0e846d8c5551 successfully
2017-02-01 01:58:16 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:16.285994538 +0000 UTC
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:16 INFO juju.apiserver apiserver.go:684 new certificate addresses: 
2017-02-01 01:58:16 DEBUG juju.worker runner.go:183 "apiserver" started
2017-02-01 01:58:16 INFO juju.apiserver apiserver.go:265 listening on "[::]:17070"
2017-02-01 01:58:16 DEBUG juju.apiserver apiserver.go:315 Starting API http server on address "[::]:17070"
2017-02-01 01:58:16 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:17 DEBUG juju.apiserver request_notifier.go:70 [1] API connection from 10.101.229.1:55252
2017-02-01 01:58:17 INFO juju.state state.go:354 starting standard state workers
2017-02-01 01:58:17 DEBUG juju.state.workers dumb.go:53 starting leadership lease manager
2017-02-01 01:58:17 DEBUG juju.state.workers dumb.go:59 starting singular lease manager
2017-02-01 01:58:17 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:17.879858611 +0000 UTC
2017-02-01 01:58:17 DEBUG juju.state.workers dumb.go:65 starting transaction log watcher
2017-02-01 01:58:17 DEBUG juju.state.workers dumb.go:71 starting presence watcher
2017-02-01 01:58:17 INFO juju.state state.go:370 creating cloud image metadata storage
2017-02-01 01:58:17 INFO juju.state state.go:376 started state for model-2c3090ee-3d0a-46df-8106-9d865f2b721b successfully
2017-02-01 01:58:17 DEBUG juju.apiserver request_notifier.go:115 <- [1]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:17 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:17.880308421 +0000 UTC
2017-02-01 01:58:17 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:18 DEBUG juju.apiserver admin.go:258 model login: user admin has "superuser" for controller; "admin" for model 2c3090ee-3d0a-46df-8106-9d865f2b721b
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:140 -> [1]  165.14417ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:115 <- [1] user-admin {"request-id":2,"type":"Block","version":2,"request":"List","params":"'params redacted'"}
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:140 -> [1] user-admin 53.901µs {"request-id":2,"error":"upgrade in progress","error-code":"upgrade in progress","response":"'body redacted'"} Block[""].List
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:80 [1] user-admin API connection terminated after 170.266788ms
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:70 [2] API connection from 10.101.229.1:55256
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:115 <- [2]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:18 DEBUG juju.apiserver admin.go:258 model login: user admin has "superuser" for controller; "admin" for model 2c3090ee-3d0a-46df-8106-9d865f2b721b
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:140 -> [2]  22.35731ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:115 <- [2] user-admin {"request-id":2,"type":"Block","version":2,"request":"List","params":"'params redacted'"}
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:140 -> [2] user-admin 55.301µs {"request-id":2,"error":"upgrade in progress","error-code":"upgrade in progress","response":"'body redacted'"} Block[""].List
2017-02-01 01:58:18 DEBUG juju.apiserver request_notifier.go:80 [2] user-admin API connection terminated after 33.168257ms
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:70 [3] API connection from 10.101.229.1:55258
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [3]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver admin.go:258 model login: user admin has "superuser" for controller; "admin" for model 2c3090ee-3d0a-46df-8106-9d865f2b721b
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [3]  30.078087ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [3] user-admin {"request-id":2,"type":"Block","version":2,"request":"List","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [3] user-admin 88.402µs {"request-id":2,"error":"upgrade in progress","error-code":"upgrade in progress","response":"'body redacted'"} Block[""].List
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:80 [3] user-admin API connection terminated after 32.84235ms
2017-02-01 01:58:19 DEBUG juju.worker.apicaller connect.go:99 connecting with current password
2017-02-01 01:58:19 INFO juju.api apiclient.go:519 dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:70 [4] API connection from 127.0.0.1:37364
2017-02-01 01:58:19 INFO juju.api apiclient.go:309 connection established to "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver admin.go:164 model login: machine-0 for fb0f8b26-20d8-46ad-850f-0e846d8c5551
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4]  209.441888ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:19 DEBUG juju.worker.apicaller connect.go:142 connected
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":2,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 738.917µs {"request-id":2,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":3,"type":"Agent","version":2,"request":"SetPasswords","params":"'params redacted'"}
2017-02-01 01:58:19 INFO juju.apiserver.common password.go:74 setting mongo password for "machine-0"
2017-02-01 01:58:19 INFO juju.apiserver.common password.go:105 setting password for "machine-0"
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 74.542304ms {"request-id":3,"response":"'body redacted'"} Agent[""].SetPasswords
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "api-caller" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "ssh-authkeys-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "tools-version-checker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machine-action-runner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "proxy-config-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "reboot-executor" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "disk-manager" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not set: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-address-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machiner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "ssh-identity-writer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-minion" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "serving-info-setter" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unit-agent-deployer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "logging-config-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "mgo-txn-resumer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "host-key-reporter" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unconverted-api-workers" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "log-sender" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "upgrader" manifold worker started
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":4,"type":"MigrationFlag","version":1,"request":"Phase","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":5,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":6,"type":"Upgrader","version":1,"request":"SetTools","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 3.024669ms {"request-id":5,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":7,"type":"Machiner","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 1.951244ms {"request-id":7,"response":"'body redacted'"} Machiner[""].Life
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "upgrade-steps-runner" manifold worker started
2017-02-01 01:58:19 DEBUG juju.wrench wrench.go:112 couldn't read wrench directory: stat /var/lib/juju/wrench: no such file or directory
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "upgrade-steps-runner" manifold worker stopped: <nil>
2017-02-01 01:58:19 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 31.912329ms {"request-id":4,"response":"'body redacted'"} MigrationFlag[""].Phase
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "migration-inactive-flag" manifold worker started
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":8,"type":"MigrationFlag","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 189.204µs {"request-id":8,"response":"'body redacted'"} MigrationFlag[""].Watch
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":9,"type":"MigrationFlag","version":1,"request":"Phase","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":10,"type":"NotifyWatcher","version":1,"id":"2","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 1.098525ms {"request-id":9,"response":"'body redacted'"} MigrationFlag[""].Phase
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "ssh-identity-writer" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "tools-version-checker" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machine-action-runner" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "proxy-config-updater" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "reboot-executor" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "disk-manager" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-address-updater" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machiner" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "ssh-authkeys-updater" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "serving-info-setter" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unit-agent-deployer" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "logging-config-updater" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "mgo-txn-resumer" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "host-key-reporter" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unconverted-api-workers" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "log-sender" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 283.136173ms {"request-id":6,"response":"'body redacted'"} Upgrader[""].SetTools
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":11,"type":"Upgrader","version":1,"request":"WatchAPIVersion","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 530.512µs {"request-id":11,"response":"'body redacted'"} Upgrader[""].WatchAPIVersion
2017-02-01 01:58:19 INFO juju.worker.upgrader upgrader.go:139 abort check blocked until version event received
2017-02-01 01:58:19 INFO juju.worker.upgrader upgrader.go:145 unblocking abort check
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":12,"type":"Upgrader","version":1,"request":"DesiredVersion","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":13,"type":"NotifyWatcher","version":1,"id":"3","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 449.31µs {"request-id":12,"response":"'body redacted'"} Upgrader[""].DesiredVersion
2017-02-01 01:58:19 INFO juju.worker.upgrader upgrader.go:178 desired tool version: 2.0.0
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "txnpruner"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "upgrade-check-flag" manifold worker stopped: gate unlocked
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "peergrouper"
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "restore"
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "mongoupgrade"
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "model worker manager"
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "certupdater"
2017-02-01 01:58:19 DEBUG juju.cmd.jujud machine.go:1385 upgrades done, starting worker "dblogpruner"
2017-02-01 01:58:19 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "log-forwarder" manifold worker stopped: "upgrade-check-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "upgrade-check-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "upgrade-check-flag" manifold worker started
2017-02-01 01:58:19 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:19 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:19 INFO juju.worker runner.go:256 start "fb0f8b26-20d8-46ad-850f-0e846d8c5551"
2017-02-01 01:58:19 DEBUG juju.workers.modelworkermanager modelworkermanager.go:129 starting workers for model "fb0f8b26-20d8-46ad-850f-0e846d8c5551"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "migration-fortress" manifold worker started
2017-02-01 01:58:19 INFO juju.worker runner.go:256 start "2c3090ee-3d0a-46df-8106-9d865f2b721b"
2017-02-01 01:58:19 DEBUG juju.workers.modelworkermanager modelworkermanager.go:129 starting workers for model "2c3090ee-3d0a-46df-8106-9d865f2b721b"
2017-02-01 01:58:19 DEBUG juju.worker.certupdater certupdater.go:118 new machine addresses: []network.Address{local-cloud:10.101.229.96}
2017-02-01 01:58:19 DEBUG juju.worker runner.go:183 "fb0f8b26-20d8-46ad-850f-0e846d8c5551" started
2017-02-01 01:58:19 DEBUG juju.worker runner.go:183 "2c3090ee-3d0a-46df-8106-9d865f2b721b" started
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":14,"type":"Agent","version":2,"request":"ControllerConfig","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.tools.lxdclient client.go:199 connecting to LXD remote "remote": "10.101.229.1:8443"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "not-dead-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "environ-tracker" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "firewaller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "application-scaler" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "status-history-pruner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "clock" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "spaces-imported-gate" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "state-cleaner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machine-undertaker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-config-watcher" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "metric-worker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "state-cleaner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "not-dead-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "not-alive-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "agent" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "clock" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "spaces-imported-gate" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "environ-tracker" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-config-watcher" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "status-history-pruner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "machine-undertaker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unit-assigner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "application-scaler" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-caller" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "is-responsible-flag" manifold worker stopped: "clock" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "firewaller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "agent" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "api-caller" manifold worker stopped: "agent" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "not-alive-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "is-responsible-flag" manifold worker stopped: "clock" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "unit-assigner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "metric-worker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 22.515514ms {"request-id":14,"response":"'body redacted'"} Agent[""].ControllerConfig
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "migration-minion" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.certupdater certupdater.go:189 existing cert addresses map[]
2017-02-01 01:58:19 DEBUG juju.worker.certupdater certupdater.go:190 new addresses [localhost juju-apiserver juju-mongodb anything 10.101.229.96]
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "log-forwarder" manifold worker started
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":15,"type":"MigrationMinion","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 117.002µs {"request-id":15,"response":"'body redacted'"} MigrationMinion[""].Watch
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "api-config-watcher" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.apicaller connect.go:99 connecting with current password
2017-02-01 01:58:19 INFO juju.api apiclient.go:519 dialing "wss://localhost:17070/model/2c3090ee-3d0a-46df-8106-9d865f2b721b/api"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "is-responsible-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.apicaller connect.go:99 connecting with current password
2017-02-01 01:58:19 INFO juju.api apiclient.go:519 dialing "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:478 "api-config-watcher" manifold worker started
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "is-responsible-flag" manifold worker stopped: "api-caller" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":16,"type":"Agent","version":2,"request":"WatchForModelConfigChanges","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":17,"type":"MigrationStatusWatcher","version":1,"id":"4","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:19 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 31.02701ms {"request-id":16,"response":"'body redacted'"} Agent[""].WatchForModelConfigChanges
2017-02-01 01:58:19 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":{"api_extensions":["id_map"],"api_status":"stable","api_version":"1.0","auth":"trusted","config":{"core.https_address":"[::]","storage.zfs_pool_name":"lxd"},"environment":{"addresses":["172.16.144.97:8443","10.101.229.1:8443"],"architectures":["x86_64","i686"],"certificate":"-----BEGIN CERTIFICATE-----\nMIIFWTCCA0GgAwIBAgIRAPchIDsBRbhRkmXzo12AHDswDQYJKoZIhvcNAQELBQAw\nPDEcMBoGA1UEChMTbGludXhjb250YWluZXJzLm9yZzEcMBoGA1UEAwwTcm9vdEBh\nc2FkLXVidW50dS0xNjAeFw0xNzAyMDEwMTI1MzFaFw0yNzAxMzAwMTI1MzFaMDwx\nHDAaBgNVBAoTE2xpbnV4Y29udGFpbmVycy5vcmcxHDAaBgNVBAMME3Jvb3RAYXNh\nZC11YnVudHUtMTYwggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQCix7my\nM4fGYRsoUiialbS5OsHICp4vtDIeJv4S/OA2FqUDhjH736sI4UR5FeC2UK8cQ73c\ns92TxUWMWrGCkQsq+k7yRYuvPyVXaSMqhmT62MlvQBFSMK4nxTEIN13raJsZ4dKj\n2PwR+VaRfJu9Z7H2uamNvcp6mSEH2yJ7Wc479c593fxv+gbq30Fpv3zO0yqyo1wc\nW0B0ML7vqCUr8IVkwO/1Bkn5vqAM9LOqWCu0i6kMnHXrBI3LvnNjVaUhyuRKHJKP\nZX97g1xU/npYd7ec0fHibaUb2fWvKoMIGvROKK3LzaCZj6yoVAhD48dg8lZFWXmv\ny8yg2KjHQM3ddfjuFafa5ea0YOUbXgsNMQjUp2pQu11ArPqyXwKglVwS10FgARd1\nI8eMtZZ5H/ZE8uwiO3s3x5/MUEKtEuXm5dUtE7L4ZyNW+7wX4fexJnxqa6flejfY\nwezAdBYZMY6QtvnkxjzcBZUjZ67cAnDNgbehxN12XlGcZUUhhW62TgfAIAvNNjIX\nuYSLUvvD4wnM3pgU8P5JzfXsgu9gqllL70x3HbC6WTjK9jj1bH8V5EpimBC2OtkV\nTEiPg1VOml8enq3pCan8gyQHufReJcq29jWnlRs1cWUCQp6sPWnke0CyMrr/bOeQ\nwD0kYqCxouU+m8g6tlsB9cgkMtJ++kMVoFfzOQIDAQABo1YwVDAOBgNVHQ8BAf8E\nBAMCBaAwEwYDVR0lBAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAfBgNVHREE\nGDAWgg5hc2FkLXVidW50dS0xNocErBCQYTANBgkqhkiG9w0BAQsFAAOCAgEAO2eF\nxwwayFySu87YjZDF8LN03H83/huN2IMCsIGjNGAocP8DGO71opQZLhTQU4IELxfc\nc8jmnbS96IqhL/8YilfKS+NiPBqdpPs1yAjPkiieoFN0SxG3vWM/oaKrDlGu0yhi\nfLg22b51UphhdWFYcwqB4MfzZyRIpgL/Ptgdf9hV0Pgm8gvgD3j5+1TYZ2CJX4WN\neNrhHU3DLqZtR2ffVpoTFM6rncp9GUKYlkAgVelbEoqmQqEFIYiuI+rCmRnlbJFB\naZ+yg3aMJ9Qu/IZVfuEE4mQX0NkxVB+Oo5a9RuBCppw5iO1fJQhKrFKq3wXea7BR\nfsT8kDleucS3VMDkZAPEB24HDxt4kDJ5imqVtaARkg3K+pDzj+M0Flw+7/YSP+Nb\n3Gj179NrT0kz5PZleWOZJQXVFzbIPzjushnFojXXue+QINhQzXAwY1yBtPDf0YrW\nPAD55HLmZYfzqUtGelfnDbUFD8U2VUp31ZsNsgZAgSWTiqH2hkGfc6ZI+Q8Wzzmr\n/xvikE1n9ZdR7lRPKo/RrDZt6vKermh1ELE3Ku9HsFzIj1E9VZVgB+vtqXF1qQwK\nv/bvKZf1u86w3P6BDHuFemfLLw9QoBMnNWHmXcwQgwhEAl5q18Y9advH3u2+1Woo\nmZqFaraseYVPsaG+AsLZ+DXrhmvywFFF9vVrLTI=\n-----END CERTIFICATE-----\n","driver":"lxc","driver_version":"2.0.6","kernel":"Linux","kernel_architecture":"x86_64","kernel_version":"4.4.0-31-generic","server":"lxd","server_pid":17652,"server_version":"2.0.8","storage":"zfs","storage_version":"5"},"public":false}}
2017-02-01 01:58:19 INFO juju.tools.lxdclient client.go:247 using LXD API version "1.0"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 26.038095ms {"request-id":17,"response":"'body redacted'"} MigrationStatusWatcher["4"].Next
2017-02-01 01:58:20 INFO juju.worker.migrationminion worker.go:116 migration phase is now: NONE
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "ssh-authkeys-updater" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "storage-provisioner" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "machine-action-runner" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "proxy-config-updater" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "reboot-executor" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "disk-manager" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "api-address-updater" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.logger logger.go:34 initial log config: "<root>=DEBUG"
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "logging-config-updater" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "host-key-reporter" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.logger logger.go:65 logger setup
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "log-sender" manifold worker started
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":18,"type":"Agent","version":2,"request":"ModelConfig","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":19,"type":"NotifyWatcher","version":1,"id":"5","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":20,"type":"MigrationStatusWatcher","version":1,"id":"4","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":21,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":22,"type":"Agent","version":2,"request":"ModelConfig","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":23,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":24,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":25,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":26,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":27,"type":"Agent","version":2,"request":"GetEntities","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":28,"type":"KeyUpdater","version":1,"request":"AuthorisedKeys","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":29,"type":"StorageProvisioner","version":3,"request":"WatchBlockDevices","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":30,"type":"MachineActions","version":1,"request":"RunningActions","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":31,"type":"ProxyUpdater","version":1,"request":"ProxyConfig","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":32,"type":"Reboot","version":2,"request":"WatchForRebootEvent","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":33,"type":"Machiner","version":1,"request":"WatchAPIHostPorts","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":34,"type":"Logger","version":1,"request":"LoggingConfig","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":35,"type":"HostKeyReporter","version":1,"request":"ReportKeys","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:70 [5] API connection from 127.0.0.1:37378
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:70 [6] API connection from 127.0.0.1:37376
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:70 [7] API connection from 10.101.229.1:55278
2017-02-01 01:58:20 INFO juju.api apiclient.go:309 connection established to "wss://localhost:17070/model/fb0f8b26-20d8-46ad-850f-0e846d8c5551/api"
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 142.569861ms {"request-id":27,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 68.350863ms {"request-id":21,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 74.130296ms {"request-id":18,"response":"'body redacted'"} Agent[""].ModelConfig
2017-02-01 01:58:20 INFO juju.api apiclient.go:309 connection established to "wss://localhost:17070/model/2c3090ee-3d0a-46df-8106-9d865f2b721b/api"
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [7]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 163.635043ms {"request-id":26,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 175.416213ms {"request-id":23,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 185.518244ms {"request-id":24,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "10.101.229.96:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 197.478017ms {"request-id":25,"response":"'body redacted'"} Agent[""].GetEntities
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 67.901953ms {"request-id":22,"response":"'body redacted'"} Agent[""].ModelConfig
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 220.431743ms {"request-id":28,"response":"'body redacted'"} KeyUpdater[""].AuthorisedKeys
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6]  {"request-id":1,"type":"Admin","version":3,"request":"Login","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":{"api_extensions":["id_map"],"api_status":"stable","api_version":"1.0","auth":"trusted","config":{"core.https_address":"[::]","storage.zfs_pool_name":"lxd"},"environment":{"addresses":["172.16.144.97:8443","10.101.229.1:8443"],"architectures":["x86_64","i686"],"certificate":"-----BEGIN CERTIFICATE-----\nMIIFWTCCA0GgAwIBAgIRAPchIDsBRbhRkmXzo12AHDswDQYJKoZIhvcNAQELBQAw\nPDEcMBoGA1UEChMTbGludXhjb250YWluZXJzLm9yZzEcMBoGA1UEAwwTcm9vdEBh\nc2FkLXVidW50dS0xNjAeFw0xNzAyMDEwMTI1MzFaFw0yNzAxMzAwMTI1MzFaMDwx\nHDAaBgNVBAoTE2xpbnV4Y29udGFpbmVycy5vcmcxHDAaBgNVBAMME3Jvb3RAYXNh\nZC11YnVudHUtMTYwggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQCix7my\nM4fGYRsoUiialbS5OsHICp4vtDIeJv4S/OA2FqUDhjH736sI4UR5FeC2UK8cQ73c\ns92TxUWMWrGCkQsq+k7yRYuvPyVXaSMqhmT62MlvQBFSMK4nxTEIN13raJsZ4dKj\n2PwR+VaRfJu9Z7H2uamNvcp6mSEH2yJ7Wc479c593fxv+gbq30Fpv3zO0yqyo1wc\nW0B0ML7vqCUr8IVkwO/1Bkn5vqAM9LOqWCu0i6kMnHXrBI3LvnNjVaUhyuRKHJKP\nZX97g1xU/npYd7ec0fHibaUb2fWvKoMIGvROKK3LzaCZj6yoVAhD48dg8lZFWXmv\ny8yg2KjHQM3ddfjuFafa5ea0YOUbXgsNMQjUp2pQu11ArPqyXwKglVwS10FgARd1\nI8eMtZZ5H/ZE8uwiO3s3x5/MUEKtEuXm5dUtE7L4ZyNW+7wX4fexJnxqa6flejfY\nwezAdBYZMY6QtvnkxjzcBZUjZ67cAnDNgbehxN12XlGcZUUhhW62TgfAIAvNNjIX\nuYSLUvvD4wnM3pgU8P5JzfXsgu9gqllL70x3HbC6WTjK9jj1bH8V5EpimBC2OtkV\nTEiPg1VOml8enq3pCan8gyQHufReJcq29jWnlRs1cWUCQp6sPWnke0CyMrr/bOeQ\nwD0kYqCxouU+m8g6tlsB9cgkMtJ++kMVoFfzOQIDAQABo1YwVDAOBgNVHQ8BAf8E\nBAMCBaAwEwYDVR0lBAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAfBgNVHREE\nGDAWgg5hc2FkLXVidW50dS0xNocErBCQYTANBgkqhkiG9w0BAQsFAAOCAgEAO2eF\nxwwayFySu87YjZDF8LN03H83/huN2IMCsIGjNGAocP8DGO71opQZLhTQU4IELxfc\nc8jmnbS96IqhL/8YilfKS+NiPBqdpPs1yAjPkiieoFN0SxG3vWM/oaKrDlGu0yhi\nfLg22b51UphhdWFYcwqB4MfzZyRIpgL/Ptgdf9hV0Pgm8gvgD3j5+1TYZ2CJX4WN\neNrhHU3DLqZtR2ffVpoTFM6rncp9GUKYlkAgVelbEoqmQqEFIYiuI+rCmRnlbJFB\naZ+yg3aMJ9Qu/IZVfuEE4mQX0NkxVB+Oo5a9RuBCppw5iO1fJQhKrFKq3wXea7BR\nfsT8kDleucS3VMDkZAPEB24HDxt4kDJ5imqVtaARkg3K+pDzj+M0Flw+7/YSP+Nb\n3Gj179NrT0kz5PZleWOZJQXVFzbIPzjushnFojXXue+QINhQzXAwY1yBtPDf0YrW\nPAD55HLmZYfzqUtGelfnDbUFD8U2VUp31ZsNsgZAgSWTiqH2hkGfc6ZI+Q8Wzzmr\n/xvikE1n9ZdR7lRPKo/RrDZt6vKermh1ELE3Ku9HsFzIj1E9VZVgB+vtqXF1qQwK\nv/bvKZf1u86w3P6BDHuFemfLLw9QoBMnNWHmXcwQgwhEAl5q18Y9advH3u2+1Woo\nmZqFaraseYVPsaG+AsLZ+DXrhmvywFFF9vVrLTI=\n-----END CERTIFICATE-----\n","driver":"lxc","driver_version":"2.0.6","kernel":"Linux","kernel_architecture":"x86_64","kernel_version":"4.4.0-31-generic","server":"lxd","server_pid":17652,"server_version":"2.0.8","storage":"zfs","storage_version":"5"},"public":false}}
2017-02-01 01:58:20 WARNING juju.cmd.jujud machine.go:808 determining kvm support: INFO: Your CPU does not support KVM extensions
KVM acceleration can NOT be used
: exit status 1
no kvm containers possible
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "tools-version-checker" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "mgo-txn-resumer" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "ssh-identity-writer" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "unit-agent-deployer" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "machiner" manifold worker started
2017-02-01 01:58:20 INFO juju.agent identity.go:22 writing system identity file
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "ssh-identity-writer" manifold worker stopped: <nil>
2017-02-01 01:58:20 INFO juju.worker.logforwarder logforwarder.go:103 config change - log forwarding not enabled
2017-02-01 01:58:20 DEBUG juju.utils.ssh authorisedkeys.go:92 reading authorised keys file /home/ubuntu/.ssh/authorized_keys
2017-02-01 01:58:20 DEBUG juju.utils.ssh authorisedkeys.go:92 reading authorised keys file /home/ubuntu/.ssh/authorized_keys
2017-02-01 01:58:20 DEBUG juju.utils.ssh authorisedkeys.go:129 writing authorised keys file /home/ubuntu/.ssh/authorized_keys
2017-02-01 01:58:20 INFO juju.cmd.jujud machine.go:972 update apiserver worker with new certificate
2017-02-01 01:58:20 INFO juju.worker.certupdater certupdater.go:174 controller cerificate addresses updated to ["10.101.229.96" "anything" "juju-apiserver" "juju-mongodb" "localhost"]
2017-02-01 01:58:20 INFO juju.apiserver apiserver.go:657 received API server certificate
2017-02-01 01:58:20 INFO juju.apiserver apiserver.go:684 new certificate addresses: 10.101.229.96
2017-02-01 01:58:20 DEBUG juju.tools.lxdclient client.go:199 connecting to LXD remote "remote": "10.101.229.1:8443"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":36,"type":"Agent","version":2,"request":"StateServingInfo","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":37,"type":"Provisioner","version":3,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":38,"type":"Deployer","version":1,"request":"WatchUnits","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":39,"type":"Machiner","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":40,"type":"KeyUpdater","version":1,"request":"WatchAuthorisedKeys","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":41,"type":"AgentTools","version":1,"request":"UpdateToolsAvailable","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":42,"type":"Resumer","version":2,"request":"ResumeTransactions","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.worker.certupdater certupdater.go:111 addresses haven't really changed since last updated cert
2017-02-01 01:58:20 DEBUG juju.apiserver admin.go:164 model login: machine-0 for 2c3090ee-3d0a-46df-8106-9d865f2b721b
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6]  66.308917ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:20 DEBUG juju.worker.apicaller connect.go:142 connected
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "api-caller" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "metric-worker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "state-cleaner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "environ-tracker" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "status-history-pruner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "machine-undertaker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "unit-assigner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "application-scaler" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "firewaller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.apiserver admin.go:164 model login: machine-0 for fb0f8b26-20d8-46ad-850f-0e846d8c5551
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":2,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":3,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":4,"type":"Singular","version":1,"request":"Claim","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5]  253.229993ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 13.602912ms {"request-id":3,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 21.343588ms {"request-id":2,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.worker.apicaller connect.go:142 connected
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "api-caller" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "not-dead-flag" manifold worker started
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "not-alive-flag" manifold worker started
2017-02-01 01:58:20 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":[{"name":"default","config":{},"description":"Default LXD profile","devices":{"eth0":{"name":"eth0","nictype":"bridged","parent":"lxdbr0","type":"nic"}}},{"name":"docker","config":{"linux.kernel_modules":"overlay, nf_nat","security.nesting":"true"},"description":"Profile supporting docker in containers","devices":{"aadisable":{"path":"/sys/module/apparmor/parameters/enabled","source":"/dev/null","type":"disk"}}},{"name":"juju-controller","config":{"boot.autostart":"true","security.nesting":"true"},"description":"","devices":{}},{"name":"juju-default","config":{"boot.autostart":"true","security.nesting":"true"},"description":"","devices":{}}]}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":5,"type":"LifeFlag","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":6,"type":"LifeFlag","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 5.674329ms {"request-id":5,"response":"'body redacted'"} LifeFlag[""].Watch
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:254 controller machines in state: []string{"0"}
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:272 found new machine "0"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 12.66139ms {"request-id":6,"response":"'body redacted'"} LifeFlag[""].Watch
2017-02-01 01:58:20 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":{"api_extensions":["id_map"],"api_status":"stable","api_version":"1.0","auth":"trusted","config":{"core.https_address":"[::]","storage.zfs_pool_name":"lxd"},"environment":{"addresses":["172.16.144.97:8443","10.101.229.1:8443"],"architectures":["x86_64","i686"],"certificate":"-----BEGIN CERTIFICATE-----\nMIIFWTCCA0GgAwIBAgIRAPchIDsBRbhRkmXzo12AHDswDQYJKoZIhvcNAQELBQAw\nPDEcMBoGA1UEChMTbGludXhjb250YWluZXJzLm9yZzEcMBoGA1UEAwwTcm9vdEBh\nc2FkLXVidW50dS0xNjAeFw0xNzAyMDEwMTI1MzFaFw0yNzAxMzAwMTI1MzFaMDwx\nHDAaBgNVBAoTE2xpbnV4Y29udGFpbmVycy5vcmcxHDAaBgNVBAMME3Jvb3RAYXNh\nZC11YnVudHUtMTYwggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQCix7my\nM4fGYRsoUiialbS5OsHICp4vtDIeJv4S/OA2FqUDhjH736sI4UR5FeC2UK8cQ73c\ns92TxUWMWrGCkQsq+k7yRYuvPyVXaSMqhmT62MlvQBFSMK4nxTEIN13raJsZ4dKj\n2PwR+VaRfJu9Z7H2uamNvcp6mSEH2yJ7Wc479c593fxv+gbq30Fpv3zO0yqyo1wc\nW0B0ML7vqCUr8IVkwO/1Bkn5vqAM9LOqWCu0i6kMnHXrBI3LvnNjVaUhyuRKHJKP\nZX97g1xU/npYd7ec0fHibaUb2fWvKoMIGvROKK3LzaCZj6yoVAhD48dg8lZFWXmv\ny8yg2KjHQM3ddfjuFafa5ea0YOUbXgsNMQjUp2pQu11ArPqyXwKglVwS10FgARd1\nI8eMtZZ5H/ZE8uwiO3s3x5/MUEKtEuXm5dUtE7L4ZyNW+7wX4fexJnxqa6flejfY\nwezAdBYZMY6QtvnkxjzcBZUjZ67cAnDNgbehxN12XlGcZUUhhW62TgfAIAvNNjIX\nuYSLUvvD4wnM3pgU8P5JzfXsgu9gqllL70x3HbC6WTjK9jj1bH8V5EpimBC2OtkV\nTEiPg1VOml8enq3pCan8gyQHufReJcq29jWnlRs1cWUCQp6sPWnke0CyMrr/bOeQ\nwD0kYqCxouU+m8g6tlsB9cgkMtJ++kMVoFfzOQIDAQABo1YwVDAOBgNVHQ8BAf8E\nBAMCBaAwEwYDVR0lBAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAfBgNVHREE\nGDAWgg5hc2FkLXVidW50dS0xNocErBCQYTANBgkqhkiG9w0BAQsFAAOCAgEAO2eF\nxwwayFySu87YjZDF8LN03H83/huN2IMCsIGjNGAocP8DGO71opQZLhTQU4IELxfc\nc8jmnbS96IqhL/8YilfKS+NiPBqdpPs1yAjPkiieoFN0SxG3vWM/oaKrDlGu0yhi\nfLg22b51UphhdWFYcwqB4MfzZyRIpgL/Ptgdf9hV0Pgm8gvgD3j5+1TYZ2CJX4WN\neNrhHU3DLqZtR2ffVpoTFM6rncp9GUKYlkAgVelbEoqmQqEFIYiuI+rCmRnlbJFB\naZ+yg3aMJ9Qu/IZVfuEE4mQX0NkxVB+Oo5a9RuBCppw5iO1fJQhKrFKq3wXea7BR\nfsT8kDleucS3VMDkZAPEB24HDxt4kDJ5imqVtaARkg3K+pDzj+M0Flw+7/YSP+Nb\n3Gj179NrT0kz5PZleWOZJQXVFzbIPzjushnFojXXue+QINhQzXAwY1yBtPDf0YrW\nPAD55HLmZYfzqUtGelfnDbUFD8U2VUp31ZsNsgZAgSWTiqH2hkGfc6ZI+Q8Wzzmr\n/xvikE1n9ZdR7lRPKo/RrDZt6vKermh1ELE3Ku9HsFzIj1E9VZVgB+vtqXF1qQwK\nv/bvKZf1u86w3P6BDHuFemfLLw9QoBMnNWHmXcwQgwhEAl5q18Y9advH3u2+1Woo\nmZqFaraseYVPsaG+AsLZ+DXrhmvywFFF9vVrLTI=\n-----END CERTIFICATE-----\n","driver":"lxc","driver_version":"2.0.6","kernel":"Linux","kernel_architecture":"x86_64","kernel_version":"4.4.0-31-generic","server":"lxd","server_pid":17652,"server_version":"2.0.8","storage":"zfs","storage_version":"5"},"public":false}}
2017-02-01 01:58:20 INFO juju.tools.lxdclient client.go:247 using LXD API version "1.0"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":7,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":8,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":9,"type":"NotifyWatcher","version":1,"id":"2","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":10,"type":"NotifyWatcher","version":1,"id":"1","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not set: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "metric-worker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "environ-tracker" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "firewaller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "application-scaler" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "status-history-pruner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "state-cleaner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "machine-undertaker" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "space-importer" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "compute-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "storage-provisioner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "instance-poller" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "not-dead-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "unit-assigner" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "charm-revision-updater" manifold worker stopped: "migration-inactive-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:303 machine "0" not ready: pending
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:254 controller machines in state: []string{"0"}
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:272 found new machine "0"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 9.595919ms {"request-id":8,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":2,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":3,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":4,"type":"Singular","version":1,"request":"Claim","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 10.113031ms {"request-id":7,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 5.591228ms {"request-id":2,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.apiserver admin.go:258 model login: user admin has "superuser" for controller; "admin" for model 2c3090ee-3d0a-46df-8106-9d865f2b721b
2017-02-01 01:58:20 DEBUG juju.worker.peergrouper worker.go:303 machine "0" not ready: pending
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "not-dead-flag" manifold worker started
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 7.203965ms {"request-id":3,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "not-alive-flag" manifold worker started
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":5,"type":"LifeFlag","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":6,"type":"LifeFlag","version":1,"request":"Watch","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [7]  304.606169ms {"request-id":1,"response":"'body redacted'"} Admin[""].Login
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 5.232919ms {"request-id":6,"response":"'body redacted'"} LifeFlag[""].Watch
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [7] user-admin {"request-id":2,"type":"Block","version":2,"request":"List","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 6.171141ms {"request-id":5,"response":"'body redacted'"} LifeFlag[""].Watch
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not set: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-inactive-flag" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-fortress" manifold worker stopped: "is-responsible-flag" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":7,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":8,"type":"LifeFlag","version":1,"request":"Life","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":9,"type":"NotifyWatcher","version":1,"id":"3","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [5] machine-0 {"request-id":10,"type":"NotifyWatcher","version":1,"id":"2","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 4.326499ms {"request-id":8,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [5] machine-0 4.695308ms {"request-id":7,"response":"'body redacted'"} LifeFlag[""].Life
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [7] user-admin 32.501644ms {"request-id":2,"response":"'body redacted'"} Block[""].List
2017-02-01 01:58:20 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":{"api_extensions":["id_map"],"api_status":"stable","api_version":"1.0","auth":"trusted","config":{"core.https_address":"[::]","storage.zfs_pool_name":"lxd"},"environment":{"addresses":["172.16.144.97:8443","10.101.229.1:8443"],"architectures":["x86_64","i686"],"certificate":"-----BEGIN CERTIFICATE-----\nMIIFWTCCA0GgAwIBAgIRAPchIDsBRbhRkmXzo12AHDswDQYJKoZIhvcNAQELBQAw\nPDEcMBoGA1UEChMTbGludXhjb250YWluZXJzLm9yZzEcMBoGA1UEAwwTcm9vdEBh\nc2FkLXVidW50dS0xNjAeFw0xNzAyMDEwMTI1MzFaFw0yNzAxMzAwMTI1MzFaMDwx\nHDAaBgNVBAoTE2xpbnV4Y29udGFpbmVycy5vcmcxHDAaBgNVBAMME3Jvb3RAYXNh\nZC11YnVudHUtMTYwggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQCix7my\nM4fGYRsoUiialbS5OsHICp4vtDIeJv4S/OA2FqUDhjH736sI4UR5FeC2UK8cQ73c\ns92TxUWMWrGCkQsq+k7yRYuvPyVXaSMqhmT62MlvQBFSMK4nxTEIN13raJsZ4dKj\n2PwR+VaRfJu9Z7H2uamNvcp6mSEH2yJ7Wc479c593fxv+gbq30Fpv3zO0yqyo1wc\nW0B0ML7vqCUr8IVkwO/1Bkn5vqAM9LOqWCu0i6kMnHXrBI3LvnNjVaUhyuRKHJKP\nZX97g1xU/npYd7ec0fHibaUb2fWvKoMIGvROKK3LzaCZj6yoVAhD48dg8lZFWXmv\ny8yg2KjHQM3ddfjuFafa5ea0YOUbXgsNMQjUp2pQu11ArPqyXwKglVwS10FgARd1\nI8eMtZZ5H/ZE8uwiO3s3x5/MUEKtEuXm5dUtE7L4ZyNW+7wX4fexJnxqa6flejfY\nwezAdBYZMY6QtvnkxjzcBZUjZ67cAnDNgbehxN12XlGcZUUhhW62TgfAIAvNNjIX\nuYSLUvvD4wnM3pgU8P5JzfXsgu9gqllL70x3HbC6WTjK9jj1bH8V5EpimBC2OtkV\nTEiPg1VOml8enq3pCan8gyQHufReJcq29jWnlRs1cWUCQp6sPWnke0CyMrr/bOeQ\nwD0kYqCxouU+m8g6tlsB9cgkMtJ++kMVoFfzOQIDAQABo1YwVDAOBgNVHQ8BAf8E\nBAMCBaAwEwYDVR0lBAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAfBgNVHREE\nGDAWgg5hc2FkLXVidW50dS0xNocErBCQYTANBgkqhkiG9w0BAQsFAAOCAgEAO2eF\nxwwayFySu87YjZDF8LN03H83/huN2IMCsIGjNGAocP8DGO71opQZLhTQU4IELxfc\nc8jmnbS96IqhL/8YilfKS+NiPBqdpPs1yAjPkiieoFN0SxG3vWM/oaKrDlGu0yhi\nfLg22b51UphhdWFYcwqB4MfzZyRIpgL/Ptgdf9hV0Pgm8gvgD3j5+1TYZ2CJX4WN\neNrhHU3DLqZtR2ffVpoTFM6rncp9GUKYlkAgVelbEoqmQqEFIYiuI+rCmRnlbJFB\naZ+yg3aMJ9Qu/IZVfuEE4mQX0NkxVB+Oo5a9RuBCppw5iO1fJQhKrFKq3wXea7BR\nfsT8kDleucS3VMDkZAPEB24HDxt4kDJ5imqVtaARkg3K+pDzj+M0Flw+7/YSP+Nb\n3Gj179NrT0kz5PZleWOZJQXVFzbIPzjushnFojXXue+QINhQzXAwY1yBtPDf0YrW\nPAD55HLmZYfzqUtGelfnDbUFD8U2VUp31ZsNsgZAgSWTiqH2hkGfc6ZI+Q8Wzzmr\n/xvikE1n9ZdR7lRPKo/RrDZt6vKermh1ELE3Ku9HsFzIj1E9VZVgB+vtqXF1qQwK\nv/bvKZf1u86w3P6BDHuFemfLLw9QoBMnNWHmXcwQgwhEAl5q18Y9advH3u2+1Woo\nmZqFaraseYVPsaG+AsLZ+DXrhmvywFFF9vVrLTI=\n-----END CERTIFICATE-----\n","driver":"lxc","driver_version":"2.0.6","kernel":"Linux","kernel_architecture":"x86_64","kernel_version":"4.4.0-31-generic","server":"lxd","server_pid":17652,"server_version":"2.0.8","storage":"zfs","storage_version":"5"},"public":false}}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:80 [7] user-admin API connection terminated after 442.185016ms
2017-02-01 01:58:20 DEBUG juju.worker.lease manager.go:217 waking to check leases at 2017-02-01 01:59:20.449101433 +0000 UTC
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [6] machine-0 234.895274ms {"request-id":4,"response":"'body redacted'"} Singular[""].Claim
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "is-responsible-flag" manifold worker started
2017-02-01 01:58:20 DEBUG lxd client.go:68 Raw response: {"type":"sync","status":"Success","status_code":200,"metadata":[{"name":"default","config":{},"description":"Default LXD profile","devices":{"eth0":{"name":"eth0","nictype":"bridged","parent":"lxdbr0","type":"nic"}}},{"name":"docker","config":{"linux.kernel_modules":"overlay, nf_nat","security.nesting":"true"},"description":"Profile supporting docker in containers","devices":{"aadisable":{"path":"/sys/module/apparmor/parameters/enabled","source":"/dev/null","type":"disk"}}},{"name":"juju-controller","config":{"boot.autostart":"true","security.nesting":"true"},"description":"","devices":{}},{"name":"juju-default","config":{"boot.autostart":"true","security.nesting":"true"},"description":"","devices":{}}]}
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 631.085537ms {"request-id":32,"response":"'body redacted'"} Reboot[""].WatchForRebootEvent
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 635.405336ms {"request-id":33,"response":"'body redacted'"} Machiner[""].WatchAPIHostPorts
2017-02-01 01:58:20 DEBUG juju.mongo open.go:142 dialled mongodb server at "127.0.0.1:37017"
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 373.146837ms {"request-id":39,"response":"'body redacted'"} Machiner[""].Life
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "undertaker" manifold worker stopped: "not-alive-flag" not set: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "migration-master" manifold worker stopped: "migration-fortress" not running: dependency not available
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:478 "migration-fortress" manifold worker started
2017-02-01 01:58:20 DEBUG juju.network network.go:402 no lxc bridge addresses to filter for machine
2017-02-01 01:58:20 WARNING juju.network network.go:447 cannot get "lxdbr0" addresses: route ip+net: no such network interface (ignoring)
2017-02-01 01:58:20 INFO juju.worker.machiner machiner.go:142 setting addresses for machine-0 to ["local-machine:127.0.0.1" "local-cloud:10.101.229.96" "local-machine:::1"]
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 393.469601ms {"request-id":40,"response":"'body redacted'"} KeyUpdater[""].WatchAuthorisedKeys
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 654.38737ms {"request-id":30,"response":"'body redacted'"} MachineActions[""].RunningActions
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 654.973284ms {"request-id":31,"response":"'body redacted'"} ProxyUpdater[""].ProxyConfig
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 382.423648ms {"request-id":36,"response":"'body redacted'"} Agent[""].StateServingInfo
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 654.100464ms {"request-id":29,"response":"'body redacted'"} StorageProvisioner[""].WatchBlockDevices
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:140 -> [4] machine-0 653.704155ms {"request-id":34,"response":"'body redacted'"} Logger[""].LoggingConfig
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":43,"type":"Reboot","version":2,"request":"GetRebootAction","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":44,"type":"Machiner","version":1,"request":"APIHostPorts","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":45,"type":"NotifyWatcher","version":1,"id":"6","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":46,"type":"NotifyWatcher","version":1,"id":"7","request":"Next","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [4] machine-0 {"request-id":47,"type":"Machiner","version":1,"request":"SetMachineAddresses","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":11,"type":"MigrationFlag","version":1,"request":"Phase","params":"'params redacted'"}
2017-02-01 01:58:20 DEBUG juju.apiserver request_notifier.go:115 <- [6] machine-0 {"request-id":12,"type":"Agent","version":2,"request":"ModelConfig","params":"'params redacted'"}
2017-02-01 01:58:20 INFO juju.worker.authenticationworker worker.go:102 "machine-0" key updater worker started
2017-02-01 01:58:20 DEBUG juju.worker.proxyupdater proxyupdater.go:151 new proxy settings proxy.Settings{Http:"", Https:"", Ftp:"", NoProxy:"10.101.229.96"}
2017-02-01 01:58:20 DEBUG juju.worker.logger logger.go:50 reconfiguring logging from "<root>=DEBUG" to "<root>=WARNING;unit=DEBUG"
2017-02-01 01:58:20 DEBUG juju.worker.dependency engine.go:492 "serving-info-setter" manifold worker stopped: resource permanently unavailable
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.worker.dependency engine.go:539 "unit-agent-deployer" manifold worker returned unexpected error: connection is shut down
2017-02-01 01:58:21 ERROR juju.worker.dependency engine.go:539 "tools-version-checker" manifold worker returned unexpected error: cannot update tools information: connection is shut down
2017-02-01 01:58:21 ERROR juju.worker.dependency engine.go:539 "machiner" manifold worker returned unexpected error: setting machine addresses: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.worker.logger logger.go:47 connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.api.watcher watcher.go:86 error trying to stop watcher: connection is shut down
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 WARNING juju.apiserver.metricsmanager metricsmanager.go:169 failed to send metrics for model-fb0f8b26-20d8-46ad-850f-0e846d8c5551: metrics manager not found
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:21 WARNING juju.worker.metricworker.sender sender.go:25 failed to send metrics failed to send metrics for model-fb0f8b26-20d8-46ad-850f-0e846d8c5551: metrics manager not found - will retry later
2017-02-01 01:58:21 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:22 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:22 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe
2017-02-01 01:58:24 WARNING juju.cmd.jujud machine.go:808 determining kvm support: INFO: Your CPU does not support KVM extensions
KVM acceleration can NOT be used
: exit status 1
no kvm containers possible
2017-02-01 01:58:27 ERROR juju.rpc server.go:510 error writing response: write tcp 127.0.0.1:17070->127.0.0.1:37364: write: broken pipe