[OPEN-ILS-DEV] Login failed. XUL Client.

Boyer, Jason A JBoyer at library.IN.gov
Tue Jul 12 14:38:29 EDT 2016


Ah, if memory serves you were using --localhost the other day in the osrf_control command lines. You'll need to add that to /etc/init/opensrf.conf at the end of both the pre-start and post-stop lines if you haven't already. If you have, then you may need to see if there's anything in the upstart log for this service (/var/log/upstart/opensrf.log)

Jason

--
Jason Boyer
MIS Supervisor
Indiana State Library
http://library.in.gov/

From: Jim Lynch [mailto:jim at fayettedigital.com]
Sent: Tuesday, July 12, 2016 1:58 PM
To: Boyer, Jason A <JBoyer at library.IN.gov>; Evergreen Development Discussion List <open-ils-dev at list.georgialibraries.org>
Subject: Re: [OPEN-ILS-DEV] Login failed. XUL Client.

**** This is an EXTERNAL email. Exercise caution. DO NOT open attachments or click links from unknown senders or unexpected email. ****
________________________________
I added the scripts to the /etc/init directory.  After the system rebooted  I got the following in the osrfsys.log file.  The Session error block is repeated many hundreds of times.



open-ils.auth 2016-07-12 13:23:09 [WARN:3176:transport_session.c:304:] State machine is not connected in send_msg()
open-ils.auth 2016-07-12 13:23:09 [INFO:3176:osrf_prefork.c:1387:] graceful shutdown waiting...
open-ils.auth 2016-07-12 13:23:09 [INFO:3176:osrf_prefork.c:1398:] all active children are now idle in graceful shutdown
open-ils.auth 2016-07-12 13:23:09 [WARN:3176:socket_bundle.c:560:] _socket_send(): Error sending data with return -1
open-ils.auth 2016-07-12 13:23:09 [WARN:3176:socket_bundle.c:561:] Last Sys Error: Bad file descriptor
[2016-07-12 13:24:28] /usr/sbin/apache2 [ERR :2349:EX.pm:66:] Exception: OpenSRF::EX::Session 2016-07-12T13:24:28 OpenSRF::Transport /usr/local/share/perl/5.18.2/OpenSRF/Transport.pm:83 Session Error: router at private.localhost/opensrf.settings<mailto:router at private.localhost/opensrf.settings> IS NOT CONNECTED TO THE NETWORK!!!

[2016-07-12 13:24:28] /usr/sbin/apache2 [ERR :2347:EX.pm:66:] Exception: OpenSRF::EX::Session 2016-07-12T13:24:28 OpenSRF::Transport /usr/local/share/perl/5.18.2/OpenSRF/Transport.pm:83 Session Error: router at private.localhost/opensrf.settings<mailto:router at private.localhost/opensrf.settings> IS NOT CONNECTED TO THE NETWORK!!!

[2016-07-12 13:24:28] /usr/sbin/apache2 [ERR :2340:EX.pm:66:] Exception: OpenSRF::EX::Session 2016-07-12T13:24:28 OpenSRF::Transport /usr/local/share/perl/5.18.2/OpenSRF/Transport.pm:83 Session Error: router at private.localhost/opensrf.settings<mailto:router at private.localhost/opensrf.settings> IS NOT CONNECTED TO THE NETWORK!!!

[2016-07-12 13:24:28] /usr/sbin/apache2 [ERR :2342:EX.pm:66:] Exception: OpenSRF::EX::Session 2016-07-12T13:24:28 OpenSRF::Transport /usr/local/share/perl/5.18.2/OpenSRF/Transport.pm:83 Session Error: router at private.localhost/opensrf.settings<mailto:router at private.localhost/opensrf.settings> IS NOT CONNECTED TO THE NETWORK!!!

after that I stopped apache, ran
osrf_control -l --diagnostic
saw that nothing was running, so I ran
osrf_control -l --start-all

And see this in htop:

[cid:image001.png at 01D1DC4A.A436F210]

Where some combination of postgres, OpenSRF Drone and primarily apache are hogging the cpu.

Nothing is going on.  No web connections, no staff connections, nothing.  No data in the database.

