Skip to content

HTTPS clone URL

Subversion checkout URL

You can clone with
or
.
Download ZIP

Loading…

Vulcan Server Crashes #37

Closed
josephwegner opened this Issue · 13 comments

6 participants

@josephwegner

2012-11-29T17:12:10+00:00 heroku[web.1]: Starting process with command bin/web
2012-11-29T17:12:11+00:00 heroku[web.1]: Process exited with status 1
2012-11-29T17:12:11+00:00 heroku[web.1]: State changed from starting to crashed
2012-11-29T17:12:11+00:00 app[web.1]: 29 Nov 17:12:11 - [nodemon] starting coffee web.coffee
2012-11-29T17:12:11+00:00 app[web.1]: 29 Nov 17:12:11 - [nodemon] watching: /app
2012-11-29T17:12:11+00:00 app[web.1]: 29 Nov 17:12:11 - [nodemon] v0.6.18
2012-11-29T17:12:12+00:00 app[web.1]: at Module._compile (module.js:446:26)
2012-11-29T17:12:12+00:00 app[web.1]: at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2012-11-29T17:12:12+00:00 app[web.1]: at Function._load (module.js:279:25)
2012-11-29T17:12:12+00:00 app[web.1]: at require (module.js:375:17)
2012-11-29T17:12:12+00:00 app[web.1]: at Object. (/app/web.coffee:10:12)
2012-11-29T17:12:12+00:00 app[web.1]: at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2012-11-29T17:12:12+00:00 app[web.1]: Error: Cannot find module 'logger'
2012-11-29T17:12:12+00:00 app[web.1]: at Function._resolveFilename (module.js:337:11)
2012-11-29T17:12:12+00:00 app[web.1]: at Module.require (module.js:359:17)
2012-11-29T17:12:12+00:00 app[web.1]: at Object. (/app/web.coffee:121:4)
2012-11-29T17:12:12+00:00 app[web.1]: at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2012-11-29T17:12:12+00:00 app[web.1]: 29 Nov 17:12:12 - [nodemon] app crashed - waiting for file changes before starting...

@wuputah
Owner

Can you retry with 0.8.1?

@josephwegner

@wuputah I updated you in the Heroku ticket, but for the records here, the issue is solve in 0.8.1. Thank you!

@runemadsen

@wuputah I'm still seeing this running 0.8.1:

2013-01-17T19:18:42+00:00 heroku[web.1]: State changed from crashed to starting
2013-01-17T19:18:46+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T19:18:46+00:00 app[web.1]: 17 Jan 19:18:46 - [nodemon] v0.6.18
2013-01-17T19:18:46+00:00 app[web.1]: 17 Jan 19:18:46 - [nodemon] watching: /app
2013-01-17T19:18:46+00:00 app[web.1]: 17 Jan 19:18:46 - [nodemon] starting `coffee web.coffee`
2013-01-17T19:18:47+00:00 app[web.1]: Error: Cannot find module 'logger'
2013-01-17T19:18:47+00:00 app[web.1]:     at require (module.js:375:17)
2013-01-17T19:18:47+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-01-17T19:18:47+00:00 app[web.1]:     at Function._load (module.js:279:25)
2013-01-17T19:18:47+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-01-17T19:18:47+00:00 app[web.1]:     at Function._resolveFilename (module.js:337:11)
2013-01-17T19:18:47+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-01-17T19:18:47+00:00 app[web.1]:     at Module.require (module.js:359:17)
2013-01-17T19:18:47+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:10:12)
2013-01-17T19:18:47+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-01-17T19:18:47+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)

Any ideas?

@wuputah
Owner
2013-01-17T19:18:47+00:00 app[web.1]: Error: Cannot find module 'logger'

Doesn't look like something was installed right there.

@josephwegner

@runemadsen How did you install vulcan? I don't manage the gem, but the logger module exists in the github repo right now.. Unless they messed something up when packaging the gem, there's no reason vulcan shouldn't be able to find 'logger'.

Perhaps try doing a vulcan update to see if that fixes things.

@runemadsen

