Forum OpenACS Q&A: tcl files source on boot but then all tcl commands fail

Collapse
1: tcl files source on boot but then all tcl commands fail
Posted by Joel Aufrecht on 11/01/03 11:34 PM
I'm moving a site from one computer to another.  The setups are similar but not identical; the site content is identical except for tweaks to config.tcl.  The database restored fine.  The site sources fine on bootstrap - that is, I see plenty of :

[01/Nov/2003:16:11:58][3312.16384][-main-] Debug: Loading packages/acs-admin/tcl/apm-admin-procs.tcl...
[01/Nov/2003:16:11:58][3312.16384][-main-] Debug: Loaded packages/acs-admin/tcl/apm-admin-procs.tcl.
[01/Nov/2003:16:11:58][3312.16384][-main-] Debug: Loading packages/acs-api-browser/tcl/acs-api-documentation-procs.tcl...

all the way through to listening on ip:port.  However, browsing to the front page returns nothing, and the log shows:

[01/Nov/2003:16:18:34][3312.49156][-conn0-] Error: tclop: invalid return code from filter proc 'invalid command name "paramete
r::get"': must be filter_ok, filter_return, or filter_break

All of the scheduled processes also fail, also because of invalid command name:

[01/Nov/2003:16:19:02][3312.376844][-sched:14-] Error: invalid command name "notification::sweep::sweep_notifications"
invalid command name "notification::sweep::sweep_notifications"
    while executing
"notification::sweep::sweep_notifications -interval_id 7289 -batched_p 0"

Any ideas where to look?  I assume it is something about the environment or prerequisite files, but what?  How do I found out why all of the tcl commands are invalid?  Could it be a TCL version difference?

Collapse
2: Re: tcl files source on boot but then all tcl commands fail (response to 1)
Posted by Joel Aufrecht on 11/02/03 12:53 AM
The boot logs are identical on both the original, working site and the new location, except for one line.

working site

[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: Executing initialization code blocks...
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: Executing initialization code block filters_register in /web/openacs-prod/packages/acs-tcl/tcl/request-processor-init.tcl
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: Executing initialization code block procs_register in /web/openacs-prod/packages/acs-tcl/tcl/request-processor-init.tcl
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: Executing initialization code block search_engine_driver in /web/openacs-prod/packages/openfts-driver/tcl/openfts-driver-init.tcl
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: sourcing files from /usr/local/src/Search-OpenFTS-tcl-0.3.2/
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: QD=Postload files to load: /web/openacs-prod/www/index-oracle.xql /web/openacs-prod/www/index.xql /web/openacs-prod/www/index-postgresql.xql
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: QD=Postload files to load:
[01/Nov/2003:16:36:58][2104.1024][-main-] Notice: tcl: generating interp init script
[01/Nov/2003:16:37:00][2104.1024][-main-] Warning: keepalive: insufficient maxkeepalive 0: keepalive disabled

[01/Nov/2003:16:37:00][2104.1024][-main-] Notice: nsmain: AOLserver/3.3.1+ad13 running
[01/Nov/2003:16:37:00][2104.1024][-main-] Notice: nsmain: security info: uid=522, euid=522, gid=503, egid=503
[01/Nov/2003:16:37:00][2104.2051][-sched-] Notice: sched: starting
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: serv: waiting for warmup
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: serv: warmed up
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: socks: idle
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: sched: idle
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: binder: listen(204.87.226.69,443) = 15
[01/Nov/2003:16:37:03][2104.8201][-nsopenssl-] Notice: waiting for startup
[01/Nov/2003:16:37:03][2104.8201][-nsopenssl-] Notice: starting
[01/Nov/2003:16:37:03][2104.8201][-nsopenssl-] Notice: nsopenssl: listening on https://aufrecht.org (204.87.226.69:443)
[01/Nov/2003:16:37:03][2104.8201][-nsopenssl-] Notice: accepting connections
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: binder: listen(204.87.226.69,80) = 18
[01/Nov/2003:16:37:03][2104.1024][-main-] Notice: nssock: listening on 204.87.226.69:80
[01/Nov/2003:16:37:03][2104.9226][-nssock-] Notice: nssock: starting
[01/Nov/2003:16:37:03][2104.9226][-nssock-] Notice: nssock: accepting connections

Broken site

[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: Executing initialization code blocks...
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: Executing initialization code block filters_register in /var/lib/aolserver/aufrecht-p
rod/packages/acs-tcl/tcl/request-processor-init.tcl
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: Executing initialization code block procs_register in /var/lib/aolserver/aufrecht-pro
d/packages/acs-tcl/tcl/request-processor-init.tcl
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: Executing initialization code block search_engine_driver in /var/lib/aolserv
ht-prod/packages/openfts-driver/tcl/openfts-driver-init.tcl
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: sourcing files from /usr/local/src/Search-OpenFTS-tcl-0.3.2/
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: QD=Postload files to load: /var/lib/aolserver/aufrecht-prod/www/index-oracle.xql /var
/lib/aolserver/aufrecht-prod/www/index.xql /var/lib/aolserver/aufrecht-prod/www/index-postgresql.xql
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: QD=Postload files to load:
[01/Nov/2003:17:40:40][6368.16384][-main-] Warning: keepalive: insufficient maxkeepalive 0: keepalive disabled
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: nsmain: AOLserver/3.3.1+ad13 running
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: nsmain: security info: uid=502, euid=502, gid=500, egid=500
[01/Nov/2003:17:40:40][6368.32771][-sched-] Notice: sched: starting
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: serv: waiting for warmup
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: serv: warmed up
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: socks: idle
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: sched: idle
[01/Nov/2003:17:40:40][6368.131081][-nsopenssl-] Notice: waiting for startup
[01/Nov/2003:17:40:40][6368.131081][-nsopenssl-] Notice: starting
[01/Nov/2003:17:40:40][6368.131081][-nsopenssl-] Notice: nsopenssl: listening on https://aufrecht.org:8443 (69.64.34.54:8443)
[01/Nov/2003:17:40:40][6368.131081][-nsopenssl-] Notice: accepting connections
[01/Nov/2003:17:40:40][6368.16384][-main-] Notice: nssock: listening on 69.64.34.54:8000
[01/Nov/2003:17:40:40][6368.147466][-nssock-] Notice: nssock: starting
[01/Nov/2003:17:40:40][6368.147466][-nssock-] Notice: nssock: accepting connections
Is the missing line about the interp script the symptom or the cause?
Collapse
3: Re: tcl files source on boot but then all tcl commands fail (response to 1)
Posted by Randy O'Meara on 11/02/03 06:40 AM
Joel,

If the systems are functioanlly identical, I would check fs permissions very carefully. Maybe a chown -R. And then the environments, including run scripts, very carefully. You've probably already done this, but it can't hurt to scrutinize again.

Also, I'm sure you've scrutinized the install log line-by-line.

Randy

Collapse
4: Re: tcl files source on boot but then all tcl commands fail (response to 1)
Posted by Brian Fenton on 11/03/03 12:23 PM
It might be a dos2unix problem. Check for those pesky ^M's!