The osrfsys.log file has thousands of lines of code that repeat like this:

[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738725] editor[0|0] open-ils.cstore.direct.actor.org_unit.search.atomic: returned 1 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738725] editor[0|0] request en-US open-ils.cstore.direct.actor.org_unit_type.search.atomic {"id":{"!=":null}}
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3869:CStoreEditor.pm:139:146834553738696] editor[0|0] open-ils.cstore.direct.actor.org_unit_type.search.atomic: returned 5 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3869:CStoreEditor.pm:139:146834553738696] editor[0|0] request en-US open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"active":"t","purpose":"opac"}
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3871:CStoreEditor.pm:139:146834553738716] editor[0|0] open-ils.cstore.direct.actor.org_unit_type.search.atomic: returned 5 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3871:CStoreEditor.pm:139:146834553738716] editor[0|0] request en-US open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"purpose":"opac","active":"t"}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3628:osrf_application.c:1059:146834553738726] CALL: open-ils.cstore open-ils.cstore.direct.actor.org_unit_type.search.atomic {"id":{"!=":null}}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_application.c:1059:146834553738717] CALL: open-ils.cstore open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"active":"t","purpose":"opac"}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3628:osrf_app_session.c:1017:146834553738726] [open-ils.cstore] sent 734 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872>
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_app_session.c:1017:146834553738717] [open-ils.cstore] sent 369 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3871<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3871>
open-ils.cstore 2016-07-12 13:51:23 [INFO:3628:osrf_stack.c:163:146834553738726] Message processing duration 0.009082
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_stack.c:163:146834553738717] Message processing duration 0.001806
open-ils.cstore 2016-07-12 13:51:23 [INFO:3618:osrf_application.c:1059:146834553738697] CALL: open-ils.cstore open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"active":"t","purpose":"opac"}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3618:osrf_app_session.c:1017:146834553738697] [open-ils.cstore] sent 369 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3869<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3869>
open-ils.cstore 2016-07-12 13:51:23 [INFO:3618:osrf_stack.c:163:146834553738697] Message processing duration 0.001618
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738726] editor[0|0] open-ils.cstore.direct.actor.org_unit_type.search.atomic: returned 5 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3869:CStoreEditor.pm:139:146834553738697] editor[0|0] open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic: returned 0 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3871:CStoreEditor.pm:139:146834553738717] editor[0|0] open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic: returned 0 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3869:Event.pm:64:146834553738697] Loading events xml file /openils/var/data/ils_events.xml
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3871:Event.pm:64:146834553738717] Loading events xml file /openils/var/data/ils_events.xml
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738726] editor[0|0] request en-US open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"active":"t","purpose":"opac"}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_application.c:1059:146834553738727] CALL: open-ils.cstore open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic {"purpose":"opac","active":"t"}
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_app_session.c:1017:146834553738727] [open-ils.cstore] sent 369 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872>
open-ils.cstore 2016-07-12 13:51:23 [INFO:3630:osrf_stack.c:163:146834553738727] Message processing duration 0.001858
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738727] editor[0|0] open-ils.cstore.direct.actor.org_unit_custom_tree.id_list.atomic: returned 0 result(s)
[2016-07-12 13:51:23] /usr/sbin/apache2 [INFO:3872:Event.pm:64:146834553738727] Loading events xml file /openils/var/data/ils_events.xml
open-ils.cstore 2016-07-12 13:51:25 [INFO:3626:osrf_app_session.c:1017:146834553738638] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3863<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3863>
open-ils.cstore 2016-07-12 13:51:25 [INFO:3626:osrf_stack.c:163:146834553738638] Message processing duration 5.101469
[2016-07-12 13:51:25] /usr/sbin/apache2 [INFO:3869:CStoreEditor.pm:139:146834553738697] editor[0|0] request en-US open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
[2016-07-12 13:51:25] /usr/sbin/apache2 [INFO:3871:CStoreEditor.pm:139:146834553738717] editor[0|0] request en-US open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
open-ils.cstore 2016-07-12 13:51:25 [INFO:3626:osrf_application.c:1059:146834553738718] CALL: open-ils.cstore open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
open-ils.cstore 2016-07-12 13:51:25 [INFO:3630:osrf_application.c:1059:146834553738698] CALL: open-ils.cstore open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
[2016-07-12 13:51:25] /usr/sbin/apache2 [INFO:3872:CStoreEditor.pm:139:146834553738727] editor[0|0] request en-US open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
open-ils.cstore 2016-07-12 13:51:25 [INFO:3618:osrf_application.c:1059:146834553738728] CALL: open-ils.cstore open-ils.cstore.direct.config.coded_value_map.search.atomic {"id":{"!=":null}}
open-ils.cstore 2016-07-12 13:51:27 [INFO:3632:osrf_app_session.c:1017:146834553738648] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3864<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3864>
open-ils.cstore 2016-07-12 13:51:27 [INFO:3632:osrf_stack.c:163:146834553738648] Message processing duration 5.756105
open-ils.cstore 2016-07-12 13:51:29 [INFO:3640:osrf_app_session.c:1017:146834553738708] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3870<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3870>
open-ils.cstore 2016-07-12 13:51:29 [INFO:3640:osrf_stack.c:163:146834553738708] Message processing duration 6.323358
open-ils.cstore 2016-07-12 13:51:31 [INFO:3618:osrf_app_session.c:1017:146834553738728] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3872>
open-ils.cstore 2016-07-12 13:51:31 [INFO:3618:osrf_stack.c:163:146834553738728] Message processing duration 6.065137
open-ils.cstore 2016-07-12 13:51:32 [INFO:3626:osrf_app_session.c:1017:146834553738718] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3871<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3871>
open-ils.cstore 2016-07-12 13:51:32 [INFO:3626:osrf_stack.c:163:146834553738718] Message processing duration 6.432045
open-ils.cstore 2016-07-12 13:51:32 [INFO:3630:osrf_app_session.c:1017:146834553738698] [open-ils.cstore] sent 306029 bytes of data to opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3869<mailto:opensrf at private.localhost/client_at_ubuntu-OptiPlex-755_3869>
open-ils.cstore 2016-07-12 13:51:32 [INFO:3630:osrf_stack.c:163:146834553738698] Message processing duration 6.899657

