juju-core

Affected files (+62, -1 lines):
   A [revision details]
   M provider/local/environprovider.go
   M provider/local/environprovider_test.go
   M provider/local/export_test.go

Index: [revision details]
=== added file '[revision details]'
--- [revision details] 2012-01-01 00:00:00 +0000
+++ [revision details] 2012-01-01 00:00:00 +0000
@@ -0,0 +1,2 @@
+Old revision: <email address hidden>
+New revision: <email address hidden>

Index: provider/local/environprovider.go
=== modified file 'provider/local/environprovider.go'
--- provider/local/environprovider.go 2014-01-31 08:44:08 +0000
+++ provider/local/environprovider.go 2014-01-31 09:04:29 +0000
@@ -51,8 +51,16 @@
   // for backwards compatibility: older versions did not store the namespace
   // in config.
   if namespace, _ := cfg.UnknownAttrs()["namespace"].(string); namespace
== "" {
+ username := os.Getenv("USER")
+ if username == "" {
+ u, err := userCurrent()
+ if err != nil {
+ return nil, fmt.Errorf("failed to determine username for
namespace: %v", err)
+ }
+ username = u.Username
+ }
    var err error
- namespace = fmt.Sprintf("%s-%s", os.Getenv("USER"), cfg.Name())
+ namespace = fmt.Sprintf("%s-%s", username, cfg.Name())
    cfg, err = cfg.Apply(map[string]interface{}{"namespace": namespace})
    if err != nil {
     return nil, fmt.Errorf("failed to create namespace: %v", err)

Index: provider/local/environprovider_test.go
=== modified file 'provider/local/environprovider_test.go'
--- provider/local/environprovider_test.go 2014-01-31 08:44:08 +0000
+++ provider/local/environprovider_test.go 2014-01-31 09:04:29 +0000
@@ -4,6 +4,9 @@
package local_test

  import (
+ "errors"
+ "os/user"
+
   "github.com/loggo/loggo"
   gc "launchpad.net/gocheck"

Reviewers: mp+204173_code.launchpad.net,

Message:
Please take a look.

Description:
provider/local: fall back to os/user if $USER=""

If $USER is unset/empty, then fall back to os/user.
If that fails, then return an error.

Fixes lp:1274780

https://code.launchpad.net/~axwalk/juju-core/lp1274780-osuser-fallback/+merge/204173

Requires:
https://code.launchpad.net/~axwalk/juju-core/local-provider-testability/+merge/204169

(do not edit description out of merge proposal)

Please review this at https://codereview.appspot.com/58970043/

Affected files (+62, -1 lines):
   A [revision details]
   M provider/local/environprovider.go
   M provider/local/environprovider_test.go
   M provider/local/export_test.go

Index: [revision details]
=== added file '[revision details]'
--- [revision details]	2012-01-01 00:00:00 +0000
+++ [revision details]	2012-01-01 00:00:00 +0000
@@ -0,0 +1,2 @@
+Old revision: andrew.wilkins@canonical.com-20140131084408-omyh4xbwv9n2evij
+New revision: andrew.wilkins@canonical.com-20140131090429-7urzema0nqpo74ud

Index: provider/local/environprovider.go
=== modified file 'provider/local/environprovider.go'
--- provider/local/environprovider.go	2014-01-31 08:44:08 +0000
+++ provider/local/environprovider.go	2014-01-31 09:04:29 +0000
@@ -51,8 +51,16 @@
  	// for backwards compatibility: older versions did not store the namespace
  	// in config.
  	if namespace, _ := cfg.UnknownAttrs()["namespace"].(string); namespace  
== "" {
+		username := os.Getenv("USER")
+		if username == "" {
+			u, err := userCurrent()
+			if err != nil {
+				return nil, fmt.Errorf("failed to determine username for  
namespace: %v", err)
+			}
+			username = u.Username
+		}
  		var err error
-		namespace = fmt.Sprintf("%s-%s", os.Getenv("USER"), cfg.Name())
+		namespace = fmt.Sprintf("%s-%s", username, cfg.Name())
  		cfg, err = cfg.Apply(map[string]interface{}{"namespace": namespace})
  		if err != nil {
  			return nil, fmt.Errorf("failed to create namespace: %v", err)

Index: provider/local/environprovider_test.go
=== modified file 'provider/local/environprovider_test.go'
--- provider/local/environprovider_test.go	2014-01-31 08:44:08 +0000
+++ provider/local/environprovider_test.go	2014-01-31 09:04:29 +0000
@@ -4,6 +4,9 @@
  package local_test

import (
+	"errors"
+	"os/user"
+
  	"github.com/loggo/loggo"
  	gc "launchpad.net/gocheck"

@@ -229,3 +232,50 @@
  		}
  	}
  }
+
+func (s *prepareSuite) TestPrepareNamespace(c *gc.C) {
+	s.PatchValue(local.DetectAptProxies, func() (osenv.ProxySettings, error) {
+		return osenv.ProxySettings{}, nil
+	})
+	basecfg, err := config.New(config.UseDefaults, map[string]interface{}{
+		"type": "local",
+		"name": "test",
+	})
+	provider, err := environs.Provider("local")
+	c.Assert(err, gc.IsNil)
+
+	type test struct {
+		userEnv   string
+		userOS    string
+		userOSErr error
+		namespace string
+		err       string
+	}
+	tests := []test{{
+		userEnv:   "someone",
+		userOS:    "other",
+		namespace: "someone-test",
+	}, {
+		userOS:    "other",
+		namespace: "other-test",
+	}, {
+		userOSErr: errors.New("oh noes"),
+		err:       "failed to determine username for namespace: oh noes",
+	}}
+
+	for i, test := range tests {
+		c.Logf("test %d: %v", i, test)
+		s.PatchEnvironment("USER", test.userEnv)
+		s.PatchValue(local.UserCurrent, func() (*user.User, error) {
+			return &user.User{Username: test.userOS}, test.userOSErr
+		})
+		env, err := provider.Prepare(basecfg)
+		if test.err == "" {
+			c.Assert(err, gc.IsNil)
+			cfg := env.Config()
+			c.Assert(cfg.UnknownAttrs()["namespace"], gc.Equals, test.namespace)
+		} else {
+			c.Assert(err, gc.ErrorMatches, test.err)
+		}
+	}
+}

Index: provider/local/export_test.go
=== modified file 'provider/local/export_test.go'
--- provider/local/export_test.go	2014-01-31 08:44:08 +0000
+++ provider/local/export_test.go	2014-01-31 09:04:29 +0000
@@ -13,6 +13,7 @@
  	FinishBootstrap  = &finishBootstrap
  	CheckLocalPort   = &checkLocalPort
  	DetectAptProxies = &detectAptProxies
+	UserCurrent      = &userCurrent
  )

// SetRootCheckFunction allows tests to override the check for a root user.

Revision history for this message

Dimiter Naydenov (dimitern) wrote on 2014-01-31:

LGTM with one comment.

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go
File provider/local/environprovider_test.go (right):

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go#newcode262
provider/local/environprovider_test.go:262: userOSErr: errors.New("oh
noes"),
You could just define userOSErr as string and construct an error from it
in PatchValue below.

https://codereview.appspot.com/58970043/

Revision history for this message

Dave Cheney (dave-cheney) wrote on 2014-01-31:

Why not just always call http://golang.org/pkg/os/user/#Current, that has
the same semantics as you described.

On Fri, Jan 31, 2014 at 8:27 PM, Dimiter Naydenov <
<email address hidden>> wrote:

> LGTM with one comment.
>
>
>
> https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go
> File provider/local/environprovider_test.go (right):
>
>
> https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go#newcode262
> provider/local/environprovider_test.go:262: userOSErr: errors.New("oh
> noes"),
> You could just define userOSErr as string and construct an error from it
> in PatchValue below.
>
> https://codereview.appspot.com/58970043/
>
> --
>
> https://code.launchpad.net/~axwalk/juju-core/lp1274780-osuser-fallback/+merge/204173
> You are subscribed to branch lp:juju-core.
>

Revision history for this message

Dimiter Naydenov (dimitern) wrote on 2014-01-31:

Because of this issue https://code.google.com/p/go/issues/detail?id=6376
which I discovered some time ago and might still be a problem.

Revision history for this message

Andrew Wilkins (axwalk) wrote on 2014-01-31:

> Because of this issue https://code.google.com/p/go/issues/detail?id=6376
> which I discovered some time ago and might still be a problem.

Also, $USER can be overridden without var override hacks. Using an env var is more easily testable.

Revision history for this message

Andrew Wilkins (axwalk) wrote on 2014-01-31:

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go
File provider/local/environprovider_test.go (right):

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider_test.go#newcode262
provider/local/environprovider_test.go:262: userOSErr: errors.New("oh
noes"),
On 2014/01/31 09:25:07, dimitern wrote:
> You could just define userOSErr as string and construct an error from
it in
> PatchValue below.

I was going to initially, but it's more long-winded that way. You need
to check if the string != "", and only then create an error. I'll leave
it unless you strongly object.

https://codereview.appspot.com/58970043/

Revision history for this message

Tim Penhey (thumper) wrote on 2014-02-13:

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go
File provider/local/environprovider.go (right):

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go#newcode60
provider/local/environprovider.go:60: username = u.Username
should we lowercase this?

https://codereview.appspot.com/58970043/

Revision history for this message

Andrew Wilkins (axwalk) wrote on 2014-02-14:

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go
File provider/local/environprovider.go (right):

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go#newcode60
provider/local/environprovider.go:60: username = u.Username
On 2014/02/13 21:58:04, thumper wrote:
> should we lowercase this?

Nope, *nix usernames are case sensitive.

https://codereview.appspot.com/58970043/

Revision history for this message

Tim Penhey (thumper) wrote on 2014-02-14:

On 2014/02/14 01:03:27, axw wrote:

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go
> File provider/local/environprovider.go (right):

https://codereview.appspot.com/58970043/diff/1/provider/local/environprovider.go#newcode60
> provider/local/environprovider.go:60: username = u.Username
> On 2014/02/13 21:58:04, thumper wrote:
> > should we lowercase this?

> Nope, *nix usernames are case sensitive.

LGTM

https://codereview.appspot.com/58970043/

Revision history for this message

Go Bot (go-bot) wrote on 2014-02-14:

Download full text (204.4 KiB)

The attempt to merge lp:~axwalk/juju-core/lp1274780-osuser-fallback into lp:juju-core failed. Below is the output from the failed tests.

ok launchpad.net/juju-core 0.017s
ok launchpad.net/juju-core/agent 1.214s
ok launchpad.net/juju-core/agent/tools 0.264s
ok launchpad.net/juju-core/bzr 6.715s
ok launchpad.net/juju-core/cert 3.834s
ok launchpad.net/juju-core/charm 0.565s
? launchpad.net/juju-core/charm/hooks [no test files]
? launchpad.net/juju-core/charm/testing [no test files]
ok launchpad.net/juju-core/cloudinit 0.037s
ok launchpad.net/juju-core/cloudinit/sshinit 1.158s
ok launchpad.net/juju-core/cmd 0.290s
ok launchpad.net/juju-core/cmd/charm-admin 0.786s
? launchpad.net/juju-core/cmd/charmd [no test files]
? launchpad.net/juju-core/cmd/charmload [no test files]

----------------------------------------------------------------------
PANIC: bootstrap_test.go:62: BootstrapSuite.TearDownTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:310
  in MgoInstance.Reset
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:396
  in MgoSuite.TearDownTest
bootstrap_test.go:64
  in BootstrapSuite.TearDownTest

----------------------------------------------------------------------
PANIC: bootstrap_test.go:106: BootstrapSuite.TestAllowRetries

[LOG] 74.70739 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 74.70745 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 74.70761 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.sjson": stat /tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.sjson: no such file or directory
[LOG] 74.70768 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.sjson" not found
[LOG] 74.70780 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.json": stat /tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.json: no such file or directory
[LOG] 74.70786 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.json": invalid URL "file:///tmp/gocheck-2781055864473387780/0/tools/streams/v1/index.json" not found
[LOG] 74.71044 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 74.71108 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
test 0: no tools uploaded, first check has no retries; no matching binary in source; sync fails with no second attempt

The attempt to merge lp:~axwalk/juju-core/lp1274780-osuser-fallback into lp:juju-core failed. Below is the output from the failed tests.

ok  	launchpad.net/juju-core	0.017s
ok  	launchpad.net/juju-core/agent	1.214s
ok  	launchpad.net/juju-core/agent/tools	0.264s
ok  	launchpad.net/juju-core/bzr	6.715s
ok  	launchpad.net/juju-core/cert	3.834s
ok  	launchpad.net/juju-core/charm	0.565s
?   	launchpad.net/juju-core/charm/hooks	[no test files]
?   	launchpad.net/juju-core/charm/testing	[no test files]
ok  	launchpad.net/juju-core/cloudinit	0.037s
ok  	launchpad.net/juju-core/cloudinit/sshinit	1.158s
ok  	launchpad.net/juju-core/cmd	0.290s
ok  	launchpad.net/juju-core/cmd/charm-admin	0.786s
?   	launchpad.net/juju-core/cmd/charmd	[no test files]
?   	launchpad.net/juju-core/cmd/charmload	[no test files]

----------------------------------------------------------------------
PANIC: bootstrap_test.go:62: BootstrapSuite.TearDownTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: bootstrap_test.go:106: BootstrapSuite.TestAllowRetries

[LOG] 74.71198 INFO juju.provider.dummy reset environment
[LOG] 74.73037 INFO juju Reset successfully reset admin password
[LOG] 74.73184 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/1/.juju/environments
clearing private storage
removing files: []
[LOG] 74.90574 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 74.90575 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 74.90581 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson": stat /tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson: no such file or directory
[LOG] 74.90584 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson" not found
[LOG] 74.90587 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.json": stat /tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.json: no such file or directory
[LOG] 74.90589 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.json": invalid URL "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.json" not found
[LOG] 74.90663 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 74.90688 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 74.90808 DEBUG juju.environs ConfigForName found bootstrap config map[string]interface {}{"broken":"", "default-series":"raring", "image-metadata-url":"", "state-id":"24", "syslog-port":514, "tools-url":"", "api-port":17070, "ca-private-key":"-----BEGIN RSA PRIVATE KEY-----\nMIIBOQIBAAJBAN3dwa+uAqNBFk7ZsO0k9jYnFSXTo0A5ILfHVTGgPGTo8e4hVeMP\nzvQNWs47tdePfxrEyv0Dqunb7sCB1A1LVtMCAwEAAQJAQE0u/22dUhdhEcVB49kc\niqFVHbtyywBDnT/mTxWzq0LVxuZV6+gEc3kp8EyHKpZgIg8uQKdfkZjQ8eGrUQSx\ngQIhAP0Ja/gUMpYPs4RCM1BTsVvVZpEOYds6KI5QR8qElmWzAiEA4HbjgPtzMy8o\nn+NBeCdOsiGbW6f8WmNiJr5PQygK+mECIH6NHMO5DkfA2I6YMWPGR9jfFOoNYGGt\nZ6Utf4pI35NDAiA6XY+gjUGSMJP+pyfx5z6mQOjVt2N92VO/QUL48mOQYQIgYnDm\nzldcQxfRDsZhcBxoBXi07oTMQepTInuByBXMvxs=\n-----END RSA PRIVATE KEY-----\n", "charm-store-auth":"", "image-stream":"", "secret":"pork", "type":"dummy", "ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB2DCCAYSgAwIBAgIBADALBgkqhkiG9w0BAQUwRTENMAsGA1UEChMEanVqdTE0\nMDIGA1UEAwwranVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJwZWNr\naGFtIjAeFw0xNDAyMTQwMTQxMzVaFw0yNDAyMTQwMTQ2MzVaMEUxDTALBgNVBAoT\nBGp1anUxNDAyBgNVBAMMK2p1anUtZ2VuZXJhdGVkIENBIGZvciBlbnZpcm9ubWVu\ndCAicGVja2hhbSIwWjALBgkqhkiG9w0BAQEDSwAwSAJBAN3dwa+uAqNBFk7ZsO0k\n9jYnFSXTo0A5ILfHVTGgPGTo8e4hVeMPzvQNWs47tdePfxrEyv0Dqunb7sCB1A1L\nVtMCAwEAAaNjMGEwDgYDVR0PAQH/BAQDAgCkMA8GA1UdEwEB/wQFMAMBAf8wHQYD\nVR0OBBYEFDCgzt0+1dTsoxSvtSJXn9byftmPMB8GA1UdIwQYMBaAFDCgzt0+1dTs\noxSvtSJXn9byftmPMAsGCSqGSIb3DQEBBQNBAKS2GBCm0Sg7DPBzLLeE6cYllPoV\nXhKEdnkKff1MLbQiCCWB6kglvBPey2TsPxBFJkfOXyPzWgs5IXWz6whPOMQ=\n-----END CERTIFICATE-----\n", "development":false, "name":"peckham", "state-port":37017, "state-server":false, "tools-metadata-url":"", "admin-secret":"arble", "authorized-keys":"i-am-a-key", "firewall-mode":"instance", "logging-config":"<root>=WARNING;juju=DEBUG;unit=DEBUG", "ssl-hostname-verification":true}
[LOG] 74.92644 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/1/.juju/environments
[LOG] 74.92650 INFO juju.environs environment info already exists; using New not Prepare
[LOG] 74.97906 INFO juju.environs.bootstrap bootstrapping environment "peckham"
[LOG] 74.97909 DEBUG juju.environs.bootstrap looking for bootstrap tools: series="raring", arch=<nil>, version=<nil>
[LOG] 74.97910 INFO juju.environs.tools filtering tools by released version
[LOG] 74.97912 WARNING juju.environs.bootstrap no tools available, attempting to retrieve from /tmp/gocheck-2781055864473387780/2
[LOG] 74.97914 INFO juju.environs.sync using sync tools source: file:///tmp/gocheck-2781055864473387780/2/tools
[LOG] 74.97915 INFO juju.environs.sync listing available tools
[LOG] 74.97916 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 74.97917 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 74.97933 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson": cannot find URL "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson" not found
[LOG] 74.97937 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.sjson" not found
[LOG] 74.98293 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/mirrors.json": cannot find URL "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/mirrors.json" not found
[LOG] 74.98295 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 74.98299 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 74.98301 DEBUG juju.environs.simplestreams read metadata index at "file:///tmp/gocheck-2781055864473387780/2/tools/streams/v1/index.json"
[LOG] 74.98311 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm" "com.ubuntu.juju:12.10:amd64" "com.ubuntu.juju:12.10:i386" "com.ubuntu.juju:12.10:arm" "com.ubuntu.juju:13.04:amd64" "com.ubuntu.juju:13.04:i386" "com.ubuntu.juju:13.04:arm" "com.ubuntu.juju:13.10:amd64" "com.ubuntu.juju:13.10:i386" "com.ubuntu.juju:13.10:arm" "com.ubuntu.juju:14.04:amd64" "com.ubuntu.juju:14.04:i386" "com.ubuntu.juju:14.04:arm"] are [{Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64 com.ubuntu.juju:12.04:i386 com.ubuntu.juju:12.10:amd64 com.ubuntu.juju:12.10:i386]}]
[LOG] 74.98313 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 74.98478 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.0.0.1 amd64   map[20140214:0xc2012590c0]} com.ubuntu.juju:12.04:i386:{ 1.1.0 i386   map[20140214:0xc2012591e0]} com.ubuntu.juju:12.10:amd64:{ 1.0.0 amd64   map[20140214:0xc201259300]} com.ubuntu.juju:12.10:i386:{ 1.0.0 i386   map[20140214:0xc201259420]}] map[] Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 74.98496 DEBUG juju.environs.simplestreams index has no matching records
[LOG] 74.98498 ERROR juju.environs.bootstrap Juju cannot bootstrap because no tools are available for your environment.
In addition, no tools could be located to upload.
You may want to use the 'tools-metadata-url' configuration setting to specify the tools location.

test 1: no tools uploaded, first check has no retries; matching binary in source; check after sync has retries

[LOG] 74.98622 INFO juju.provider.dummy reset environment
[LOG] 74.99419 INFO juju Reset successfully reset admin password
[LOG] 74.99500 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/3/.juju/environments
clearing private storage
removing files: []
[LOG] 75.15486 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 75.15488 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 75.15493 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson": stat /tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson: no such file or directory
[LOG] 75.15495 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson" not found
[LOG] 75.15498 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.json": stat /tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.json: no such file or directory
[LOG] 75.15500 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.json": invalid URL "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.json" not found
[LOG] 75.15579 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 75.15607 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 75.16944 DEBUG juju.environs ConfigForName found bootstrap config map[string]interface {}{"admin-secret":"arble", "logging-config":"<root>=WARNING;juju=DEBUG;unit=DEBUG", "name":"peckham", "state-port":37017, "state-server":false, "syslog-port":514, "tools-metadata-url":"", "tools-url":"", "api-port":17070, "authorized-keys":"i-am-a-key", "ca-private-key":"-----BEGIN RSA PRIVATE KEY-----\nMIIBOQIBAAJBAKUY6/tjmHDhbC0ExjYkE8ICK2MoP2wwNQofSDTJNkawIfHe+o+L\nKpx7qJPj/SSO4/sgTXmf0OleCOhV63tNVikCAwEAAQJAbZaDXdUYZSVc1u0qXNnJ\nu6gRALrAjqHZMyTcmx1Mx9IlXh9Z/RKdluLoleXVrzACSeOLgEFx0NsYRE3otVfo\nOQIhAMoaHYCP1HOu77TqKd1xa4tU3et0f+EqCdsJC9XFi+WzAiEA0SBtvEJTcjJQ\nOW2kEfJmvfBik4YmJoJqedYqvIlMXrMCIFQMbk6EAk+l5exwIb8FJzuHrM754SDL\n8dNUvMZHZHm/AiAKXG/zZtnZi5Kb9cmuNfNPL8zCgF/9gnKiDLFbW/YTrwIgBUhQ\nfVTBB2T49YmLoRlmq9VNCVt/FGw/Uvt5D1n1p+I=\n-----END RSA PRIVATE KEY-----\n", "charm-store-auth":"", "firewall-mode":"instance", "image-stream":"", "secret":"pork", "ssl-hostname-verification":true, "type":"dummy", "broken":"", "ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB2DCCAYSgAwIBAgIBADALBgkqhkiG9w0BAQUwRTENMAsGA1UEChMEanVqdTE0\nMDIGA1UEAwwranVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJwZWNr\naGFtIjAeFw0xNDAyMTQwMTQxMzZaFw0yNDAyMTQwMTQ2MzZaMEUxDTALBgNVBAoT\nBGp1anUxNDAyBgNVBAMMK2p1anUtZ2VuZXJhdGVkIENBIGZvciBlbnZpcm9ubWVu\ndCAicGVja2hhbSIwWjALBgkqhkiG9w0BAQEDSwAwSAJBAKUY6/tjmHDhbC0ExjYk\nE8ICK2MoP2wwNQofSDTJNkawIfHe+o+LKpx7qJPj/SSO4/sgTXmf0OleCOhV63tN\nVikCAwEAAaNjMGEwDgYDVR0PAQH/BAQDAgCkMA8GA1UdEwEB/wQFMAMBAf8wHQYD\nVR0OBBYEFIElZAl86iTcwluWt1rPFr1gLPRuMB8GA1UdIwQYMBaAFIElZAl86iTc\nwluWt1rPFr1gLPRuMAsGCSqGSIb3DQEBBQNBAF5WuugDPJ1bqo8nl2OZyy5lolWZ\n8D8tdj8iXHJ223qytRwecx9BeUOqNUvJcQe6RllKr8RssHYRG7ztd8e1SX0=\n-----END CERTIFICATE-----\n", "default-series":"raring", "development":false, "image-metadata-url":"", "state-id":"25"}
[LOG] 75.20242 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/3/.juju/environments
[LOG] 75.20249 INFO juju.environs environment info already exists; using New not Prepare
[LOG] 75.25575 INFO juju.environs.bootstrap bootstrapping environment "peckham"
[LOG] 75.25578 DEBUG juju.environs.bootstrap looking for bootstrap tools: series="raring", arch=<nil>, version=<nil>
[LOG] 75.25579 INFO juju.environs.tools filtering tools by released version
[LOG] 75.25581 WARNING juju.environs.bootstrap no tools available, attempting to retrieve from /tmp/gocheck-2781055864473387780/4
[LOG] 75.25583 INFO juju.environs.sync using sync tools source: file:///tmp/gocheck-2781055864473387780/4/tools
[LOG] 75.25584 INFO juju.environs.sync listing available tools
[LOG] 75.25585 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 75.25587 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 75.25607 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson": cannot find URL "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson" not found
[LOG] 75.25611 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.sjson" not found
[LOG] 75.25638 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/mirrors.json": cannot find URL "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/mirrors.json" not found
[LOG] 75.25640 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 75.25642 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 75.25644 DEBUG juju.environs.simplestreams read metadata index at "file:///tmp/gocheck-2781055864473387780/4/tools/streams/v1/index.json"
[LOG] 75.25654 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm" "com.ubuntu.juju:12.10:amd64" "com.ubuntu.juju:12.10:i386" "com.ubuntu.juju:12.10:arm" "com.ubuntu.juju:13.04:amd64" "com.ubuntu.juju:13.04:i386" "com.ubuntu.juju:13.04:arm" "com.ubuntu.juju:13.10:amd64" "com.ubuntu.juju:13.10:i386" "com.ubuntu.juju:13.10:arm" "com.ubuntu.juju:14.04:amd64" "com.ubuntu.juju:14.04:i386" "com.ubuntu.juju:14.04:arm"] are [{Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64 com.ubuntu.juju:12.04:i386 com.ubuntu.juju:12.10:amd64 com.ubuntu.juju:12.10:i386]}]
[LOG] 75.25656 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 75.25836 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.0.0 amd64   map[20140214:0xc200a0ea80]} com.ubuntu.juju:12.04:i386:{ 1.2.0 i386   map[20140214:0xc200a0eba0]} com.ubuntu.juju:12.10:amd64:{ 1.1.0 amd64   map[20140214:0xc200a0ecc0]} com.ubuntu.juju:12.10:i386:{ 1.0.0 i386   map[20140214:0xc200a0ede0]}] map[] Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 75.25856 INFO juju.environs.sync found 1 tools
[LOG] 75.25858 INFO juju.environs.sync found 1 recent tools (version 1.16.0)
[LOG] 75.25862 DEBUG juju.environs.sync found source tool: &{1.16.0-precise-amd64 file:///tmp/gocheck-2781055864473387780/4/tools/releases/juju-1.16.0-precise-amd64.tgz  0}
[LOG] 75.25863 INFO juju.environs.sync listing target tools storage
[LOG] 75.25864 DEBUG juju.environs.tools reading v1.* tools
[LOG] 75.25866 INFO juju.environs.sync found 0 tools in target; 1 tools to be copied
[LOG] 75.25869 INFO juju.environs.sync copying 1.16.0-precise-amd64 from file:///tmp/gocheck-2781055864473387780/4/tools/releases/juju-1.16.0-precise-amd64.tgz
[LOG] 75.25870 INFO juju.environs.sync copying tools/releases/juju-1.16.0-precise-amd64.tgz
[LOG] 75.25884 INFO juju.environs.sync downloaded tools/releases/juju-1.16.0-precise-amd64.tgz (0kB), uploading
[LOG] 75.25885 INFO juju.environs.sync download 0kB, uploading
[LOG] 75.25887 INFO juju.environs.sync copied 1 tools
[LOG] 75.25888 INFO juju.environs.sync generating tools metadata
[LOG] 75.25889 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 75.25890 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 75.25894 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 75.25895 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
[LOG] 75.25898 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.json": file "tools/streams/v1/index.json" not found not found
[LOG] 75.25899 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.json": invalid URL "tools/streams/v1/index.json" not found
[LOG] 75.25916 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 75.25917 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 75.25919 INFO juju.environs.sync tools metadata written
[LOG] 75.25920 INFO juju.environs.tools filtering tools by released version
test 2: no tools uploaded, first check has no retries; no matching binary in source; check after upload has retries

[LOG] 75.26030 INFO juju.provider.dummy reset environment
[LOG] 75.28211 INFO juju Reset successfully reset admin password
[LOG] 75.28385 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/5/.juju/environments
clearing private storage
removing files: []
[LOG] 75.43031 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 75.43033 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 75.43038 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson": stat /tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson: no such file or directory
[LOG] 75.43040 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson" not found
[LOG] 75.43044 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.json": stat /tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.json: no such file or directory
[LOG] 75.43045 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.json": invalid URL "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.json" not found
[LOG] 75.43123 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 75.43145 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 75.44858 DEBUG juju.environs ConfigForName found bootstrap config map[string]interface {}{"broken":"", "default-series":"raring", "image-metadata-url":"", "state-id":"26", "syslog-port":514, "tools-url":"", "api-port":17070, "ca-private-key":"-----BEGIN RSA PRIVATE KEY-----\nMIIBOwIBAAJBANVcohUEkdvjElbqHNGGTfqD8PZNPBKSlKI5KgvIgDicsMm9FyDC\nbhGrcpvD9+NmTxXDxODrBD7NXlso6MKKxh0CAwEAAQJAaBnSWz7ni8m24QFJHlHR\nKjHGF+aHMOij7KLHiQhCx1uILuZagKDFjSLDCIyi8mD85MpmgcYSygBo7IwLVHXA\nAQIhAOXziJoz426W4cDU6LUq/roIlRoD0qU4SjrnRsTNzqwdAiEA7YgDm60uXjkz\nPochnxXiHKiyUuRsjs3/DEqpI4DtYgECIA8MhhcZaDv3keStymD45FzGbQOb1nBL\no8gBFMeSdIEdAiEAs0xeXN7nB1zqH6LlcC6WlceJhCTFBS7d/StGbXRevAECIQCR\nt28EU8lNePOa2/aAHt1EXjBFJemQRBNrv+/Dv8REsw==\n-----END RSA PRIVATE KEY-----\n", "charm-store-auth":"", "image-stream":"", "secret":"pork", "type":"dummy", "ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB2DCCAYSgAwIBAgIBADALBgkqhkiG9w0BAQUwRTENMAsGA1UEChMEanVqdTE0\nMDIGA1UEAwwranVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJwZWNr\naGFtIjAeFw0xNDAyMTQwMTQxMzZaFw0yNDAyMTQwMTQ2MzZaMEUxDTALBgNVBAoT\nBGp1anUxNDAyBgNVBAMMK2p1anUtZ2VuZXJhdGVkIENBIGZvciBlbnZpcm9ubWVu\ndCAicGVja2hhbSIwWjALBgkqhkiG9w0BAQEDSwAwSAJBANVcohUEkdvjElbqHNGG\nTfqD8PZNPBKSlKI5KgvIgDicsMm9FyDCbhGrcpvD9+NmTxXDxODrBD7NXlso6MKK\nxh0CAwEAAaNjMGEwDgYDVR0PAQH/BAQDAgCkMA8GA1UdEwEB/wQFMAMBAf8wHQYD\nVR0OBBYEFHA7sJEr/iNhdhZT1yFjVqIlNe7IMB8GA1UdIwQYMBaAFHA7sJEr/iNh\ndhZT1yFjVqIlNe7IMAsGCSqGSIb3DQEBBQNBAB38m0t5u5OBOb9zjhC5LCmAwJgC\nN+XppmZhSEPqiDE6wsn+4V9FkTQUiRQEQst8/28SZwF5qccsN0MW5v+26gE=\n-----END CERTIFICATE-----\n", "development":false, "name":"peckham", "state-port":37017, "state-server":false, "tools-metadata-url":"", "admin-secret":"arble", "authorized-keys":"i-am-a-key", "firewall-mode":"instance", "logging-config":"<root>=WARNING;juju=DEBUG;unit=DEBUG", "ssl-hostname-verification":true}
[LOG] 75.48895 DEBUG juju.environs.configstore Making /tmp/gocheck-2781055864473387780/5/.juju/environments
[LOG] 75.48901 INFO juju.environs environment info already exists; using New not Prepare
[LOG] 75.54666 INFO juju.environs.bootstrap bootstrapping environment "peckham"
[LOG] 75.54670 DEBUG juju.environs.bootstrap looking for bootstrap tools: series="raring", arch=<nil>, version=<nil>
[LOG] 75.54672 WARNING juju.environs.bootstrap no tools available, attempting to retrieve from /tmp/gocheck-2781055864473387780/6
[LOG] 75.54674 INFO juju.environs.sync using sync tools source: file:///tmp/gocheck-2781055864473387780/6/tools
[LOG] 75.54675 INFO juju.environs.sync listing available tools
[LOG] 75.54677 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 75.54678 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 75.54694 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson": cannot find URL "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson" not found
[LOG] 75.54698 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson": invalid URL "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.sjson" not found
[LOG] 75.54723 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/mirrors.json": cannot find URL "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/mirrors.json" not found
[LOG] 75.54724 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 75.54727 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 75.54728 DEBUG juju.environs.simplestreams read metadata index at "file:///tmp/gocheck-2781055864473387780/6/tools/streams/v1/index.json"
[LOG] 75.54743 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm" "com.ubuntu.juju:12.10:amd64" "com.ubuntu.juju:12.10:i386" "com.ubuntu.juju:12.10:arm" "com.ubuntu.juju:13.04:amd64" "com.ubuntu.juju:13.04:i386" "com.ubuntu.juju:13.04:arm" "com.ubuntu.juju:13.10:amd64" "com.ubuntu.juju:13.10:i386" "com.ubuntu.juju:13.10:arm" "com.ubuntu.juju:14.04:amd64" "com.ubuntu.juju:14.04:i386" "com.ubuntu.juju:14.04:arm"] are [{Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64 com.ubuntu.juju:12.04:i386 com.ubuntu.juju:12.10:amd64 com.ubuntu.juju:12.10:i386]}]
[LOG] 75.54745 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 75.54911 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.0.0 amd64   map[20140214:0xc201172420]} com.ubuntu.juju:12.04:i386:{ 1.2.0 i386   map[20140214:0xc201172540]} com.ubuntu.juju:12.10:amd64:{ 1.1.0 amd64   map[20140214:0xc201172660]} com.ubuntu.juju:12.10:i386:{ 1.0.0 i386   map[20140214:0xc201172780]}] map[] Fri, 14 Feb 2014 01:46:36 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 75.54927 DEBUG juju.environs.simplestreams index has no matching records
[LOG] 75.54929 WARNING juju.environs.bootstrap no tools found, so attempting to build and upload new tools
[LOG] 75.54931 DEBUG juju.environs.sync Uploading tools for [raring precise]
[LOG] 75.54945 DEBUG juju.environs.tools looking for: /tmp/go-build823966727/launchpad.net/juju-core/cmd/juju/_test/juju.test
[LOG] 75.54947 DEBUG juju.environs.tools checking: /tmp/go-build823966727/launchpad.net/juju-core/cmd/juju/_test/jujud
[LOG] 75.54949 INFO juju.environs.tools couldn't find existing jujud
[LOG] 75.54951 DEBUG juju.environs.tools copy existing failed: stat /tmp/go-build823966727/launchpad.net/juju-core/cmd/juju/_test/jujud: no such file or directory
[LOG] 75.54952 INFO juju.environs.tools building jujud
[LOG] 89.80761 DEBUG juju.environs.tools forcing version to 1.15.1.1
[LOG] 90.05466 DEBUG juju.environs.tools adding entry: &tar.Header{Name:"FORCE-VERSION", Mode:436, Uid:0, Gid:0, Size:8, ModTime:time.Time{sec:63527939210, nsec:930570001, loc:(*time.Location)(0x1674f40)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63527939210, nsec:930570001, loc:(*time.Location)(0x1674f40)}, ChangeTime:time.Time{sec:63527939210, nsec:930570001, loc:(*time.Location)(0x1674f40)}}
[LOG] 90.05712 DEBUG juju.environs.tools adding entry: &tar.Header{Name:"jujud", Mode:509, Uid:0, Gid:0, Size:17101536, ModTime:time.Time{sec:63527939210, nsec:918570001, loc:(*time.Location)(0x1674f40)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63527939210, nsec:918570001, loc:(*time.Location)(0x1674f40)}, ChangeTime:time.Time{sec:63527939210, nsec:918570001, loc:(*time.Location)(0x1674f40)}}
[LOG] 93.10094 INFO juju.environs.sync built tools 1.15.1.1-precise-amd64 (3695kB)
[LOG] 93.10109 DEBUG juju.environs.sync generating tarballs for [raring precise]
[LOG] 93.11296 DEBUG juju.environs.sync generating tools metadata
[LOG] 93.11300 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 93.11301 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 93.11309 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/618746180/tools/streams/v1/index.sjson": stat /tmp/618746180/tools/streams/v1/index.sjson: no such file or directory
[LOG] 93.11311 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/618746180/tools/streams/v1/index.sjson": invalid URL "file:///tmp/618746180/tools/streams/v1/index.sjson" not found
[LOG] 93.11314 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/618746180/tools/streams/v1/index.json": stat /tmp/618746180/tools/streams/v1/index.json: no such file or directory
[LOG] 93.11316 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/618746180/tools/streams/v1/index.json": invalid URL "file:///tmp/618746180/tools/streams/v1/index.json" not found
[LOG] 93.11354 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 93.11385 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 93.11398 DEBUG juju.environs.sync uploading tools to cloud storage
[LOG] 93.11400 INFO juju.environs.sync using sync tools source: file:///tmp/618746180/tools
[LOG] 93.11401 INFO juju.environs.sync listing available tools
[LOG] 93.11402 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 93.11403 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 93.11488 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/618746180/tools/streams/v1/index.sjson": cannot find URL "file:///tmp/618746180/tools/streams/v1/index.sjson" not found
[LOG] 93.11495 DEBUG juju.environs.simplestreams cannot load index "file:///tmp/618746180/tools/streams/v1/index.sjson": invalid URL "file:///tmp/618746180/tools/streams/v1/index.sjson" not found
[LOG] 93.11552 DEBUG juju.environs.simplestreams fetchData failed for "file:///tmp/618746180/tools/streams/v1/mirrors.json": cannot find URL "file:///tmp/618746180/tools/streams/v1/mirrors.json" not found
[LOG] 93.11561 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 93.11568 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 93.11571 DEBUG juju.environs.simplestreams read metadata index at "file:///tmp/618746180/tools/streams/v1/index.json"
[LOG] 93.11600 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm" "com.ubuntu.juju:12.10:amd64" "com.ubuntu.juju:12.10:i386" "com.ubuntu.juju:12.10:arm" "com.ubuntu.juju:13.04:amd64" "com.ubuntu.juju:13.04:i386" "com.ubuntu.juju:13.04:arm" "com.ubuntu.juju:13.10:amd64" "com.ubuntu.juju:13.10:i386" "com.ubuntu.juju:13.10:arm" "com.ubuntu.juju:14.04:amd64" "com.ubuntu.juju:14.04:i386" "com.ubuntu.juju:14.04:arm"] are [{Fri, 14 Feb 2014 01:46:54 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64 com.ubuntu.juju:13.04:amd64]}]
[LOG] 93.11608 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 93.11749 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.15.1.1 amd64   map[20140214:0xc200c65cc0]} com.ubuntu.juju:13.04:amd64:{ 1.15.1.1 amd64   map[20140214:0xc200c65de0]}] map[] Fri, 14 Feb 2014 01:46:54 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 93.11783 INFO juju.environs.sync found 2 tools
[LOG] 93.11790 DEBUG juju.environs.sync found source tool: &{1.15.1.1-precise-amd64 file:///tmp/618746180/tools/releases/juju-1.15.1.1-precise-amd64.tgz d6c0c91af9989a5f753c09f4e746169172d5e3be70a6e7bdf2f62c21c7505172 3783910}
[LOG] 93.11795 DEBUG juju.environs.sync found source tool: &{1.15.1.1-raring-amd64 file:///tmp/618746180/tools/releases/juju-1.15.1.1-raring-amd64.tgz d6c0c91af9989a5f753c09f4e746169172d5e3be70a6e7bdf2f62c21c7505172 3783910}
[LOG] 93.11798 INFO juju.environs.sync listing target tools storage
[LOG] 93.11801 DEBUG juju.environs.tools reading v1.* tools
[LOG] 93.11806 INFO juju.environs.sync found 0 tools in target; 2 tools to be copied
[LOG] 93.11810 INFO juju.environs.sync copying 1.15.1.1-precise-amd64 from file:///tmp/618746180/tools/releases/juju-1.15.1.1-precise-amd64.tgz
[LOG] 93.11814 INFO juju.environs.sync copying tools/releases/juju-1.15.1.1-precise-amd64.tgz
[LOG] 93.22489 INFO juju.environs.sync downloaded tools/releases/juju-1.15.1.1-precise-amd64.tgz (3695kB), uploading
[LOG] 93.22492 INFO juju.environs.sync download 3695kB, uploading
[LOG] 93.23996 INFO juju.environs.sync copying 1.15.1.1-raring-amd64 from file:///tmp/618746180/tools/releases/juju-1.15.1.1-raring-amd64.tgz
[LOG] 93.23999 INFO juju.environs.sync copying tools/releases/juju-1.15.1.1-raring-amd64.tgz
[LOG] 93.31608 INFO juju.environs.sync downloaded tools/releases/juju-1.15.1.1-raring-amd64.tgz (3695kB), uploading
[LOG] 93.31610 INFO juju.environs.sync download 3695kB, uploading
[LOG] 93.32413 INFO juju.environs.sync copied 2 tools
[LOG] 93.32419 INFO juju.environs.sync generating tools metadata
[LOG] 93.32421 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 93.32422 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 93.32428 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 93.32430 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
[LOG] 93.32433 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.json": file "tools/streams/v1/index.json" not found not found
[LOG] 93.32434 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.json": invalid URL "tools/streams/v1/index.json" not found
[LOG] 93.32474 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 93.32477 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 93.32480 INFO juju.environs.sync tools metadata written
test 3: new tools uploaded, so we want to allow retries to give them a chance at showing up

[LOG] 93.38747 INFO juju.provider.dummy reset environment
... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: cmd_test.go:50: CmdSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
cmd_test.go:51
  in CmdSuite.SetUpTest

----------------------------------------------------------------------
PANIC: cmd_test.go:55: CmdSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/environ.go:187
  in FakeHome.Restore
cmd_test.go:56
  in CmdSuite.TearDownTest

----------------------------------------------------------------------
PANIC: cmd_test.go:240: CmdSuite.TestAddUnitCommandInit

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: ConstraintsCommandsSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: ConstraintsCommandsSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: constraints_test.go:101: ConstraintsCommandsSuite.TestGetEnvironEmpty

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DebugHooksSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
ssh_test.go:41
  in SSHCommonSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DebugHooksSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: debughooks_test.go:69: DebugHooksSuite.TestDebugHooksCommand

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DeploySuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DeploySuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: deploy_test.go:109: DeploySuite.TestCharmBundle

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: destroyEnvSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: destroyEnvSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: destroyenvironment_test.go:28: destroyEnvSuite.TestDestroyEnvironmentCommand

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyMachineSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyMachineSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: destroymachine_test.go:117: DestroyMachineSuite.TestBadArgs

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyRelationSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyRelationSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: destroyrelation_test.go:24: DestroyRelationSuite.TestDestroyRelation

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyServiceSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyServiceSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: destroyservice_test.go:37: DestroyServiceSuite.TestFailure

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyUnitSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: DestroyUnitSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: destroyunit_test.go:26: DestroyUnitSuite.TestDestroyUnit

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: EndpointSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: EndpointSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: endpoint_test.go:23: EndpointSuite.TestEndpoint

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: GetEnvironmentSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: GetEnvironmentSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: environment_test.go:61: GetEnvironmentSuite.TestAllValues

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: SetEnvironmentSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: SetEnvironmentSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: environment_test.go:153: SetEnvironmentSuite.TestChangeAsCommandPair

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: ExposeSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: ExposeSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: expose_test.go:32: ExposeSuite.TestExpose

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: GetSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: GetSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: get_test.go:63: GetSuite.TestGetConfig

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: ResolvedSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: ResolvedSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: resolved_test.go:74: ResolvedSuite.TestResolved

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: SCPSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
ssh_test.go:41
  in SSHCommonSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: SCPSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: scp_test.go:52: SCPSuite.TestSCPCommand

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: set_test.go:27: SetSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
set_test.go:28
  in SetSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: SetSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: set_test.go:58: SetSuite.TestSetConfig

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: SSHSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
ssh_test.go:41
  in SSHCommonSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: SSHSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: ssh_test.go:93: SSHSuite.TestSSHCommand

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: StatusSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: StatusSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: status_test.go:1887: StatusSuite.TestStatusAllFormats

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: synctools_test.go:50: syncToolsSuite.TearDownTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:310
  in MgoInstance.Reset
/home/tarmac/trees/src/launchpad.net/juju-core/provider/dummy/environs.go:226
  in Reset
synctools_test.go:52
  in syncToolsSuite.TearDownTest

----------------------------------------------------------------------
PANIC: synctools_test.go:124: syncToolsSuite.TestSyncToolsCommand

test 0: environment as only argument
[LOG] 68.58282 DEBUG juju.environs.configstore Making /tmp/gocheck-7273596521315663110/0/.juju/environments
[LOG] 68.79670 DEBUG juju.environs ConfigForName found bootstrap config map[string]interface {}{"name":"test-target", "state-port":37017, "state-server":false, "syslog-port":514, "tools-metadata-url":"", "tools-url":"", "api-port":17070, "authorized-keys":"not-really-one", "ca-private-key":"-----BEGIN RSA PRIVATE KEY-----\nMIIBOwIBAAJBANFIEBTMkyhjsCWMnojABcj5GSfewlS0d53HrGGqAgW8x5xp02oB\n2RKlwPSjsMurZLF/BHmTIQZofVndRxifkW8CAwEAAQJAU4tC8CqibDMvdC3oc4rE\nRHA8PJBOX2YTgibdh7dIS2VSDEHxnAyO8ZXwQXQHXXLw+XXoCp5F4j4f6eRtvqw5\nEQIhAPE8c8uMJij7jWZFM/mWenKQGMe4DyaDnggPejHE0/lDAiEA3hb2soo2dw+N\nSetgrXeDHh7nwkeHxTI4NQ96FQDgPmUCIQDH4Y0YlNFxl6z7lk+QeEyQ7DB8G1gC\nU3/3sctPvYTdvQIhANwAkYdRxRxyansUUSPlpRx8bwcUxtlAo09ksoIF6R3FAiBq\n7SCXmYF4k0YlGsq2byPf52IOQ5d5gHSFH5hfbnJFCA==\n-----END RSA PRIVATE KEY-----\n", "charm-store-auth":"", "firewall-mode":"instance", "image-stream":"", "secret":"pork", "ssl-hostname-verification":true, "type":"dummy", "broken":"", "ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB4DCCAYygAwIBAgIBADALBgkqhkiG9w0BAQUwSTENMAsGA1UEChMEanVqdTE4\nMDYGA1UEAwwvanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJ0ZXN0\nLXRhcmdldCIwHhcNMTQwMjE0MDE0ODA5WhcNMjQwMjE0MDE1MzA5WjBJMQ0wCwYD\nVQQKEwRqdWp1MTgwNgYDVQQDDC9qdWp1LWdlbmVyYXRlZCBDQSBmb3IgZW52aXJv\nbm1lbnQgInRlc3QtdGFyZ2V0IjBaMAsGCSqGSIb3DQEBAQNLADBIAkEA0UgQFMyT\nKGOwJYyeiMAFyPkZJ97CVLR3ncesYaoCBbzHnGnTagHZEqXA9KOwy6tksX8EeZMh\nBmh9Wd1HGJ+RbwIDAQABo2MwYTAOBgNVHQ8BAf8EBAMCAKQwDwYDVR0TAQH/BAUw\nAwEB/zAdBgNVHQ4EFgQUR6NVGLtsxTIrYWLTjRlLvriPtPswHwYDVR0jBBgwFoAU\nR6NVGLtsxTIrYWLTjRlLvriPtPswCwYJKoZIhvcNAQEFA0EAYDKjkJq8FgpZTBH3\n2HOwwwaLAFDVCixMCgo7G271nbV1vCOkKZ9tBIHkT5Lfquwsf+4NOLqxS7EV5LK/\nlubtwQ==\n-----END CERTIFICATE-----\n", "default-series":"precise", "development":false, "image-metadata-url":"", "state-id":"27", "admin-secret":"eb6b64e6927fdae900f91cbf88cad1ea", "logging-config":"<root>=WARNING;juju=DEBUG;unit=DEBUG"}
[LOG] 68.81542 DEBUG juju.environs.configstore Making /tmp/gocheck-7273596521315663110/0/.juju/environments
[LOG] 68.81546 INFO juju.environs environment info already exists; using New not Prepare
[LOG] 68.86621 INFO juju.provider.dummy reset environment
[LOG] 83.89743 INFO juju.provider.dummy reset environment
... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: UnexposeSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: UnexposeSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: unexpose_test.go:32: UnexposeSuite.TestUnexpose

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: unset_test.go:26: UnsetSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
unset_test.go:27
  in UnsetSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: UnsetSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: unset_test.go:66: UnsetSuite.TestUnsetOptionFail

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: UpgradeCharmErrorsSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: UpgradeCharmErrorsSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: upgradecharm_test.go:31: UpgradeCharmErrorsSuite.TestInvalidArgs

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: upgradecharm_test.go:94: UpgradeCharmSuccessSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:25
  in RepoSuite.SetUpTest
upgradecharm_test.go:95
  in UpgradeCharmSuccessSuite.SetUpTest

----------------------------------------------------------------------
PANIC: addmachine.go:0: UpgradeCharmSuccessSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/repo.go:50
  in RepoSuite.TearDownTest

----------------------------------------------------------------------
PANIC: upgradecharm_test.go:162: UpgradeCharmSuccessSuite.TestForcedUpgrade

... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: addmachine.go:0: UpgradeJujuSuite.SetUpTest

... Panic: no reachable servers (PC=0x414321)

----------------------------------------------------------------------
PANIC: addmachine.go:0: UpgradeJujuSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: upgradejuju_test.go:275: UpgradeJujuSuite.TestUpgradeJuju

... Panic: Fixture has panicked (see related PANIC)
OOPS: 92 passed, 2 skipped, 50 FIXTURE-PANICKED, 106 MISSED
--- FAIL: TestPackage (524.93 seconds)
FAIL
FAIL	launchpad.net/juju-core/cmd/juju	525.212s

----------------------------------------------------------------------
FAIL: machine_test.go:78: MachineSuite.TearDownTest

cannot reset admin password: cannot disable admin password: EOF
machine_test.go:80:
    s.agentSuite.TearDownTest(c)
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:249:
    c.Assert(s.Conn.Close(), gc.IsNil)
... value *errors.errorString = &errors.errorString{s:"watcher iteration error: EOF"} ("watcher iteration error: EOF")

----------------------------------------------------------------------
PANIC: machine_test.go:334: MachineSuite.TestManageEnvironRunsInstancePoller

[LOG] 79.64660 DEBUG juju.environs.configstore Making /tmp/gocheck-1460320609597786623/72/home/ubuntu/.juju/environments
[LOG] 79.87911 DEBUG juju.environs.tools reading v1.* tools
[LOG] 79.87916 INFO juju environs/testing: uploading FAKE tools 1.17.3-precise-amd64
[LOG] 79.88958 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 79.88967 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 79.88973 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 79.88974 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
[LOG] 79.88977 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.json": file "tools/streams/v1/index.json" not found not found
[LOG] 79.88979 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.json": invalid URL "tools/streams/v1/index.json" not found
[LOG] 79.89008 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 79.89015 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 79.89040 INFO juju.environs.bootstrap bootstrapping environment "dummyenv"
[LOG] 79.89043 DEBUG juju.environs.bootstrap looking for bootstrap tools: series="precise", arch=<nil>, version=1.17.3
[LOG] 79.89044 INFO juju.environs.tools reading tools with major.minor version 1.17
[LOG] 79.89045 INFO juju.environs.tools filtering tools by version: 1.17.3
[LOG] 79.89048 INFO juju.environs.tools filtering tools by series: precise
[LOG] 79.89050 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 79.89054 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 79.89055 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
[LOG] 79.89066 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/mirrors.json": file "tools/streams/v1/mirrors.json" not found not found
[LOG] 79.89068 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 79.89071 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 79.89072 DEBUG juju.environs.simplestreams read metadata index at "http://127.0.0.1:48733/dummyenv/private/tools/streams/v1/index.json"
[LOG] 79.89078 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm"] are [{Fri, 14 Feb 2014 01:46:41 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64]}]
[LOG] 79.89079 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 79.89100 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.17.3 amd64   map[20140214:0xc20071cd20]}] map[] Fri, 14 Feb 2014 01:46:41 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 79.89109 INFO juju.environs.bootstrap picked newest version: 1.17.3
[LOG] 79.89112 INFO juju.provider.dummy would pick tools from 1.17.3-precise-amd64
[LOG] 79.89159 INFO juju.state opening state; mongo addresses: ["localhost:39074"]; entity ""
[LOG] 79.91276 INFO juju.state connection established
[LOG] 79.92767 INFO juju.state adding state server info to legacy environment
[LOG] 79.92810 INFO juju.state found existing state servers []
[LOG] 79.94355 INFO juju.state initializing environment
[LOG] 79.97763 INFO juju.state.apiserver listening on "127.0.0.1:41377"
[LOG] 80.00298 INFO juju.state opening state; mongo addresses: ["localhost:39074"]; entity ""
[LOG] 80.01526 INFO juju.state connection established
[LOG] 80.02872 INFO juju juju: authorization error while connecting to state server; retrying
[LOG] 80.02879 INFO juju.state opening state; mongo addresses: ["localhost:39074"]; entity ""
[LOG] 80.04166 INFO juju.state connection established
[LOG] 80.04764 INFO juju.state adding state server info to legacy environment
[LOG] 80.04792 INFO juju.state found existing state servers []
[LOG] 80.12155 INFO juju state/api: dialing "wss://127.0.0.1:41377/"
[LOG] 80.12500 INFO juju.state.apiserver [14] API connection from 127.0.0.1:38572
[LOG] 80.12511 INFO juju state/api: connection established
[LOG] 80.12527 DEBUG juju.state.apiserver <- [14] <unknown> {"RequestId":1,"Type":"Admin","Request":"Login","Params":{"AuthTag":"user-admin","Password":"dummy-secret","Nonce":""}}
[LOG] 80.12570 DEBUG juju.state.apiserver -> [14] user-admin 430.199us {"RequestId":1,"Response":{}} Admin[""].Login
[LOG] 80.12624 DEBUG juju.environs.tools reading v1.* tools
[LOG] 80.12629 DEBUG juju.environs.tools found 1.17.3-precise-amd64
[LOG] 80.12633 INFO juju environs/testing: uploading FAKE tools 1.17.3-quantal-amd64
[LOG] 80.12728 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 80.12729 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 80.12735 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 80.12737 DEBUG juju.environs.simplestreams cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
[LOG] 80.12746 DEBUG juju.environs.simplestreams fetchData failed for "tools/streams/v1/mirrors.json": file "tools/streams/v1/mirrors.json" not found not found
[LOG] 80.12748 DEBUG juju.environs.simplestreams no mirror index file found
[LOG] 80.12750 DEBUG juju.environs.simplestreams no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 80.12752 DEBUG juju.environs.simplestreams read metadata index at "http://127.0.0.1:48733/dummyenv/private/tools/streams/v1/index.json"
[LOG] 80.12761 DEBUG juju.environs.simplestreams candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm" "com.ubuntu.juju:12.10:amd64" "com.ubuntu.juju:12.10:i386" "com.ubuntu.juju:12.10:arm" "com.ubuntu.juju:13.04:amd64" "com.ubuntu.juju:13.04:i386" "com.ubuntu.juju:13.04:arm" "com.ubuntu.juju:13.10:amd64" "com.ubuntu.juju:13.10:i386" "com.ubuntu.juju:13.10:arm" "com.ubuntu.juju:14.04:amd64" "com.ubuntu.juju:14.04:i386" "com.ubuntu.juju:14.04:arm"] are [{Fri, 14 Feb 2014 01:46:41 +0000 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64]}]
[LOG] 80.12767 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 80.12790 DEBUG juju.environs.simplestreams metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.17.3 amd64   map[20140214:0xc2009b8ea0]}] map[] Fri, 14 Feb 2014 01:46:41 +0000 products:1.0 com.ubuntu.juju:released:tools}
[LOG] 80.12831 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 80.12833 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 80.17550 INFO juju environs/testing: uploading FAKE tools 1.17.3-precise-amd64
[LOG] 80.18725 INFO juju.cmd.jujud machine agent machine-0 start
[LOG] 80.18736 DEBUG juju.agent Reading agent config, format: format 1.16
[LOG] 80.18802 INFO juju.cmd.jujud Starting StateWorker for machine-0
[LOG] 80.18806 INFO juju worker: start "state"
[LOG] 80.18808 INFO juju.state opening state; mongo addresses: ["localhost:39074"]; entity "machine-0"
[LOG] 80.18842 INFO juju worker: start "api"
[LOG] 80.18861 INFO juju state/api: dialing "wss://localhost:59230/"
[LOG] 80.18907 INFO juju worker: start "termination"
[LOG] 80.19095 ERROR juju state/api: websocket.Dial wss://localhost:59230/: dial tcp 127.0.0.1:59230: connection refused
[LOG] 80.19108 ERROR juju worker: exited "api": websocket.Dial wss://localhost:59230/: dial tcp 127.0.0.1:59230: connection refused
[LOG] 80.19111 INFO juju worker: restarting "api" in 50ms
[LOG] 80.22431 INFO juju writing charm to storage [1418 bytes]
[LOG] 80.22439 INFO juju adding charm to state
[LOG] 80.22688 INFO juju.state connection established
[LOG] 80.23824 INFO juju worker: start "instancepoller"
[LOG] 80.23830 INFO juju worker: start "apiserver"
[LOG] 80.23841 INFO juju.state.apiserver listening on "[::]:59230"
[LOG] 80.27820 INFO juju worker: start "cleaner"
[LOG] 80.27873 INFO juju worker: start "resumer"
[LOG] 80.27897 INFO juju worker: start "minunitsworker"
[LOG] 80.27983 INFO juju worker: start "api"
[LOG] 80.28024 INFO juju state/api: dialing "wss://localhost:59230/"
[LOG] 80.28515 INFO juju.worker.instanceupdater instance poller received inital environment configuration
[LOG] 80.28620 INFO juju.state.apiserver [15] API connection from 127.0.0.1:51906
[LOG] 80.28666 INFO juju state/api: connection established
[LOG] 80.28685 WARNING juju.worker.instanceupdater cannot get instance info for instance "ardbeg-0": no instances found
[LOG] 80.29250 DEBUG juju.state.apiserver <- [15] <unknown> {"RequestId":1,"Type":"Admin","Request":"Login","Params":{"AuthTag":"machine-0","Password":"machine-password-1234567890","Nonce":"user-admin:bootstrap"}}
[LOG] 80.29696 DEBUG juju.state.apiserver -> [15] machine-0 4.496494ms {"RequestId":1,"Response":{}} Admin[""].Login
[LOG] 80.29710 DEBUG juju.agent writing configuration file
[LOG] 80.29871 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":2,"Type":"Agent","Request":"GetEntities","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.29929 DEBUG juju.state.apiserver -> [15] machine-0 590.929us {"RequestId":2,"Response":{"Entities":[{"Life":"alive","Jobs":["JobManageEnviron"],"ContainerType":"","Error":null}]}} Agent[""].GetEntities
[LOG] 80.30009 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":4,"Type":"Agent","Request":"SetPasswords","Params":{"Changes":[{"Tag":"machine-0","Password":"qEMxIWbzTvCHzxz+qXa8FNRw"}]}}
[LOG] 80.30295 INFO juju setting mongo password for "machine-0"
[LOG] 80.31420 INFO juju setting password for "machine-0"
[LOG] 80.31430 DEBUG juju.state.apiserver -> [15] machine-0 14.201045ms {"RequestId":4,"Response":{"Results":[{"Error":null}]}} Agent[""].SetPasswords
[LOG] 80.31448 INFO juju worker: start "machiner"
[LOG] 80.31460 INFO juju worker: start "upgrader"
[LOG] 80.31462 INFO juju worker: start "logger"
[LOG] 80.31472 DEBUG juju.worker.logger initial log config: "<root>=WARNING;juju=DEBUG;unit=DEBUG"
[LOG] 80.31481 DEBUG juju.worker.logger logger setup
[LOG] 80.31489 WARNING juju.cmd.jujud determining kvm support: exec: "kvm-ok": executable file not found in $PATH
no kvm containers possible
[LOG] 80.31495 INFO juju worker: start "machineenvironmentworker"
[LOG] 80.31496 DEBUG juju.worker.machineenvironment write system files: true
[LOG] 80.31502 INFO juju worker: start "authenticationworker"
[LOG] 80.31593 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":5,"Type":"Machiner","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.31606 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":6,"Type":"Upgrader","Request":"SetTools","Params":{"AgentTools":[{"Tag":"machine-0","Tools":{"Version":"1.17.3-precise-amd64"}}]}}
[LOG] 80.31612 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":7,"Type":"Logger","Request":"LoggingConfig","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.31622 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":8,"Type":"Provisioner","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.31626 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":9,"Type":"Environment","Request":"EnvironConfig","Params":{}}
[LOG] 80.31633 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":10,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.31736 DEBUG juju.state.apiserver -> [15] machine-0 1.434468ms {"RequestId":5,"Response":{"Results":[{"Life":"alive","Error":null}]}} Machiner[""].Life
[LOG] 80.31826 DEBUG juju.state.apiserver -> [15] machine-0 2.125241ms {"RequestId":7,"Response":{"Results":[{"Error":null,"Result":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG"}]}} Logger[""].LoggingConfig
[LOG] 80.31838 DEBUG juju.state.apiserver -> [15] machine-0 2.168416ms {"RequestId":8,"Response":{"Results":[{"Life":"alive","Error":null}]}} Provisioner[""].Life
[LOG] 80.32000 DEBUG juju.state.apiserver -> [15] machine-0 3.658592ms {"RequestId":9,"Response":{"Error":null,"Config":{"admin-secret":"","agent-version":"1.17.3","api-port":4321,"authorized-keys":"ssh-rsa BBBB jo@bloggs.com","broken":"","ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB4jCCAY6gAwIBAgIBADALBgkqhkiG9w0BAQUwSjENMAsGA1UEChMEanVqdTE5\nMDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJqdWp1\nIHRlc3RpbmciMB4XDTE0MDIxNDAxNDExMVoXDTI0MDIxNDAxNDYxMVowSjENMAsG\nA1UEChMEanVqdTE5MDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmly\nb25tZW50ICJqdWp1IHRlc3RpbmciMFowCwYJKoZIhvcNAQEBA0sAMEgCQQDw9Jrj\nhx/o9y7x7umN+mV7IqmypLC66ke9gyYHUlPqSfbi6NEWl7d6IEgX11XEXdLhxiFE\nR/IFvfOVf5PQNhp/AgMBAAGjYzBhMA4GA1UdDwEB/wQEAwIApDAPBgNVHRMBAf8E\nBTADAQH/MB0GA1UdDgQWBBSbyPFkBXPfHEIj34dUq1iuxeu9LTAfBgNVHSMEGDAW\ngBSbyPFkBXPfHEIj34dUq1iuxeu9LTALBgkqhkiG9w0BAQUDQQCW6c57tKnvKH93\nuCPIJwmwZEzjg3Ko3fSKd9UwxFnm8fvibeNUU5IzRoh9NRF0AMe6BZf+JNVLCQ7x\n3EllXDZr\n-----END CERTIFICATE-----\n","ca-private-key":"","charm-store-auth":"","default-series":"precise","development":false,"firewall-mode":"instance","image-metadata-url":"","image-stream":"","logging-config":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG","name":"dummyenv","secret":"not available","ssl-hostname-verification":true,"state-id":"11","state-port":1234,"state-server":true,"syslog-port":2345,"tools-metadata-url":"","tools-url":"","type":"dummy"}}} Environment[""].EnvironConfig
[LOG] 80.32381 DEBUG juju.state.apiserver -> [15] machine-0 7.45416ms {"RequestId":10,"Response":{"Results":[{"Error":null,"Result":["ssh-rsa BBBB jo@bloggs.com"]}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.32412 INFO juju.worker.machiner setting addresses for machine-0 to ["10.55.32.52" "fe80::f816:3eff:fef7:1c4e"]
[LOG] 80.32470 DEBUG juju.worker.machineenvironment new proxy settings osenv.ProxySettings{Http:"", Https:"", Ftp:""}
[LOG] 80.35190 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":11,"Type":"Machiner","Request":"SetMachineAddresses","Params":{"MachineAddresses":[{"Tag":"machine-0","Addresses":[{"Value":"10.55.32.52","Type":"ipv4","NetworkName":"","NetworkScope":""},{"Value":"fe80::f816:3eff:fef7:1c4e","Type":"ipv6","NetworkName":"","NetworkScope":""}]}]}}
[LOG] 80.35211 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":12,"Type":"Logger","Request":"WatchLoggingConfig","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.35228 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":13,"Type":"Provisioner","Request":"SetSupportedContainers","Params":{"Params":[{"MachineTag":"machine-0","ContainerTypes":["lxc"]}]}}
[LOG] 80.35340 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.35350 WARNING juju.utils.ssh invalid Juju ssh key ssh-rsa BBBB jo@bloggs.com: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.35354 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.35358 ERROR juju.worker.authenticationworker adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.35494 ERROR juju worker: exited "authenticationworker": adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.35497 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.35602 DEBUG juju.state.apiserver -> [15] machine-0 3.90246ms {"RequestId":12,"Response":{"Results":[{"NotifyWatcherId":"2","Error":null}]}} Logger[""].WatchLoggingConfig
[LOG] 80.35660 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":15,"Type":"Logger","Request":"LoggingConfig","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.35671 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":16,"Type":"NotifyWatcher","Id":"2","Request":"Next","Params":{}}
[LOG] 80.35927 DEBUG juju.state.apiserver -> [15] machine-0 2.637292ms {"RequestId":15,"Response":{"Results":[{"Error":null,"Result":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG"}]}} Logger[""].LoggingConfig
[LOG] 80.36323 DEBUG juju.state.apiserver -> [15] machine-0 47.164762ms {"RequestId":6,"Response":{"Results":[{"Error":null}]}} Upgrader[""].SetTools
[LOG] 80.36354 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":17,"Type":"Upgrader","Request":"WatchAPIVersion","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.36373 INFO juju.util.exec run result: exit status 1
[LOG] 80.36378 ERROR juju.worker.machineenvironment failed writing new proxy values:

/bin/bash: line 1: /home/ubuntu/.juju-proxy: Permission denied

[LOG] 80.36385 DEBUG juju.worker.machineenvironment new apt proxy settings osenv.ProxySettings{Http:"", Https:"", Ftp:""}
[LOG] 80.36390 ERROR juju.worker.machineenvironment error writing apt proxy config file: open /etc/apt/apt.conf.d/42-juju-proxy-settings: permission denied
[LOG] 80.36406 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":18,"Type":"Environment","Request":"WatchForEnvironConfigChanges","Params":{}}
[LOG] 80.36494 DEBUG juju.state.apiserver -> [15] machine-0 1.405431ms {"RequestId":17,"Response":{"Results":[{"NotifyWatcherId":"3","Error":null}]}} Upgrader[""].WatchAPIVersion
[LOG] 80.36504 DEBUG juju.state.apiserver -> [15] machine-0 985.078us {"RequestId":18,"Response":{"NotifyWatcherId":"4","Error":null}} Environment[""].WatchForEnvironConfigChanges
[LOG] 80.36585 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":19,"Type":"Upgrader","Request":"DesiredVersion","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.36593 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":20,"Type":"Environment","Request":"EnvironConfig","Params":{}}
[LOG] 80.36601 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":21,"Type":"NotifyWatcher","Id":"3","Request":"Next","Params":{}}
[LOG] 80.36609 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":22,"Type":"NotifyWatcher","Id":"4","Request":"Next","Params":{}}
[LOG] 80.36894 DEBUG juju.state.apiserver -> [15] machine-0 3.062625ms {"RequestId":19,"Response":{"Results":[{"Version":"1.17.3","Error":null}]}} Upgrader[""].DesiredVersion
[LOG] 80.37327 DEBUG juju.state.apiserver -> [15] machine-0 7.168338ms {"RequestId":20,"Response":{"Error":null,"Config":{"admin-secret":"","agent-version":"1.17.3","api-port":4321,"authorized-keys":"ssh-rsa BBBB jo@bloggs.com","broken":"","ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB4jCCAY6gAwIBAgIBADALBgkqhkiG9w0BAQUwSjENMAsGA1UEChMEanVqdTE5\nMDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJqdWp1\nIHRlc3RpbmciMB4XDTE0MDIxNDAxNDExMVoXDTI0MDIxNDAxNDYxMVowSjENMAsG\nA1UEChMEanVqdTE5MDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmly\nb25tZW50ICJqdWp1IHRlc3RpbmciMFowCwYJKoZIhvcNAQEBA0sAMEgCQQDw9Jrj\nhx/o9y7x7umN+mV7IqmypLC66ke9gyYHUlPqSfbi6NEWl7d6IEgX11XEXdLhxiFE\nR/IFvfOVf5PQNhp/AgMBAAGjYzBhMA4GA1UdDwEB/wQEAwIApDAPBgNVHRMBAf8E\nBTADAQH/MB0GA1UdDgQWBBSbyPFkBXPfHEIj34dUq1iuxeu9LTAfBgNVHSMEGDAW\ngBSbyPFkBXPfHEIj34dUq1iuxeu9LTALBgkqhkiG9w0BAQUDQQCW6c57tKnvKH93\nuCPIJwmwZEzjg3Ko3fSKd9UwxFnm8fvibeNUU5IzRoh9NRF0AMe6BZf+JNVLCQ7x\n3EllXDZr\n-----END CERTIFICATE-----\n","ca-private-key":"","charm-store-auth":"","default-series":"precise","development":false,"firewall-mode":"instance","image-metadata-url":"","image-stream":"","logging-config":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG","name":"dummyenv","secret":"not available","ssl-hostname-verification":true,"state-id":"11","state-port":1234,"state-server":true,"syslog-port":2345,"tools-metadata-url":"","tools-url":"","type":"dummy"}}} Environment[""].EnvironConfig
[LOG] 80.37608 INFO juju.worker.upgrader desired tool version: 1.17.3
[LOG] 80.39686 DEBUG juju.state.apiserver -> [15] machine-0 45.237085ms {"RequestId":11,"Response":{"Results":[{"Error":null}]}} Machiner[""].SetMachineAddresses
[LOG] 80.42980 INFO juju worker: start "authenticationworker"
[LOG] 80.43053 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":23,"Type":"Machiner","Request":"SetStatus","Params":{"Entities":[{"Tag":"machine-0","Status":"started","Info":"","Data":null}]}}
[LOG] 80.43060 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":24,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.43322 DEBUG juju.state.apiserver -> [15] machine-0 2.599096ms {"RequestId":24,"Response":{"Results":[{"Error":null,"Result":["ssh-rsa BBBB jo@bloggs.com"]}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.43389 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.43398 WARNING juju.utils.ssh invalid Juju ssh key ssh-rsa BBBB jo@bloggs.com: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.43405 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.43408 ERROR juju.worker.authenticationworker adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.43527 ERROR juju worker: exited "authenticationworker": adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.43647 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.43863 DEBUG juju.state.apiserver -> [15] machine-0 86.369377ms {"RequestId":13,"Response":{"Results":[{"Error":null}]}} Provisioner[""].SetSupportedContainers
[LOG] 80.43893 INFO juju worker: start "0-container-watcher"
[LOG] 80.43895 INFO juju worker: start "environ-provisioner"
[LOG] 80.43913 INFO juju worker: start "firewaller"
[LOG] 80.43923 INFO juju worker: start "charm-revision-updater"
[LOG] 80.43941 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":26,"Type":"Provisioner","Request":"WatchContainers","Params":{"Params":[{"MachineTag":"machine-0","ContainerType":""}]}}
[LOG] 80.43949 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":27,"Type":"Provisioner","Request":"WatchForEnvironConfigChanges","Params":{}}
[LOG] 80.43956 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":28,"Type":"Firewaller","Request":"WatchForEnvironConfigChanges","Params":{}}
[LOG] 80.43966 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":29,"Type":"CharmRevisionUpdater","Request":"UpdateLatestRevisions","Params":{}}
[LOG] 80.44198 DEBUG juju.state.apiserver -> [15] machine-0 2.442754ms {"RequestId":27,"Response":{"NotifyWatcherId":"5","Error":null}} Provisioner[""].WatchForEnvironConfigChanges
[LOG] 80.44252 DEBUG juju.state.apiserver -> [15] machine-0 2.568087ms {"RequestId":28,"Response":{"NotifyWatcherId":"6","Error":null}} Firewaller[""].WatchForEnvironConfigChanges
[LOG] 80.44369 INFO juju.state.apiserver.charmrevisionupdater retrieving revision information for 0 charms
[LOG] 80.44439 DEBUG juju.state.apiserver -> [15] machine-0 4.845515ms {"RequestId":26,"Response":{"Results":[{"StringsWatcherId":"7","Changes":[],"Error":null}]}} Provisioner[""].WatchContainers
[LOG] 80.44495 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":30,"Type":"Firewaller","Request":"WatchEnvironMachines","Params":{}}
[LOG] 80.44507 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":31,"Type":"Provisioner","Request":"EnvironConfig","Params":{}}
[LOG] 80.44516 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":32,"Type":"NotifyWatcher","Id":"5","Request":"Next","Params":{}}
[LOG] 80.44524 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":33,"Type":"NotifyWatcher","Id":"6","Request":"Next","Params":{}}
[LOG] 80.44642 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":34,"Type":"StringsWatcher","Id":"7","Request":"Next","Params":{}}
[LOG] 80.44884 DEBUG juju.state.apiserver -> [15] machine-0 3.459045ms {"RequestId":31,"Response":{"Error":null,"Config":{"admin-secret":"","agent-version":"1.17.3","api-port":4321,"authorized-keys":"ssh-rsa BBBB jo@bloggs.com","broken":"","ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB4jCCAY6gAwIBAgIBADALBgkqhkiG9w0BAQUwSjENMAsGA1UEChMEanVqdTE5\nMDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJqdWp1\nIHRlc3RpbmciMB4XDTE0MDIxNDAxNDExMVoXDTI0MDIxNDAxNDYxMVowSjENMAsG\nA1UEChMEanVqdTE5MDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmly\nb25tZW50ICJqdWp1IHRlc3RpbmciMFowCwYJKoZIhvcNAQEBA0sAMEgCQQDw9Jrj\nhx/o9y7x7umN+mV7IqmypLC66ke9gyYHUlPqSfbi6NEWl7d6IEgX11XEXdLhxiFE\nR/IFvfOVf5PQNhp/AgMBAAGjYzBhMA4GA1UdDwEB/wQEAwIApDAPBgNVHRMBAf8E\nBTADAQH/MB0GA1UdDgQWBBSbyPFkBXPfHEIj34dUq1iuxeu9LTAfBgNVHSMEGDAW\ngBSbyPFkBXPfHEIj34dUq1iuxeu9LTALBgkqhkiG9w0BAQUDQQCW6c57tKnvKH93\nuCPIJwmwZEzjg3Ko3fSKd9UwxFnm8fvibeNUU5IzRoh9NRF0AMe6BZf+JNVLCQ7x\n3EllXDZr\n-----END CERTIFICATE-----\n","ca-private-key":"","charm-store-auth":"","default-series":"precise","development":false,"firewall-mode":"instance","image-metadata-url":"","image-stream":"","logging-config":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG","name":"dummyenv","secret":"pork","ssl-hostname-verification":true,"state-id":"11","state-port":1234,"state-server":true,"syslog-port":2345,"tools-metadata-url":"","tools-url":"","type":"dummy"}}} Provisioner[""].EnvironConfig
[LOG] 80.44925 DEBUG juju.state.apiserver -> [15] machine-0 4.291921ms {"RequestId":30,"Response":{"StringsWatcherId":"8","Changes":["0"],"Error":null}} Firewaller[""].WatchEnvironMachines
[LOG] 80.45506 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":35,"Type":"Provisioner","Request":"StateAddresses","Params":{}}
[LOG] 80.45514 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":36,"Type":"Firewaller","Request":"EnvironConfig","Params":{}}
[LOG] 80.45521 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":37,"Type":"StringsWatcher","Id":"8","Request":"Next","Params":{}}
[LOG] 80.46049 DEBUG juju.state.apiserver -> [15] machine-0 5.270726ms {"RequestId":36,"Response":{"Error":null,"Config":{"admin-secret":"","agent-version":"1.17.3","api-port":4321,"authorized-keys":"ssh-rsa BBBB jo@bloggs.com","broken":"","ca-cert":"-----BEGIN CERTIFICATE-----\nMIIB4jCCAY6gAwIBAgIBADALBgkqhkiG9w0BAQUwSjENMAsGA1UEChMEanVqdTE5\nMDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmlyb25tZW50ICJqdWp1\nIHRlc3RpbmciMB4XDTE0MDIxNDAxNDExMVoXDTI0MDIxNDAxNDYxMVowSjENMAsG\nA1UEChMEanVqdTE5MDcGA1UEAwwwanVqdS1nZW5lcmF0ZWQgQ0EgZm9yIGVudmly\nb25tZW50ICJqdWp1IHRlc3RpbmciMFowCwYJKoZIhvcNAQEBA0sAMEgCQQDw9Jrj\nhx/o9y7x7umN+mV7IqmypLC66ke9gyYHUlPqSfbi6NEWl7d6IEgX11XEXdLhxiFE\nR/IFvfOVf5PQNhp/AgMBAAGjYzBhMA4GA1UdDwEB/wQEAwIApDAPBgNVHRMBAf8E\nBTADAQH/MB0GA1UdDgQWBBSbyPFkBXPfHEIj34dUq1iuxeu9LTAfBgNVHSMEGDAW\ngBSbyPFkBXPfHEIj34dUq1iuxeu9LTALBgkqhkiG9w0BAQUDQQCW6c57tKnvKH93\nuCPIJwmwZEzjg3Ko3fSKd9UwxFnm8fvibeNUU5IzRoh9NRF0AMe6BZf+JNVLCQ7x\n3EllXDZr\n-----END CERTIFICATE-----\n","ca-private-key":"","charm-store-auth":"","default-series":"precise","development":false,"firewall-mode":"instance","image-metadata-url":"","image-stream":"","logging-config":"\u003croot\u003e=WARNING;juju=DEBUG;unit=DEBUG","name":"dummyenv","secret":"pork","ssl-hostname-verification":true,"state-id":"11","state-port":1234,"state-server":true,"syslog-port":2345,"tools-metadata-url":"","tools-url":"","type":"dummy"}}} Firewaller[""].EnvironConfig
[LOG] 80.47100 DEBUG juju.state.apiserver -> [15] machine-0 15.930362ms {"RequestId":35,"Response":{"Error":null,"Result":["0.1.2.3:1234"]}} Provisioner[""].StateAddresses
[LOG] 80.47143 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":38,"Type":"Firewaller","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.47149 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":39,"Type":"Provisioner","Request":"APIAddresses","Params":{}}
[LOG] 80.47274 DEBUG juju.state.apiserver -> [15] machine-0 1.306356ms {"RequestId":38,"Response":{"Results":[{"Life":"alive","Error":null}]}} Firewaller[""].Life
[LOG] 80.47331 DEBUG juju.state.apiserver -> [15] machine-0 42.814668ms {"RequestId":23,"Response":{"Results":[{"Error":null}]}} Machiner[""].SetStatus
[LOG] 80.47385 DEBUG juju.state.apiserver -> [15] machine-0 2.353695ms {"RequestId":39,"Response":{"Error":null,"Result":["0.1.2.3:4321"]}} Provisioner[""].APIAddresses
[LOG] 80.47403 INFO juju.worker.machiner "machine-0" started
[LOG] 80.47424 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":40,"Type":"Firewaller","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.47432 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":41,"Type":"Machiner","Request":"Watch","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.47437 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":42,"Type":"Provisioner","Request":"CACert","Params":{}}
[LOG] 80.47500 DEBUG juju.state.apiserver -> [15] machine-0 35.320221ms {"RequestId":29,"Response":{"Error":null}} CharmRevisionUpdater[""].UpdateLatestRevisions
[LOG] 80.47524 DEBUG juju.state.apiserver -> [15] machine-0 841.42us {"RequestId":42,"Response":{"Result":"LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUI0akNDQVk2Z0F3SUJBZ0lCQURBTEJna3Foa2lHOXcwQkFRVXdTakVOTUFzR0ExVUVDaE1FYW5WcWRURTUKTURjR0ExVUVBd3d3YW5WcWRTMW5aVzVsY21GMFpXUWdRMEVnWm05eUlHVnVkbWx5YjI1dFpXNTBJQ0pxZFdwMQpJSFJsYzNScGJtY2lNQjRYRFRFME1ESXhOREF4TkRFeE1Wb1hEVEkwTURJeE5EQXhORFl4TVZvd1NqRU5NQXNHCkExVUVDaE1FYW5WcWRURTVNRGNHQTFVRUF3d3dhblZxZFMxblpXNWxjbUYwWldRZ1EwRWdabTl5SUdWdWRtbHkKYjI1dFpXNTBJQ0pxZFdwMUlIUmxjM1JwYm1jaU1Gb3dDd1lKS29aSWh2Y05BUUVCQTBzQU1FZ0NRUUR3OUpyagpoeC9vOXk3eDd1bU4rbVY3SXFteXBMQzY2a2U5Z3lZSFVsUHFTZmJpNk5FV2w3ZDZJRWdYMTFYRVhkTGh4aUZFClIvSUZ2Zk9WZjVQUU5ocC9BZ01CQUFHall6QmhNQTRHQTFVZER3RUIvd1FFQXdJQXBEQVBCZ05WSFJNQkFmOEUKQlRBREFRSC9NQjBHQTFVZERnUVdCQlNieVBGa0JYUGZIRUlqMzRkVXExaXV4ZXU5TFRBZkJnTlZIU01FR0RBVwpnQlNieVBGa0JYUGZIRUlqMzRkVXExaXV4ZXU5TFRBTEJna3Foa2lHOXcwQkFRVURRUUNXNmM1N3RLbnZLSDkzCnVDUElKd213WkV6amczS28zZlNLZDlVd3hGbm04ZnZpYmVOVVU1SXpSb2g5TlJGMEFNZTZCWmYrSk5WTENRN3gKM0VsbFhEWnIKLS0tLS1FTkQgQ0VSVElGSUNBVEUtLS0tLQo="}} Provisioner[""].CACert
[LOG] 80.47551 DEBUG juju.state.apiserver -> [15] machine-0 1.266894ms {"RequestId":40,"Response":{"Results":[{"Life":"alive","Error":null}]}} Firewaller[""].Life
[LOG] 80.47651 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":43,"Type":"Provisioner","Request":"WatchEnvironMachines","Params":{}}
[LOG] 80.47660 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":44,"Type":"Firewaller","Request":"WatchUnits","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.47682 DEBUG juju.state.apiserver -> [15] machine-0 2.513714ms {"RequestId":41,"Response":{"Results":[{"NotifyWatcherId":"9","Error":null}]}} Machiner[""].Watch
[LOG] 80.48122 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":45,"Type":"Machiner","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48130 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":46,"Type":"NotifyWatcher","Id":"9","Request":"Next","Params":{}}
[LOG] 80.48241 DEBUG juju.state.apiserver -> [15] machine-0 5.889645ms {"RequestId":43,"Response":{"StringsWatcherId":"10","Changes":["0"],"Error":null}} Provisioner[""].WatchEnvironMachines
[LOG] 80.48258 INFO juju.provisioner Starting up provisioner task machine-0
[LOG] 80.48463 DEBUG juju.state.apiserver -> [15] machine-0 3.374614ms {"RequestId":45,"Response":{"Results":[{"Life":"alive","Error":null}]}} Machiner[""].Life
[LOG] 80.48482 DEBUG juju.state.apiserver -> [15] machine-0 8.223129ms {"RequestId":44,"Response":{"Results":[{"StringsWatcherId":"11","Changes":null,"Error":null}]}} Firewaller[""].WatchUnits
[LOG] 80.48506 DEBUG juju.worker.firewaller started watching "machine-0"
[LOG] 80.48530 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":47,"Type":"Provisioner","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48537 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":48,"Type":"StringsWatcher","Id":"10","Request":"Next","Params":{}}
[LOG] 80.48545 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":49,"Type":"Firewaller","Request":"Life","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48553 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":50,"Type":"StringsWatcher","Id":"11","Request":"Next","Params":{}}
[LOG] 80.48634 DEBUG juju.state.apiserver -> [15] machine-0 1.039877ms {"RequestId":47,"Response":{"Results":[{"Life":"alive","Error":null}]}} Provisioner[""].Life
[LOG] 80.48648 DEBUG juju.state.apiserver -> [15] machine-0 1.046563ms {"RequestId":49,"Response":{"Results":[{"Life":"alive","Error":null}]}} Firewaller[""].Life
[LOG] 80.48757 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":51,"Type":"Provisioner","Request":"InstanceId","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48764 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":52,"Type":"Firewaller","Request":"InstanceId","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48822 INFO juju worker: start "authenticationworker"
[LOG] 80.48841 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":53,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.48872 DEBUG juju.state.apiserver -> [15] machine-0 1.149248ms {"RequestId":51,"Response":{"Results":[{"Error":null,"Result":"ardbeg-0"}]}} Provisioner[""].InstanceId
[LOG] 80.48886 DEBUG juju.state.apiserver -> [15] machine-0 1.228545ms {"RequestId":52,"Response":{"Results":[{"Error":null,"Result":"ardbeg-0"}]}} Firewaller[""].InstanceId
[LOG] 80.48900 INFO juju.provisioner machine 0 already started as instance "ardbeg-0"
[LOG] 80.48915 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":54,"Type":"Provisioner","Request":"InstanceId","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.49048 DEBUG juju.state.apiserver -> [15] machine-0 1.321092ms {"RequestId":54,"Response":{"Results":[{"Error":null,"Result":"ardbeg-0"}]}} Provisioner[""].InstanceId
[LOG] 80.49175 DEBUG juju.state.apiserver -> [15] machine-0 3.337993ms {"RequestId":53,"Response":{"Results":[{"Error":null,"Result":["ssh-rsa BBBB jo@bloggs.com"]}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.49195 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.49200 WARNING juju.utils.ssh invalid Juju ssh key ssh-rsa BBBB jo@bloggs.com: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.49203 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.49206 ERROR juju.worker.authenticationworker adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.49228 ERROR juju worker: exited "authenticationworker": adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.49230 INFO juju worker: restarting "authenticationworker" in 50ms
waiting for unit "test-service/0" to be provisioned
[LOG] 80.54256 INFO juju worker: start "authenticationworker"
[LOG] 80.54298 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":56,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.54456 DEBUG juju.state.apiserver -> [15] machine-0 1.574612ms {"RequestId":56,"Response":{"Results":[{"Error":null,"Result":["ssh-rsa BBBB jo@bloggs.com"]}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.54478 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.54483 WARNING juju.utils.ssh invalid Juju ssh key ssh-rsa BBBB jo@bloggs.com: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.54487 DEBUG juju.utils.ssh reading authorised keys file /tmp/gocheck-1460320609597786623/78/.ssh/authorized_keys
[LOG] 80.54490 ERROR juju.worker.authenticationworker adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.54547 ERROR juju worker: exited "authenticationworker": adding current Juju keys to ssh authorised keys: generating key fingerprint: invalid authorized_key "ssh-rsa BBBB jo@bloggs.com"
[LOG] 80.54550 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.57851 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 80.57880 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 80.59571 INFO juju worker: start "authenticationworker"
[LOG] 80.59608 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":58,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.59629 DEBUG juju.state.apiserver -> [15] machine-0 228.241us {"RequestId":58,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.59644 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.59668 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.59670 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.64690 INFO juju worker: start "authenticationworker"
[LOG] 80.64723 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":60,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.64739 DEBUG juju.state.apiserver -> [15] machine-0 175.027us {"RequestId":60,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.64755 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.64772 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.64773 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.69795 INFO juju worker: start "authenticationworker"
[LOG] 80.70101 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":62,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.70128 DEBUG juju.state.apiserver -> [15] machine-0 362.335us {"RequestId":62,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.70163 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.70196 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.70198 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.72679 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 80.75225 INFO juju worker: start "authenticationworker"
[LOG] 80.75265 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":64,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.75289 DEBUG juju.state.apiserver -> [15] machine-0 254.986us {"RequestId":64,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.75307 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.75325 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.75327 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.80346 INFO juju worker: start "authenticationworker"
[LOG] 80.80383 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":66,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.80399 DEBUG juju.state.apiserver -> [15] machine-0 181.106us {"RequestId":66,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.80425 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.80448 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.80450 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.85471 INFO juju worker: start "authenticationworker"
[LOG] 80.85515 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":68,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.85533 DEBUG juju.state.apiserver -> [15] machine-0 270.059us {"RequestId":68,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.85547 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.85569 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.85571 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.90590 INFO juju worker: start "authenticationworker"
[LOG] 80.90625 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":70,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.90645 DEBUG juju.state.apiserver -> [15] machine-0 209.435us {"RequestId":70,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.90661 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.90680 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.90682 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 80.95701 INFO juju worker: start "authenticationworker"
[LOG] 80.95739 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":72,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 80.95758 DEBUG juju.state.apiserver -> [15] machine-0 224.596us {"RequestId":72,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 80.95782 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.95803 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 80.95804 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.00826 INFO juju worker: start "authenticationworker"
[LOG] 81.00863 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":74,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.00888 DEBUG juju.state.apiserver -> [15] machine-0 267.233us {"RequestId":74,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.00906 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.00923 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.00926 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.05947 INFO juju worker: start "authenticationworker"
[LOG] 81.05981 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":76,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.05999 DEBUG juju.state.apiserver -> [15] machine-0 192.327us {"RequestId":76,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.06020 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.06043 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.06044 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.07874 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.07896 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.11068 INFO juju worker: start "authenticationworker"
[LOG] 81.11104 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":78,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.11124 DEBUG juju.state.apiserver -> [15] machine-0 212.889us {"RequestId":78,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.11142 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.11162 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.11164 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.16186 INFO juju worker: start "authenticationworker"
[LOG] 81.16226 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":80,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.16246 DEBUG juju.state.apiserver -> [15] machine-0 232.492us {"RequestId":80,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.16270 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.16291 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.16293 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.21317 INFO juju worker: start "authenticationworker"
[LOG] 81.21355 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":82,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.21374 DEBUG juju.state.apiserver -> [15] machine-0 216.708us {"RequestId":82,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.21389 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.21414 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.21417 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.22722 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.26440 INFO juju worker: start "authenticationworker"
[LOG] 81.26476 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":84,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.26494 DEBUG juju.state.apiserver -> [15] machine-0 194.14us {"RequestId":84,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.26512 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.26533 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.26534 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.29262 WARNING juju.worker.instanceupdater cannot get instance info for instance "ardbeg-0": no instances found
[LOG] 81.29271 WARNING juju.worker.instanceupdater cannot get current machine status for machine 0: cannot get status "m#0": EOF
[LOG] 81.31555 INFO juju worker: start "authenticationworker"
[LOG] 81.31593 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":86,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.31612 DEBUG juju.state.apiserver -> [15] machine-0 211.384us {"RequestId":86,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.31631 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.31663 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.31665 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.36686 INFO juju worker: start "authenticationworker"
[LOG] 81.36720 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":88,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.36738 DEBUG juju.state.apiserver -> [15] machine-0 190.141us {"RequestId":88,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.36754 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.36776 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.36778 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.41797 INFO juju worker: start "authenticationworker"
[LOG] 81.41832 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":90,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.41851 DEBUG juju.state.apiserver -> [15] machine-0 205.585us {"RequestId":90,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.41867 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.41889 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.41891 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.46911 INFO juju worker: start "authenticationworker"
[LOG] 81.46948 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":92,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.46969 DEBUG juju.state.apiserver -> [15] machine-0 185.327us {"RequestId":92,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.46983 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.47006 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.47008 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.52030 INFO juju worker: start "authenticationworker"
[LOG] 81.52082 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":94,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.52101 DEBUG juju.state.apiserver -> [15] machine-0 318.611us {"RequestId":94,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.52120 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.52142 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.52143 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.57165 INFO juju worker: start "authenticationworker"
[LOG] 81.57200 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":96,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.57222 DEBUG juju.state.apiserver -> [15] machine-0 200.824us {"RequestId":96,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.57240 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.57263 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.57264 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.57907 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.57916 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.62285 INFO juju worker: start "authenticationworker"
[LOG] 81.62321 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":98,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.62341 DEBUG juju.state.apiserver -> [15] machine-0 195.922us {"RequestId":98,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.62357 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.62387 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.62391 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.67412 INFO juju worker: start "authenticationworker"
[LOG] 81.67458 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":100,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.67485 DEBUG juju.state.apiserver -> [15] machine-0 276.156us {"RequestId":100,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.67500 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.67524 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.67525 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.72546 INFO juju worker: start "authenticationworker"
[LOG] 81.72591 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":102,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.72607 DEBUG juju.state.apiserver -> [15] machine-0 190.55us {"RequestId":102,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.72623 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.72647 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.72649 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.72752 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 81.77670 INFO juju worker: start "authenticationworker"
[LOG] 81.77708 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":104,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.77731 DEBUG juju.state.apiserver -> [15] machine-0 235.859us {"RequestId":104,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.77748 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.77779 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.77780 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.82801 INFO juju worker: start "authenticationworker"
[LOG] 81.82842 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":106,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.82860 DEBUG juju.state.apiserver -> [15] machine-0 214.712us {"RequestId":106,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.82874 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.82896 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.82898 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.87922 INFO juju worker: start "authenticationworker"
[LOG] 81.87960 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":108,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.87976 DEBUG juju.state.apiserver -> [15] machine-0 202.655us {"RequestId":108,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.87994 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.88022 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.88024 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.93044 INFO juju worker: start "authenticationworker"
[LOG] 81.93080 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":110,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.93098 DEBUG juju.state.apiserver -> [15] machine-0 181.89us {"RequestId":110,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.93114 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.93138 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.93159 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 81.98181 INFO juju worker: start "authenticationworker"
[LOG] 81.98226 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":112,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 81.98245 DEBUG juju.state.apiserver -> [15] machine-0 204.888us {"RequestId":112,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 81.98264 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.98281 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 81.98284 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.03304 INFO juju worker: start "authenticationworker"
[LOG] 82.03338 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":114,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.03357 DEBUG juju.state.apiserver -> [15] machine-0 201.271us {"RequestId":114,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.03380 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.03403 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.03404 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.07984 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.07990 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.07995 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.07997 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.08423 INFO juju worker: start "authenticationworker"
[LOG] 82.08456 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":116,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.08474 DEBUG juju.state.apiserver -> [15] machine-0 200.247us {"RequestId":116,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.08487 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.08519 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.08520 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.13541 INFO juju worker: start "authenticationworker"
[LOG] 82.13576 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":118,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.13595 DEBUG juju.state.apiserver -> [15] machine-0 198.704us {"RequestId":118,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.13613 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.13640 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.13643 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.18664 INFO juju worker: start "authenticationworker"
[LOG] 82.18700 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":120,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.18719 DEBUG juju.state.apiserver -> [15] machine-0 207.698us {"RequestId":120,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.18734 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.18756 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.18757 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.22812 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.22822 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.23781 INFO juju worker: start "authenticationworker"
[LOG] 82.23818 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":122,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.23840 DEBUG juju.state.apiserver -> [15] machine-0 212.734us {"RequestId":122,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.23856 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.23883 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.23885 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.28905 INFO juju worker: start "authenticationworker"
[LOG] 82.28939 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":124,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.28957 DEBUG juju.state.apiserver -> [15] machine-0 178.32us {"RequestId":124,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.28981 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.29002 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.29004 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.34027 INFO juju worker: start "authenticationworker"
[LOG] 82.34071 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":126,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.34093 DEBUG juju.state.apiserver -> [15] machine-0 303.915us {"RequestId":126,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.34110 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.34131 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.34132 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.39151 INFO juju worker: start "authenticationworker"
[LOG] 82.39187 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":128,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.39205 DEBUG juju.state.apiserver -> [15] machine-0 197.668us {"RequestId":128,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.39225 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.39254 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.39255 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.44277 INFO juju worker: start "authenticationworker"
[LOG] 82.44321 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":130,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.44337 DEBUG juju.state.apiserver -> [15] machine-0 178.099us {"RequestId":130,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.44352 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.44374 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.44377 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.49397 INFO juju worker: start "authenticationworker"
[LOG] 82.49434 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":132,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.49454 DEBUG juju.state.apiserver -> [15] machine-0 198.18us {"RequestId":132,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.49470 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.49492 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.49494 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.54515 INFO juju worker: start "authenticationworker"
[LOG] 82.54552 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":134,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.54576 DEBUG juju.state.apiserver -> [15] machine-0 252.116us {"RequestId":134,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.54594 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.54617 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.54619 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.58021 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.58028 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.59640 INFO juju worker: start "authenticationworker"
[LOG] 82.59675 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":136,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.59702 DEBUG juju.state.apiserver -> [15] machine-0 290.858us {"RequestId":136,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.59717 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.59739 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.59741 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.64764 INFO juju worker: start "authenticationworker"
[LOG] 82.64802 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":138,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.64821 DEBUG juju.state.apiserver -> [15] machine-0 197.635us {"RequestId":138,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.64838 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.64861 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.64863 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.69887 INFO juju worker: start "authenticationworker"
[LOG] 82.69924 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":140,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.69943 DEBUG juju.state.apiserver -> [15] machine-0 234.896us {"RequestId":140,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.69959 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.69983 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.69984 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.72862 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 82.75007 INFO juju worker: start "authenticationworker"
[LOG] 82.75047 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":142,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.75066 DEBUG juju.state.apiserver -> [15] machine-0 223.179us {"RequestId":142,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.75087 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.75105 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.75107 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.80143 INFO juju worker: start "authenticationworker"
[LOG] 82.80182 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":144,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.80199 DEBUG juju.state.apiserver -> [15] machine-0 187.962us {"RequestId":144,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.80218 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.80245 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.80247 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.85268 INFO juju worker: start "authenticationworker"
[LOG] 82.85303 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":146,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.85321 DEBUG juju.state.apiserver -> [15] machine-0 189.445us {"RequestId":146,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.85338 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.85361 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.85362 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.90383 INFO juju worker: start "authenticationworker"
[LOG] 82.90425 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":148,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.90443 DEBUG juju.state.apiserver -> [15] machine-0 198.44us {"RequestId":148,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.90460 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.90491 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.90493 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 82.95513 INFO juju worker: start "authenticationworker"
[LOG] 82.95552 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":150,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 82.95571 DEBUG juju.state.apiserver -> [15] machine-0 206.624us {"RequestId":150,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 82.95589 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.95609 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 82.95611 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.00631 INFO juju worker: start "authenticationworker"
[LOG] 83.00679 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":152,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.00809 DEBUG juju.state.apiserver -> [15] machine-0 1.406097ms {"RequestId":152,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.00831 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.00852 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.00854 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.05873 INFO juju worker: start "authenticationworker"
[LOG] 83.05910 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":154,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.05930 DEBUG juju.state.apiserver -> [15] machine-0 210.02us {"RequestId":154,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.05947 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.05971 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.05974 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.08048 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.08053 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.10996 INFO juju worker: start "authenticationworker"
[LOG] 83.11043 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":156,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.11058 DEBUG juju.state.apiserver -> [15] machine-0 181.839us {"RequestId":156,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.11074 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.11095 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.11097 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.16118 INFO juju worker: start "authenticationworker"
[LOG] 83.16154 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":158,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.16177 DEBUG juju.state.apiserver -> [15] machine-0 246.363us {"RequestId":158,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.16192 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.16215 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.16217 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.21237 INFO juju worker: start "authenticationworker"
[LOG] 83.21273 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":160,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.21292 DEBUG juju.state.apiserver -> [15] machine-0 209.058us {"RequestId":160,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.21307 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.21330 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.21332 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.22915 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.26357 INFO juju worker: start "authenticationworker"
[LOG] 83.26393 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":162,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.26421 DEBUG juju.state.apiserver -> [15] machine-0 250.016us {"RequestId":162,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.26439 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.26460 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.26462 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.29310 WARNING juju.worker.instanceupdater cannot get instance info for instance "ardbeg-0": no instances found
[LOG] 83.29324 WARNING juju.worker.instanceupdater cannot get current machine status for machine 0: cannot get status "m#0": EOF
[LOG] 83.31504 INFO juju worker: start "authenticationworker"
[LOG] 83.31577 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":164,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.31625 DEBUG juju.state.apiserver -> [15] machine-0 565.398us {"RequestId":164,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.31713 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.31823 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.31828 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.36870 INFO juju worker: start "authenticationworker"
[LOG] 83.36937 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":166,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.36980 DEBUG juju.state.apiserver -> [15] machine-0 498.148us {"RequestId":166,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.37032 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.37112 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.37117 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.42173 INFO juju worker: start "authenticationworker"
[LOG] 83.42307 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":168,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.42382 DEBUG juju.state.apiserver -> [15] machine-0 947.213us {"RequestId":168,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.42490 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.42653 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.42665 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.47707 INFO juju worker: start "authenticationworker"
[LOG] 83.47783 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":170,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.47830 DEBUG juju.state.apiserver -> [15] machine-0 463.976us {"RequestId":170,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.47871 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.47927 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.47932 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.52972 INFO juju worker: start "authenticationworker"
[LOG] 83.53051 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":172,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.53092 DEBUG juju.state.apiserver -> [15] machine-0 435.998us {"RequestId":172,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.53134 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.53191 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.53195 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.58416 INFO juju worker: start "authenticationworker"
[LOG] 83.58495 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.58580 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.58608 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.58713 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":174,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.58799 DEBUG juju.state.apiserver -> [15] machine-0 1.30564ms {"RequestId":174,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.58861 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.58949 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.59069 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.59083 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.64113 INFO juju worker: start "authenticationworker"
[LOG] 83.64193 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":176,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.64230 DEBUG juju.state.apiserver -> [15] machine-0 443.224us {"RequestId":176,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.64265 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.64324 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.64328 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.69347 INFO juju worker: start "authenticationworker"
[LOG] 83.69538 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":178,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.69662 DEBUG juju.state.apiserver -> [15] machine-0 1.042451ms {"RequestId":178,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.69842 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.70019 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.70019 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.73084 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.73119 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 83.75050 INFO juju worker: start "authenticationworker"
[LOG] 83.75163 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":180,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.75258 DEBUG juju.state.apiserver -> [15] machine-0 867.286us {"RequestId":180,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.75352 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.75503 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.75514 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.80549 INFO juju worker: start "authenticationworker"
[LOG] 83.80711 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":182,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.80800 DEBUG juju.state.apiserver -> [15] machine-0 757.277us {"RequestId":182,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.80892 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.81031 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.81056 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.86127 INFO juju worker: start "authenticationworker"
[LOG] 83.86182 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":184,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.86305 DEBUG juju.state.apiserver -> [15] machine-0 995.089us {"RequestId":184,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.86334 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.86356 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.86362 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.91417 INFO juju worker: start "authenticationworker"
[LOG] 83.91468 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":186,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.91484 DEBUG juju.state.apiserver -> [15] machine-0 234.95us {"RequestId":186,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.91505 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.91544 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.91550 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 83.96617 INFO juju worker: start "authenticationworker"
[LOG] 83.96655 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":188,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 83.96677 DEBUG juju.state.apiserver -> [15] machine-0 235.629us {"RequestId":188,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 83.96707 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.96759 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 83.96761 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.01813 INFO juju worker: start "authenticationworker"
[LOG] 84.01880 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":190,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.01906 DEBUG juju.state.apiserver -> [15] machine-0 350.27us {"RequestId":190,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.01930 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.02062 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.02064 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.07103 INFO juju worker: start "authenticationworker"
[LOG] 84.07227 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":192,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.07313 DEBUG juju.state.apiserver -> [15] machine-0 892.944us {"RequestId":192,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.07427 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.07570 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.07581 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.08944 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.08950 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.12628 INFO juju worker: start "authenticationworker"
[LOG] 84.12749 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":194,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.12832 DEBUG juju.state.apiserver -> [15] machine-0 1.051098ms {"RequestId":194,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.12923 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.13165 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.13177 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.18234 INFO juju worker: start "authenticationworker"
[LOG] 84.18278 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":196,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.18309 DEBUG juju.state.apiserver -> [15] machine-0 338.164us {"RequestId":196,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.18335 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.18374 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.18376 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.23204 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.23431 INFO juju worker: start "authenticationworker"
[LOG] 84.23466 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":198,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.23491 DEBUG juju.state.apiserver -> [15] machine-0 174.98us {"RequestId":198,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.23514 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.23539 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.23540 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.28606 INFO juju worker: start "authenticationworker"
[LOG] 84.28651 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":200,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.28680 DEBUG juju.state.apiserver -> [15] machine-0 361.004us {"RequestId":200,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.28702 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.28739 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.28741 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.33815 INFO juju worker: start "authenticationworker"
[LOG] 84.33859 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":202,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.33875 DEBUG juju.state.apiserver -> [15] machine-0 192.612us {"RequestId":202,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.33893 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.33933 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.33934 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.39018 INFO juju worker: start "authenticationworker"
[LOG] 84.39121 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":204,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.39138 DEBUG juju.state.apiserver -> [15] machine-0 317.528us {"RequestId":204,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.39170 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.39223 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.39225 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.44282 INFO juju worker: start "authenticationworker"
[LOG] 84.44335 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":206,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.44359 DEBUG juju.state.apiserver -> [15] machine-0 308.745us {"RequestId":206,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.44391 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.44461 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.44463 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.49513 INFO juju worker: start "authenticationworker"
[LOG] 84.49600 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":208,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.49643 DEBUG juju.state.apiserver -> [15] machine-0 587.518us {"RequestId":208,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.49685 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.49895 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.49905 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.54928 INFO juju worker: start "authenticationworker"
[LOG] 84.54971 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":210,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.55025 DEBUG juju.state.apiserver -> [15] machine-0 606.257us {"RequestId":210,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.55048 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.55083 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.55084 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.58989 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.58994 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.60123 INFO juju worker: start "authenticationworker"
[LOG] 84.60211 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":212,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.60250 DEBUG juju.state.apiserver -> [15] machine-0 394.786us {"RequestId":212,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.60293 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.60356 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.60361 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.65385 INFO juju worker: start "authenticationworker"
[LOG] 84.65422 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":214,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.65453 DEBUG juju.state.apiserver -> [15] machine-0 271.905us {"RequestId":214,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.65479 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.65515 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.65522 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.70558 INFO juju worker: start "authenticationworker"
[LOG] 84.70630 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":216,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.70698 DEBUG juju.state.apiserver -> [15] machine-0 533.522us {"RequestId":216,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.70753 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.70835 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.70840 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.73249 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 84.75862 INFO juju worker: start "authenticationworker"
[LOG] 84.75903 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":218,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.75941 DEBUG juju.state.apiserver -> [15] machine-0 467.039us {"RequestId":218,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.75963 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.76011 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.76012 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.81038 INFO juju worker: start "authenticationworker"
[LOG] 84.81089 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":220,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.81114 DEBUG juju.state.apiserver -> [15] machine-0 300.002us {"RequestId":220,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.81130 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.81161 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.81162 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.86181 INFO juju worker: start "authenticationworker"
[LOG] 84.86228 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":222,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.86250 DEBUG juju.state.apiserver -> [15] machine-0 237.705us {"RequestId":222,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.86271 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.86320 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.86322 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.91338 INFO juju worker: start "authenticationworker"
[LOG] 84.91437 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":224,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.91477 DEBUG juju.state.apiserver -> [15] machine-0 1.021233ms {"RequestId":224,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.91528 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.91583 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.91585 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 84.96606 INFO juju worker: start "authenticationworker"
[LOG] 84.96655 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":226,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 84.96678 DEBUG juju.state.apiserver -> [15] machine-0 257.846us {"RequestId":226,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 84.96697 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.96760 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 84.96762 INFO juju worker: restarting "authenticationworker" in 50ms
[LOG] 85.01779 INFO juju worker: start "authenticationworker"
[LOG] 85.01825 DEBUG juju.state.apiserver <- [15] machine-0 {"RequestId":228,"Type":"KeyUpdater","Request":"AuthorisedKeys","Params":{"Entities":[{"Tag":"machine-0"}]}}
[LOG] 85.01841 DEBUG juju.state.apiserver -> [15] machine-0 234.728us {"RequestId":228,"Response":{"Results":[{"Error":{"Message":"cannot get machine 0: EOF","Code":""},"Result":null}]}} KeyUpdater[""].AuthorisedKeys
[LOG] 85.01874 ERROR juju.worker.authenticationworker reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 85.01905 ERROR juju worker: exited "authenticationworker": reading Juju ssh keys for "machine-0": cannot get machine 0: EOF
[LOG] 85.01907 INFO juju worker: restarting "authenticationworker" in 50ms
machine_test.go:356:
    m, instId := s.waitProvisioned(c, units[0])
machine_test.go:393:
    c.Assert(ok, jc.IsTrue)
... obtained bool = false

[LOG] 85.05699 DEBUG juju worker: killing runner 0xc200a8f540
[LOG] 85.05702 INFO juju worker: runner is dying
[LOG] 85.05703 DEBUG juju worker: killing "state"
[LOG] 85.05704 DEBUG juju worker: killing runner 0xc201116ea0
[LOG] 85.05705 DEBUG juju worker: killing "api"
[LOG] 85.05706 DEBUG juju worker: killing runner 0xc2008e9600
[LOG] 85.05707 DEBUG juju worker: killing "termination"
[LOG] 85.05710 INFO juju worker: runner is dying
[LOG] 85.05711 DEBUG juju worker: killing "instancepoller"
[LOG] 85.05712 DEBUG juju worker: killing "apiserver"
[LOG] 85.05719 DEBUG juju worker: killing "cleaner"
[LOG] 85.05721 DEBUG juju worker: killing "resumer"
[LOG] 85.05722 DEBUG juju worker: killing "minunitsworker"
[LOG] 85.05724 INFO juju worker: runner is dying
[LOG] 85.05724 DEBUG juju worker: killing "machiner"
[LOG] 85.05725 DEBUG juju worker: killing "0-container-watcher"
[LOG] 85.05727 DEBUG juju worker: killing "firewaller"
[LOG] 85.05728 DEBUG juju worker: killing "charm-revision-updater"
[LOG] 85.05729 DEBUG juju worker: killing "upgrader"
[LOG] 85.05730 DEBUG juju worker: killing "logger"
[LOG] 85.05731 DEBUG juju worker: killing "machineenvironmentworker"
[LOG] 85.05733 DEBUG juju worker: killing "authenticationworker"
[LOG] 85.05734 DEBUG juju worker: killing "environ-provisioner"
[LOG] 85.05805 INFO juju.provisioner Shutting down provisioner task machine-0
[LOG] 85.05816 ERROR juju state/api: error stopping *apiserver.machinePinger resource: EOF
[LOG] 85.05832 DEBUG juju.state.apiserver -> [15] machine-0 4.692295762s {"RequestId":21,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["3"].Next
[LOG] 85.05848 DEBUG juju.state.apiserver -> [15] machine-0 4.613259062s {"RequestId":32,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["5"].Next
[LOG] 85.05861 DEBUG juju.state.apiserver -> [15] machine-0 4.612200798s {"RequestId":34,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} StringsWatcher["7"].Next
[LOG] 85.05868 DEBUG juju.state.apiserver -> [15] machine-0 4.577380349s {"RequestId":46,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["9"].Next
[LOG] 85.05874 DEBUG juju.state.apiserver -> [15] machine-0 4.573372927s {"RequestId":48,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} StringsWatcher["10"].Next
[LOG] 85.05880 DEBUG juju.state.apiserver -> [15] machine-0 4.702111646s {"RequestId":16,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["2"].Next
[LOG] 85.05887 DEBUG juju.state.apiserver -> [15] machine-0 4.692771123s {"RequestId":22,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["4"].Next
[LOG] 85.05895 DEBUG juju.state.apiserver -> [15] machine-0 4.613706167s {"RequestId":33,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} NotifyWatcher["6"].Next
[LOG] 85.05914 DEBUG juju.state.apiserver -> [15] machine-0 4.603935088s {"RequestId":37,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} StringsWatcher["8"].Next
[LOG] 85.05924 DEBUG juju.state.apiserver -> [15] machine-0 4.573708829s {"RequestId":50,"Error":"watcher has been stopped","ErrorCode":"stopped","Response":{}} StringsWatcher["11"].Next
[LOG] 85.05984 INFO juju.state.apiserver [15] machine-0 API connection terminated after 4.77364143s
[LOG] 85.05988 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05990 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05991 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05992 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05993 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05994 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05995 ERROR juju state/api: error trying to stop watcher error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.05996 ERROR juju state/api: error trying to stop watcher connection is shut down
[LOG] 85.05997 ERROR juju state/api: error trying to stop watcher connection is shut down
[LOG] 85.05999 ERROR juju state/api: error trying to stop watcher connection is shut down
[LOG] 85.06019 INFO juju.cmd.jujud error pinging *api.State: connection is shut down
[LOG] 85.06021 ERROR juju worker: fatal "environ-provisioner": watcher has been stopped
[LOG] 85.06025 INFO juju.cmd.jujud error pinging *api.State: connection is shut down
[LOG] 85.06026 ERROR juju worker: fatal "firewaller": watcher has been stopped
[LOG] 85.06034 INFO juju.rpc error closing codec: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.06035 ERROR juju.cmd.jujud closeWorker: close error: error receiving message: read tcp 127.0.0.1:59230: connection reset by peer
[LOG] 85.06037 ERROR juju worker: exited "api": watcher has been stopped
... Panic: Fixture has panicked (see related PANIC)

----------------------------------------------------------------------
PANIC: machine_test.go:746: MachineWithCharmsSuite.SetUpTest

[LOG] 85.11483 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 85.11492 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 85.61559 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 86.11651 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 86.61940 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 86.61956 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 87.12065 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 87.62214 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 88.12401 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 88.12425 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 88.62591 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 89.12774 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 89.63026 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 89.63034 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 90.13090 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 90.63152 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 91.13287 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 91.13324 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 91.63379 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 92.13431 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 92.63519 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 92.63535 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 93.13561 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 93.63623 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 94.13748 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 94.13794 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 94.63875 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 95.13956 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 95.64212 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 95.64250 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 96.14424 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 96.64509 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 97.14684 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 97.14722 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 97.64803 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 98.14921 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 98.65075 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 98.65111 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 99.15190 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 99.65284 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/state/apiserver/charmrevisionupdater/testing/suite.go:42
  in CharmSuite.SetUpTest
machine_test.go:747
  in MachineWithCharmsSuite.SetUpTest

----------------------------------------------------------------------
PANIC: agent.go:0: MachineWithCharmsSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest

----------------------------------------------------------------------
PANIC: machine_test.go:769: MachineWithCharmsSuite.TestManageEnvironRunsCharmRevisionUpdater

... Panic: Fixture has panicked (see related PANIC)
[jujuc whatever]
[remote]
[/path/to/remote]
[remote --help]
[unknown]
[remote --error borken]
[remote --unknown]
[remote unwanted]

----------------------------------------------------------------------
PANIC: unit_test.go:29: UnitSuite.SetUpTest

[LOG] 6.67974 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 7.18107 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 7.68383 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 7.68467 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 8.18616 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 8.68687 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 9.18949 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 9.19019 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 9.69089 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 10.19186 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 10.69297 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 10.69317 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 11.19380 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 11.69459 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 12.19569 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 12.19646 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 12.69707 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 13.19790 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 13.69902 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 13.69940 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 14.20012 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 14.70081 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 15.20177 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 15.20215 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 15.70319 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 16.20407 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 16.70528 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 16.70578 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 17.20694 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 17.70778 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 18.20933 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 18.21006 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 18.71084 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 19.21173 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 19.71336 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 19.71432 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 20.21522 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 20.71646 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 21.21793 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
[LOG] 21.21813 DEBUG juju.state connection failed, will retry: dial tcp 127.0.0.1:39074: connection refused
... Panic: no reachable servers (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:254
  in MgoInstance.MustDial
/home/tarmac/trees/src/launchpad.net/juju-core/testing/mgo.go:304
  in MgoSuite.SetUpTest
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:81
  in JujuConnSuite.SetUpTest
unit_test.go:31
  in UnitSuite.SetUpTest

----------------------------------------------------------------------
PANIC: unit_test.go:34: UnitSuite.TearDownTest

... Panic: runtime error: invalid memory address or nil pointer dereference (PC=0x414321)

/usr/lib/go/src/pkg/runtime/panic.c:229
  in panic
/usr/lib/go/src/pkg/runtime/panic.c:487
  in panicstring
/usr/lib/go/src/pkg/runtime/os_linux.c:236
  in sigpanic
/home/tarmac/trees/src/launchpad.net/juju-core/state/state.go:1296
  in State.SetAdminMongoPassword
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:246
  in JujuConnSuite.tearDownConn
/home/tarmac/trees/src/launchpad.net/juju-core/juju/testing/conn.go:87
  in JujuConnSuite.TearDownTest
unit_test.go:35
  in UnitSuite.TearDownTest

----------------------------------------------------------------------
PANIC: unit_test.go:153: UnitSuite.TestOpenAPIState

... Panic: Fixture has panicked (see related PANIC)
OOPS: 33 passed, 1 skipped, 1 FAILED, 4 FIXTURE-PANICKED, 24 MISSED
--- FAIL: TestPackage (71.11 seconds)
FAIL
FAIL	launchpad.net/juju-core/cmd/jujud	71.440s
ok  	launchpad.net/juju-core/cmd/plugins/juju-metadata	12.060s
?   	launchpad.net/juju-core/cmd/plugins/juju-restore	[no test files]
ok  	launchpad.net/juju-core/constraints	0.038s
ok  	launchpad.net/juju-core/container	0.048s
ok  	launchpad.net/juju-core/container/factory	0.062s
ok  	launchpad.net/juju-core/container/kvm	0.291s
ok  	launchpad.net/juju-core/container/kvm/mock	0.062s
?   	launchpad.net/juju-core/container/kvm/testing	[no test files]
ok  	launchpad.net/juju-core/container/lxc	0.271s
?   	launchpad.net/juju-core/container/lxc/mock	[no test files]
?   	launchpad.net/juju-core/container/lxc/testing	[no test files]
?   	launchpad.net/juju-core/container/testing	[no test files]
ok  	launchpad.net/juju-core/downloader	5.273s
ok  	launchpad.net/juju-core/environs	3.065s
ok  	launchpad.net/juju-core/environs/bootstrap	4.590s
ok  	launchpad.net/juju-core/environs/cloudinit	0.651s
ok  	launchpad.net/juju-core/environs/config	4.398s
ok  	launchpad.net/juju-core/environs/configstore	0.038s
ok  	launchpad.net/juju-core/environs/filestorage	0.053s
ok  	launchpad.net/juju-core/environs/httpstorage	0.996s
ok  	launchpad.net/juju-core/environs/imagemetadata	0.675s
?   	launchpad.net/juju-core/environs/imagemetadata/testing	[no test files]
ok  	launchpad.net/juju-core/environs/instances	0.070s
ok  	launchpad.net/juju-core/environs/jujutest	0.317s
ok  	launchpad.net/juju-core/environs/manual	14.490s
ok  	launchpad.net/juju-core/environs/simplestreams	0.389s
?   	launchpad.net/juju-core/environs/simplestreams/testing	[no test files]
ok  	launchpad.net/juju-core/environs/sshstorage	2.056s
ok  	launchpad.net/juju-core/environs/storage	1.177s
ok  	launchpad.net/juju-core/environs/sync	32.883s
ok  	launchpad.net/juju-core/environs/testing	0.222s
ok  	launchpad.net/juju-core/environs/tools	6.974s
?   	launchpad.net/juju-core/environs/tools/testing	[no test files]
ok  	launchpad.net/juju-core/errors	0.026s
ok  	launchpad.net/juju-core/instance	0.034s
?   	launchpad.net/juju-core/instance/testing	[no test files]
ok  	launchpad.net/juju-core/juju	23.761s
ok  	launchpad.net/juju-core/juju/osenv	0.029s
?   	launchpad.net/juju-core/juju/testing	[no test files]
ok  	launchpad.net/juju-core/log	0.014s
ok  	launchpad.net/juju-core/log/syslog	0.024s
ok  	launchpad.net/juju-core/names	0.026s
?   	launchpad.net/juju-core/provider	[no test files]
?   	launchpad.net/juju-core/provider/all	[no test files]
ok  	launchpad.net/juju-core/provider/azure	6.222s
ok  	launchpad.net/juju-core/provider/common	9.225s
ok  	launchpad.net/juju-core/provider/dummy	24.835s
ok  	launchpad.net/juju-core/provider/ec2	19.975s
ok  	launchpad.net/juju-core/provider/joyent	5.327s

----------------------------------------------------------------------
FAIL: environprovider_test.go:236: prepareSuite.TestPrepareNamespace

test 0: {someone other <nil> someone-test }
[LOG] 37.10902 TRACE juju.provider.local Look for proxies?
[LOG] 37.10904 TRACE juju.provider.local Proxies detected osenv.ProxySettings{Http:"", Https:"", Ftp:""}
[LOG] 37.10906 INFO juju.provider.local opening environment "test"
[LOG] 37.10965 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/storage
[LOG] 37.10972 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/db
[LOG] 37.10976 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/log
[LOG] 37.11009 ERROR juju.utils cannot find network interface "lxcbr0": net: no such interface
[LOG] 37.11011 INFO juju.provider.local configure a different bridge using 'network-bridge' in the config file
[LOG] 37.11012 ERROR juju.provider.local failure setting config: cannot find address of network-bridge: "lxcbr0": net: no such interface
environprovider_test.go:274:
    c.Assert(err, gc.IsNil)
... value *errors.errorString = &errors.errorString{s:"cannot find address of network-bridge: \"lxcbr0\": net: no such interface"} ("cannot find address of network-bridge: \"lxcbr0\": net: no such interface")

OOPS: 20 passed, 1 skipped, 1 FAILED
--- FAIL: TestLocal (5.88 seconds)
FAIL
FAIL	launchpad.net/juju-core/provider/local	6.197s
ok  	launchpad.net/juju-core/provider/maas	23.815s
ok  	launchpad.net/juju-core/provider/manual	1.707s
ok  	launchpad.net/juju-core/provider/openstack	33.124s

----------------------------------------------------------------------
FAIL: replicaset_test.go:295: MongoSuite.TestCurrentStatus

replicaset_test.go:367:
    c.Errorf("Servers did not get into final state before timeout.  Status: %#v", res)
... Error: Servers did not get into final state before timeout.  Status: &replicaset.Status{Name:"juju", Members:[]replicaset.MemberStatus{replicaset.MemberStatus{Id:1, Address:"localhost:56265", Self:true, ErrMsg:"", Healthy:true, State:1, Uptime:77, Ping:0}, replicaset.MemberStatus{Id:2, Address:"localhost:50138", Self:false, ErrMsg:"", Healthy:true, State:2, Uptime:36, Ping:0}, replicaset.MemberStatus{Id:3, Address:"localhost:33991", Self:false, ErrMsg:"initial sync exception: 9001 socket exception [2] server [127.0.0.1:56265]  9 attempts remaining", Healthy:true, State:5, Uptime:20, Ping:0}}}

OOPS: 2 passed, 1 FAILED
--- FAIL: TestPackage (77.09 seconds)
FAIL
FAIL	launchpad.net/juju-core/replicaset	77.335s
ok  	launchpad.net/juju-core/rpc	0.082s
ok  	launchpad.net/juju-core/rpc/jsoncodec	0.051s
?   	launchpad.net/juju-core/rpc/rpcreflect	[no test files]
ok  	launchpad.net/juju-core/schema	0.023s
ok  	launchpad.net/juju-core/state	83.784s
ok  	launchpad.net/juju-core/state/api	1.888s
ok  	launchpad.net/juju-core/state/api/agent	2.031s
?   	launchpad.net/juju-core/state/api/base	[no test files]
ok  	launchpad.net/juju-core/state/api/charmrevisionupdater	1.449s
?   	launchpad.net/juju-core/state/api/common	[no test files]
?   	launchpad.net/juju-core/state/api/common/testing	[no test files]
ok  	launchpad.net/juju-core/state/api/deployer	6.157s
ok  	launchpad.net/juju-core/state/api/environment	1.864s
ok  	launchpad.net/juju-core/state/api/firewaller	10.430s
ok  	launchpad.net/juju-core/state/api/keymanager	3.447s
ok  	launchpad.net/juju-core/state/api/keyupdater	2.640s
ok  	launchpad.net/juju-core/state/api/logger	2.237s
ok  	launchpad.net/juju-core/state/api/machiner	3.501s
ok  	launchpad.net/juju-core/state/api/params	0.035s
ok  	launchpad.net/juju-core/state/api/provisioner	9.618s
ok  	launchpad.net/juju-core/state/api/uniter	28.935s
ok  	launchpad.net/juju-core/state/api/upgrader	3.884s
ok  	launchpad.net/juju-core/state/api/watcher	3.350s
ok  	launchpad.net/juju-core/state/apiserver	8.227s
ok  	launchpad.net/juju-core/state/apiserver/agent	3.076s
ok  	launchpad.net/juju-core/state/apiserver/charmrevisionupdater	2.486s
?   	launchpad.net/juju-core/state/apiserver/charmrevisionupdater/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/client	44.340s
ok  	launchpad.net/juju-core/state/apiserver/common	2.137s
?   	launchpad.net/juju-core/state/apiserver/common/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/deployer	4.489s
ok  	launchpad.net/juju-core/state/apiserver/environment	1.559s
ok  	launchpad.net/juju-core/state/apiserver/firewaller	6.137s
ok  	launchpad.net/juju-core/state/apiserver/keymanager	4.100s
?   	launchpad.net/juju-core/state/apiserver/keymanager/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/keyupdater	2.976s
ok  	launchpad.net/juju-core/state/apiserver/logger	3.727s
ok  	launchpad.net/juju-core/state/apiserver/machine	3.059s
ok  	launchpad.net/juju-core/state/apiserver/provisioner	12.496s
?   	launchpad.net/juju-core/state/apiserver/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/uniter	20.178s
ok  	launchpad.net/juju-core/state/apiserver/upgrader	5.709s
ok  	launchpad.net/juju-core/state/multiwatcher	0.760s
ok  	launchpad.net/juju-core/state/presence	6.477s
ok  	launchpad.net/juju-core/state/statecmd	1.986s
?   	launchpad.net/juju-core/state/testing	[no test files]
ok  	launchpad.net/juju-core/state/watcher	5.451s
ok  	launchpad.net/juju-core/store	19.307s
ok  	launchpad.net/juju-core/testing	1.358s
ok  	launchpad.net/juju-core/testing/checkers	0.023s
ok  	launchpad.net/juju-core/testing/testbase	0.018s
ok  	launchpad.net/juju-core/thirdparty/pbkdf2	0.135s
ok  	launchpad.net/juju-core/tools	0.027s
ok  	launchpad.net/juju-core/upgrades	0.316s
ok  	launchpad.net/juju-core/upstart	0.151s
ok  	launchpad.net/juju-core/utils	2.426s
ok  	launchpad.net/juju-core/utils/exec	0.053s
ok  	launchpad.net/juju-core/utils/fslock	0.900s
ok  	launchpad.net/juju-core/utils/parallel	0.938s
ok  	launchpad.net/juju-core/utils/set	0.022s
ok  	launchpad.net/juju-core/utils/ssh	25.303s
?   	launchpad.net/juju-core/utils/ssh/testing	[no test files]
ok  	launchpad.net/juju-core/utils/tailer	1.038s
ok  	launchpad.net/juju-core/utils/voyeur	0.017s
ok  	launchpad.net/juju-core/version	0.065s
ok  	launchpad.net/juju-core/worker	6.670s
ok  	launchpad.net/juju-core/worker/authenticationworker	3.728s
ok  	launchpad.net/juju-core/worker/charmrevisionworker	1.993s
ok  	launchpad.net/juju-core/worker/cleaner	1.275s
ok  	launchpad.net/juju-core/worker/deployer	4.089s
ok  	launchpad.net/juju-core/worker/firewaller	15.018s
ok  	launchpad.net/juju-core/worker/instancepoller	3.225s
ok  	launchpad.net/juju-core/worker/localstorage	0.062s
ok  	launchpad.net/juju-core/worker/logger	1.502s
ok  	launchpad.net/juju-core/worker/machineenvironmentworker	7.664s
ok  	launchpad.net/juju-core/worker/machiner	3.355s
ok  	launchpad.net/juju-core/worker/minunitsworker	1.348s
ok  	launchpad.net/juju-core/worker/provisioner	34.146s
ok  	launchpad.net/juju-core/worker/resumer	1.669s
ok  	launchpad.net/juju-core/worker/terminationworker	0.060s
ok  	launchpad.net/juju-core/worker/uniter	205.091s
ok  	launchpad.net/juju-core/worker/uniter/charm	2.906s
ok  	launchpad.net/juju-core/worker/uniter/debug	1.103s
ok  	launchpad.net/juju-core/worker/uniter/hook	0.026s
ok  	launchpad.net/juju-core/worker/uniter/jujuc	0.439s
ok  	launchpad.net/juju-core/worker/uniter/relation	1.322s
ok  	launchpad.net/juju-core/worker/upgrader	3.440s

warning: building out-of-date packages:
	launchpad.net/lpad
	launchpad.net/goose/testservices/hook
	launchpad.net/goose/testservices/identityservice
	launchpad.net/goose/testservices
	launchpad.net/goose/testservices/novaservice
	launchpad.net/goose/testservices/swiftservice
	launchpad.net/goose/testservices/openstackservice
installing these packages with 'go test -i ./...' will speed future tests.

Revision history for this message

Go Bot (go-bot) wrote on 2014-02-14:

Download full text (10.3 KiB)

The attempt to merge lp:~axwalk/juju-core/lp1274780-osuser-fallback into lp:juju-core failed. Below is the output from the failed tests.

ok launchpad.net/juju-core 0.016s
ok launchpad.net/juju-core/agent 0.752s
ok launchpad.net/juju-core/agent/tools 0.298s
ok launchpad.net/juju-core/bzr 6.846s
ok launchpad.net/juju-core/cert 3.893s
ok launchpad.net/juju-core/charm 0.577s
? launchpad.net/juju-core/charm/hooks [no test files]
? launchpad.net/juju-core/charm/testing [no test files]
ok launchpad.net/juju-core/cloudinit 0.038s
ok launchpad.net/juju-core/cloudinit/sshinit 1.190s
ok launchpad.net/juju-core/cmd 0.251s
ok launchpad.net/juju-core/cmd/charm-admin 0.821s
? launchpad.net/juju-core/cmd/charmd [no test files]
? launchpad.net/juju-core/cmd/charmload [no test files]
ok launchpad.net/juju-core/cmd/juju 235.014s
ok launchpad.net/juju-core/cmd/jujud 60.122s
ok launchpad.net/juju-core/cmd/plugins/juju-metadata 10.370s
? launchpad.net/juju-core/cmd/plugins/juju-restore [no test files]
ok launchpad.net/juju-core/constraints 0.028s
ok launchpad.net/juju-core/container 0.048s
ok launchpad.net/juju-core/container/factory 0.051s
ok launchpad.net/juju-core/container/kvm 0.262s
ok launchpad.net/juju-core/container/kvm/mock 0.038s
? launchpad.net/juju-core/container/kvm/testing [no test files]
ok launchpad.net/juju-core/container/lxc 0.286s
? launchpad.net/juju-core/container/lxc/mock [no test files]
? launchpad.net/juju-core/container/lxc/testing [no test files]
? launchpad.net/juju-core/container/testing [no test files]
ok launchpad.net/juju-core/downloader 5.252s
ok launchpad.net/juju-core/environs 3.014s
ok launchpad.net/juju-core/environs/bootstrap 4.453s
ok launchpad.net/juju-core/environs/cloudinit 0.641s
ok launchpad.net/juju-core/environs/config 3.139s
ok launchpad.net/juju-core/environs/configstore 0.039s
ok launchpad.net/juju-core/environs/filestorage 0.032s
ok launchpad.net/juju-core/environs/httpstorage 0.918s
ok launchpad.net/juju-core/environs/imagemetadata 0.626s
? launchpad.net/juju-core/environs/imagemetadata/testing [no test files]
ok launchpad.net/juju-core/environs/instances 0.059s
ok launchpad.net/juju-core/environs/jujutest 0.283s
ok launchpad.net/juju-core/environs/manual 9.680s
ok launchpad.net/juju-core/environs/simplestreams 0.357s
? launchpad.net/juju-core/environs/simplestreams/testing [no test files]
ok launchpad.net/juju-core/environs/sshstorage 1.270s
ok launchpad.net/juju-core/environs/storage 1.207s
ok launchpad.net/juju-core/environs/sync 34.372s
ok launchpad.net/juju-core/environs/testing 0.290s
ok launchpad.net/juju-core/environs/tools 6.917s
? launchpad.net/juju-core/environs/tools/testing [no test files]
ok launchpad.net/juju-core/errors 0.015s
ok launchpad.net/juju-core/instance 0.024s
? launchpad.net/juju-core/instance/testing [no test files]
ok launchpad.net/juju-core/juju 23.752s
ok launchpad.net/juju-core/juju/osenv 0.020s
? launchpad.net/juju-core/juju/testing [no test files]
ok launchpad.net/juju-core/log 0.015s
ok launchpad.net/juju-core/log/syslog 0.026s
? launchpad.net/juju-cor...

The attempt to merge lp:~axwalk/juju-core/lp1274780-osuser-fallback into lp:juju-core failed. Below is the output from the failed tests.

ok  	launchpad.net/juju-core	0.016s
ok  	launchpad.net/juju-core/agent	0.752s
ok  	launchpad.net/juju-core/agent/tools	0.298s
ok  	launchpad.net/juju-core/bzr	6.846s
ok  	launchpad.net/juju-core/cert	3.893s
ok  	launchpad.net/juju-core/charm	0.577s
?   	launchpad.net/juju-core/charm/hooks	[no test files]
?   	launchpad.net/juju-core/charm/testing	[no test files]
ok  	launchpad.net/juju-core/cloudinit	0.038s
ok  	launchpad.net/juju-core/cloudinit/sshinit	1.190s
ok  	launchpad.net/juju-core/cmd	0.251s
ok  	launchpad.net/juju-core/cmd/charm-admin	0.821s
?   	launchpad.net/juju-core/cmd/charmd	[no test files]
?   	launchpad.net/juju-core/cmd/charmload	[no test files]
ok  	launchpad.net/juju-core/cmd/juju	235.014s
ok  	launchpad.net/juju-core/cmd/jujud	60.122s
ok  	launchpad.net/juju-core/cmd/plugins/juju-metadata	10.370s
?   	launchpad.net/juju-core/cmd/plugins/juju-restore	[no test files]
ok  	launchpad.net/juju-core/constraints	0.028s
ok  	launchpad.net/juju-core/container	0.048s
ok  	launchpad.net/juju-core/container/factory	0.051s
ok  	launchpad.net/juju-core/container/kvm	0.262s
ok  	launchpad.net/juju-core/container/kvm/mock	0.038s
?   	launchpad.net/juju-core/container/kvm/testing	[no test files]
ok  	launchpad.net/juju-core/container/lxc	0.286s
?   	launchpad.net/juju-core/container/lxc/mock	[no test files]
?   	launchpad.net/juju-core/container/lxc/testing	[no test files]
?   	launchpad.net/juju-core/container/testing	[no test files]
ok  	launchpad.net/juju-core/downloader	5.252s
ok  	launchpad.net/juju-core/environs	3.014s
ok  	launchpad.net/juju-core/environs/bootstrap	4.453s
ok  	launchpad.net/juju-core/environs/cloudinit	0.641s
ok  	launchpad.net/juju-core/environs/config	3.139s
ok  	launchpad.net/juju-core/environs/configstore	0.039s
ok  	launchpad.net/juju-core/environs/filestorage	0.032s
ok  	launchpad.net/juju-core/environs/httpstorage	0.918s
ok  	launchpad.net/juju-core/environs/imagemetadata	0.626s
?   	launchpad.net/juju-core/environs/imagemetadata/testing	[no test files]
ok  	launchpad.net/juju-core/environs/instances	0.059s
ok  	launchpad.net/juju-core/environs/jujutest	0.283s
ok  	launchpad.net/juju-core/environs/manual	9.680s
ok  	launchpad.net/juju-core/environs/simplestreams	0.357s
?   	launchpad.net/juju-core/environs/simplestreams/testing	[no test files]
ok  	launchpad.net/juju-core/environs/sshstorage	1.270s
ok  	launchpad.net/juju-core/environs/storage	1.207s
ok  	launchpad.net/juju-core/environs/sync	34.372s
ok  	launchpad.net/juju-core/environs/testing	0.290s
ok  	launchpad.net/juju-core/environs/tools	6.917s
?   	launchpad.net/juju-core/environs/tools/testing	[no test files]
ok  	launchpad.net/juju-core/errors	0.015s
ok  	launchpad.net/juju-core/instance	0.024s
?   	launchpad.net/juju-core/instance/testing	[no test files]
ok  	launchpad.net/juju-core/juju	23.752s
ok  	launchpad.net/juju-core/juju/osenv	0.020s
?   	launchpad.net/juju-core/juju/testing	[no test files]
ok  	launchpad.net/juju-core/log	0.015s
ok  	launchpad.net/juju-core/log/syslog	0.026s
?   	launchpad.net/juju-core/log/syslog/testing	[no test files]
ok  	launchpad.net/juju-core/names	0.026s
?   	launchpad.net/juju-core/provider	[no test files]
?   	launchpad.net/juju-core/provider/all	[no test files]
ok  	launchpad.net/juju-core/provider/azure	6.315s
ok  	launchpad.net/juju-core/provider/common	6.817s
ok  	launchpad.net/juju-core/provider/dummy	24.058s
ok  	launchpad.net/juju-core/provider/ec2	16.337s
ok  	launchpad.net/juju-core/provider/joyent	5.212s

----------------------------------------------------------------------
FAIL: environprovider_test.go:236: prepareSuite.TestPrepareNamespace

test 0: {someone other <nil> someone-test }
[LOG] 40.74495 TRACE juju.provider.local Look for proxies?
[LOG] 40.74495 TRACE juju.provider.local Proxies detected osenv.ProxySettings{Http:"", Https:"", Ftp:""}
[LOG] 40.74495 INFO juju.provider.local opening environment "test"
[LOG] 40.74550 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/storage
[LOG] 40.74550 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/db
[LOG] 40.74577 TRACE juju.provider.local creating directory /tmp/gocheck-5600924393587988459/1/.juju/test/log
[LOG] 40.74603 ERROR juju.utils cannot find network interface "lxcbr0": net: no such interface
[LOG] 40.74603 INFO juju.provider.local configure a different bridge using 'network-bridge' in the config file
[LOG] 40.74603 ERROR juju.provider.local failure setting config: cannot find address of network-bridge: "lxcbr0": net: no such interface
environprovider_test.go:274:
    c.Assert(err, gc.IsNil)
... value *errors.errorString = &errors.errorString{s:"cannot find address of network-bridge: \"lxcbr0\": net: no such interface"} ("cannot find address of network-bridge: \"lxcbr0\": net: no such interface")

OOPS: 20 passed, 1 skipped, 1 FAILED
--- FAIL: TestLocal (5.56 seconds)
FAIL
FAIL	launchpad.net/juju-core/provider/local	5.805s
ok  	launchpad.net/juju-core/provider/maas	19.765s
ok  	launchpad.net/juju-core/provider/manual	1.633s
ok  	launchpad.net/juju-core/provider/openstack	37.158s
ok  	launchpad.net/juju-core/replicaset	43.780s
ok  	launchpad.net/juju-core/rpc	0.125s
ok  	launchpad.net/juju-core/rpc/jsoncodec	0.039s
?   	launchpad.net/juju-core/rpc/rpcreflect	[no test files]
ok  	launchpad.net/juju-core/schema	0.034s
ok  	launchpad.net/juju-core/state	83.068s
ok  	launchpad.net/juju-core/state/api	1.918s
ok  	launchpad.net/juju-core/state/api/agent	1.934s
?   	launchpad.net/juju-core/state/api/base	[no test files]
ok  	launchpad.net/juju-core/state/api/charmrevisionupdater	1.497s
?   	launchpad.net/juju-core/state/api/common	[no test files]
?   	launchpad.net/juju-core/state/api/common/testing	[no test files]
ok  	launchpad.net/juju-core/state/api/deployer	5.951s
ok  	launchpad.net/juju-core/state/api/environment	1.757s
ok  	launchpad.net/juju-core/state/api/firewaller	10.451s
ok  	launchpad.net/juju-core/state/api/keymanager	3.650s
ok  	launchpad.net/juju-core/state/api/keyupdater	2.577s
ok  	launchpad.net/juju-core/state/api/logger	2.164s
ok  	launchpad.net/juju-core/state/api/machiner	3.398s
ok  	launchpad.net/juju-core/state/api/params	0.036s
ok  	launchpad.net/juju-core/state/api/provisioner	9.257s
ok  	launchpad.net/juju-core/state/api/uniter	27.543s
ok  	launchpad.net/juju-core/state/api/upgrader	3.808s
ok  	launchpad.net/juju-core/state/api/watcher	3.063s
ok  	launchpad.net/juju-core/state/apiserver	7.601s
ok  	launchpad.net/juju-core/state/apiserver/agent	2.996s
ok  	launchpad.net/juju-core/state/apiserver/charmrevisionupdater	2.471s
?   	launchpad.net/juju-core/state/apiserver/charmrevisionupdater/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/client	43.605s
ok  	launchpad.net/juju-core/state/apiserver/common	2.034s
?   	launchpad.net/juju-core/state/apiserver/common/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/deployer	4.439s
ok  	launchpad.net/juju-core/state/apiserver/environment	1.579s
ok  	launchpad.net/juju-core/state/apiserver/firewaller	5.992s
ok  	launchpad.net/juju-core/state/apiserver/keymanager	3.979s
?   	launchpad.net/juju-core/state/apiserver/keymanager/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/keyupdater	2.883s
ok  	launchpad.net/juju-core/state/apiserver/logger	3.519s
ok  	launchpad.net/juju-core/state/apiserver/machine	2.868s
ok  	launchpad.net/juju-core/state/apiserver/provisioner	11.700s
?   	launchpad.net/juju-core/state/apiserver/testing	[no test files]
ok  	launchpad.net/juju-core/state/apiserver/uniter	19.683s
ok  	launchpad.net/juju-core/state/apiserver/upgrader	5.670s
ok  	launchpad.net/juju-core/state/multiwatcher	0.783s
ok  	launchpad.net/juju-core/state/presence	6.353s
ok  	launchpad.net/juju-core/state/statecmd	1.949s
?   	launchpad.net/juju-core/state/testing	[no test files]
ok  	launchpad.net/juju-core/state/watcher	5.561s
ok  	launchpad.net/juju-core/store	19.322s
ok  	launchpad.net/juju-core/testing	1.372s
ok  	launchpad.net/juju-core/testing/checkers	0.026s
ok  	launchpad.net/juju-core/testing/testbase	0.021s
ok  	launchpad.net/juju-core/thirdparty/pbkdf2	0.134s
ok  	launchpad.net/juju-core/tools	0.035s
ok  	launchpad.net/juju-core/upgrades	1.831s
ok  	launchpad.net/juju-core/upstart	0.140s
ok  	launchpad.net/juju-core/utils	2.357s
ok  	launchpad.net/juju-core/utils/exec	0.050s
ok  	launchpad.net/juju-core/utils/fslock	1.299s
ok  	launchpad.net/juju-core/utils/parallel	0.929s
ok  	launchpad.net/juju-core/utils/set	0.017s
ok  	launchpad.net/juju-core/utils/ssh	20.732s
?   	launchpad.net/juju-core/utils/ssh/testing	[no test files]
ok  	launchpad.net/juju-core/utils/tailer	1.009s
ok  	launchpad.net/juju-core/utils/voyeur	0.018s
ok  	launchpad.net/juju-core/version	0.064s
ok  	launchpad.net/juju-core/worker	6.595s
ok  	launchpad.net/juju-core/worker/authenticationworker	3.141s
ok  	launchpad.net/juju-core/worker/charmrevisionworker	1.975s
ok  	launchpad.net/juju-core/worker/cleaner	1.320s
ok  	launchpad.net/juju-core/worker/deployer	3.546s
ok  	launchpad.net/juju-core/worker/firewaller	12.418s
ok  	launchpad.net/juju-core/worker/instancepoller	2.216s
ok  	launchpad.net/juju-core/worker/localstorage	0.052s
ok  	launchpad.net/juju-core/worker/logger	1.577s
ok  	launchpad.net/juju-core/worker/machineenvironmentworker	7.767s
ok  	launchpad.net/juju-core/worker/machiner	8.106s
ok  	launchpad.net/juju-core/worker/minunitsworker	1.316s
ok  	launchpad.net/juju-core/worker/provisioner	39.017s
ok  	launchpad.net/juju-core/worker/resumer	1.580s
ok  	launchpad.net/juju-core/worker/terminationworker	0.065s
ok  	launchpad.net/juju-core/worker/uniter	197.728s
ok  	launchpad.net/juju-core/worker/uniter/charm	4.128s
ok  	launchpad.net/juju-core/worker/uniter/debug	0.087s
ok  	launchpad.net/juju-core/worker/uniter/hook	0.015s
ok  	launchpad.net/juju-core/worker/uniter/jujuc	0.490s
ok  	launchpad.net/juju-core/worker/uniter/relation	1.399s
ok  	launchpad.net/juju-core/worker/upgrader	3.352s

Revision history for this message

Go Bot (go-bot) wrote on 2014-02-14:

There are additional revisions which have not been approved in review. Please seek review and approval of these new revisions.

Preview Diff

[H/L] Next/Prev Comment, [J/K] Next/Prev File, [N/P] Next/Prev Hunk

Subscribers

People subscribed via source and target branches

to all changes:

Aaron Bentley

Andrew Wilkins

Dave Cheney

Dimiter Naydenov

Eric Snow

John A Meinel

Martin Packman

Nate Finch

Raphaël Badin

Tim Penhey

to status/vote changes:

rowez

 === modified file 'provider/local/environprovider.go'
 --- provider/local/environprovider.go	2014-02-12 02:56:13 +0000
 +++ provider/local/environprovider.go	2014-02-14 03:42:42 +0000
@@ -51,8 +51,16 @@
  	// for backwards compatibility: older versions did not store the namespace
  	// in config.
  	if namespace, _ := cfg.UnknownAttrs()["namespace"].(string); namespace == "" {
++		username := os.Getenv("USER")
++		if username == "" {
++			u, err := userCurrent()
++			if err != nil {
++				return nil, fmt.Errorf("failed to determine username for namespace: %v", err)
++			}
++			username = u.Username
++		}
  		var err error
--		namespace = fmt.Sprintf("%s-%s", os.Getenv("USER"), cfg.Name())
++		namespace = fmt.Sprintf("%s-%s", username, cfg.Name())
  		cfg, err = cfg.Apply(map[string]interface{}{"namespace": namespace})
  		if err != nil {
  			return nil, fmt.Errorf("failed to create namespace: %v", err)
 === modified file 'provider/local/environprovider_test.go'
 --- provider/local/environprovider_test.go	2014-01-31 08:44:08 +0000
 +++ provider/local/environprovider_test.go	2014-02-14 03:42:42 +0000
@@ -4,6 +4,9 @@
  package local_test
  import (
++	"errors"
++	"os/user"
++
  	"github.com/loggo/loggo"
  	gc "launchpad.net/gocheck"
@@ -53,10 +56,11 @@
  	s.PatchEnvironment("ftp_proxy", "")
  	s.PatchEnvironment("FTP_PROXY", "")
  	s.HookCommandOutput(&utils.AptCommandOutput, nil, nil)
--	restore := testbase.PatchValue(local.CheckLocalPort, func(port int, desc string) error {
++	s.PatchValue(local.CheckLocalPort, func(port int, desc string) error {
  		return nil
  	})
--	s.AddSuiteCleanup(func(*gc.C) { restore() })
++	restore := local.MockAddressForInterface()
++	s.AddCleanup(func(*gc.C) { restore() })
+ }
  func (s *prepareSuite) TestPrepareCapturesEnvironment(c *gc.C) {
@@ -67,7 +71,6 @@
  	c.Assert(err, gc.IsNil)
  	provider, err := environs.Provider(provider.Local)
  	c.Assert(err, gc.IsNil)
--	defer local.MockAddressForInterface()()
  	for i, test := range []struct {
  		message          string
@@ -229,3 +232,50 @@
+ 		}
+ 	}
+ }
++
++func (s *prepareSuite) TestPrepareNamespace(c *gc.C) {
++	s.PatchValue(local.DetectAptProxies, func() (osenv.ProxySettings, error) {
++		return osenv.ProxySettings{}, nil
++	})
++	basecfg, err := config.New(config.UseDefaults, map[string]interface{}{
++		"type": "local",
++		"name": "test",
++	})
++	provider, err := environs.Provider("local")
++	c.Assert(err, gc.IsNil)
++
++	type test struct {
++		userEnv   string
++		userOS    string
++		userOSErr error
++		namespace string
++		err       string
++	}
++	tests := []test{{
++		userEnv:   "someone",
++		userOS:    "other",
++		namespace: "someone-test",
++	}, {
++		userOS:    "other",
++		namespace: "other-test",
++	}, {
++		userOSErr: errors.New("oh noes"),
++		err:       "failed to determine username for namespace: oh noes",
++	}}
++
++	for i, test := range tests {
++		c.Logf("test %d: %v", i, test)
++		s.PatchEnvironment("USER", test.userEnv)
++		s.PatchValue(local.UserCurrent, func() (*user.User, error) {
++			return &user.User{Username: test.userOS}, test.userOSErr
++		})
++		env, err := provider.Prepare(basecfg)
++		if test.err == "" {
++			c.Assert(err, gc.IsNil)
++			cfg := env.Config()
++			c.Assert(cfg.UnknownAttrs()["namespace"], gc.Equals, test.namespace)
++		} else {
++			c.Assert(err, gc.ErrorMatches, test.err)
++		}
++	}
++}
 === modified file 'provider/local/export_test.go'
 --- provider/local/export_test.go	2014-02-12 02:56:13 +0000
 +++ provider/local/export_test.go	2014-02-14 03:42:42 +0000
@@ -14,6 +14,7 @@
  	FinishBootstrap  = &finishBootstrap
  	CheckLocalPort   = &checkLocalPort
  	DetectAptProxies = &detectAptProxies
++	UserCurrent      = &userCurrent
+ )
  // SetRootCheckFunction allows tests to override the check for a root user.