[OPEN-ILS-DEV] Testing connections to Evergreen: osrfMethodException: No authentication seed found. open-ils.auth.authenticate.init must be called first
Nathan Eady
eady at galion.lib.oh.us
Tue Jun 23 18:08:59 EDT 2009
Okay, I've progressed somewhat...
I went back to the .example files and re-created the opensrf.xml and
opensrf_core.xml files. I saved the ones I had in a subdirectory, and
diff shows now difference in opensrf_core.xml, but for opensrf.xml it
does show some, so it's possible that I didn't follow those
instructions entirely correctly the first time.
I also followed some advice given in another thread about starting
things up one at a time:
********************************* begin paste
opensrf at thorin:/openils/conf$ ps -A | grep -i "srf"
opensrf at thorin:/openils/conf$
opensrf at thorin:/openils/conf$
opensrf at thorin:/openils/conf$ osrf_ctl.sh -l -a start_router
Starting OpenSRF Router
opensrf at thorin:/openils/conf$ sleep 90
opensrf at thorin:/openils/conf$ osrf_ctl.sh -l -a start_perl
Starting OpenSRF Perl
opensrf at thorin:/openils/conf$ sleep 90
opensrf at thorin:/openils/conf$ sleep 30
opensrf at thorin:/openils/conf$ osrf_ctl.sh -l -a start_c
Starting OpenSRF C (host=localhost)
opensrf at thorin:/openils/conf$
opensrf at thorin:/openils/conf$ sleep 30
opensrf at thorin:/openils/conf$
********************************* end paste
After doing these two things, not only can my test user get results
from the opensrf.math service, but also I get *something* back from
the login request, though it's not quite as expected:
********************************* begin paste
thorin:~# su testing
thorin:/root$ cd
thorin:~$ /openils/bin/srfsh
srfsh# request opensrf.math add 2 3
Received Data: 5
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.430114
------------------------------------
srfsh# exit
thorin:~$ cp public.srfsh.xml .srfsh.xml
thorin:~$ /openils/bin/srfsh
srfsh# request opensrf.math mult 2 7
Received Data: 14
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.056229
------------------------------------
srfsh# exit
thorin:~$ /openils/bin/srfsh
srfsh# login admin open-ils
Received Data: "291b6ef60fb6117f5bef705b83990b26"
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.366845
------------------------------------
********************************* suspend paste
[Here the output stopped coming for upwards of 20 seconds, and I sort
of panicked and starting trying to get some response from it, and then
tried to exit srfsh...]
********************************* resume paste
exit
^[[B
Received Exception:
Name: osrfMethodException
Status: No authentication seed found. open-ils.auth.authenticate.init must be called first
Status: 404
------------------------------------
Request Completed Successfully
Request Time in seconds: 60.127025
------------------------------------
Login Session: (none). Session timeout: 0.000000
srfsh#
srfsh# exit thorin:~$
thorin:~$
********************************* end paste
So I decided to try to repeat that...
********************************* begin paste
thorin:~$ /openils/bin/srfsh
srfsh# login admin open-ils
Received Data: "8b33c876291eee0d5b8d3ae4d6dda2de"
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.012525
------------------------------------
********************************* suspend paste
[Here again output froze, but this time I just waited it out...]
********************************* resume paste
Received Exception:
Name: osrfMethodException
Status: No authentication seed found. open-ils.auth.authenticate.init must be called first
Status: 404
------------------------------------
Request Completed Successfully
Request Time in seconds: 60.014660
------------------------------------
Login Session: (none). Session timeout: 0.000000
srfsh#
********************************* end paste
Okay, it's at least minimally repeatable, so how about we get a log of
just that:
********************************* begin paste
thorin:~$ cd log
thorin:~/log$ ls
private.srfsh.log public.srfsh.log
thorin:~/log$ mkdir old
thorin:~/log$ mv private.srfsh.log public.srfsh.log old/
thorin:~/log$ /openils/bin/srfsh
srfsh# login admin open-ils
Received Data: "fe6d2562537c520a83887706026ab973"
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.061777
------------------------------------
Received Exception:
Name: osrfMethodException
Status: No authentication seed found. open-ils.auth.authenticate.init must be called first
Status: 404
------------------------------------
Request Completed Successfully
Request Time in seconds: 60.014877
------------------------------------
Login Session: (none). Session timeout: 0.000000
srfsh# exit
thorin:~/log$ ls
old public.srfsh.log
thorin:~/log$ cat public.srfsh.log
srfsh 2009-07-23 15:37:40 [INFO:18212:osrf_system.c:415:] Bootstrapping system with domain public.lo
calhost, port 5222, and unixpath (none)
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:282:] open-ils.auth session is stateless
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:293:] Building a new client session with id [open-ils.auth] [1248377871.956789.124837787118212]
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:500:] AppSession connecting to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377871.956789.124837787118212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377871.956789.124837787118212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:51 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 83 bytes of data to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"0","locale":"en-US","type":"CONNECT"}}]
srfsh 2009-07-23 15:37:51 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 5
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:24:] Received message from transport code from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:51:] Transport handler received new message
from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694 to opensrf at public.localhost/_thorin_1248377860.676645_18212 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"0","locale":"en-US","type":"STATUS","payload":{"__c":"osrfConnectStatus","__p":{"status":"Connection Successful","statusCode":"200"}}}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:77:] Session [1248377871.956789.124837787118212] found or built
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:84:] We received 1 messages from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:160:] We connected successfully
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:162:] State: 8062fd8 => 1248377871.956789.124837787118212 => 1
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_stack.c:116:] Message processing duration 0.000100
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:119:] after msg delete
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:523:] * Connected Successfully to open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 184 bytes of data to opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"open-ils.auth.authenticate.init","params":["admin"]}}}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:426:] Pushing [1] onto request queue for session [open-ils.auth] [1248377871.956789.124837787118212]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:109:] In app_request receive with remaining time [120]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 120
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:24:] Received message from transport code from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:51:] Transport handler received new message
from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694 to opensrf at public.localhost/_thorin_1248377860.676645_18212 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"RESULT","payload":{"__c":"osrfResult","__p":{"status":"OK","statusCode":"200","content":"fe6d2562537c520a83887706026ab973"}}}},{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"STATUS","payload":{"__c":"osrfConnectStatus","__p":{"status":"Request Complete","statusCode":"205"}}}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:77:] Session [1248377871.956789.124837787118212] found or built
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:84:] We received 2 messages from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:136:] passing message 1 / session 1248377871.956789.124837787118212 to app handler
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:53:] App Session pushing request [1] onto request queue
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_stack.c:116:] Message processing duration 0.000116
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:119:] after msg delete
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:143:] app_request_recv received a message, returning it
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:109:] In app_request receive with remaining time [120]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:548:] AppSession disconnecting from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 86 bytes of data to opensrf at private.localhost/open-ils.auth_drone_thorin_1248376251.035281_13694
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"DISCONNECT"}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377871.956789.124837787118212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:649:] AppSession [open-ils.auth] [1248377871.956789.124837787118212] destroying self and deleting requests
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:282:] open-ils.auth session is stateless
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:293:] Building a new client session with id [open-ils.auth] [1248377872.223132.124837787218212]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:500:] AppSession connecting to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377872.223132.124837787218212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377872.223132.124837787218212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 83 bytes of data to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"0","locale":"en-US","type":"CONNECT"}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 5
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:24:] Received message from transport code from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:51:] Transport handler received new message
from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535 to opensrf at public.localhost/_thorin_1248377860.676645_18212 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"0","locale":"en-US","type":"STATUS","payload":{"__c":"osrfConnectStatus","__p":{"status":"Connection Successful","statusCode":"200"}}}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:77:] Session [1248377872.223132.124837787218212] found or built
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:84:] We received 1 messages from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:160:] We connected successfully
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:162:] State: 80633d0 => 1248377872.223132.124837787218212 => 1
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_stack.c:116:] Message processing duration 0.000099
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_stack.c:119:] after msg delete
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:523:] * Connected Successfully to open-ils.auth
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 261 bytes of data to opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"open-ils.auth.authenticate.complete","params":[{"username":"admin","password":"6b175876cc097c94df3d230c895fee1c","type":"opac"}]}}}}]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:426:] Pushing [1] onto request queue for session [open-ils.auth] [1248377872.223132.124837787218212]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:109:] In app_request receive with remaining time [120]
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:37:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 120
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:24:] Received message from transport code from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:51:] Transport handler received new message
from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535 to opensrf at public.localhost/_thorin_1248377860.676645_18212 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"STATUS","payload":{"__c":"osrfMethodException","__p":{"status":"No authentication seed found. open-ils.auth.authenticate.init must be called first","statusCode":"404"}}}}]
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:77:] Session [1248377872.223132.124837787218212] found or built
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:84:] We received 1 messages from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:38:52 [WARN:18212:osrf_stack.c:195:] The stack doesn't know what to do with the provided message code: 404, name osrfMethodException. Passing UP.
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:136:] passing message 1 / session 1248377872.223132.124837787218212 to app handler
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:53:] App Session pushing request [1] onto request queue
srfsh 2009-07-23 15:38:52 [INFO:18212:osrf_stack.c:116:] Message processing duration 0.000196
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_stack.c:119:] after msg delete
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:143:] app_request_recv received a message, returning it
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:109:] In app_request receive with remaining time [120]
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:548:] AppSession disconnecting from opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:639:] AppSession in queue_wait with timeout 0
srfsh 2009-07-23 15:38:52 [INFO:18212:osrf_app_session.c:608:] [open-ils.auth] sent 86 bytes of data to opensrf at private.localhost/open-ils.auth_drone_thorin_1248376576.169031_14535
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:611:] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"DISCONNECT"}}]
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:456:] App Session [open-ils.auth] [1248377872.223132.124837787218212] resetting remote id to router at public.localhost/open-ils.auth
srfsh 2009-07-23 15:38:52 [DEBG:18212:osrf_app_session.c:649:] AppSession [open-ils.auth] [1248377872.223132.124837787218212] destroying self and deleting requests
srfsh 2009-07-23 15:39:25 [DEBG:18212:socket_bundle.c:394:] removing socket 3
thorin:~/log$
********************************* end paste
So then, following the troubleshooting guide again, I went into
opensrf_core.xml and changed the loglevel from 3 to 4 in four places,
then...
(Some of the commands that follow took a significant amount of time to
respond; however, the testbed system that I am using is low-end 2005
hardware, with a desktop and web browser also running on it, so I'm
not greatly concerned about start/stop performance at this point.)
********************************* begin paste
opensrf at thorin:/root$ osrf_ctl.sh -l -a stop_all
Stopping OpenSRF C process 13675...
Stopping OpenSRF C process 13681...
Stopping OpenSRF C process 13683...
Stopping OpenSRF C process 13685...
Stopping OpenSRF Perl
Stopping OpenSRF Router process 13456...
opensrf at thorin:/root$ ps -A | grep -i "srf"
13457 ? 00:00:00 opensrf_router
13500 ? 00:00:00 opensrf-perl.pl
13502 ? 00:00:00 opensrf-perl.pl
13503 ? 00:00:00 opensrf-perl.pl
13505 ? 00:00:00 opensrf-perl.pl <defunct>
13506 ? 00:00:00 opensrf-perl.pl <defunct>
13507 ? 00:00:00 opensrf-perl.pl <defunct>
13508 ? 00:00:00 opensrf-perl.pl <defunct>
13509 ? 00:00:00 opensrf-perl.pl <defunct>
13510 ? 00:00:00 opensrf-perl.pl
13512 ? 00:00:00 opensrf-perl.pl
13514 ? 00:00:02 opensrf-perl.pl
13515 ? 00:00:00 opensrf-perl.pl
13516 ? 00:00:01 opensrf-perl.pl
13518 ? 00:00:00 opensrf-perl.pl
13519 ? 00:00:00 opensrf-perl.pl
13520 ? 00:00:00 opensrf-perl.pl
13522 ? 00:00:02 opensrf-perl.pl
13524 ? 00:00:00 opensrf-perl.pl
13525 ? 00:00:00 opensrf-perl.pl
13527 ? 00:00:02 opensrf-perl.pl
13528 ? 00:00:00 opensrf-perl.pl
13529 ? 00:00:02 opensrf-perl.pl
13531 ? 00:00:00 opensrf-perl.pl
13532 ? 00:00:00 opensrf-perl.pl
13533 ? 00:00:00 opensrf-perl.pl
13534 ? 00:00:25 opensrf-perl.pl
13536 ? 00:00:00 opensrf-perl.pl
13537 ? 00:00:00 opensrf-perl.pl
13539 ? 00:00:02 opensrf-perl.pl
13540 ? 00:00:00 opensrf-perl.pl
13542 ? 00:00:00 opensrf-perl.pl
13543 ? 00:00:00 opensrf-perl.pl
13544 ? 00:00:02 opensrf-perl.pl
13545 ? 00:00:02 opensrf-perl.pl
13547 ? 00:00:00 opensrf-perl.pl
13548 ? 00:00:00 opensrf-perl.pl
13549 ? 00:00:00 opensrf-perl.pl
13550 ? 00:00:02 opensrf-perl.pl
13552 ? 00:00:00 opensrf-perl.pl
13553 ? 00:00:00 opensrf-perl.pl
13555 ? 00:00:02 opensrf-perl.pl
13556 ? 00:00:00 opensrf-perl.pl
13557 ? 00:00:02 opensrf-perl.pl
13558 ? 00:00:00 opensrf-perl.pl
13560 ? 00:00:00 opensrf-perl.pl
13561 ? 00:00:02 opensrf-perl.pl
13562 ? 00:00:00 opensrf-perl.pl
13583 ? 00:00:00 opensrf-perl.pl
13584 ? 00:00:00 opensrf-perl.pl
13585 ? 00:00:00 opensrf-perl.pl
13586 ? 00:00:00 opensrf-perl.pl
13587 ? 00:00:00 opensrf-perl.pl
13588 ? 00:00:00 opensrf-perl.pl
13589 ? 00:00:00 opensrf-perl.pl
13590 ? 00:00:00 opensrf-perl.pl
13599 ? 00:00:00 opensrf-perl.pl
13617 ? 00:00:00 opensrf-perl.pl
13618 ? 00:00:00 opensrf-perl.pl
13619 ? 00:00:00 opensrf-perl.pl
13620 ? 00:00:00 opensrf-perl.pl
13621 ? 00:00:00 opensrf-perl.pl
13622 ? 00:00:00 opensrf-perl.pl <defunct>
13627 ? 00:00:00 opensrf-perl.pl <defunct>
13628 ? 00:00:00 opensrf-perl.pl
13629 ? 00:00:00 opensrf-perl.pl
13630 ? 00:00:00 opensrf-perl.pl <defunct>
13643 ? 00:00:00 opensrf-perl.pl
13651 ? 00:00:00 opensrf-perl.pl
13654 ? 00:00:00 opensrf-perl.pl
13656 ? 00:00:00 opensrf-perl.pl
13665 ? 00:00:00 opensrf-perl.pl
opensrf at thorin:/root$ osrf_ctl.sh -l -a stop_all
OpenSRF C not running
Stopping OpenSRF Perl
* opensrf.settings not running
* open-ils.cat not running
* open-ils.supercat not running
* open-ils.search not running
* open-ils.circ not running
* open-ils.actor not running
* open-ils.storage not running
* open-ils.penalty not running
* open-ils.collections not running
* open-ils.ingest not running
* open-ils.reporter not running
* open-ils.permacrud not running
* open-ils.fielder not running
* open-ils.vandelay not running
OpenSRF Router not running
opensrf at thorin:/root$ ps -A | grep -i "srf"
13457 ? 00:00:00 opensrf_router
opensrf at thorin:/root$ osrf_ctl.sh -l -a stop_all
OpenSRF C not running
Stopping OpenSRF Perl
* opensrf.settings not running
* open-ils.cat not running
* open-ils.supercat not running
* open-ils.search not running
* open-ils.circ not running
* open-ils.actor not running
* open-ils.storage not running
* open-ils.penalty not running
* open-ils.collections not running
* open-ils.ingest not running
* open-ils.reporter not running
* open-ils.permacrud not running
* open-ils.fielder not running
* open-ils.vandelay not running
OpenSRF Router not running
opensrf at thorin:/root$ ps -A | grep -i "srf"
13457 ? 00:00:00 opensrf_router
opensrf at thorin:/root$ kill 13457
opensrf at thorin:/root$ ps -A | grep -i "srf"
opensrf at thorin:/root$ ls /openils/var/log/*rout*
/openils/var/log/router-private.log /openils/var/log/router-public.log
opensrf at thorin:/root$ grep ERR /openils/var/log/*router*.log
opensrf at thorin:/root$ ps -aef | grep Router
opensrf 19818 1 0 16:01 ? 00:00:00 OpenSRF Router
opensrf 19819 1 0 16:01 ? 00:00:00 OpenSRF Router
opensrf 19937 19414 0 16:05 pts/1 00:00:00 grep Router
opensrf at thorin:/root$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a start_perl
Starting OpenSRF Perl
opensrf at thorin:/root$
********************************* suspend paste
I note that the troubleshooting guide claims I should get more output
than this with EG 1.4 and later, but the version I installed is
1.4.0.4, and that's all the output I get. Huh. Shall we try that
again? (Bear in mind, I didn't stop it first...)
********************************* resume paste
Starting OpenSRF Perl
* opensrf.settings is already running
* open-ils.cat is already running
* open-ils.supercat is already running
* open-ils.search is already running
* open-ils.circ is already running
* open-ils.actor is already running
* open-ils.storage is already running
* open-ils.penalty is already running
* open-ils.collections is already running
* open-ils.ingest is already running
* open-ils.reporter is already running
* open-ils.permacrud is already running
* open-ils.fielder is already running
* open-ils.vandelay is already running
********************************* end paste
Well, that looks more likely to be correct. Let's stop it and try...
********************************* begin paste
opensrf at thorin:/root$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a stop_perl
Stopping OpenSRF Perl
opensrf at thorin:/root$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a stop_perl
^[[A^[[B
Stopping OpenSRF Perl
Use of uninitialized value $@ in concatenation (.) or string at /usr/local/share/perl/5.10.0/OpenSRF/Transport/SlimJabber/Client.pm line 153.
Exception: OpenSRF::EX::Jabber 2009-07-23T17:36:25 OpenSRF::Transport::SlimJabber::Client /usr/local/share/perl/5.10.0/OpenSRF/Transport/SlimJabber/Client.pm:153 Jabber Exception: Could not authenticate with Jabber server:
opensrf at thorin:/root$
opensrf at thorin:/root$ ps -A | grep -i "srf-perl"
opensrf at thorin:/root$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a start_perl
Starting OpenSRF Perl
opensrf at thorin:/root$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a start_perl
Starting OpenSRF Perl
* opensrf.settings is already running
* open-ils.cat is already running
* open-ils.supercat is already running
* open-ils.search is already running
* open-ils.circ is already running
* open-ils.actor is already running
* open-ils.storage is already running
* open-ils.penalty is already running
* open-ils.collections is already running
* open-ils.ingest is already running
* open-ils.reporter is already running
* open-ils.permacrud is already running
* open-ils.fielder is already running
* open-ils.vandelay is already running
opensrf at thorin:/root$
********************************* end paste
Well, at least it's consistent. Okay, so just in case anyone wants to
look over the logfiles, let's tar them up...
********************************* begin paste
opensrf at thorin:/root$ cd
opensrf at thorin:~$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a stop_all
OpenSRF C not running
Stopping OpenSRF Perl
Stopping OpenSRF Router process 19818...
opensrf at thorin:~$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a stop_all
OpenSRF C not running
Stopping OpenSRF Perl
Use of uninitialized value $@ in concatenation (.) or string at /usr/local/share/perl/5.10.0/OpenSRF/Transport/SlimJabber/Client.pm line 153.
Exception: OpenSRF::EX::Jabber 2009-07-23T17:58:58 OpenSRF::Transport::SlimJabber::Client /usr/local/share/perl/5.10.0/OpenSRF/Transport/SlimJabber/Client.pm:153 Jabber Exception: Could not authenticate with Jabber server:
OpenSRF Router not running
opensrf at thorin:~$ ps -A | grep -i "srf-perl"
29627 ? 00:00:07 opensrf-perl.pl
30253 ? 00:00:00 opensrf-perl.pl <defunct>
opensrf at thorin:~$ /openils/bin/osrf_ctl.sh -c /openils/conf/opensrf_core.xml -l -a stop_all
OpenSRF C not running
Stopping OpenSRF Perl
* opensrf.settings not running
* open-ils.cat not running
* open-ils.supercat not running
* open-ils.search not running
* open-ils.circ not running
* open-ils.actor not running
* open-ils.storage not running
* open-ils.penalty not running
* open-ils.collections not running
* open-ils.ingest not running
* open-ils.reporter not running
* open-ils.permacrud not running
* open-ils.fielder not running
* open-ils.vandelay not running
OpenSRF Router not running
opensrf at thorin:~$ ps -A | grep -i "srf-perl"
opensrf at thorin:~$ tar -cjvf temp.tar.bz2 /openils/var/log/router*.log /openils/var/log/osrfsys.log /openils/conf/opensrf.xml /openils/conf/opensrf_core.xml
tar: Removing leading `/' from member names
/openils/var/log/router-private.log
/openils/var/log/router-public.log
/openils/var/log/osrfsys.log
/openils/conf/opensrf.xml
/openils/conf/opensrf_core.xml
opensrf at thorin:~$ scp temp.tar.bz2 root at cgi.galion.lib.oh.us:/var/www/staff/galion-openils-attempt-1.tar.bz2
The authenticity of host 'cgi.galion.lib.oh.us (10.0.2.5)' can't be established.
RSA key fingerprint is 48:e1:a9:75:df:b5:a2:ad:40:58:2c:b1:d9:9b:c8:db.
Are you sure you want to continue connecting (yes/no)? yes
Warning: Permanently added 'cgi.galion.lib.oh.us,10.0.2.5' (RSA) to the list of known hosts.
Password:
temp.tar.bz2 100% 216KB 215.9KB/s 00:00
opensrf at thorin:~$
********************************* end paste
That tarball is available here:
http://cgi.galion.lib.oh.us/staff/galion-openils-attempt-1.tar.bz2
(Don't worry about the passwords. I'll just pick new ones later,
using a different generation pattern. One of my superpowers is the
ability to think up new passwords easily.)
So, umm, any ideas?
--
Nathan Eady
Galion Public Library
More information about the Open-ils-dev
mailing list