Yeah, it's weird. Gem lists vulcan (0.8.1), so I'm running the correct version. Still not working after vulcan update.

I basically just did this:

gem install vulcan
vulcan create something

App crashing right away. Maybe I should try to install directly from Github?

@runemadsen

Just a follow up. I think something is wrong with the released vulcan version. This issue #46 points to the same problem, and was created yesterday. Cloudant is installed, so it's not related to the addons not being there.

My deploy output:

dmins-MacBook-Air-4:vulcan rmadsen$ vulcan create headless-build
fatal: Not a git repository (or any of the parent directories): .git
Creating headless-build... done, stack is cedar
http://headless-build.herokuapp.com/ | git@heroku.com:headless-build.git
Initialized empty Git repository in /private/var/folders/s3/6td4_mvs3t59zhqbnt0rx9gm0000gp/T/d20130117-80631-nac3ee/.git/
Counting objects: 884, done.
Delta compression using up to 4 threads.
Compressing objects: 100% (804/804), done.
Writing objects: 100% (884/884), 1015.00 KiB | 87 KiB/s, done.
Total 884 (delta 82), reused 0 (delta 0)
-----> Node.js app detected
-----> Resolving engine versions
       Using Node.js version: 0.6.20
       Using npm version: 1.1.4
-----> Fetching Node.js binaries
-----> Vendoring node into slug
-----> Installing dependencies with npm
       npm WARN coffee-script@1.3.3 package.json: bugs['name'] should probably be bugs['url']
       npm WARN coffee-script@1.3.3 package.json: bugs['name'] should probably be bugs['url']
       npm WARN prefer global nodemon@0.6.18 should be installed with -g
       coffee-script@1.3.3 /tmp/build_1zj1ds4mv9pbi/node_modules/coffee-script
       connect-form@0.2.0 /tmp/build_1zj1ds4mv9pbi/node_modules/connect-form
       formidable@1.0.9 /tmp/build_1zj1ds4mv9pbi/node_modules/connect-form/node_modules/formidable
       cradle@0.6.3 /tmp/build_1zj1ds4mv9pbi/node_modules/cradle
       follow@0.7.2 /tmp/build_1zj1ds4mv9pbi/node_modules/cradle/node_modules/follow
       request@2.2.9 /tmp/build_1zj1ds4mv9pbi/node_modules/cradle/node_modules/follow/node_modules/request
       request@2.9.202 /tmp/build_1zj1ds4mv9pbi/node_modules/cradle/node_modules/request
       vargs@0.1.0 /tmp/build_1zj1ds4mv9pbi/node_modules/cradle/node_modules/vargs
       express@2.5.9 /tmp/build_1zj1ds4mv9pbi/node_modules/express
       connect@1.8.7 /tmp/build_1zj1ds4mv9pbi/node_modules/express/node_modules/connect
       qs@0.4.2 /tmp/build_1zj1ds4mv9pbi/node_modules/express/node_modules/qs
       mime@1.2.4 /tmp/build_1zj1ds4mv9pbi/node_modules/express/node_modules/mime
       formidable@1.0.9 /tmp/build_1zj1ds4mv9pbi/node_modules/express/node_modules/connect/node_modules/formidable
       mkdirp@0.3.0 /tmp/build_1zj1ds4mv9pbi/node_modules/express/node_modules/mkdirp
       knox@0.0.9 /tmp/build_1zj1ds4mv9pbi/node_modules/knox
       node-uuid@1.3.3 /tmp/build_1zj1ds4mv9pbi/node_modules/node-uuid
       nodemon@0.6.18 /tmp/build_1zj1ds4mv9pbi/node_modules/nodemon
       restler@2.0.1 /tmp/build_1zj1ds4mv9pbi/node_modules/restler
       Dependencies installed
-----> Building runtime environment
-----> Discovering process types
       Procfile declares types -> web
-----> Compiled slug size: 4.1MB
-----> Launching... done, v4
       http://headless-build.herokuapp.com deployed to Heroku

My logs:

