[OPEN-ILS-DEV] Trying out staff client with new install (long)

Tue May 23 15:10:33 EDT 2006

Short answer -

Check the storage_unix.log, or any of the *unix* logs (usually found in
/openils/var/log/) for errors.  Sometimes you'll get errors there that show
up nowhere else.  If you find anything useful, let us know.

-bill

On 5/23/06, Josh Stompro <stomproj at larl.org> wrote:
>
> I think I am up to the same point that Don McMorris was at back at the
> end of March.  I am attempting to connect to the server with the staff
> client.  I setup the server to accept the beta.02 build id and the test
> server function of the staff client seems to work ok, Status is 200 : OK
> and Version is 200 : OK.
>
> When I try and log in with admin/open-ils the staff client sends this to
> the server.
>
> POST /gateway HTTP/1.1
> service=
> open-ils.auth&method=open-ils.auth.authenticate.init&param=%22admin%22
>
> And the server responds with
> HTTP/1.1 200 OK
> {"payload":["3f8c0fa178b1e77b93d1c77286cd69cc"], "status":200}
>
> Then the client sends
> service=
> open-ils.auth&method=open-ils.auth.authenticate.complete&param=%7B%22username%22%3A%22admin%22%2C%22password%22%3A%22a6f8d41ac7868a5cbad6ddffd6ddec6a%22%2C%22type%22%3A%22temp%22%7D
>
> The server doesn't respond for about 60 seconds and then sends back
> {"payload" : [], "status":200}
>
> And the client hangs until it pops up a box with "Network failure.
> Please check your Internet connection to undefined and choose Retry
> Network, ... etc... give them this message
> "open-ils.auth.authenticate.complete".
>
>
> I'm wondering how I can debug the auth service?  I can see that it is
> running,
> debiantest1:~# ps aux |grep auth
> opensrf  28533  0.0  0.5   3656  1472 pts/1    S    12:29   0:00 OpenSRF
> Listener [open-ils.auth]
> opensrf  28542  0.0  0.6   3920  1704 pts/1    S    12:29   0:00 OpenSRF
> Drone [open-ils.auth]
> ....
>
> But there is no log file in /openils/var/log/ for the auth service like
> there is for all the others.
> And there is no pid file in /openils/var/pid like there is for
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 open-ils.actor_unix.pid
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 open-ils.cat_unix.pid
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 open-ils.circ_unix.pid
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 open-ils.penalty_unix.pid
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 open-ils.search_unix.pid
> -rw-r--r-- 1 opensrf opensrf 6 2006-05-23 10:46 opoensrf.settings_unix.pid
>
> And dito with the unix sockets.
>
>
> I see these error messages in the terminal where I ran opensrv_all start.
> [NOTICE at 1148408854.437340] mcm_server_connect():2302: Software caused
> connection abort
> [NOTICE at 1148408854.438902] mcm_server_connect_next_avail():2333:
> Software caused connection abort
> [WARN at 1148408854.438921] mcm_server_connect_next_avail():2338
> [NOTICE at 1148409734.895610] mcm_server_connect_next_avail():2328
>
> The posgres database is not being queried, could the problem be with
> open-ils.storage
>
> >>>> from osrfsys.log
> open-ils.auth 2006-05-23 13:49:53 [DEBG:28545:osrf_app_session.c:554]
> AppSession in queue_wait with timeout 60
> open-ils.auth 2006-05-23 13:49:53 [INT :28545:socket_bundle.c:472] 1
> active sockets after select()
> open-ils.auth 2006-05-23 13:49:53 [INT :28545:socket_bundle.c:641] 28545
> : Received data at 1148410193.311210
>
> open-ils.auth 2006-05-23 13:49:53 [INT :28545:socket_bundle.c:644]
> Socket 17 Read 486 bytes and data: <message
> to="client at 127.0.0.1/open-ils.auth_drone__28545"
> from="router at 127.0.0.1/open-ils.storage" router_from="" router_to=""
> router_class="" router_command=""><error type="cancel"
> code="501"/><thread>1148410193.296929.114841019328545</thread><body>[/*--S
> osrfMessage--*/{"threadTrace":"1","type":"REQUEST","payload":/*--S
> osrfMethod--*/{"method":"
> open-ils.storage.direct.actor.user.search.usrname.atomic
> ","params":["admin"]}/*--E
> osrfMethod--*/}/*--E osrfMessage--*/]</body></message>
> open-ils.auth 2006-05-23 13:49:53 [INFO:28545:transport_session.c:401]
> Received <error> message with type cancel and code 501
> open-ils.auth 2006-05-23 13:49:53 [DEBG:28545:osrf_stack.c:15] Received
> message from transport code from router at 127.0.0.1/open-ils.storage
> open-ils.auth 2006-05-23 13:49:53 [DEBG:28545:osrf_stack.c:32] Transport
> handler received new message
> from router at 127.0.0.1/open-ils.storage to
> client at 127.0.0.1/open-ils.auth_drone__28545 with body
>
> [/*--S
> osrfMessage--*/{"threadTrace":"1","type":"REQUEST","payload":/*--S
> osrfMethod--*/{"method":"
> open-ils.storage.direct.actor.user.search.usrname.atomic
> ","params":["admin"]}/*--E
> osrfMethod--*/}/*--E osrfMessage--*/]
>
> open-ils.auth 2006-05-23 13:49:53 [DEBG:28545:osrf_stack.c:62] We
> received 1 messages from router at 127.0.0.1/open-ils.storage
> open-ils.auth 2006-05-23 13:49:53 [WARN:28545:osrf_stack.c:71]  !!!
> Received Jabber layer error message
> open-ils.auth 2006-05-23 13:49:53 [WARN:28545:osrf_stack.c:81]  * Jabber
> Error is for top level remote id [router at 127.0.0.1/open-ils.storage], no
> one to send my message too!!!
> open-ils.auth 2006-05-23 13:49:53 [DEBG:28545:osrf_stack.c:90] after msg
> delete
> open-ils.auth 2006-05-23 13:49:53 [INT :28545:socket_bundle.c:472] 0
> active sockets after select()
> open-ils.auth 2006-05-23 13:49:53 [INT :28545:socket_bundle.c:641] 28545
> : Received data at 1148410193.315189
> >>>>>>
>
> Any ideas on what I should try next?
> Thanks
> Josh
>
>
>
>

-- 
Bill Erickson
PINES Systems Developer
Georgia Public Library Service
billserickson at gmail.com
http://open-ils.org
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://libmail.georgialibraries.org/pipermail/open-ils-dev/attachments/20060523/b910bb9f/attachment.html