juju: sporadic test failure in TestDeployWithForceMachineRejectsTooManyUnits

[Roger Peppe]

I just saw this test failure:

----------------------------------------------------------------------
FAIL: apiconn_test.go:0: DeployLocalSuite.TearDownTest

Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
Waiting for sockets to die: 0 in use, 1 alive
/home/rog/src/go/src/launchpad.net/juju-core/testing/mgo.go:333:
    c.Fatal("Test left sockets in a dirty state")
... Error: Test left sockets in a dirty state

----------------------------------------------------------------------
PANIC: conn_test.go:509: DeployLocalSuite.TestDeployWithForceMachineRejectsTooManyUnits

[LOG] 9.02491 DEBUG juju.environs.configstore Making /tmp/gocheck-2703501726821866378/8/home/ubuntu/.juju/environments
[LOG] 9.14276 INFO juju environs/testing: uploading FAKE tools 1.15.1-raring-amd64
[LOG] 9.14761 INFO juju environs/testing: uploading FAKE tools 1.15.1-precise-amd64
[LOG] 9.14832 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 9.14833 DEBUG juju.environs.tools no series specified when finding tools, looking for any
[LOG] 9.14838 DEBUG juju.environs.simplestreams fetchData failed for "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 9.14841 DEBUG juju.environs.simplestreams cannot load index "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson": invalid URL "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson" not found
[LOG] 9.14843 DEBUG juju.environs.simplestreams fetchData failed for "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.json": file "tools/streams/v1/index.json" not found not found
[LOG] 9.14846 DEBUG juju.environs.simplestreams cannot load index "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.json": invalid URL "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.json" not found
[LOG] 9.14865 INFO juju.environs.tools Writing tools/streams/v1/index.json
[LOG] 9.14867 INFO juju.environs.tools Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
[LOG] 9.14870 INFO juju.environs.boostrap bootstrapping environment "dummyenv"
[LOG] 9.14874 INFO juju.environs.tools reading tools with major.minor version 1.15
[LOG] 9.14875 INFO juju.environs.tools filtering tools by version: 1.15.1
[LOG] 9.14877 INFO juju.environs.tools filtering tools by series: precise
[LOG] 9.14880 DEBUG juju.environs.tools no architecture specified when finding tools, looking for any
[LOG] 9.14886 DEBUG juju.environs.simplestreams fetchData failed for "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson": file "tools/streams/v1/index.sjson" not found not found
[LOG] 9.14888 DEBUG juju.environs.simplestreams cannot load index "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson": invalid URL "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.sjson" not found
[LOG] 9.14899 DEBUG juju.environs.simplestreams no mirror information available for {DataType:content-download MirrorContentId:com.ubuntu.juju:released:tools FilterFunc:0x609380 ValueTemplate:{Release: Version: Arch: Size:0 Path: FullPath: FileType: SHA256:}}: mirror data for "com.ubuntu.juju:released:tools" not found
[LOG] 9.14900 DEBUG juju.environs.simplestreams read metadata index at "http://127.0.0.1:37714/dummyenv/private/tools/streams/v1/index.json"
[LOG] 9.14904 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 [{Tue, 08 Oct 2013 15:02:10 +0100 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] 9.14905 DEBUG juju.environs.simplestreams finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
[LOG] 9.14934 INFO juju.provider.dummy would pick tools from 1.15.1-precise-amd64
[LOG] 9.17813 INFO juju.state opening state; mongo addresses: ["localhost:36761"]; entity ""
[LOG] 9.19200 INFO juju.state connection established
[LOG] 9.20955 INFO juju.state initializing environment
[LOG] 9.22867 INFO juju state/api: listening on "127.0.0.1:49763"
[LOG] 9.25498 INFO juju.state opening state; mongo addresses: ["localhost:36761"]; entity ""
[LOG] 9.25787 INFO juju.state connection established
[LOG] 9.27644 INFO juju juju: authorization error while connecting to state server; retrying
[LOG] 9.27650 INFO juju.state opening state; mongo addresses: ["localhost:36761"]; entity ""
[LOG] 9.27969 INFO juju.state connection established
[LOG] 9.34307 INFO juju state/api: dialing "wss://127.0.0.1:49763/"
[LOG] 9.34676 INFO juju state/api: connection established
[LOG] 9.34689 DEBUG juju.rpc.jsoncodec <- {"RequestId":1,"Type":"Admin","Request":"Login","Params":{"AuthTag":"user-admin","Password":"dummy-secret","Nonce":""}}
[LOG] 9.34723 DEBUG juju.rpc.jsoncodec -> {"RequestId":1,"Response":{}}
[LOG] 9.36361 DEBUG juju.rpc.jsoncodec <- {"RequestId":2,"Type":"Pinger","Request":"Ping","Params":{}}
[LOG] 9.36368 DEBUG juju.rpc.jsoncodec -> {"RequestId":2,"Response":{}}
[LOG] 9.37117 INFO juju writing charm to storage [1418 bytes]
[LOG] 9.37122 INFO juju adding charm to state
[LOG] 9.40094 INFO juju.provider.dummy reset environment
[LOG] 9.40113 DEBUG juju.rpc.jsoncodec <- error: read tcp 127.0.0.1:60873: use of closed network connection (closing true)
[LOG] 9.40453 INFO juju MgoReset successfully reset admin password
[LOG] 9.40930 INFO juju MgoReset successfully reset admin password
[LOG] 9.41272 INFO juju MgoReset successfully reset admin password
... Panic: Fixture has panicked (see related PANIC)
OOPS: 36 passed, 1 FAILED, 1 MISSED
--- FAIL: Test (34.14 seconds)
FAIL
FAIL launchpad.net/juju-core/juju 34.824s