Can't get Passenger to work/start

[Oswald Yang]

Hi All,

USING:
passenger-3.0.0
rvm 1.0.14
ruby 1.9.2p0
rails 3.0.1
apache 2.2.3-4+etch11

I've recently started using Passenger along with RVM and Apache. Now
I've installed it on 2 servers and it works like a dream, but on the
3rd server (installed on the exact same way as the previous two) when
I browse to the Rails app it just hangs (browser says 'waiting for
example.com') indefinitely. I've tried other versions of passenger as
well, but to no avail. This is what I get when I restart Apache:

[ pid=12392 thr=3078350528 file=ext/apache2/Hooks.cpp:1592
time=2010-10-19 12:10:50.995 ]: Shutting down Phusion Passenger...
[ pid=25982 thr=3078883008 file=ext/apache2/Hooks.cpp:1319
time=2010-10-19 12:10:53.325 ]: Initializing Phusion Passenger...
[ pid=25982 thr=3078883008 file=ext/apache2/Hooks.cpp:1592
time=2010-10-19 12:10:53.427 ]: Shutting down Phusion Passenger...
[ pid=25999 thr=3078883008 file=ext/apache2/Hooks.cpp:1319
time=2010-10-19 12:10:53.721 ]: Initializing Phusion Passenger...
[Tue Oct 19 12:10:53 2010] [notice] Apache configured -- resuming
normal operations
[ pid=12404 thr=3081123520 file=ext/common/LoggingAgent/
LoggingServer.h:824 time=2010-10-19 12:10:53.817 ]: Flushing all sinks
(periodic action)
[ pid=12400 thr=3075165104 file=ext/common/MessageServer.h:475
time=2010-10-19 12:10:56.5 ]: MessageServer client thread 9
interrupted.
[ pid=26007 thr=3075374000 file=ext/common/ApplicationPool/Pool.h:894
time=2010-10-19 12:10:59.864 ]: Restarting /web/cv/html/rails/
capri_village
[ pid=26007 thr=3075374000 file=ext/common/ApplicationPool/Pool.h:927
time=2010-10-19 12:10:59.864 ]: Spawning a process for /web/cv/html/
rails/capri_village because there are none for this app group
[ pid=26007 thr=3075374000 file=ext/common/ApplicationPool/../
SpawnManager.h:291 time=2010-10-19 12:10:59.864 ]: Spawning a new
application process for /web/cv/html/rails/capri_village...
[ pid=25998 thr=3084327136 file=ext/common/Watchdog.cpp:888
time=2010-10-19 12:11:01.27 ]: All Phusion Passenger agent processes
have exited.
[ pid=26011 thr=3080795840 file=ext/common/LoggingAgent/
LoggingServer.h:824 time=2010-10-19 12:11:08.802 ]: Flushing all sinks
(periodic action)
[Tue Oct 19 12:11:18 2010] [notice] caught SIGTERM, shutting down
[ pid=25999 thr=3078883008 file=ext/apache2/Hooks.cpp:1592
time=2010-10-19 12:11:18.994 ]: Shutting down Phusion Passenger...
[ pid=26203 thr=3078883008 file=ext/apache2/Hooks.cpp:1319
time=2010-10-19 12:11:21.9 ]: Initializing Phusion Passenger...
[ pid=25978 thr=3083552992 file=ext/common/Watchdog.cpp:883
time=2010-10-19 12:11:21.18 ]: Some Phusion Passenger agent processes
did not exit in time, forcefully shutting down all.
[ pid=26203 thr=3078883008 file=ext/apache2/Hooks.cpp:1592
time=2010-10-19 12:11:21.97 ]: Shutting down Phusion Passenger...
[Tue Oct 19 12:11:21 2010] [notice] FastCGI: process manager
initialized (pid 26231)
[Tue Oct 19 12:11:21 2010] [notice] mod_python: Creating 8 session
mutexes based on 150 max processes and 0 max threads.
[Tue Oct 19 12:11:21 2010] [notice] mod_python: using mutex_directory /
tmp
PHP Warning: PHP Startup: Unable to load dynamic library '/usr/lib/
php5/20060613+lfs/php_mcrypt.so' - /usr/lib/php5/20060613+lfs/
php_mcrypt.so: cannot open shared object file: No such file or
directory in Unknown on line 0
[ pid=26226 thr=3078883008 file=ext/apache2/Hooks.cpp:1319
time=2010-10-19 12:11:21.439 ]: Initializing Phusion Passenger...
[Tue Oct 19 12:11:21 2010] [notice] Apache configured -- resuming
normal operations
[ pid=26011 thr=3080795840 file=ext/common/LoggingAgent/
LoggingServer.h:824 time=2010-10-19 12:11:23.801 ]: Flushing all sinks
(periodic action)
[ pid=26007 thr=3075374000 file=ext/common/MessageServer.h:481
time=2010-10-19 12:11:24.10 ]: MessageServer client thread 9
interrupted.
[ pid=26225 thr=3083995360 file=ext/common/Watchdog.cpp:888
time=2010-10-19 12:11:29.27 ]: All Phusion Passenger agent processes
have exited.
[ pid=26238 thr=3080541888 file=ext/common/LoggingAgent/
LoggingServer.h:824 time=2010-10-19 12:11:36.523 ]: Flushing all sinks
(periodic action)

I have no idea what the above means and any help will be much
appreciated.

Thanks,
Oswald

[Hongli Lai]

On Tue, Oct 19, 2010 at 12:23 PM, Oswald Yang <oswald...@gmail.com> wrote:
> Hi All,
>
> USING:
> passenger-3.0.0
> rvm 1.0.14
> ruby 1.9.2p0
> rails 3.0.1
> apache 2.2.3-4+etch11
>
> I've recently started using Passenger along with RVM and Apache. Now
> I've installed it on 2 servers and it works like a dream, but on the
> 3rd server (installed on the exact same way as the previous two) when
> I browse to the Rails app it just hangs (browser says 'waiting for
> example.com') indefinitely. I've tried other versions of passenger as
> well, but to no avail. This is what I get when I restart Apache:

The restart message isn't so useful. Try setting PassengerLogLevel to
3 and post the logs that exist when the server is hanging.

--
Phusion | The Computer Science Company

Web: http://www.phusion.nl/
E-mail: in...@phusion.nl
Chamber of commerce no: 08173483 (The Netherlands)

[Oswald Yang]

Hey,

OK, so after restarting Apache and browse to the app (only the first
time) I get the following:

[ pid=4922 thr=3074485168 file=ext/common/ApplicationPool/Pool.h:894
time=2010-10-20 10:05:40.263 ]: Restarting /web/cv/html/rails/
capri_village
[ pid=4922 thr=3074485168 file=ext/common/ApplicationPool/Pool.h:927
time=2010-10-20 10:05:40.263 ]: Spawning a process for /web/cv/html/

rails/capri_village because there are none for this app group

[ pid=4922 thr=3074485168 file=ext/common/ApplicationPool/../
SpawnManager.h:291 time=2010-10-20 10:05:40.263 ]: Spawning a new
application process for /web/cv/html/rails/capri_village...
[ pid=4926 thr=3080701632 file=ext/common/LoggingAgent/LoggingServer.h:
824 time=2010-10-20 10:07:54.864 ]: Flushing all sinks (periodic
action)

The last line continues to get logged every minute or so. It also
spawns the following procs:

root 4920 4914 0 10:04 ? 00:00:00 PassengerWatchdog
root 4922 4920 0 10:04 ? 00:00:00 PassengerHelperAgent
root 4923 4922 0 10:04 ? 00:00:00 Passenger spawn
server
nobody 4926 4920 0 10:04 ? 00:00:00 PassengerLoggingAgent
root 5650 4923 0 10:05 ? 00:00:00 Passenger
ApplicationSpawner: /web/cv/html/rails/capri_village

I hope this info will be helpful.

Thanks,
Oswald


On Oct 19, 4:30 pm, Hongli Lai <hon...@phusion.nl> wrote:

> On Tue, Oct 19, 2010 at 12:23 PM, Oswald Yang <oswald.yo...@gmail.com> wrote:
> > Hi All,
>
> > USING:
> > passenger-3.0.0
> > rvm 1.0.14
> > ruby 1.9.2p0
> > rails 3.0.1
> > apache 2.2.3-4+etch11
>
> > I've recently started using Passenger along with RVM and Apache. Now
> > I've installed it on 2 servers and it works like a dream, but on the
> > 3rd server (installed on the exact same way as the previous two) when
> > I browse to the Rails app it just hangs (browser says 'waiting for
> > example.com') indefinitely. I've tried other versions of passenger as
> > well, but to no avail. This is what I get when I restart Apache:
>
> The restart message isn't so useful. Try setting PassengerLogLevel to
> 3 and post the logs that exist when the server is hanging.
>
> --
> Phusion | The Computer Science Company
>
> Web:http://www.phusion.nl/

> E-mail: i...@phusion.nl

[Hongli Lai]

This indicates that Phusion Passenger tried to spawn capri_village,
but that operation never finished. In other words, your application
capri_village froze during startup. Try fixing that.

--
Phusion | The Computer Science Company

Web: http://www.phusion.nl/
E-mail: in...@phusion.nl

[Oswald Yang]

Hey,

Thanks for the reply, any idea how I would go about trouble shooting
this? As that's the thing right, this exact app works on two other
servers (unfortunately not our main web servers) all with the exact
same rvm, rails and passenger versions installed. With that said
though the problem seems to be with the server setup and not Passenger
then. Perhaps it's time to persuade my boss that we need a dedicated
Rails server :)

Cheers,
Oswald

On Oct 21, 7:42 pm, Hongli Lai <hon...@phusion.nl> wrote:

> E-mail: i...@phusion.nl

[Hongli Lai]

On Fri, Oct 22, 2010 at 10:45 AM, Oswald Yang <oswald...@gmail.com> wrote:
> Hey,
>
> Thanks for the reply, any idea how I would go about trouble shooting
> this?

The way I'd do it is by by placing 'STDERR.puts' calls in various
places in the code to see where it freezes. Alternatively you can
attach the Ruby process to gdb and use the following command to have
it print the current backtrace to stderr:

p (void) rb_backtrace()

--
Phusion | The Computer Science Company

Web: http://www.phusion.nl/
E-mail: in...@phusion.nl