2013-01-17T20:39:04+00:00 heroku[api]: Enable Logplex by rune@runemadsen.com
2013-01-17T20:39:04+00:00 heroku[api]: Release v2 created by rune@runemadsen.com
2013-01-17T20:39:37+00:00 heroku[api]: Add PATH config by rune@runemadsen.com
2013-01-17T20:39:37+00:00 heroku[api]: Release v3 created by rune@runemadsen.com
2013-01-17T20:39:38+00:00 heroku[api]: Scale to web=1 by rune@runemadsen.com
2013-01-17T20:39:38+00:00 heroku[api]: Release v4 created by rune@runemadsen.com
2013-01-17T20:39:38+00:00 heroku[api]: Deploy c9c41d6 by rune@runemadsen.com
2013-01-17T20:39:40+00:00 heroku[api]: Release v5 created by rune@runemadsen.com
2013-01-17T20:39:40+00:00 heroku[api]: Add SECRET, SPAWN_ENV, HEROKU_APP, HEROKU_API_KEY, NODE_PATH, NODE_ENV config by rune@runemadsen.com
2013-01-17T20:39:47+00:00 heroku[web.1]: State changed from starting to crashed
2013-01-17T20:39:47+00:00 heroku[web.1]: State changed from crashed to starting
2013-01-17T20:39:52+00:00 heroku[web.1]: State changed from starting to crashed
2013-01-17T20:40:00+00:00 heroku[api]: Release v6 created by rune@runemadsen.com
2013-01-17T20:40:00+00:00 heroku[api]: Add cloudant:oxygen add-on by rune@runemadsen.com
2013-01-17T20:40:03+00:00 heroku[web.1]: State changed from crashed to starting
2013-01-17T20:39:43+00:00 app[web.1]: 17 Jan 20:39:43 - [nodemon] app crashed - waiting for file changes before starting...
2013-01-17T20:39:43+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-01-17T20:39:41+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:39:43+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-01-17T20:39:43+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-01-17T20:39:42+00:00 app[web.1]: 17 Jan 20:39:42 - [nodemon] starting `coffee web.coffee`
2013-01-17T20:39:43+00:00 app[web.1]:     at require (module.js:375:17)
2013-01-17T20:39:42+00:00 app[web.1]: 17 Jan 20:39:42 - [nodemon] watching: /app
2013-01-17T20:39:43+00:00 app[web.1]:     at Function._resolveFilename (module.js:337:11)
2013-01-17T20:39:43+00:00 app[web.1]:     at Module.require (module.js:359:17)
2013-01-17T20:39:43+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-01-17T20:39:42+00:00 app[web.1]: 17 Jan 20:39:42 - [nodemon] v0.6.18
2013-01-17T20:39:28+00:00 heroku[slugc]: Slug compilation started
2013-01-17T20:39:43+00:00 app[web.1]: Error: Cannot find module 'logger'
2013-01-17T20:39:47+00:00 heroku[web.1]: Process exited with status 1
2013-01-17T20:39:43+00:00 app[web.1]:     at Function._load (module.js:279:25)
2013-01-17T20:39:44+00:00 app[web.1]: 17 Jan 20:39:44 - [nodemon] exiting
2013-01-17T20:39:43+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:10:12)
2013-01-17T20:39:43+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2013-01-17T20:39:39+00:00 heroku[slugc]: Slug compilation finished
2013-01-17T20:39:59+00:00 heroku[web.1]: Process exited with status 0
2013-01-17T20:39:51+00:00 app[web.1]: TypeError: Parameter 'url' must be a string, not undefined
2013-01-17T20:39:51+00:00 app[web.1]:     at Object.urlParse [as parse] (url.js:92:11)
2013-01-17T20:39:51+00:00 app[web.1]:     at Object.connect (/app/lib/cloudant.coffee:10:22)
2013-01-17T20:39:51+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:22:28)
2013-01-17T20:39:51+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-01-17T20:39:51+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-01-17T20:39:51+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2013-01-17T20:39:51+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-01-17T20:39:51+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-01-17T20:39:51+00:00 app[web.1]:     at [object Object].<anonymous> (fs.js:123:5)
2013-01-17T20:39:49+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:39:51+00:00 app[web.1]:     at [object Object].emit (events.js:64:17)
2013-01-17T20:39:52+00:00 heroku[web.1]: Process exited with status 1
2013-01-17T20:39:45+00:00 app[web.1]: TypeError: Parameter 'url' must be a string, not undefined
2013-01-17T20:39:45+00:00 app[web.1]:     at Object.urlParse [as parse] (url.js:92:11)
2013-01-17T20:39:45+00:00 app[web.1]:     at Object.connect (/app/lib/cloudant.coffee:10:22)
2013-01-17T20:39:45+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:22:28)
2013-01-17T20:39:45+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-01-17T20:39:45+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-01-17T20:39:45+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2013-01-17T20:39:45+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-01-17T20:39:45+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-01-17T20:39:45+00:00 app[web.1]:     at [object Object].<anonymous> (fs.js:123:5)
2013-01-17T20:39:45+00:00 app[web.1]:     at [object Object].emit (events.js:64:17)
2013-01-17T20:39:45+00:00 app[web.1]: 17 Jan 20:39:45 - [nodemon] exiting
2013-01-17T20:39:42+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:39:44+00:00 app[web.1]: 17 Jan 20:39:44 - [nodemon] starting `coffee web.coffee`
2013-01-17T20:39:44+00:00 app[web.1]: 17 Jan 20:39:44 - [nodemon] v0.6.18
2013-01-17T20:39:44+00:00 app[web.1]: 17 Jan 20:39:44 - [nodemon] watching: /app
2013-01-17T20:40:01+00:00 heroku[web.1]: Process exited with status 0
2013-01-17T20:41:12+00:00 heroku[slugc]: Slug compilation started
2013-01-17T20:41:21+00:00 heroku[api]: Release v7 created by rune@runemadsen.com
2013-01-17T20:41:21+00:00 heroku[api]: Deploy d000867 by rune@runemadsen.com
2013-01-17T20:41:22+00:00 heroku[slugc]: Slug compilation finished
2013-01-17T20:41:25+00:00 heroku[web.1]: State changed from starting to up
2013-01-17T20:41:23+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:41:24+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:41:23+00:00 heroku[api]: Release v8 created by rune@runemadsen.com
2013-01-17T20:41:23+00:00 heroku[api]: Add SECRET, SPAWN_ENV, HEROKU_APP, HEROKU_API_KEY, NODE_PATH, NODE_ENV config by rune@runemadsen.com
2013-01-17T20:41:29+00:00 heroku[web.1]: Stopping all processes with SIGTERM
2013-01-17T20:41:31+00:00 heroku[web.1]: Process exited with status 1
2013-01-17T20:41:27+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-17T20:41:47+00:00 heroku[web.1]: Stopping all processes with SIGTERM
2013-01-17T20:41:49+00:00 heroku[web.1]: Process exited with status 1

