Bootstrap on Joyent often fails with "model is not bootstrapped"

Bug #1542206 reported by John George
14
This bug affects 2 people
Affects Status Importance Assigned to Milestone
Canonical Juju
Fix Released
High
Anastasia

Bug Description

Failures can be seen here:
http://reports.vapour.ws/releases/issue/56b460e5749a565a4aca7169

This issue has become more prevalent in joyent and precise then other substrates and series. It can happen twice in a row, cursing a revision under test.

John George (jog)
Changed in juju-core:
status: New → Invalid
Aaron Bentley (abentley)
Changed in juju-core:
status: Invalid → Triaged
importance: Undecided → High
Curtis Hovey (sinzui)
Changed in juju-core:
milestone: none → 2.0-beta3
tags: added: intermittent-failure joyent-provider precise
description: updated
Curtis Hovey (sinzui)
tags: added: regression
description: updated
Revision history for this message
Dimiter Naydenov (dimitern) wrote :

This is NOT a bug, it's only a warning and the logs show that:

2016-03-21 05:51:42 WARNING juju.api api.go:127 discarding API open error: space discovery still in progress

The CI job however treats this as an error and immediately destroys the newly successfully bootstrapped model.

Changed in juju-core:
status: Triaged → Invalid
Revision history for this message
Cheryl Jennings (cherylj) wrote :

If you look at the rest of the command output, you'll see that the bootstrap fails with "model is not bootstrapped" after encountering this error.

2016-03-21 11:56:11 WARNING juju.api api.go:127 discarding API open error: space discovery still in progress
2016-03-21 11:56:11 INFO juju.provider.common destroy.go:22 destroying model "joyent-deploy-precise-amd64"
2016-03-21 11:56:11 INFO juju.provider.common destroy.go:33 destroying instances
2016-03-21 11:56:23 INFO juju.provider.common destroy.go:53 destroying storage
2016-03-21 11:56:23 ERROR cmd supercommand.go:448 model is not bootstrapped

Changed in juju-core:
status: Invalid → Triaged
Revision history for this message
Martin Packman (gz) wrote :

This is our top cause of failure for the week, at 88 matches currently:

<http://reports.vapour.ws/releases/top-issues>

A couple are spurious, but most are hard bootstrap failures on joyent with no obvious cause, and only the spaces warning standing out in the log. That may be a red herring, but we do have a intermittent but persistent issue getting a successful bootstrap on Joyent.

I'd be happy to add more debugging if possible, but nothing CI does aborts bootstrap in response to log output from juju.

summary: - space discovery still in progress
+ Bootstrap on Joyent often fails with "model is not bootstrapped"
Revision history for this message
Cheryl Jennings (cherylj) wrote :

I think this bug is now for a slightly different problem than when originally reported. It seems that bootstrapping is failing with "model is not bootstrapped", starting after the switch over to use tags to track controller instances, rather than storage.

I suspect that there's some timing window where while the instance is coming up, the filtering on tags.JujuController == true won't return the machine that's just been provisioned.

If this is a true limitation in Joyent (i.e. we can't guarantee filtering on tags that were just set), we could add the "model is not bootstrapped" error to the list of errors we retry on when waiting for the API to become available in the bootstrap command.

Revision history for this message
Cheryl Jennings (cherylj) wrote :

Okay, this is actually a bug in the joyent provider. We are ignoring the tags passed into StartInstance (which contain the is-controller tag).

We need to append the joyent specific tags to this list, not ignore them.

Revision history for this message
Cheryl Jennings (cherylj) wrote :

Verified that properly setting (and filtering) on the tags fixed the bootstrap issue for me locally. Anastasia is working on making the changes.

Changed in juju-core:
assignee: nobody → Anastasia (anastasia-macmood)
Changed in juju-core:
status: Triaged → In Progress
Revision history for this message
Anastasia (anastasia-macmood) wrote :
Changed in juju-core:
status: In Progress → Fix Committed
Curtis Hovey (sinzui)
Changed in juju-core:
status: Fix Committed → Fix Released
tags: added: 2.0-count
affects: juju-core → juju
Changed in juju:
milestone: 2.0-beta3 → none
milestone: none → 2.0-beta3
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Duplicates of this bug

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.