Problem: running cron script
. ~/.bashrc && $EG_BIN_DIR/thaw_expired_frozen_holds.srfsh
and getting
Received no data from server
With my .srfsh.xml set to call on the public.router, I test:
[vbush@commons-ctlt-hyperv ~]$ /openils/bin/srfsh
srfsh# request open-ils.cstore opensrf.system.echo "Testing"
Received no data from server
------------------------------------
Request Time in seconds: 0.001605
------------------------------------
srfsh# exit
In srfsh.log:
srfsh 2012-03-29 09:25:07 [INFO:17094:osrf_system.c:628:] Bootstrapping system with domain public.localhost, port 5222, and unixpath (none)
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:486:] open-ils.cstore session is stateless
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:497:] Building a new client session with id [open-ils.cstore] [1333031109.789956.133303110917094]
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:1044:1333031107170940] AppSession in queue_wait with timeout 0
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:759:1333031107170940] App Session [open-ils.cstore] [1333031109.789956.133303110917094] resetting remote id to router@public.localhost/open-ils.cstore
srfsh 2012-03-29 09:25:09 [INFO:17094:osrf_app_session.c:991:1333031107170940] [open-ils.cstore] sent 174 bytes of data to router@public.localhost/open-ils.cstore
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:994:1333031107170940] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"opensrf.system.echo","params":["Testing"]}}}}]
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:714:1333031107170940] Pushing [1] onto request queue for session [open-ils.cstore] [1333031109.789956.133303110917094]
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:275:1333031107170940] In app_request receive with remaining time [120]
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:1044:1333031107170940] AppSession in queue_wait with timeout 0
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:1044:1333031107170940] AppSession in queue_wait with timeout 120
srfsh 2012-03-29 09:25:09 [INFO:17094:transport_session.c:649:1333031107170940] Received <error> message with type cancel and code 503
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_stack.c:44:1333031107170940] Received message from transport code from router@public.localhost/open-ils.cstore
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_stack.c:87:1333031107170940] Transport handler received new message
from router@public.localhost/open-ils.cstore to opensrf@public.localhost/_commons-ctlt-hyperv.ilstu.edu_1333031107.503056_17094 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"opensrf.system.echo","params":["Testing"]}}}}]
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_stack.c:123:1333031107170940] We received 1 messages from router@public.localhost/open-ils.cstore
srfsh 2012-03-29 09:25:09 [WARN:17094:osrf_stack.c:134:1333031107170940] !!! Received Jabber layer error message
srfsh 2012-03-29 09:25:09 [WARN:17094:osrf_stack.c:144:1333031107170940] * Jabber Error is for top level remote id [router@public.localhost/open-ils.cstore], no one to send my message to! Cutting request short...
srfsh 2012-03-29 09:25:09 [INFO:17094:osrf_stack.c:159:1333031107170940] Message processing duration 0.000041
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_stack.c:162:1333031107170940] after msg delete
srfsh 2012-03-29 09:25:09 [ERR :17094:osrf_app_session.c:302:1333031107170940] Transport error in recv()
srfsh 2012-03-29 09:25:09 [DEBG:17094:osrf_app_session.c:1063:1333031107170940] AppSession [open-ils.cstore] [1333031109.789956.133303110917094] destroying self and deleting requests
srfsh 2012-03-29 09:25:12 [DEBG:17094:socket_bundle.c:482:1333031107170940] removing socket 3
Results from settings_tester.pl:
1..5
ok 1 - use OpenSRF::Utils::Config;
ok 2 - use UNIVERSAL::require;
ok 3 - use Getopt::Long;
ok 4 - use MARC::Record;
ok 5 - use Net::Domain;
LWP::UserAgent version 5.833
XML::LibXML version 1.70
XML::LibXML::XPathContext version 1.70
XML::LibXSLT version 1.70
Net::Server::PreFork version 0.99
Cache::Memcached version 1.28
Class::DBI version 3.0.17
Class::DBI::AbstractSearch version 0.07
Template version 2.22
DBD::Pg version 2.15.1
Net::Z3950::ZOOM version 1.28
MARC::Record version 2.0.3
MARC::Charset version 1.33
MARC::File::XML version 0.93
Text::Aspell version 0.09
CGI version 3.51
DateTime::TimeZone version 1.08
DateTime version 0.53
DateTime::Format::ISO8601 version 0.07
DateTime::Format::Mail version 0.3001
Unix::Syslog version 1.1
GD::Graph3d version 0.63
JavaScript::SpiderMonkey version 0.20
Log::Log4perl version 1.30
Email::Send version 2.198
Text::CSV version 1.21
Text::CSV_XS version 0.86
Spreadsheet::WriteExcel::Big version 2.37
Tie::IxHash version 1.21
Parse::RecDescent version 1.965001
SRU version 0.99
JSON::XS version 2.32
UUID::Tiny version 1.03
Please install Business::CreditCard::Object
Net::Z3950::Simple2ZOOM version 1.04
Checking /openils/conf/opensrf_core.xml for Evergreen services:
* OK: Found a public Evergreen service in /openils/conf/opensrf_core.xml
Checking Jabber connection for user opensrf, domain private.localhost
* Jabber successfully connected
Checking Jabber connection for user opensrf, domain public.localhost
* Jabber successfully connected
Checking Jabber connection for user router, domain public.localhost
* Jabber successfully connected
Checking Jabber connection for user router, domain private.localhost
* Jabber successfully connected
Checking database connections
* /opensrf/default/reporter/setup :: Successfully connected to database dbi:Pg:dbname=evergreen;host=localhost;port=5432
* Database has the expected server encoding UTF8.
* /opensrf/default/apps/open-ils.storage/app_settings/databases :: Successfully connected to database dbi:Pg:dbname=evergreen;host=localhost;port=5432
* Database has the expected server encoding UTF8.
* /opensrf/default/apps/open-ils.cstore/app_settings :: Successfully connected to database dbi:Pg:dbname=evergreen;host=localhost;port=5432
* Database has the expected server encoding UTF8.
* /opensrf/default/apps/open-ils.pcrud/app_settings :: Successfully connected to database dbi:Pg:dbname=evergreen;host=localhost;port=5432
* Database has the expected server encoding UTF8.
* /opensrf/default/apps/open-ils.reporter-store/app_settings :: Successfully connected to database dbi:Pg:dbname=evergreen;host=localhost;port=5432
* Database has the expected server encoding UTF8.
Checking database drivers to ensure <driver> matches <language>
* OK SIP from telephony section.
* OK SIP from telephony section.
* OK: Pg language is undefined for reporter base configuration
* OK: Pg language is undefined for reporter base configuration
* OK: Pg language is perl in /opensrf/default/apps/open-ils.storage/language
* OK: pgsql language is C in /opensrf/default/apps/open-ils.cstore/language
* OK: pgsql language is C in /opensrf/default/apps/open-ils.pcrud/language
* OK: pgsql language is C in /opensrf/default/apps/open-ils.qstore/language
* OK: pgsql language is C in /opensrf/default/apps/open-ils.reporter-store/language
Checking postgresql version
psql (PostgreSQL) 9.0.6
contains support for command-line editing
Checking libdbi and libdbi-drivers
libdbdpgsql.so was not found in /usr/local/libdbi/dbd/
We have found that system packages don't link against libdbi.so;
therefore, we strongly recommend compiling libdbi and libdbi-drivers from source.
Checking hostname
* OK: found hostname 'localhost' in <hosts> section of opensrf.xml
NOTE: Ignore the error about libdbi drivers; it's actually okay, but that doesn't test properly on CentOS.
====================================================================
2nd test:
I stopped all the opensrf processes (osrf_ctl.sh -l -a stop_all), edited ejabberd.cfg to increase the max_stanza_size up from the requested 2000000 to 20000000. Restarted ejabberd, restarted osrf_ctl.sh processes.
$ /openils/bin/srfsh
srfsh# request open-ils.cstore opensrf.system.echo "Testing"
Received no data from server
------------------------------------
Request Time in seconds: 0.002489
------------------------------------
srfsh# exit
From srfsh.log:
srfsh 2012-03-29 10:01:38 [INFO:17661:osrf_system.c:628:] Bootstrapping system with domain public.localhost, port 5222, and unixpath (none)
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:486:] open-ils.cstore session is stateless
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:497:] Building a new client session with id [open-ils.cstore] [1333033310.191857.133303331017661]
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:1044:1333033298176610] AppSession in queue_wait with timeout 0
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:759:1333033298176610] App Session [open-ils.cstore] [1333033310.191857.133303331017661] resetting remote id to router@public.localhost/open-ils.cstore
srfsh 2012-03-29 10:01:50 [INFO:17661:osrf_app_session.c:991:1333033298176610] [open-ils.cstore] sent 174 bytes of data to router@public.localhost/open-ils.cstore
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:994:1333033298176610] Sent: [{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"opensrf.system.echo","params":["Testing"]}}}}]
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:714:1333033298176610] Pushing [1] onto request queue for session [open-ils.cstore] [1333033310.191857.133303331017661]
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:275:1333033298176610] In app_request receive with remaining time [120]
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:1044:1333033298176610] AppSession in queue_wait with timeout 0
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:1044:1333033298176610] AppSession in queue_wait with timeout 120
srfsh 2012-03-29 10:01:50 [INFO:17661:transport_session.c:649:1333033298176610] Received <error> message with type cancel and code 503
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_stack.c:44:1333033298176610] Received message from transport code from router@public.localhost/open-ils.cstore
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_stack.c:87:1333033298176610] Transport handler received new message
from router@public.localhost/open-ils.cstore to opensrf@public.localhost/_commons-ctlt-hyperv.ilstu.edu_1333033298.990145_17661 with body
[{"__c":"osrfMessage","__p":{"threadTrace":"1","locale":"en-US","type":"REQUEST","payload":{"__c":"osrfMethod","__p":{"method":"opensrf.system.echo","params":["Testing"]}}}}]
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_stack.c:123:1333033298176610] We received 1 messages from router@public.localhost/open-ils.cstore
srfsh 2012-03-29 10:01:50 [WARN:17661:osrf_stack.c:134:1333033298176610] !!! Received Jabber layer error message
srfsh 2012-03-29 10:01:50 [WARN:17661:osrf_stack.c:144:1333033298176610] * Jabber Error is for top level remote id [router@public.localhost/open-ils.cstore], no one to send my message to! Cutting request short...
srfsh 2012-03-29 10:01:50 [INFO:17661:osrf_stack.c:159:1333033298176610] Message processing duration 0.000076
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_stack.c:162:1333033298176610] after msg delete
srfsh 2012-03-29 10:01:50 [ERR :17661:osrf_app_session.c:302:1333033298176610] Transport error in recv()
srfsh 2012-03-29 10:01:50 [DEBG:17661:osrf_app_session.c:1063:1333033298176610] AppSession [open-ils.cstore] [1333033310.191857.133303331017661] destroying self and deleting requests
srfsh 2012-03-29 10:01:56 [DEBG:17661:socket_bundle.c:482:1333033298176610] removing socket 3