|
From: Charles P. <c.e...@da...> - 2008-07-14 00:03:25
|
I've installed version 3.2.3 of the Wrapper on my Ubuntu box (Hardy Heron - 8.04). I configured the wrapper to start my program "harmonium", then configured linux to start the service at boot (I symlinked in /etc/init.d, then ran update-rc.d). When I 'cd' to /etc/init.d and run: sudo ./harmonium console everything works as expected. I can run my program and all is well. If I just start the program with sudo ./harmonium start everything works as expected. The program happily rolls along until I do a 'stop'. If I reboot the machine, harmonium is started at boot as expected, but then it immediately stops. I don't know why. I'm hoping someone on here can give me some guidance. I'm including DEBUG level logs below. Thanks, Charlie ##### BEGIN LOG ##### DEBUG | wrapper | 2008/07/13 17:53:16 | Spawning intermediate process... DEBUG | wrapper | 2008/07/13 17:53:16 | Spawning daemon process... STATUS | wrapper | 2008/07/13 17:53:16 | --> Wrapper Started as Daemon DEBUG | wrapper | 2008/07/13 17:53:16 | Using tick timer. DEBUG | wrapperp | 2008/07/13 17:53:16 | server listening on port 32000. DEBUG | wrapper | 2008/07/13 17:53:17 | Command[0] : java DEBUG | wrapper | 2008/07/13 17:53:17 | Command[1] : -Djava.library.path=../lib DEBUG | wrapper | 2008/07/13 17:53:17 | Command[2] : -classpath DEBUG | wrapper | 2008/07/13 17:53:17 | Command[3] : ../lib/bananas.jar:../lib/hme.jar:../lib/commons-logging-1.1.1.jar:../lib/hme-hd-0.4.1.jar:../lib/wrapper.jar:../lib/hme-host-sample.jar:../lib/JID3.jar:../Harmonium.jar DEBUG | wrapper | 2008/07/13 17:53:17 | Command[4] : -Dwrapper.key=P6TgVO2G8iqqxuI1 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[5] : -Dwrapper.port=32000 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[6] : -Dwrapper.jvm.port.min=31000 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[7] : -Dwrapper.jvm.port.max=31999 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[8] : -Dwrapper.debug=TRUE DEBUG | wrapper | 2008/07/13 17:53:17 | Command[9] : -Dwrapper.pid=5902 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[10] : -Dwrapper.version=3.2.3 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[11] : -Dwrapper.native_library=wrapper DEBUG | wrapper | 2008/07/13 17:53:17 | Command[12] : -Dwrapper.service=TRUE DEBUG | wrapper | 2008/07/13 17:53:17 | Command[13] : -Dwrapper.cpu.timeout=10 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[14] : -Dwrapper.jvmid=1 DEBUG | wrapper | 2008/07/13 17:53:17 | Command[15] : org.tanukisoftware.wrapper.WrapperSimpleApp DEBUG | wrapper | 2008/07/13 17:53:17 | Command[16] : com.tivo.hme.host.sample.Main DEBUG | wrapper | 2008/07/13 17:53:17 | Command[17] : org.dazeend.harmonium.Harmonium DEBUG | wrapper | 2008/07/13 17:53:17 | Command[18] : -musicRoot DEBUG | wrapper | 2008/07/13 17:53:17 | Command[19] : /home/ceperry/Harmonium/test_data/music DEBUG | wrapper | 2008/07/13 17:53:17 | Command[20] : -playlistRoot DEBUG | wrapper | 2008/07/13 17:53:17 | Command[21] : /home/ceperry/Harmonium/test_data/playlists STATUS | wrapper | 2008/07/13 17:53:17 | Launching a JVM... INFO | jvm 1 | 2008/07/13 17:53:19 | WrapperManager class initialized by thread: main Using classloader: sun.misc.Launcher$AppClassLoader@1ba34f2 INFO | jvm 1 | 2008/07/13 17:53:21 | Wrapper (Version 3.2.3) http://wrapper.tanukisoftware.org INFO | jvm 1 | 2008/07/13 17:53:21 | Copyright 1999-2006 Tanuki Software, Inc. All Rights Reserved. INFO | jvm 1 | 2008/07/13 17:53:21 | INFO | jvm 1 | 2008/07/13 17:53:21 | Wrapper Manager: JVM #1 INFO | jvm 1 | 2008/07/13 17:53:21 | Running a 32-bit JVM. INFO | jvm 1 | 2008/07/13 17:53:21 | Wrapper Manager: Registering shutdown hook INFO | jvm 1 | 2008/07/13 17:53:21 | Wrapper Manager: Using wrapper INFO | jvm 1 | 2008/07/13 17:53:21 | Load native library. One or more attempts may fail if platform specific libraries do not exist. INFO | jvm 1 | 2008/07/13 17:53:21 | Loading native library failed: libwrapper-linux-x86-32.so Cause: java.lang.UnsatisfiedLinkError: no wrapper-linux-x86-32 in java.library.path INFO | jvm 1 | 2008/07/13 17:53:21 | Loaded native library: libwrapper.so INFO | jvm 1 | 2008/07/13 17:53:21 | Calling native initialization method. INFO | jvm 1 | 2008/07/13 17:53:21 | Inside native WrapperManager initialization method INFO | jvm 1 | 2008/07/13 17:53:21 | Java Version : 1.6.0_06-b02 Java HotSpot(TM) Server VM INFO | jvm 1 | 2008/07/13 17:53:21 | Java VM Vendor : Sun Microsystems Inc. INFO | jvm 1 | 2008/07/13 17:53:21 | INFO | jvm 1 | 2008/07/13 17:53:21 | Startup runner thread started. INFO | jvm 1 | 2008/07/13 17:53:21 | Control event monitor thread started. INFO | jvm 1 | 2008/07/13 17:53:21 | WrapperManager.start(org.tanukisoftware.wrapper.WrapperSimpleApp@17bd6a1, args["org.dazeend.harmonium.Harmonium", "-musicRoot", "/home/ceperry/Harmonium/test_data/music", "-playlistRoot", "/home/ceperry/Harmonium/test_data/playlists"]) called by thread: main INFO | jvm 1 | 2008/07/13 17:53:21 | Communications runner thread started. INFO | jvm 1 | 2008/07/13 17:53:21 | Open socket to wrapper...Wrapper-Connection INFO | jvm 1 | 2008/07/13 17:53:21 | Opened Socket from 31000 to 32000 INFO | jvm 1 | 2008/07/13 17:53:21 | Send a packet KEY : P6TgVO2G8iqqxuI1 INFO | jvm 1 | 2008/07/13 17:53:21 | handleSocket(Socket[addr=/127.0.0.1,port=32000,localport=31000]) DEBUG | wrapperp | 2008/07/13 17:53:21 | accepted a socket from 127.0.0.1 on port 31000 DEBUG | wrapperp | 2008/07/13 17:53:21 | read a packet KEY : P6TgVO2G8iqqxuI1 DEBUG | wrapper | 2008/07/13 17:53:21 | Got key from JVM: P6TgVO2G8iqqxuI1 DEBUG | wrapperp | 2008/07/13 17:53:21 | send a packet LOW_LOG_LEVEL : 1 DEBUG | wrapperp | 2008/07/13 17:53:21 | send a packet PING_TIMEOUT : 30 DEBUG | wrapperp | 2008/07/13 17:53:21 | send a packet PROPERTIES : (Property Values) DEBUG | wrapper | 2008/07/13 17:53:21 | Start Application. DEBUG | wrapperp | 2008/07/13 17:53:21 | send a packet START : start INFO | jvm 1 | 2008/07/13 17:53:21 | Received a packet LOW_LOG_LEVEL : 1 INFO | jvm 1 | 2008/07/13 17:53:21 | Wrapper Manager: LowLogLevel from Wrapper is 1 INFO | jvm 1 | 2008/07/13 17:53:21 | Received a packet PING_TIMEOUT : 30 INFO | jvm 1 | 2008/07/13 17:53:21 | PingTimeout from Wrapper is 30000 INFO | jvm 1 | 2008/07/13 17:53:21 | Received a packet PROPERTIES : (Property Values) INFO | jvm 1 | 2008/07/13 17:53:21 | Received a packet START : start INFO | jvm 1 | 2008/07/13 17:53:21 | calling WrapperListener.start() INFO | jvm 1 | 2008/07/13 17:53:21 | Waiting for WrapperListener.start runner thread to complete. INFO | jvm 1 | 2008/07/13 17:53:21 | WrapperListener.start runner thread started. INFO | jvm 1 | 2008/07/13 17:53:21 | WrapperSimpleApp: start(args) Will wait up to 2 seconds for the main method to complete. INFO | jvm 1 | 2008/07/13 17:53:21 | WrapperSimpleApp: invoking main method INFO | jvm 1 | 2008/07/13 17:53:21 | HME SDK 1.4 (TiVo, Inc.) INFO | jvm 1 | 2008/07/13 17:53:21 | Searching for music... INFO | jvm 1 | 2008/07/13 17:53:22 | Send a packet START_PENDING : 5000 DEBUG | wrapperp | 2008/07/13 17:53:22 | read a packet START_PENDING : 5000 DEBUG | wrapper | 2008/07/13 17:53:22 | JVM signalled a start pending with waitHint of 5000 millis. INFO | jvm 1 | 2008/07/13 17:53:23 | Send a packet START_PENDING : 5000 INFO | jvm 1 | 2008/07/13 17:53:23 | WrapperSimpleApp: start(args) end. Main Completed=false, exitCode=null INFO | jvm 1 | 2008/07/13 17:53:23 | WrapperListener.start runner thread stopped. INFO | jvm 1 | 2008/07/13 17:53:23 | returned from WrapperListener.start() INFO | jvm 1 | 2008/07/13 17:53:23 | Send a packet STARTED : INFO | jvm 1 | 2008/07/13 17:53:23 | Startup runner thread stopped. DEBUG | wrapperp | 2008/07/13 17:53:23 | read a packet START_PENDING : 5000 DEBUG | wrapper | 2008/07/13 17:53:23 | JVM signalled a start pending with waitHint of 5000 millis. DEBUG | wrapperp | 2008/07/13 17:53:23 | read a packet STARTED : DEBUG | wrapper | 2008/07/13 17:53:23 | JVM signalled that it was started. DEBUG | wrapperp | 2008/07/13 17:53:23 | send a packet PING : ping INFO | jvm 1 | 2008/07/13 17:53:23 | Received a packet PING : ping INFO | jvm 1 | 2008/07/13 17:53:23 | Send a packet PING : ok DEBUG | wrapperp | 2008/07/13 17:53:23 | read a packet PING : ok DEBUG | wrapper | 2008/07/13 17:53:23 | Got ping response from JVM DEBUG | wrapperp | 2008/07/13 17:53:27 | send a packet PING : ping INFO | jvm 1 | 2008/07/13 17:53:27 | Received a packet PING : ping INFO | jvm 1 | 2008/07/13 17:53:27 | Send a packet PING : ok DEBUG | wrapperp | 2008/07/13 17:53:27 | read a packet PING : ok DEBUG | wrapper | 2008/07/13 17:53:27 | Got ping response from JVM INFO | jvm 1 | 2008/07/13 17:53:27 | Searching for playlists... INFO | jvm 1 | 2008/07/13 17:53:27 | Build of music database completed INFO | jvm 1 | 2008/07/13 17:53:27 | LOG: added factory INFO | jvm 1 | 2008/07/13 17:53:27 | WrapperSimpleApp: main method completed INFO | jvm 1 | 2008/07/13 17:53:27 | Wrapper Manager: ShutdownHook started INFO | jvm 1 | 2008/07/13 17:53:27 | WrapperManager.stop(0) called by thread: Wrapper-Shutdown-Hook INFO | jvm 1 | 2008/07/13 17:53:27 | Send a packet STOP : 0 DEBUG | wrapperp | 2008/07/13 17:53:27 | read a packet STOP : 0 DEBUG | wrapper | 2008/07/13 17:53:27 | JVM requested a shutdown. (0) DEBUG | wrapper | 2008/07/13 17:53:27 | wrapperStopProcess(0) called. DEBUG | wrapper | 2008/07/13 17:53:27 | Sending stop signal to JVM DEBUG | wrapperp | 2008/07/13 17:53:27 | send a packet STOP : NULL INFO | jvm 1 | 2008/07/13 17:53:27 | Received a packet STOP : INFO | jvm 1 | 2008/07/13 17:53:28 | Thread, Wrapper-Shutdown-Hook, handling the shutdown process. INFO | jvm 1 | 2008/07/13 17:53:28 | calling listener.stop() INFO | jvm 1 | 2008/07/13 17:53:28 | WrapperSimpleApp: stop(0) INFO | jvm 1 | 2008/07/13 17:53:28 | returned from listener.stop() -> 0 INFO | jvm 1 | 2008/07/13 17:53:28 | shutdownJVM(0) Thread:Wrapper-Shutdown-Hook INFO | jvm 1 | 2008/07/13 17:53:28 | Send a packet STOPPED : 0 DEBUG | wrapperp | 2008/07/13 17:53:28 | read a packet STOPPED : 0 DEBUG | wrapper | 2008/07/13 17:53:28 | JVM signalled that it was stopped. INFO | jvm 1 | 2008/07/13 17:53:29 | Closing socket. DEBUG | wrapperp | 2008/07/13 17:53:29 | socket read no code (closed?). DEBUG | wrapperp | 2008/07/13 17:53:29 | server listening on port 32001. DEBUG | wrapper | 2008/07/13 17:53:29 | JVM exited normally. DEBUG | wrapper | 2008/07/13 17:53:29 | Signal trapped. Details: DEBUG | wrapper | 2008/07/13 17:53:29 | signal number=17 (SIGCHLD), source="unknown" DEBUG | wrapper | 2008/07/13 17:53:29 | Received SIGCHLD, checking JVM process status. DEBUG | wrapper | 2008/07/13 17:53:29 | JVM process exited with a code of 0, leaving the wrapper exit code set to 0. INFO | jvm 1 | 2008/07/13 17:53:29 | Wrapper Manager: ShutdownHook complete INFO | jvm 1 | 2008/07/13 17:53:29 | Server daemon shut down STATUS | wrapper | 2008/07/13 17:53:29 | <-- Wrapper Stopped |