Skip to content

Instantly share code, notes, and snippets.

@squeedee

squeedee/Error

Last active August 29, 2015 14:00
Show Gist options
  • Save squeedee/11220922 to your computer and use it in GitHub Desktop.
Save squeedee/11220922 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
Error
Started preparing configuration > Binding configuration. Failed: Error filling in template `ctl.erb' for `etcd_leader_z1/0' (line 26: undefined method `collect' for "(( .properties.nats.machines ))":String) (00:00:01)
Error 100: Error filling in template `ctl.erb' for `etcd_leader_z1/0' (line 26: undefined method `collect' for "(( .properties.nats.machines ))":String)
Raw
Log
:40:19.492784 #4423] [0x1560990] DEBUG -- : (0.001998s) UPDATE "vms" SET "apply_spec_json" = '{"deployment":"cf-warden","resource_pool":{"name":"medium_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.38","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.etcd-leader-z1.cf1.cf-warden.bosh"}},"agent_id":"51ceb6d4-769f-4e94-a2c1-f5e0024cd1ee","vm":{"name":"vm-443170b2-ea38-44a1-a982-afb757a98f88","id":"vm-443170b2-ea38-44a1-a982-afb757a98f88"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"etcd_leader_z1","templates":[{"name":"etcd","version":"5","sha1":"dce7ea88f3d6c1b1d605f3354b370fbb20800e60","blobstore_id":"751a4ffd-db64-42fe-a57f-9c1427da29c0"},{"name":"etcd_metrics_server","version":"1","sha1":"5748e5cba763ddf48aedb2881f253d000a80e58a","blobstore_id":"0884457a-f10b-4ef4-bb2c-495e42d632f1"}],"template":"etcd","version":"5","sha1":"dce7ea88f3d6c1b1d605f3354b370fbb20800e60","blobstore_id":"751a4ffd-db64-42fe-a57f-9c1427da29c0"},"index":0}' WHERE ("id" = 10)
D, [2014-04-23T08:40:19.489999 #4423] [0x1562d30] DEBUG -- : Acquired connection: 13220160
D, [2014-04-23T08:40:19.494726 #4423] [0x15602d8] DEBUG -- : (0.000420s) COMMIT
D, [2014-04-23T08:40:19.495405 #4423] [0x155f4f0] DEBUG -- : Acquired connection: 22599540
D, [2014-04-23T08:40:19.495222 #4423] [0x1580038] DEBUG -- : RECEIVED: director.3a27a74c-f586-4468-8242-8df87053312f.df07fa22-1f33-4ccb-b0c1-fbc684911516 {"value":{"deployment":"cf-warden","resource_pool":{"name":"medium_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.14","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.loggregator-z1.cf1.cf-warden.bosh"}},"agent_id":"b2e6cfe0-b353-4fc5-92c0-0ae477656e01","vm":{"name":"vm-091293a1-dcdd-47a4-aca3-d31006bce51a","id":"vm-091293a1-dcdd-47a4-aca3-d31006bce51a"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"loggregator_z1","templates":[{"name":"loggregator","version":"20","sha1":"49d26d8128f24ab3f09eb2274dcb187b835ffeb6","blobstore_id":"a489afc2-0f98-40f2-908d-926715773392"}],"template":"loggregator","version":"20","sha1":"49d26d8128f24ab3f09eb2274dcb187b835ffeb6","blobstore_id":"a489afc2-0f98-40f2-908d-926715773392"},"index":0}}
D, [2014-04-23T08:40:19.496402 #4423] [0x156060c] DEBUG -- : (0.002299s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'runner_z1') AND ("index" = 0) AND ("id" != 9)) LIMIT 1
D, [2014-04-23T08:40:19.496610 #4423] [0x1562650] DEBUG -- : (0.000408s) BEGIN
D, [2014-04-23T08:40:19.497397 #4423] [0x155f130] DEBUG -- : (0.001413s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 18) AND ("id" != 6)) LIMIT 1
D, [2014-04-23T08:40:19.497697 #4423] [0x15602d8] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.500057 #4423] [0x15602d8] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.498016 #4423] [0x155f4f0] DEBUG -- : (0.000179s) BEGIN
D, [2014-04-23T08:40:19.498051 #4423] [0x1560990] DEBUG -- : (0.000789s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'etcd_leader_z1') AND ("index" = 0) AND ("id" != 7)) LIMIT 1
D, [2014-04-23T08:40:19.497911 #4423] [0x1562d30] DEBUG -- : (0.000295s) BEGIN
D, [2014-04-23T08:40:19.501032 #4423] [0x1562308] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.501913 #4423] [0x156060c] DEBUG -- : (0.001692s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 16) AND ("id" != 9)) LIMIT 1
D, [2014-04-23T08:40:19.502546 #4423] [0x155f4f0] DEBUG -- : (0.000361s) SELECT COUNT(*) AS "count" FROM "vms" WHERE (("agent_id" = 'e55aa74b-d908-4574-95d2-d52af028865e') AND ("id" != 11)) LIMIT 1
D, [2014-04-23T08:40:19.503026 #4423] [0x1562650] DEBUG -- : (0.000647s) SELECT COUNT(*) AS "count" FROM "vms" WHERE (("agent_id" = '343b6382-80b9-42cf-926a-b09655d58733') AND ("id" != 7)) LIMIT 1
D, [2014-04-23T08:40:19.503423 #4423] [0x1560990] DEBUG -- : (0.000393s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 10) AND ("id" != 7)) LIMIT 1
D, [2014-04-23T08:40:19.503913 #4423] [0x1562d30] DEBUG -- : (0.000749s) SELECT COUNT(*) AS "count" FROM "vms" WHERE (("agent_id" = '3c217524-555c-4fdd-be3d-0394e10952eb') AND ("id" != 15)) LIMIT 1
D, [2014-04-23T08:40:19.504112 #4423] [0x1562308] DEBUG -- : (0.000842s) BEGIN
D, [2014-04-23T08:40:19.505255 #4423] [0x155f130] DEBUG -- : (0.001040s) UPDATE "instances" SET "vm_id" = 18 WHERE ("id" = 6)
D, [2014-04-23T08:40:19.507876 #4423] [0x156060c] DEBUG -- : (0.001845s) UPDATE "instances" SET "vm_id" = 16 WHERE ("id" = 9)
D, [2014-04-23T08:40:19.507992 #4423] [0x155f4f0] DEBUG -- : (0.001438s) UPDATE "vms" SET "apply_spec_json" = '{"deployment":"cf-warden","resource_pool":{"name":"medium_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.130","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.uaa-z1.cf1.cf-warden.bosh"}},"agent_id":"e55aa74b-d908-4574-95d2-d52af028865e","vm":{"name":"vm-825d5f4e-113e-470f-b4e7-f8c43fb8466b","id":"vm-825d5f4e-113e-470f-b4e7-f8c43fb8466b"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"uaa_z1","templates":[{"name":"uaa","version":"45","sha1":"6dad6def5be7e13160687661f65892183283c6c6","blobstore_id":"8ee18ae0-00b6-4565-bae5-2ca582d00e17"}],"template":"uaa","version":"45","sha1":"6dad6def5be7e13160687661f65892183283c6c6","blobstore_id":"8ee18ae0-00b6-4565-bae5-2ca582d00e17"},"index":0}' WHERE ("id" = 11)
D, [2014-04-23T08:40:19.510239 #4423] [0x155f130] DEBUG -- : (0.001056s) COMMIT
D, [2014-04-23T08:40:19.510635 #4423] [0x155f4f0] DEBUG -- : (0.000807s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'uaa_z1') AND ("index" = 0) AND ("id" != 4)) LIMIT 1
D, [2014-04-23T08:40:19.511166 #4423] [0x156060c] DEBUG -- : (0.001941s) COMMIT
D, [2014-04-23T08:40:19.511341 #4423] [0x1562650] DEBUG -- : (0.004551s) UPDATE "vms" SET "apply_spec_json" = '{"deployment":"cf-warden","resource_pool":{"name":"small_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.10","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.loggregator-trafficcontroller-z1.cf1.cf-warden.bosh"}},"agent_id":"343b6382-80b9-42cf-926a-b09655d58733","vm":{"name":"vm-32b56421-c152-4a0c-92eb-2e570830c20c","id":"vm-32b56421-c152-4a0c-92eb-2e570830c20c"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"loggregator_trafficcontroller_z1","templates":[{"name":"loggregator_trafficcontroller","version":"12","sha1":"0fd1ec2a025d7b120d9bab2f5452ee690e9db7e3","blobstore_id":"cf43212c-e4a5-499e-b902-e87cbed002b5"}],"template":"loggregator_trafficcontroller","version":"12","sha1":"0fd1ec2a025d7b120d9bab2f5452ee690e9db7e3","blobstore_id":"cf43212c-e4a5-499e-b902-e87cbed002b5"},"index":0}' WHERE ("id" = 7)
D, [2014-04-23T08:40:19.512173 #4423] [0x1562308] DEBUG -- : (0.003285s) SELECT COUNT(*) AS "count" FROM "vms" WHERE (("agent_id" = 'b2e6cfe0-b353-4fc5-92c0-0ae477656e01') AND ("id" != 12)) LIMIT 1
D, [2014-04-23T08:40:19.512454 #4423] [0x155f130] DEBUG -- : Released connection: 13723880
D, [2014-04-23T08:40:19.512712 #4423] [0x155f130] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.512972 #4423] [0x1560990] DEBUG -- : (0.001305s) UPDATE "instances" SET "vm_id" = 10 WHERE ("id" = 7)
D, [2014-04-23T08:40:19.513172 #4423] [0x156060c] DEBUG -- : Released connection: 26420020
D, [2014-04-23T08:40:19.513385 #4423] [0x156060c] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.514252 #4423] [0x155f4f0] DEBUG -- : (0.001119s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 11) AND ("id" != 4)) LIMIT 1
D, [2014-04-23T08:40:19.514717 #4423] [0x1562650] DEBUG -- : (0.000594s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'loggregator_trafficcontroller_z1') AND ("index" = 0) AND ("id" != 11)) LIMIT 1
D, [2014-04-23T08:40:19.515360 #4423] [0x1560990] DEBUG -- : (0.000832s) COMMIT
D, [2014-04-23T08:40:19.516130 #4423] [0x1560990] DEBUG -- : Released connection: 22617800
D, [2014-04-23T08:40:19.516366 #4423] [0x1560990] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.516537 #4423] [0x1562650] DEBUG -- : (0.000467s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 7) AND ("id" != 11)) LIMIT 1
D, [2014-04-23T08:40:19.517208 #4423] [0x1562d30] DEBUG -- : (0.001076s) UPDATE "vms" SET "apply_spec_json" = '{"deployment":"cf-warden","resource_pool":{"name":"router_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.22","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.router-z1.cf1.cf-warden.bosh"}},"agent_id":"3c217524-555c-4fdd-be3d-0394e10952eb","vm":{"name":"vm-80d0a712-3ac5-49bd-ab8c-a2489f815f90","id":"vm-80d0a712-3ac5-49bd-ab8c-a2489f815f90"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"router_z1","templates":[{"name":"gorouter","version":"19","sha1":"f943a4b998f67685357a7976516ff07a3ef72104","blobstore_id":"5a3c2315-eebe-4354-a69b-91011ab80f89"}],"template":"gorouter","version":"19","sha1":"f943a4b998f67685357a7976516ff07a3ef72104","blobstore_id":"5a3c2315-eebe-4354-a69b-91011ab80f89"},"index":0}' WHERE ("id" = 15)
D, [2014-04-23T08:40:19.518078 #4423] [0x155f4f0] DEBUG -- : (0.001211s) UPDATE "instances" SET "vm_id" = 11 WHERE ("id" = 4)
D, [2014-04-23T08:40:19.519785 #4423] [0x155f4f0] DEBUG -- : (0.000851s) COMMIT
D, [2014-04-23T08:40:19.520153 #4423] [0x155f4f0] DEBUG -- : Released connection: 22599540
D, [2014-04-23T08:40:19.520387 #4423] [0x155f4f0] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.520544 #4423] [0x1562308] DEBUG -- : (0.000472s) UPDATE "vms" SET "apply_spec_json" = '{"deployment":"cf-warden","resource_pool":{"name":"medium_z1","cloud_properties":{"name":"random"},"stemcell":{"name":"bosh-warden-boshlite-ubuntu","version":"53"}},"networks":{"cf1":{"ip":"10.244.0.14","netmask":"255.255.255.252","cloud_properties":{"name":"random"},"default":["dns","gateway"],"dns_record_name":"0.loggregator-z1.cf1.cf-warden.bosh"}},"agent_id":"b2e6cfe0-b353-4fc5-92c0-0ae477656e01","vm":{"name":"vm-091293a1-dcdd-47a4-aca3-d31006bce51a","id":"vm-091293a1-dcdd-47a4-aca3-d31006bce51a"},"job_state":"running","bosh_protocol":"1","ntp":{"message":"file missing"},"job":{"name":"loggregator_z1","templates":[{"name":"loggregator","version":"20","sha1":"49d26d8128f24ab3f09eb2274dcb187b835ffeb6","blobstore_id":"a489afc2-0f98-40f2-908d-926715773392"}],"template":"loggregator","version":"20","sha1":"49d26d8128f24ab3f09eb2274dcb187b835ffeb6","blobstore_id":"a489afc2-0f98-40f2-908d-926715773392"},"index":0}' WHERE ("id" = 12)
D, [2014-04-23T08:40:19.521253 #4423] [0x1562d30] DEBUG -- : (0.001263s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'router_z1') AND ("index" = 0) AND ("id" != 12)) LIMIT 1
D, [2014-04-23T08:40:19.521773 #4423] [0x1562308] DEBUG -- : (0.000636s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("deployment_id" = 1) AND ("job" = 'loggregator_z1') AND ("index" = 0) AND ("id" != 10)) LIMIT 1
D, [2014-04-23T08:40:19.522293 #4423] [0x1562d30] DEBUG -- : (0.000687s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 15) AND ("id" != 12)) LIMIT 1
D, [2014-04-23T08:40:19.522724 #4423] [0x1562650] DEBUG -- : (0.002575s) UPDATE "instances" SET "vm_id" = 7 WHERE ("id" = 11)
D, [2014-04-23T08:40:19.522904 #4423] [0x1562d30] DEBUG -- : (0.000296s) UPDATE "instances" SET "vm_id" = 15 WHERE ("id" = 12)
D, [2014-04-23T08:40:19.523073 #4423] [0x1562308] DEBUG -- : (0.000875s) SELECT COUNT(*) AS "count" FROM "instances" WHERE (("vm_id" = 12) AND ("id" != 10)) LIMIT 1
D, [2014-04-23T08:40:19.523656 #4423] [0x1562650] DEBUG -- : (0.000821s) COMMIT
D, [2014-04-23T08:40:19.523756 #4423] [0x1562650] DEBUG -- : Released connection: 8592620
D, [2014-04-23T08:40:19.523864 #4423] [0x1562d30] DEBUG -- : (0.000822s) COMMIT
D, [2014-04-23T08:40:19.524157 #4423] [0x1562650] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.524332 #4423] [0x1562d30] DEBUG -- : Released connection: 13220160
D, [2014-04-23T08:40:19.524518 #4423] [0x1562308] DEBUG -- : (0.001030s) UPDATE "instances" SET "vm_id" = 12 WHERE ("id" = 10)
D, [2014-04-23T08:40:19.524887 #4423] [0x1562d30] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.525518 #4423] [0x1562308] DEBUG -- : (0.000393s) COMMIT
D, [2014-04-23T08:40:19.525565 #4423] [0x1562308] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.525618 #4423] [0x1562308] DEBUG -- : Thread is no longer needed, cleaning up
D, [2014-04-23T08:40:19.525748 #4423] [task:3] DEBUG -- : Shutting down pool
I, [2014-04-23T08:40:19.525873 #4423] [task:3] INFO -- : Binding configuration
D, [2014-04-23T08:40:19.526449 #4423] [task:3] DEBUG -- : Downloading template `haproxy' (ca505637-6065-405e-8761-5df6c0eb9c37)...
D, [2014-04-23T08:40:19.527833 #4423] [task:3] DEBUG -- : Template `haproxy' downloaded to /tmp/template-9d293c08-798e-4854-ba8e-6179f3b0af7a (took 0.001335693s)
D, [2014-04-23T08:40:19.539500 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.540307 #4423] [task:3] DEBUG -- : (0.000620s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 1) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:19.540380 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.590625 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.590895 #4423] [task:3] DEBUG -- : (0.000125s) BEGIN
D, [2014-04-23T08:40:19.593674 #4423] [task:3] DEBUG -- : (0.002318s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('a9b66601-c220-4454-be7a-8bb3bedaf1ba', '9b7b12481c0d558c614dfc6adfce81274ddc4914', '8bf07632972a70fd5ed74f08a2c360c1b08f8cdb', '2014-04-23 08:40:19.589923-0700', 1) RETURNING *
D, [2014-04-23T08:40:19.594330 #4423] [task:3] DEBUG -- : (0.000324s) COMMIT
D, [2014-04-23T08:40:19.594404 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.595133 #4423] [task:3] DEBUG -- : Downloading template `nats' (07aa2c73-ebe5-44a3-816b-d9f8dae15347)...
D, [2014-04-23T08:40:19.596463 #4423] [task:3] DEBUG -- : Template `nats' downloaded to /tmp/template-7725e370-dce2-47d8-87f2-2658fe249fa1 (took 0.001280853s)
D, [2014-04-23T08:40:19.605749 #4423] [task:3] DEBUG -- : Downloading template `nats_stream_forwarder' (382600c9-e727-42ed-9b3c-0acd6d8319a5)...
D, [2014-04-23T08:40:19.607267 #4423] [task:3] DEBUG -- : Template `nats_stream_forwarder' downloaded to /tmp/template-9779cb70-6044-4fd1-8a5c-f994c7719312 (took 0.001442612s)
D, [2014-04-23T08:40:19.633108 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.633817 #4423] [task:3] DEBUG -- : (0.000535s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 2) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:19.633886 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.681961 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.682418 #4423] [task:3] DEBUG -- : (0.000166s) BEGIN
D, [2014-04-23T08:40:19.683428 #4423] [task:3] DEBUG -- : (0.000377s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('308a7d3d-b10c-49c8-bc40-887e41dbf02f', '8d731f9780cb6353160099a3fc535b566db1b754', 'a7a9949d39bab65ff1dd59dab9d760a0a7b94221', '2014-04-23 08:40:19.681457-0700', 2) RETURNING *
D, [2014-04-23T08:40:19.684179 #4423] [task:3] DEBUG -- : (0.000419s) COMMIT
D, [2014-04-23T08:40:19.684304 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.684925 #4423] [task:3] DEBUG -- : Downloading template `postgres' (ff359cca-cdb5-4b7c-867f-d839d06b644d)...
D, [2014-04-23T08:40:19.686533 #4423] [task:3] DEBUG -- : Template `postgres' downloaded to /tmp/template-0f2aa9ec-92fc-4d67-af89-8e1f87477363 (took 0.001553521s)
D, [2014-04-23T08:40:19.724231 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.724874 #4423] [task:3] DEBUG -- : (0.000498s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 3) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:19.724965 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.774503 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.774930 #4423] [task:3] DEBUG -- : (0.000197s) BEGIN
D, [2014-04-23T08:40:19.775996 #4423] [task:3] DEBUG -- : (0.000365s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('ea112b0f-481f-49b0-a395-aa3731a01b1b', 'e799731a2f6082c12c45f53e2836103d6d5bd746', '1d4066bed97402721a89ac05b51b24355c953e3d', '2014-04-23 08:40:19.773970-0700', 3) RETURNING *
D, [2014-04-23T08:40:19.776898 #4423] [task:3] DEBUG -- : (0.000328s) COMMIT
D, [2014-04-23T08:40:19.776972 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.777766 #4423] [task:3] DEBUG -- : Downloading template `uaa' (8ee18ae0-00b6-4565-bae5-2ca582d00e17)...
D, [2014-04-23T08:40:19.779318 #4423] [task:3] DEBUG -- : Template `uaa' downloaded to /tmp/template-65b3b14d-4174-4cf8-8a86-69f3716a8957 (took 0.001493047s)
D, [2014-04-23T08:40:19.795265 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.795890 #4423] [task:3] DEBUG -- : (0.000504s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 4) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:19.795972 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.848126 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.848356 #4423] [task:3] DEBUG -- : (0.000099s) BEGIN
D, [2014-04-23T08:40:19.848983 #4423] [task:3] DEBUG -- : (0.000252s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('8dce8676-535c-4a88-9c65-eba70c4bd12b', '0d77e9fd49ef683b09a0b44fe8357ab0b462deaf', 'f21c85884453c9d428cc54d9b691f42fae318fe7', '2014-04-23 08:40:19.847645-0700', 4) RETURNING *
D, [2014-04-23T08:40:19.849554 #4423] [task:3] DEBUG -- : (0.000344s) COMMIT
D, [2014-04-23T08:40:19.849621 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.850268 #4423] [task:3] DEBUG -- : Downloading template `login' (db3b690f-c468-4e29-9233-ee2460c354ea)...
D, [2014-04-23T08:40:19.851914 #4423] [task:3] DEBUG -- : Template `login' downloaded to /tmp/template-c1cd06bd-527d-49a9-8f7d-5a58b4a828e3 (took 0.001594635s)
D, [2014-04-23T08:40:19.878344 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.878769 #4423] [task:3] DEBUG -- : (0.000299s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 5) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:19.878833 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.933554 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:19.934037 #4423] [task:3] DEBUG -- : (0.000339s) BEGIN
D, [2014-04-23T08:40:19.934906 #4423] [task:3] DEBUG -- : (0.000433s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('6f242c1e-7605-48c0-a24e-a349bfb53f0e', '621a01dd76b38fbf6cf1592864d82a28033abbaa', '93ebbfeec993ae76a3a793dd7a1441c952f06400', '2014-04-23 08:40:19.933190-0700', 5) RETURNING *
D, [2014-04-23T08:40:19.935708 #4423] [task:3] DEBUG -- : (0.000557s) COMMIT
D, [2014-04-23T08:40:19.935778 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:19.938044 #4423] [task:3] DEBUG -- : Downloading template `cloud_controller_ng' (9e4cbfad-3fab-4395-8cf4-2b18869115a4)...
D, [2014-04-23T08:40:19.939745 #4423] [task:3] DEBUG -- : Template `cloud_controller_ng' downloaded to /tmp/template-150fb252-5d02-4c50-a9a0-50c92fb9c676 (took 0.001644741s)
D, [2014-04-23T08:40:19.954618 #4423] [task:3] DEBUG -- : Downloading template `cloud_controller_clock' (fa256840-b9ab-4002-a90d-2d6f5985d8d4)...
D, [2014-04-23T08:40:19.956212 #4423] [task:3] DEBUG -- : Template `cloud_controller_clock' downloaded to /tmp/template-b0175686-8659-4140-938b-e3918a4c0c1f (took 0.001514375s)
D, [2014-04-23T08:40:19.989156 #4423] [task:3] DEBUG -- : Downloading template `cloud_controller_worker' (7b859ba8-3f6d-4362-8308-be8350d0e3d8)...
D, [2014-04-23T08:40:19.990931 #4423] [task:3] DEBUG -- : Template `cloud_controller_worker' downloaded to /tmp/template-86b22370-e959-49f3-81d7-f752f2d9f6dd (took 0.001672637s)
D, [2014-04-23T08:40:20.042333 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:20.042847 #4423] [task:3] DEBUG -- : (0.000386s) SELECT * FROM "rendered_templates_archives" WHERE ("rendered_templates_archives"."instance_id" = 6) ORDER BY "created_at" DESC LIMIT 1
D, [2014-04-23T08:40:20.042922 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:20.093007 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:20.093545 #4423] [task:3] DEBUG -- : (0.000367s) BEGIN
D, [2014-04-23T08:40:20.094517 #4423] [task:3] DEBUG -- : (0.000472s) INSERT INTO "rendered_templates_archives" ("blobstore_id", "sha1", "content_sha1", "created_at", "instance_id") VALUES ('712f625d-ee0c-4061-9377-ed104da98325', 'fe18e250a4f155656ff2d62f2aea40945f566424', 'd59a0b872643fa0f95355eda01c4f611228c89d5', '2014-04-23 08:40:20.092524-0700', 6) RETURNING *
D, [2014-04-23T08:40:20.095369 #4423] [task:3] DEBUG -- : (0.000540s) COMMIT
D, [2014-04-23T08:40:20.095439 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:20.096212 #4423] [task:3] DEBUG -- : Downloading template `etcd' (751a4ffd-db64-42fe-a57f-9c1427da29c0)...
D, [2014-04-23T08:40:20.097756 #4423] [task:3] DEBUG -- : Template `etcd' downloaded to /tmp/template-a18240ed-b638-440e-8b71-da5946a1974a (took 0.001475559s)
D, [2014-04-23T08:40:20.112526 #4423] [task:3] DEBUG -- : Downloading template `etcd_metrics_server' (0884457a-f10b-4ef4-bb2c-495e42d632f1)...
D, [2014-04-23T08:40:20.114144 #4423] [task:3] DEBUG -- : Template `etcd_metrics_server' downloaded to /tmp/template-bd1c0bbe-8a33-4883-a892-c3a1d364492c (took 0.001537993s)
D, [2014-04-23T08:40:20.128754 #4423] [task:3] DEBUG -- : #<NoMethodError: undefined method `collect' for "(( .properties.nats.machines ))":String>
D, [2014-04-23T08:40:20.129143 #4423] [task:3] DEBUG -- : Error filling in template `ctl.erb' for `etcd_leader_z1/0' (line 26: undefined method `collect' for "(( .properties.nats.machines ))":String)
etcd_metrics_server/ctl.erb:26:in `get_binding'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/1.9.1/erb.rb:838:in `eval'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/1.9.1/erb.rb:838:in `result'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/source_erb.rb:17:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:26:in `block in render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:25:in `map'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:25:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:14:in `block in render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:12:in `map'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:12:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:15:in `block in render_job_instances'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:14:in `each'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:14:in `render_job_instances'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:315:in `block in bind_configuration'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:314:in `each'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:314:in `bind_configuration'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/updater.rb:29:in `block in update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:48:in `block in track_and_log'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:83:in `call'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:83:in `advance_and_track'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:36:in `track'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:46:in `track_and_log'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/updater.rb:28:in `update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:52:in `update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:78:in `block in perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock_helper.rb:21:in `block in with_deployment_lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock.rb:58:in `lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock_helper.rb:21:in `with_deployment_lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:71:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:98:in `perform_job'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:29:in `block in run'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh_common-1.2200.0/lib/common/thread_formatter.rb:46:in `with_thread_name'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:29:in `run'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:10:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/job.rb:125:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:186:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:149:in `block in work'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:128:in `loop'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:128:in `work'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/bin/bosh-director-worker:76:in `<top (required)>'
/opt/rbenv/versions/1.9.3-p484/bin/bosh-director-worker:23:in `load'
/opt/rbenv/versions/1.9.3-p484/bin/bosh-director-worker:23:in `<main>'
D, [2014-04-23T08:40:20.130950 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:20.132177 #4423] [task:3] DEBUG -- : (0.001030s) SELECT "stemcells".* FROM "stemcells" INNER JOIN "deployments_stemcells" ON (("deployments_stemcells"."stemcell_id" = "stemcells"."id") AND ("deployments_stemcells"."deployment_id" = 1))
D, [2014-04-23T08:40:20.132299 #4423] [task:3] DEBUG -- : Released connection: 26454500
D, [2014-04-23T08:40:20.132487 #4423] [task:3] DEBUG -- : Deleting lock: lock:deployment:cf-warden
D, [2014-04-23T08:40:20.132561 #4423] [task:3] DEBUG -- : Redis >> WATCH lock:deployment:cf-warden
D, [2014-04-23T08:40:20.132596 #4423] [0x12c2544] DEBUG -- : Lock renewal thread exiting
D, [2014-04-23T08:40:20.132690 #4423] [0x12c2544] DEBUG -- : Redis >> QUIT
D, [2014-04-23T08:40:20.133862 #4423] [task:3] DEBUG -- : Redis >> 1.21ms
D, [2014-04-23T08:40:20.133987 #4423] [task:3] DEBUG -- : Redis >> GET lock:deployment:cf-warden
D, [2014-04-23T08:40:20.134212 #4423] [0x12c2544] DEBUG -- : Redis >> 1.47ms
D, [2014-04-23T08:40:20.134650 #4423] [task:3] DEBUG -- : Redis >> 0.58ms
D, [2014-04-23T08:40:20.134734 #4423] [task:3] DEBUG -- : Redis >> MULTI
D, [2014-04-23T08:40:20.134760 #4423] [task:3] DEBUG -- : Redis >> DEL lock:deployment:cf-warden
D, [2014-04-23T08:40:20.134777 #4423] [task:3] DEBUG -- : Redis >> EXEC
D, [2014-04-23T08:40:20.134983 #4423] [task:3] DEBUG -- : Redis >> 0.18ms
D, [2014-04-23T08:40:20.135037 #4423] [task:3] DEBUG -- : Deleted lock: lock:deployment:cf-warden
E, [2014-04-23T08:40:20.135303 #4423] [task:3] ERROR -- : Error filling in template `ctl.erb' for `etcd_leader_z1/0' (line 26: undefined method `collect' for "(( .properties.nats.machines ))":String)
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/source_erb.rb:32:in `rescue in render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/source_erb.rb:17:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:26:in `block in render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:25:in `map'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_template_renderer.rb:25:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:14:in `block in render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:12:in `map'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-core-1.2200.0/lib/bosh/director/core/templates/job_instance_renderer.rb:12:in `render'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:15:in `block in render_job_instances'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:14:in `each'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_renderer.rb:14:in `render_job_instances'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:315:in `block in bind_configuration'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:314:in `each'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/assembler.rb:314:in `bind_configuration'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/updater.rb:29:in `block in update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:48:in `block in track_and_log'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:83:in `call'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:83:in `advance_and_track'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/event_log.rb:36:in `track'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:46:in `track_and_log'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/deployment_plan/updater.rb:28:in `update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:52:in `update'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:78:in `block in perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock_helper.rb:21:in `block in with_deployment_lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock.rb:58:in `lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/lock_helper.rb:21:in `with_deployment_lock'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/update_deployment.rb:71:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:98:in `perform_job'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:29:in `block in run'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh_common-1.2200.0/lib/common/thread_formatter.rb:46:in `with_thread_name'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/job_runner.rb:29:in `run'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/lib/bosh/director/jobs/base_job.rb:10:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/job.rb:125:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:186:in `perform'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:149:in `block in work'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:128:in `loop'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/resque-1.23.1/lib/resque/worker.rb:128:in `work'
/opt/rbenv/versions/1.9.3-p484/lib/ruby/gems/1.9.1/gems/bosh-director-1.2200.0/bin/bosh-director-worker:76:in `<top (required)>'
/opt/rbenv/versions/1.9.3-p484/bin/bosh-director-worker:23:in `load'
/opt/rbenv/versions/1.9.3-p484/bin/bosh-director-worker:23:in `<main>'
D, [2014-04-23T08:40:20.135700 #4423] [task:3] DEBUG -- : Acquired connection: 26454500
D, [2014-04-23T08:40:20.135935 #4423] [task:3] DEBUG -- : (0.000149s) BEGIN
D, [2014-04-23T08:40:20.136963 #4423] [task:3] DEBUG -- : (0.000453s) UPDATE "tasks" SET "state" = 'error', "timestamp" = '2014-04-23 08:40:20.135475-0700', "description" = 'create deployment', "result" = 'Error filling in template `ctl.erb'' for `etcd_leader_z1/0'' (line 26: undefined method `collect'' for "((...', "output" = '/opt/bosh/director/tasks/3', "user_id" = NULL, "checkpoint_time" = '2014-04-23 08:40:08.675577-0700', "type" = 'update_deployment' WHERE ("id" = 3)
D, [2014-04-23T08:40:20.138385 #4423] [task:3] DEBUG -- : (0.001105s) COMMIT
D, [2014-04-23T08:40:20.138569 #4423] [task:3] DEBUG -- : Released connection: 26454500
I, [2014-04-23T08:40:20.138801 #4423] [0x48d078] INFO -- : Task took 7 minutes 12.213878810999972 seconds to process.
Task 3 error
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment