Forum OpenACS Q&A: Installation of OpenACS

Collapse
1: Installation of OpenACS
Posted by priya kumari on 04/25/17 08:23 AM
I am using Ubuntu 16.04 and I installed openacs with naviserver.
Now how to access the openacs
I tried to access openacs through browser by typing http://localhost:8000
Collapse
3: Re: Installation of openACS (response to 1)
Posted by Benjamin Brink on 04/25/17 08:45 AM
What installation method did you use?
Collapse
4: Re: Installation of openACS (response to 1)
Posted by priya kumari on 04/25/17 09:06 AM
Collapse
2: Re: Installation of openACS (response to 1)
Posted by Gustaf Neumann on 04/25/17 09:12 AM
i assume, you have installed OpenACS with the script from https://openacs.org/xowiki/naviserver-openacs

the 2nd script (install-oacs.sh) installs a systemd file /lib/systemd/system/${oacs_service}.service and/or a upstart script /etc/init/${oacs_service}.conf, where $oacs_service is per default "oacs-5-9". Do you have these files?

if i see correctly, Ubuntu 16.04 has switched to systemd, so the .service file is the preferred path, although one can use Ubuntu 16.04 with upstart as well (see [1]). So this depends on your configuration.

When using systemd, don't forget to run "sudo systemctl daemon-reload". See e.g. [2]. I've updated the wiki page [3] to include these commands.

[1] https://wiki.ubuntu.com/SystemdForUpstartUsers
[2] https://openacs.org/forums/message-view?message_id=5334880
[3] https://openacs.org/xowiki/naviserver-openacs

Collapse
5: Re: Installation of openACS (response to 1)
Posted by priya kumari on 04/25/17 09:24 AM
I already started the service and it created the startup file oacs-5-9.conf
but unable to access the openACS through browser
Collapse
6: Re: Installation of openACS (response to 1)
Posted by Benjamin Brink on 04/25/17 10:46 AM
Check the naviserver log file for errors. The first error is usually the most significant one.

Error log file path is something like: /var/www/oacs-5-9/log/errors.log

Also, from shell, is naviserver running?
Try either:
status oacs-5-9
or
ps auxw| grep nsd | grep -v grep

Collapse
7: Re: Installation of openACS (response to 1)
Posted by Gustaf Neumann on 04/25/17 11:11 AM
When the server is starting (via service), then you find in the error.log of the server a "listening on" line like the following.
[24/Feb/2017:15:29:44][64734.70000cee5000][-driver:nssock:0-] Notice: nssock:0: listening on [localhost]:8000
If some other service is running already on this port, you find a prior line in the error.log that listening failed.
Collapse
8: Re: Installation of openACS (response to 1)
Posted by priya kumari on 04/25/17 11:23 AM
yes, naviserver is running from the shell.

and i m sending the log file error.log:

^[[0;32m[25/Apr/2017:03:23:23][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 stopping^[[0m
^[[0;32m[25/Apr/2017:03:23:23][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: [driver:nssock_v4:0]: stopping^[[0m
^[[0;32m[25/Apr/2017:03:23:23][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: server [oacs-5-9]: stopping^[[0m
^[[0;32m[25/Apr/2017:03:23:23][18166.7f2852326700][-conn:oacs-5-9:1-] ^[[0m^[[0;39mNotice: exiting: shutdown pending^[[0m
^[[0;32m[25/Apr/2017:03:23:23][18166.7f2851b25700][-conn:oacs-5-9:0-] ^[[0m^[[0;39mNotice: exiting: shutdown pending^[[0m
^[[0;32m[25/Apr/2017:03:23:24][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: server [oacs-5-9]: connection threads stopped^[[0m
^[[0;32m[25/Apr/2017:03:23:24][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: driver: stopping writer and spooler threads^[[0m
^[[0;32m[25/Apr/2017:03:23:24][18166.7f285ae07700][-main-] ^[[0m^[[1;31mError: driver: trigger send() failed: Socket operation on non-socket^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[1;39mWarning: writer1: timeout waiting for shutdown^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[1;31mError: driver: trigger send() failed: Socket operation on non-socket^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[1;39mWarning: writer0: timeout waiting for shutdown^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: sched: shutdown pending^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f2857fa7700][-sched-] ^[[0m^[[0;39mNotice: sched: shutdown started^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f2857fa7700][-sched-] ^[[0m^[[0;39mNotice: sched: shutdown complete^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f2851b25700][-shutdown-] ^[[0m^[[0;39mNotice: nslog: closed '/var/www/oacs-5-9/log//access.log'^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: [driver:nssock_v4:0]: stopped^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[1;31mError: pidfile: failed to remove '/var/www/oacs-5-9/log//nsd.pid': 'No such file or directory'^[[0m
^[[0;32m[25/Apr/2017:03:23:44][18166.7f285ae07700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 exiting^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 starting^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: Tcl version: 8.5.19^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: max files: soft limit 65536, hard limit 65536^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[1;39mWarning: nsmain: rl_cur (65536) > FD_SETSIZE (1024), select() calls should not be used^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: pool default: queueLength 90 low water 9 high water 90^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsd/init.tcl[oacs-5-9]: booting virtual server: tcl system encoding: "utf-8"^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nslog from file /usr/local/ns/bin/nslog.so^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nslog: opened '/var/www/oacs-5-9/log//access.log'^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsdb from file /usr/local/ns/bin/nsdb.so^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module ns/db/driver/postgres from file /usr/local/ns/bin/nsdbpg.so^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: version 2.1 loaded^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool1 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool2 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsproxy from file /usr/local/ns/bin/nsproxy.so^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nssock_v4 from file /usr/local/ns/bin/nssock.so^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 0 spooler thread(s) ^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 2 writer thread(s) for downloads >= 1024 bytes, bufsize=8192 bytes, HTML streaming 0^[[0m
^[[0;32m[25/Apr/2017:04:28:49][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: modload: loading module libthread from file /usr/local/ns/lib/thread2.7.3/libthread2.7.3.so^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: XOTcl 2.0.0 loaded^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Using ns_cache based on NX 2.0.0^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: adp[oacs-5-9]: mapped {GET HEAD POST} /*.adp^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: conf: [ns/server/oacs-5-9] enabletclpages = 0^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading OpenACS, rooted at /var/www/oacs-5-9^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/bootstrap.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: bootstrap begin encoding utf-8^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/10-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/20-db-bootstrap-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/30-apm-load-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/40-db-query-dispatcher-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Database API: Default database (dbn) is: 'default'^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Database API: Using ALL database pools for OpenACS.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Database API: The following pools are available for OpenACS: pool1 pool2 pool3^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Loading acs-tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs-postgresql.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/10-charset-compat-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/30-xml-utils-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-permissions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-private-data-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ad-functional-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/admin-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/adp-parser-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/aolserver-3-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-file-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-xml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-data-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/defs-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/deprecated-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/document-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ds-stub-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/exception-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/form-processing-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/html-email-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-auth-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-client-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/image-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/json-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/membership-rel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/memoize-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-type-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/openacs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/parameter-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/pdf-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/proxy-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/request-processor-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/security-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/server-cluster-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/set-operation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-apm-integration-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-object-map-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-nodes-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/sql-statement-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/stack-trace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/table-display-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcl-documentation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcltrace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tdom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/text-html-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/user-extensions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/util-diff-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/whos-online-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/widgets-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-0-sgml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-1-dom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Installation is not complete - sourcing the installer.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Sourcing files for postload...^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Done.^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: Executing initialization code blocks...^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from www: ^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from tcl: ^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3a9ffff700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: starting^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3a9ffff700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: nssock_v4:0: listening on [0.0.0.0]:8000^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3ab1e10700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3a9ffff700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: driver: accepting connections^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3aaefb0700][-sched-] ^[[0m^[[0;39mNotice: sched: starting^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3a9effd700][-writer0-] ^[[0m^[[0;39mNotice: writer0: accepting connections^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3a9f7fe700][-writer1-] ^[[0m^[[0;39mNotice: writer1: accepting connections^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3aa4af7700][-conn:oacs-5-9:1-] ^[[0m^[[0;39mNotice: thread initialized (0.053939 secs)^[[0m
^[[0;32m[25/Apr/2017:04:28:50][2134.7f3aa52f8700][-conn:oacs-5-9:0-] ^[[0m^[[0;39mNotice: thread initialized (0.054838 secs)^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 starting^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: Tcl version: 8.5.19^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: max files: soft limit 65536, hard limit 65536^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[1;39mWarning: nsmain: rl_cur (65536) > FD_SETSIZE (1024), select() calls should not be used^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: pool default: queueLength 90 low water 9 high water 90^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsd/init.tcl[oacs-5-9]: booting virtual server: tcl system encoding: "utf-8"^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nslog from file /usr/local/ns/bin/nslog.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nslog: opened '/var/www/oacs-5-9/log//access.log'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsdb from file /usr/local/ns/bin/nsdb.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module ns/db/driver/postgres from file /usr/local/ns/bin/nsdbpg.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: version 2.1 loaded^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool1 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool2 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsproxy from file /usr/local/ns/bin/nsproxy.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nssock_v4 from file /usr/local/ns/bin/nssock.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 0 spooler thread(s) ^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 2 writer thread(s) for downloads >= 1024 bytes, bufsize=8192 bytes, HTML streaming 0^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: modload: loading module libthread from file /usr/local/ns/lib/thread2.7.3/libthread2.7.3.so^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: XOTcl 2.0.0 loaded^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Using ns_cache based on NX 2.0.0^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: adp[oacs-5-9]: mapped {GET HEAD POST} /*.adp^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: conf: [ns/server/oacs-5-9] enabletclpages = 0^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading OpenACS, rooted at /var/www/oacs-5-9^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/bootstrap.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: bootstrap begin encoding utf-8^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/10-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/20-db-bootstrap-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/30-apm-load-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/40-db-query-dispatcher-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Database API: Default database (dbn) is: 'default'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Database API: Using ALL database pools for OpenACS.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Database API: The following pools are available for OpenACS: pool1 pool2 pool3^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Loading acs-tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs-postgresql.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/10-charset-compat-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/30-xml-utils-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-permissions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-private-data-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ad-functional-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/admin-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/adp-parser-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/aolserver-3-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-file-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-xml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-data-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/defs-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/deprecated-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/document-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ds-stub-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/exception-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/form-processing-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/html-email-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-auth-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-client-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/image-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/json-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/membership-rel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/memoize-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-type-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/openacs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/parameter-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/pdf-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/proxy-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/request-processor-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/security-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/server-cluster-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/set-operation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-apm-integration-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-object-map-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-nodes-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/sql-statement-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/stack-trace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/table-display-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcl-documentation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcltrace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tdom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/text-html-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/user-extensions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/util-diff-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/whos-online-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/widgets-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-0-sgml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-1-dom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Installation is not complete - sourcing the installer.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Sourcing files for postload...^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Done.^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: Executing initialization code blocks...^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from www: ^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from tcl: ^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: starting^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: bind operation on sock 15 lead to error: Address already in use^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[1;39mWarning: bind on: SockAddr family AF_INET, ip 0.0.0.0, port 8000^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: Ns_SockBinderListen: sendmsg() failed: sent 53 bytes, 'Address already in use'^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: nssock_v4:0: failed to listen on [0.0.0.0]:8000: Address already in use^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c094700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: exiting^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f976a03f700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f97671df700][-sched-] ^[[0m^[[0;39mNotice: sched: starting^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975c895700][-conn:oacs-5-9:1-] ^[[0m^[[0;39mNotice: thread initialized (0.055123 secs)^[[0m
^[[0;32m[25/Apr/2017:04:30:33][2175.7f975d096700][-conn:oacs-5-9:0-] ^[[0m^[[0;39mNotice: thread initialized (0.055541 secs)^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 starting^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: Tcl version: 8.5.19^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: max files: soft limit 4096, hard limit 4096^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[1;39mWarning: nsmain: rl_cur (4096) > FD_SETSIZE (1024), select() calls should not be used^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: pool default: queueLength 90 low water 9 high water 90^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsd/init.tcl[oacs-5-9]: booting virtual server: tcl system encoding: "utf-8"^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nslog from file /usr/local/ns/bin/nslog.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nslog: opened '/var/www/oacs-5-9/log//access.log'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsdb from file /usr/local/ns/bin/nsdb.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module ns/db/driver/postgres from file /usr/local/ns/bin/nsdbpg.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: version 2.1 loaded^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool1 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: dbinit: set LogMinDuration for pool pool2 over 0.01 to 0.010000^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nsproxy from file /usr/local/ns/bin/nsproxy.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module nssock_v4 from file /usr/local/ns/bin/nssock.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 0 spooler thread(s) ^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nssock_v4:0: enable 2 writer thread(s) for downloads >= 1024 bytes, bufsize=8192 bytes, HTML streaming 0^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: modload: loading module libthread from file /usr/local/ns/lib/thread2.7.3/libthread2.7.3.so^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: XOTcl 2.0.0 loaded^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Using ns_cache based on NX 2.0.0^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: adp[oacs-5-9]: mapped {GET HEAD POST} /*.adp^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: conf: [ns/server/oacs-5-9] enabletclpages = 0^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading OpenACS, rooted at /var/www/oacs-5-9^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/bootstrap.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: bootstrap begin encoding utf-8^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/10-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/20-db-bootstrap-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/30-apm-load-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: sourcing /var/www/oacs-5-9/packages/acs-bootstrap-installer/tcl/40-db-query-dispatcher-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Database API: Default database (dbn) is: 'default'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Database API: Using ALL database pools for OpenACS.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Database API: The following pools are available for OpenACS: pool1 pool2 pool3^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: dbdrv: opening database 'postgres:localhost::oacs-5-9'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg: Opening oacs-5-9 on localhost^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsdbpg(postgres): Opened connection to localhost::oacs-5-9.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Loading acs-tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs-postgresql.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/00-database-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/10-charset-compat-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/30-xml-utils-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-permissions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/acs-private-data-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ad-functional-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/admin-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/adp-parser-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/aolserver-3-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-file-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/apm-xml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-data-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/application-link-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/community-core-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/defs-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/deprecated-utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/document-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/ds-stub-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/exception-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/form-processing-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/html-email-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-auth-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/http-client-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/image-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/install-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/json-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/membership-rel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/memoize-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-callback-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/navigation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/object-type-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/openacs-kernel-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/parameter-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/pdf-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/proxy-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/request-processor-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/security-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/server-cluster-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/set-operation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-apm-integration-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-node-object-map-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/site-nodes-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/sql-statement-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/stack-trace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/table-display-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcl-documentation-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tcltrace-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/tdom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/text-html-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/user-extensions-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/util-diff-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/utilities-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/whos-online-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/widgets-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-0-sgml-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-1-dom-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Loading acs-tcl/tcl/xml-2-procs.tcl^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Bootstrap: Installation is not complete - sourcing the installer.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Sourcing files for postload...^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Done.^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: Executing initialization code blocks...^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from www: ^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: QD=Postload files to load from tcl: ^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: starting^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: bind operation on sock 15 lead to error: Address already in use^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[1;39mWarning: bind on: SockAddr family AF_INET, ip 0.0.0.0, port 8000^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: Ns_SockBinderListen: sendmsg() failed: sent 53 bytes, 'Address already in use'^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: nssock_v4:0: failed to listen on [0.0.0.0]:8000: Address already in use^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd531688700][-main-] ^[[0m^[[0;39mNotice: nsmain: security info: uid=1001, euid=1001, gid=1001, egid=1001^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd52e828700][-sched-] ^[[0m^[[0;39mNotice: sched: starting^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: exiting^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd524b0a700][-conn:oacs-5-9:0-] ^[[0m^[[0;39mNotice: thread initialized (0.053105 secs)^[[0m
^[[0;32m[25/Apr/2017:04:31:18][2199.7fd524309700][-conn:oacs-5-9:1-] ^[[0m^[[0;39mNotice: thread initialized (0.053219 secs)^[[0m

Collapse
9: Re: Intallation of openACS (response to 1)
Posted by Gustaf Neumann on 04/25/17 12:42 PM
The relevant line is:
 [25/Apr/2017:04:31:18][2199.7fd523b08700][-driver:nssock_v4:0-] Error: Ns_SockBinderListen: sendmsg() failed: sent 53 bytes, 'Address already in use'^[[0m
to figure out, what's running on that port, use:
netstat -pltn
You can either stop the service using port 8000 on your machine, or you can alter the port, on which OpenACS is listening by modifying the config file /usr/local/ns/config-oacs-5-9.tcl (look for "httpport"). As long the port is higher than 1024, changing this number is sufficient. For using privileged ports, one has to adjust the service file as well (look into the oacs-5-9.service file).
Collapse
10: Re: Installation of openACS (response to 1)
Posted by priya kumari on 04/25/17 01:42 PM
I modified the port (new port is 8888)
and the error.log:
^[[0;32m[25/Apr/2017:11:17:27][11354.7fa7f3fff700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: nssock_v4:0: listening on [0.0.0.0]:8888^[[0m
^[[0;32m[25/Apr/2017:11:17:27][11354.7fa806011700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m

now also I m unable to access openacs through browser

Collapse
11: Re: Installation of openACS (response to 10)
Posted by Gustaf Neumann on 04/25/17 01:54 PM
have you tried in your browser "localhost:8888/" and "0.0.0.0:8888/". The IP address 0.0.0.0 means, that the server is accepting requests from all the IPv4 addresses, so "localhost" should be included.
Collapse
12: Re: Installation of openACS (response to 1)
Posted by priya kumari on 04/26/17 08:22 AM
previously when i changed the httpPort (i.e 8888) the error log is:
^[[0;32m[25/Apr/2017:11:17:27][11354.7fa7f3fff700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: nssock_v4:0: listening on [0.0.0.0]:8888^[[0m
^[[0;32m[25/Apr/2017:11:17:27][11354.7fa806011700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m

and now when i am restarting the same, then getting error log:
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: starting^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: bind operation on sock 15 lead to error: Address already in use^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[1;39mWarning: bind on: SockAddr family AF_INET, ip 0.0.0.0, port 8888^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: Ns_SockBinderListen: sendmsg() failed: sent 53 bytes, 'Address already in use'^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[1;31mError: nssock_v4:0: failed to listen on [0.0.0.0]:8888: Address already in use^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7161d700][-driver:nssock_v4:0-] ^[[0m^[[0;39mNotice: exiting^[[0m
^[[0;32m[25/Apr/2017:11:17:44][11369.7fef7f166700][-main-] ^[[0m^[[0;39mNotice: nsmain: NaviServer/4.99.15 running^[[0m
^

Collapse
13: Re: Installation of openACS (response to 1)
Posted by Gustaf Neumann on 04/26/17 10:55 AM
With the command
ps ax | fgrep nsd
you see the running server instances. You should be able to stop these via
    sudo systemctl stop oacs-5-9
then check again with ps. If for some reason, the server is not stopped by the command above, the you should kill the running nsd via the PID reported by the ps command. Then, starting should work.
Collapse
14: Re: Installation of OpenACS (response to 1)
Posted by priya kumari on 04/26/17 12:33 PM
I cant try with localhost in browser as it is ubuntu server 16.4 and connected from ssh terminal (putty)...
So, i just want to access the service from anywhere using my public ip...
Collapse
15: Re: Installation of OpenACS (response to 1)
Posted by Benjamin Brink on 04/26/17 02:28 PM
Oh, so OpenACS is on an Ubuntu 16.04 server os.

The extra copies of naviserver should still be stopped as Gustaf suggests in message 13 ( https://openacs.org/forums/message-view?message_id=5359248#msg_5359467) or by restarting the server.

To browse to the OpenACS site from another system, try: http://public-ip-number:8888 where "public-ip-number" is public IP number assigned to the Ubuntu 16.04 server.

Use whatever port has been configured in the config file /usr/local/ns/config-oacs-5-9.tcl

Also, if the server's public ip number is static (does not change), set the "address" parameter to the public ip number.

Also set the parameter "hostname" to the value returned by the command "uname -n". If none has been assigned or the local network does not appear to use DNS, setting "hostname" to the same public ip number may help.

Collapse
16: Re: Installation of OpenACS (response to 1)
Posted by Benjamin Brink on 04/26/17 02:29 PM
..And restart naviserver after changing any settings in the config file.
Collapse
17: Re: Installation of OpenACS (response to 1)
Posted by priya kumari on 04/27/17 08:08 AM
i tried with http://public-ip-address:8888/ but its not working.
Collapse
18: Re: Installation of OpenACS (response to 1)
Posted by Gustaf Neumann on 04/27/17 02:05 PM
What is the host address used in your putty/ssh command ("Debian host")? Use this name in front of the :8888 in the URL you are using. Do not forget to allow clients to connect to port 8888 in the firewall settings of your Debian host.
Collapse
19: Re: Installation of OpenACS (response to 1)
Posted by priya kumari on 04/27/17 02:53 PM
Thanks, for all your help...
Its working now...