I stopped troubleshooting there so I can wander off to the gym and clear my mind.  :-)

Thanks,
Jim.
On 07/12/2016 07:46 AM, Boyer, Jason A wrote:

Hey Jim, I saw your question about the services not running after a reboot and sent you a @later in #evergreen pointing to these upstart scripts: http://pastie.org/10058161 You'll need to edit the first 2 and put them in /etc/init/ and then you should be set. The other 2 are for optional features you don't need for testing.



Jason



--

Jason Boyer

MIS Supervisor

Indiana State Library

http://library.in.gov/





-----Original Message-----

From: Open-ils-dev [mailto:open-ils-dev-bounces at list.georgialibraries.org] On

Behalf Of Jim Lynch

Sent: Monday, July 11, 2016 4:45 PM

To: open-ils-dev at list.georgialibraries.org<mailto:open-ils-dev at list.georgialibraries.org>

Subject: Re: [OPEN-ILS-DEV] Login failed. XUL Client.



**** This is an EXTERNAL email. Exercise caution. DO NOT open attachments or

click links from unknown senders or unexpected email. ****

________________________________



I redid the opensrf_core.xml copy and edit.  It's now working.



Jim.

On 07/11/2016 01:28 PM, Jim Lynch wrote:

New install on Ubuntu 14.04.  Browser login via

https://192.168.2.131/eg/opac/home works fine.  Shows me as

Administrator System Account.



I downloaded evergreen-client-2.10.5_x86_64.tar.bz2, untarred it and

executed the ./evergreen file.  I've tried it from the server and from

another Mint 17 system on the network.



-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://libmail.georgialibraries.org/pipermail/open-ils-dev/attachments/20160712/eaa8b530/attachment-0001.html>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image001.png
Type: image/png
Size: 130969 bytes
Desc: image001.png
URL: <http://libmail.georgialibraries.org/pipermail/open-ils-dev/attachments/20160712/eaa8b530/attachment-0001.png>


More information about the Open-ils-dev mailing list