[OPEN-ILS-DEV] So very close--but no response
Steven Owley
steveno at ohionet.org
Wed Nov 12 11:47:03 EST 2008
Hello everyone and thanks for any help you might be.
I have set up 1.2.3.1 on Debian, using the on-line directions.
Settings-tester.pl runs wihout error, except for a message about
"/usr/local/lib/dbd/libdbdpgsql.so
was not linked against libdbi - you probably need to compile
libdbi-drivers from source with the --enable-libdbi configure switch."
However, when I attempt "login admin open-ils" in the srfsh shell, I
get this after it times out:
Received Data: "1a05f27059a1be6f53484e57afebd1d7"
------------------------------------
Request Completed Successfully
Request Time in seconds: 0.009853
------------------------------------
Received no data from server
------------------------------------
Request Time in seconds: 120.009415
------------------------------------
Login Session: (null). Session timeout: 0.000000
I know that some minor setting has been overlooked, and thanks very
much if you can help me track it down.
Steve
Here is the log of such a session:
srfsh 2008-11-12 11:29:00 [INFO:4988:osrf_system.c:267:] Bootstrapping
system with domain localhost, port 5222, and unixpath (none)
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:222:]
open-ils.auth session is stateless
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:234:] Building
a new client session with id [open-ils.auth]
[1226507351.607858.12265073514988]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:418:]
AppSession connecting to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.607858.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.607858.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 80 bytes of data to
router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"0","type":"CONNECT"}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 5
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:17:] Received
message from transport code from
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:43:] Transport
handler received new message
from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757 to
opensrf at localhost/__1226507340.671373_4988 with body
[/*--S osrfMessage--*/{"threadTrace":"0","type":"STATUS","payload":/*--S
osrfConnectStatus--*/{"status":"Connection
Successful","statusCode":"200"}/*--E osrfConnectStatus--*/}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:66:] Session
[1226507351.607858.12265073514988] found or built
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:73:] We received 1
messages from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:147:] We connected
successfully
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:149:] State: 805d9c8
=> 1226507351.607858.12265073514988 => 1
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_stack.c:103:] Message
processing duration 0.000083
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:106:] after msg delete
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:437:] *
Connected Successfully to open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 194 bytes of data to
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"1","type":"REQUEST","payload":/*--S
osrfMethod--*/{"method":"open-ils.auth.authenticate.init","params":["admin"]}/*--E
osrfMethod--*/}/*--E osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:344:] Pushing
[1] onto requeust queue for session [open-ils.auth]
[1226507351.607858.12265073514988]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:104:] In
app_request receive with remaining time [120]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 120
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:17:] Received
message from transport code from
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:43:] Transport
handler received new message
from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757 to
opensrf at localhost/__1226507340.671373_4988 with body
[/*--S osrfMessage--*/{"threadTrace":"1","type":"RESULT","payload":/*--S
osrfResult--*/{"status":"OK","statusCode":"200","content":"1a05f27059a1be6f53484e57afebd1d7"}/*--E
osrfResult--*/}/*--E osrfMessage--*/,/*--S
osrfMessage--*/{"threadTrace":"1","type":"STATUS","payload":/*--S
osrfConnectStatus--*/{"status":"Request
Complete","statusCode":"205"}/*--E osrfConnectStatus--*/}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:66:] Session
[1226507351.607858.12265073514988] found or built
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:73:] We received 2
messages from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:123:] passing
message 1 / session 1226507351.607858.12265073514988 to app handler
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:48:] App
Session pushing request [1] onto request queue
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_stack.c:103:] Message
processing duration 0.000100
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:106:] after msg delete
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:124:]
app_request_recv received a message, returning it
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:104:] In
app_request receive with remaining time [120]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:462:]
AppSession disconnecting from
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 83 bytes of data to
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"1","type":"DISCONNECT"}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.607858.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:570:]
AppSession [open-ils.auth] [1226507351.607858.12265073514988]
destroying self and deleting requests
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:222:]
open-ils.auth session is stateless
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:234:] Building
a new client session with id [open-ils.auth]
[1226507351.625770.12265073514988]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:418:]
AppSession connecting to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.625770.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.625770.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 80 bytes of data to
router at localhost/open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"0","type":"CONNECT"}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 5
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:17:] Received
message from transport code from
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:43:] Transport
handler received new message
from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757 to
opensrf at localhost/__1226507340.671373_4988 with body
[/*--S osrfMessage--*/{"threadTrace":"0","type":"STATUS","payload":/*--S
osrfConnectStatus--*/{"status":"Connection
Successful","statusCode":"200"}/*--E osrfConnectStatus--*/}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:66:] Session
[1226507351.625770.12265073514988] found or built
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:73:] We received 1
messages from opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:147:] We connected
successfully
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:149:] State: 8063370
=> 1226507351.625770.12265073514988 => 1
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_stack.c:103:] Message
processing duration 0.000077
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_stack.c:106:] after msg delete
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:437:] *
Connected Successfully to open-ils.auth
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 271 bytes of data to
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"1","type":"REQUEST","payload":/*--S
osrfMethod--*/{"method":"open-ils.auth.authenticate.complete","params":[{"username":"admin","password":"c2fe6c06860be32f7f80567d8798a9a6","type":"opac"}]}/*--E
osrfMethod--*/}/*--E osrfMessage--*/]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:344:] Pushing
[1] onto requeust queue for session [open-ils.auth]
[1226507351.625770.12265073514988]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:104:] In
app_request receive with remaining time [120]
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:29:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 120
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:104:] In
app_request receive with remaining time [0]
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:31:11 [INFO:4988:osrf_app_session.c:142:]
Returning NULL from app_request_recv after timeout
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:462:]
AppSession disconnecting from
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:554:]
AppSession in queue_wait with timeout 0
srfsh 2008-11-12 11:31:11 [INFO:4988:osrf_app_session.c:522:]
[open-ils.auth] sent 83 bytes of data to
opensrf at localhost/open-ils.auth_drone__1226507025.878114_3757
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:525:] Sent:
[/*--S osrfMessage--*/{"threadTrace":"1","type":"DISCONNECT"}/*--E
osrfMessage--*/]
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:374:] App
Session [open-ils.auth] [1226507351.625770.12265073514988] resetting
remote id to router at localhost/open-ils.auth
srfsh 2008-11-12 11:31:11 [DEBG:4988:osrf_app_session.c:570:]
AppSession [open-ils.auth] [1226507351.625770.12265073514988]
destroying self and deleting requests
--
More information about the Open-ils-dev
mailing list