@ddollar any ideas on what could cause this? Again, running with version 0.8.1.

@runemadsen

This error suddenly went away after the dyno had been idling for 10 minutes or so. Seriously weird. I have no explanation.

@davidfrey

I've been experiencing the same issue. I've just started playing with buildpacks today and tried to run through the tutorial using memcache. I ran vulcan build and got the following error.

memcached-1.4.13$ vulcan build
Packaging local directory... done
Uploading source package... !! Unknown error, no build output given

Tailing the logs on the vulcan app that was created shows the same logger error that runemadsen gave.

2013-01-24T22:33:05+00:00 heroku[web.1]: State changed from crashed to starting
2013-01-24T22:33:10+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-01-24T22:33:11+00:00 app[web.1]: 24 Jan 22:33:11 - [nodemon] v0.6.18
2013-01-24T22:33:11+00:00 app[web.1]: 24 Jan 22:33:11 - [nodemon] watching: /app
2013-01-24T22:33:11+00:00 app[web.1]: 24 Jan 22:33:11 - [nodemon] starting `coffee web.coffee`
2013-01-24T22:33:11+00:00 app[web.1]: Error: Cannot find module 'logger'
2013-01-24T22:33:11+00:00 app[web.1]:     at Function._resolveFilename (module.js:337:11)
2013-01-24T22:33:11+00:00 app[web.1]:     at Function._load (module.js:279:25)
2013-01-24T22:33:11+00:00 app[web.1]:     at Module.require (module.js:359:17)
2013-01-24T22:33:11+00:00 app[web.1]:     at require (module.js:375:17)
2013-01-24T22:33:11+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:10:12)
2013-01-24T22:33:11+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-01-24T22:33:11+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-01-24T22:33:11+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2013-01-24T22:33:11+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-01-24T22:33:11+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-01-24T22:33:11+00:00 app[web.1]: 24 Jan 22:33:11 - [nodemon] app crashed - waiting for file changes before starting...
2013-01-24T22:33:12+00:00 app[web.1]: 24 Jan 22:33:12 - [nodemon] exiting
2013-01-24T22:33:27+00:00 heroku[web.1]: Process exited with status 0
2013-01-24T22:33:27+00:00 heroku[web.1]: State changed from starting to crashed

