[OPEN-ILS-DEV] problems running opensrf-c
Josh Stompro
stomproj at larl.org
Tue May 23 10:32:40 EDT 2006
Thank you Bill, that really did the trick. I also had a typo in my
hosts file that wasn't helping the problem at all either. Everything
looks to be running nicely now. The srfsh math_bench test ran with no
problems. I added a note to the openils.xml setup page about editing
the <host> entry, I didn't see anything there about it.
Josh
Bill Erickson wrote:
> Josh
>
> It looks the setting server is not getting loaded correctly. The
> error "Use of uninitialized value in string eq at
> /openils/lib/perl5/OpenSRF/System.pm line 155" indicates that the host
> has no Perl apps configured in the settings config ( openils.xml).
> The XML node within which the host settings for a given host reside
> must match the output from the "hostname -f" command (typically the
> fully qualified domain name).
>
> E.g.
> < app07.dev.gapines.org <http://app07.dev.gapines.org>>
> <activeapps>
> <appname>opensrf.math</appname>
> <appname>opensrf.dbmath</appname>
> <appname>opensrf.settings</appname>
> </activeapps>
> </app07.dev.gapines.org>
>
> Also, the "opensrf.settings" application must be configured to run.
> Another thing to check is that the bootstrap.conf file lists
> /path/to/openils.xml as the settings_config file. Once the settings
> server is running, the C code should be happier.
>
> -bill
>
> On 5/23/06, *Josh Stompro* <stomproj at larl.org
> <mailto:stomproj at larl.org>> wrote:
>
> I am having trouble with opensrf-c segfaulting after about a minute.
> First I started the system with the opensrf_all start command which
> gives this output.
>
> >>>>>
> debiantest1:/openils/bin$ ./opensrf_all start
> Starting Chop Chop, Jabber (jserver-c)...
> Attempting to launch ChopChop with:
> domain: 127.0.0.1 <http://127.0.0.1>
> port: 5222
> listen address: 127.0.0.1 <http://127.0.0.1>
> log level: 3
> log file: syslog
> Chop Chop started OK
> Starting router...
> Router started OK
> Starting OpenSRF...
> Use of uninitialized value in string eq at
> /openils/lib/perl5/OpenSRF/System.pm line 155.
>
> --- PS ---
> 24473 pts/1 S 0:01 OpenSRF System
> 24469 ? Ss 0:00 OpenSRF Router
> --- PS ---
>
> OpenSRF System is running
>
> Starting OpenSRF-C...
> Loading OpenSRF host debiantest.larl.org
> <http://debiantest.larl.org> with bootstrap config
> /openils/conf//opensrf_core.xml and config context opensrf
> ./opensrf_all: line 89: 24490 Segmentation fault
> "$BINDIR/opensrf-c" $(hostname -f) "$ETCDIR//opensrf_core.xml"
> "opensrf"
> OpenSRF-C started OK
> OpenSRF started OK
> >>>>>
>
> Then I tried running just opensrf-c
> >>>>>
> debiantest1:/openils/bin$ ./opensrf-c 127.0.0.1 <http://127.0.0.1>
> ../conf/opensrf_core.xml
> "opensrf"
> Loading OpenSRF host 127.0.0.1 <http://127.0.0.1> with bootstrap
> config
> ../conf/opensrf_core.xml and config context opensrf
> Segmentation fault
> >>>>>
>
> These are the log files from running just opensrf-c.
>
> >>>>> From osrfsys.log
> opensrf 2006-05-23 08:32:05 [INFO:24506:osrf_system.c:190]
> Bootstrapping
> system with domain 127.0.0.1 <http://127.0.0.1>, port 5222, and
> unixpath (null)
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:46] Adding
> socket node with fd 3
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:472] 1 active
> sockets after select()
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:641] 24506 :
> Received data at 1148391125.265216
>
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:644] Socket 3
> Read 183 bytes and data: <?xml version=' 1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client'
> from='127.0.0.1 <http://127.0.0.1>' version='1.0'
> id='ae5ffe593536e646726d368da92e82b891ddfe32'>
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:472] 1 active
> sockets after select()
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:641] 24506 :
> Received data at 1148391125.272869
>
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:644] Socket 3
> Read 57 bytes and data: <iq xmlns='jabber:client' id='0123456789'
> type='result'/>
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:230]
> opensrf.settings session is stateless
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:242]
> Building
> a new client session with id [opensrf.settings]
> [1148391125.275433.114839112524506]
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:554]
> AppSession in queue_wait with timeout 0
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:472] 0 active
> sockets after select()
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:641] 24506 :
> Received data at 1148391125.278778
>
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:377] App
> Session [ opensrf.settings] [1148391125.275433.114839112524506]
> resetting
> remote id to router at 127.0.0.1/opensrf.settings
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:521]
> Session
> [opensrf.settings] [1148391125.275433.114839112524506 ] sending to
> router at 127.0.0.1/opensrf.settings
> Data: [/*--S
> osrfMessage--*/{"threadTrace":"1","type":"REQUEST","payload":/*--S
> osrfMethod--*/{"method":"
> opensrf.settings.host_config.get","params":["127.0.0.1
> <http://127.0.0.1>"]}/*--E
> osrfMethod--*/}/*--E osrfMessage--*/]
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:347]
> Pushing
> [1] onto requeust queue for session [opensrf.settings]
> [1148391125.275433.114839112524506]
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:119] In
> app_request receive with remaining time [60]
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:554]
> AppSession in queue_wait with timeout 0
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:472] 0 active
> sockets after select()
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:641] 24506 :
> Received data at 1148391125.292866
>
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:644] Socket 3
> Read 270 bytes and data: <message xmlns='jabber:client' type='error'
> from='router at 127.0.0.1/opensrf.settings'
> to=' client at 127.0.0.1/settings_grabber__24506'><error type='cancel'
> code='404'><item-not-found
> xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error><body>NOT ADDING
> BODY</body></message>
> opensrf 2006-05-23 08:32:05 [INFO:24506:transport_session.c:401]
> Received <error> message with type cancel and code 404
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_stack.c:15] Received
> message from transport code from router at 127.0.0.1/opensrf.settings
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_stack.c:32] Transport
> handler received new message
> from router at 127.0.0.1/opensrf.settings to
> client at 127.0.0.1/settings_grabber__24506 with body
>
> NOT ADDING BODY
>
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:472] 0 active
> sockets after select()
> opensrf 2006-05-23 08:32:05 [INT :24506:socket_bundle.c:641] 24506 :
> Received data at 1148391125.296864
>
> opensrf 2006-05-23 08:32:05 [DEBG:24506:osrf_app_session.c:554]
> AppSession in queue_wait with timeout 60
> >>>>>
>
>
> >>>>> From syslog
> May 23 08:32:05 localhost chochop: [INFO:24466:osrf_chat.c:719]
> client at 127.0.0.1/settings_grabber__24506 successfully logged in
> May 23 08:32:05 localhost chochop: [INFO:24466:osrf_chat.c:278]
> Sending
> message on local connection from:
> client at 127.0.0.1/settings_grabber__24506 to:
> router at 127.0.0.1/opensrf.settings
> May 23 08:32:05 localhost chochop: [INFO:24466:osrf_chat.c:304] We
> have
> no connection for router at 127.0.0.1/opensrf.settings
> >>>>>>
>
> >>>>> When I do a strace on opensrf-c, this is what it looks like
> when
> it is pausing, before it crashes. It looks like it is waiting for a
> message.
> open("/openils/var/log/osrfsys.log", O_WRONLY|O_APPEND|O_CREAT,
> 0666) = 4
> fstat64(4, {st_mode=S_IFREG|0644, st_size=60039, ...}) = 0
> mmap2(NULL, 131072, PROT_READ|PROT_WRITE,
> MAP_PRIVATE|MAP_ANONYMOUS, -1,
> 0) = 0x4030f000
> fstat64(4, {st_mode=S_IFREG|0644, st_size=60039, ...}) = 0
> _llseek(4, 60039, [60039], SEEK_SET) = 0
> write(4, "opensrf 2006-05-23 08:38:20 [DEB"..., 105) = 105
> close(4) = 0
> munmap(0x4030f000, 131072) = 0
> time(NULL) = 1148391500
> select(4, [3], NULL, NULL, {60, 0} <<<<<<< Waiting for select to
> return, for 60 seconds.
> >>>>>>>
>
>
> >>>>>> opensrf section from opensrf_core.xml
> <opensrf> <!-- bootstrap config for the C apps -->
> <router_name>router</router_name>
> <routers>
> <router>127.0.0.1 <http://127.0.0.1></router>
> </routers>
> <domains>
> <domain>127.0.0.1 <http://127.0.0.1></domain>
> </domains>
> <username>client</username>
> <passwd>mypass</passwd>
> <port>5222</port>
> <logfile>/openils/var/log/osrfsys.log</logfile>
> <loglevel>5</loglevel>
> </opensrf>
> >>>>>>
>
> Let me know what other info might be usefull.
>
>
>
>
>
> --
> Bill Erickson
> PINES Systems Developer
> Georgia Public Library Service
> billserickson at gmail.com <mailto:billserickson at gmail.com>
> http://open-ils.org
--
--
Lake Agassiz Regional Library - Moorhead MN larl.org
Josh Stompro | Office 218.233.3757 EXT-139
LARL Network Administrator | Mobile 701.371.3857
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://libmail.georgialibraries.org/pipermail/open-ils-dev/attachments/20060523/a2f2ed6d/attachment-0001.html
More information about the Open-ils-dev
mailing list