I'm running this vanilla trying to follow the tutorial verbatim, but keep hitting this road block.

@davidfrey

Just wanted to add that in my case this seems environment specific. I tried running on a different machine and everything worked fine. I'll try to isolate the cause and share the findings.

@theoephraim

Any update on this or a better install/setup tutorial?

@lastobelus

I was having this issue having first created the build-server on an account without a credit card, so that cloudant was not added. After adding the credit card, the problem continued to happen even after deleting the build-server and re-creating it.

Then I tried creating a build-server with a different name, and this time the " Error: Cannot find module 'logger'" error appeared in the log, but afterwards the following:

2013-10-11T10:10:51.707438+00:00 heroku[api]: Add cloudant:oxygen add-on by lastobelus@mac.com
2013-10-11T10:10:51.741618+00:00 heroku[api]: Release v6 created by lastobelus@mac.com
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:121:4)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Module._compile (module.js:446:26)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Object.run (/app/node_modules/coffee-script/lib/coffee-script/coffee-script.js:79:25)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:175:29
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at /app/node_modules/coffee-script/lib/coffee-script/command.js:150:18
2013-10-11T10:10:52.303658+00:00 app[web.1]: TypeError: Parameter 'url' must be a string, not undefined
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Object.urlParse [as parse] (url.js:92:11)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Object.<anonymous> (/app/web.coffee:22:28)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at Object.connect (/app/lib/cloudant.coffee:10:22)
2013-10-11T10:10:52.303986+00:00 app[web.1]:     at [object Object].emit (events.js:64:17)
2013-10-11T10:10:52.303658+00:00 app[web.1]:     at [object Object].<anonymous> (fs.js:123:5)
2013-10-11T10:10:52.378599+00:00 heroku[web.1]: Process exited with status 0
2013-10-11T10:10:53.745104+00:00 heroku[web.1]: Process exited with status 1
2013-10-11T10:10:54.182956+00:00 heroku[web.1]: Starting process with command `bin/web`
2013-10-11T10:10:56.117487+00:00 heroku[web.1]: State changed from starting to up

So it seems like something was still messed up with vulcan's attempt to setup cloudant. Upon trying a build, I got this error: Uploading source package... Internal Server Error> and in the log:

2013-10-11T10:13:50.470333+00:00 app[web.1]: [cfa6d050-7041-4940-a991-9bdf3998c4ac] saving to couchdb
2013-10-11T10:13:50.576345+00:00 app[web.1]: [cfa6d050-7041-4940-a991-9bdf3998c4ac] ERROR: { error: 'not_found', reason: 'Database does not exist.' }
2013-10-11T10:13:50.591690+00:00 app[web.1]: { error: 'not_found', reason: 'Database does not exist.' }
2013-10-11T10:13:50.592312+00:00 app[web.1]: 10.93.31.62 - - [Fri, 11 Oct 2013 10:13:50 GMT] "POST /make HTTP/1.1" 500 - "-" "Ruby"

Can I manually create a database using cloudant to continue? What should I call it?

@lastobelus

Ah, I think when I created the second vulcan server, I did not do vulcan update. After doing vulcan update I am now able to do a build.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Something went wrong with that request. Please try again.