Forum .LRN Q&A: Server startup failed: Error during bootstrapping

I'm trying to install dotlrn, but i received an error message during the bootstrapping and I'm not sure what is causing it or what to do it. I've included my log file below and would really appreciate it if any of you could help me figure out the problem. I'm using postgresql 7.2.3, aolserver 3.3+ad13 and openacs 4.6 in a machine whith redhat 8.0.I'm following the installation instrutions given in the openacs website.
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nsmain: AOLserver/3.3.1+ad13 starting
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nsmain: security info: uid=500, euid=500, gid=500, egid=500
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nsmain: max files: FD_SETSIZE
= 1024, rl_cur = 1024, rl_max = 1024
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: return: redirecting '404' to 'global/file-not-found.html'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: return: redirecting '403' to 'global/forbidden.html'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/postgres.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: PostgreSQL loaded.
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: adp: mapped /*.adp
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nssock.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nslog.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nslog: opened '/home/admin/web/openacs/log/access.log'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nssha1.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nscache.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nscache module version @VER@
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nsrewrite.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: modload: loading '/usr/local/aolserver/bin/nsxml.so'
[26/Mar/2003:13:01:30][1055.8192][-main-] Notice: nsxml module starting
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: conf: [ns/server/openacs]enabletclpages = 0
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Loading OpenACS, rooted at /home/admin/web/openacs
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Sourcing /home/admin/web/openacs/packages/acs-bootstrap-installer/bootstrap.tcl
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Bootstrap: sourcing /home/admin/web/openacs/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl
[26/Mar/2003:13:01:31][1055.8192][-main-] Error: Bootstrap: Server startup failed: Error during bootstrapping
syntax error in expression " [nsv_exists proc_source_file $proc_name] \
            && [string"
    ("if" test expression)
    while compiling
"if { [nsv_exists proc_source_file $proc_name] \
            && [string compare [nsv_get proc_source_file $proc_name] [info script]] != 0 } {
        ns_log..."
    (compiling body of proc "ad_proc", line 231)
    invoked from within
"ad_proc -public -deprecated proc_doc { args } {

    A synonym for ad_proc (to support legacy code).
    
} {
    eval ad_proc $args..."
    (file "/home/admin/web/openacs/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl" line 393)
    invoked from within
"source $file"
    ("foreach" body line 3)
    invoked from within
"foreach file [lsort $files] {
        ns_log Notice "$proc_name: sourcing $file"
        source $file
    }"
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Sourcing files for postload...[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Done.
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: Executing initialization code
blocks...
[26/Mar/2003:13:01:31][1055.8192][-main-] Error:
invalid command name "ad_find_all_files"
    while executing
"ad_find_all_files -check_file_func __is_xql [acs_root_dir]/$dir"
    ("foreach" body line 2)
    invoked from within
"foreach dir $dirs {
    set files [ad_find_all_files -check_file_func __is_xql [acs_root_dir]/$dir]

   ns_log Debug "QD=Postload files to loa..."
    (file "/home/admin/web/openacs/tcl/zz-postload.tcl" line 48)
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: tcl: generating interp init script
[26/Mar/2003:13:01:31][1055.8192][-main-] Warning: keepalive: insufficient maxkeepalive 0: keepalive disabled
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: nsmain: AOLserver/3.3.1+ad13 running
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: nsmain: security info: uid=500, euid=500, gid=500, egid=500
[26/Mar/2003:13:01:31][1055.16387][-sched-] Notice: sched: starting
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: serv: waiting for warmup
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: serv: warmed up
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: socks: idle
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: sched: idle
[26/Mar/2003:13:01:31][1055.8192][-main-] Notice: nssock: listening on 127.0.0.1:8000
[26/Mar/2003:13:01:31][1055.65545][-nssock-] Notice: nssock: starting
[26/Mar/2003:13:01:31][1055.65545][-nssock-] Notice: nssock: accepting connections
Tanks.
Collapse
Posted by Kenneth Wyrick on
Request Error
Server startup failed: Error during bootstrapping

invalid database id: "handle"
while executing
"ns_db releasehandle $db"
(procedure "::nsf::procs::db_release_unused_handles" line 20)
invoked from within
"db_release_unused_handles"
(procedure "::nsf::procs::apm_bootstrap_load_libraries" line 29)
invoked from within
"apm_bootstrap_load_libraries -procs acs-tcl"

http://litli.net is the instance.
Any help would be greatly appreciated. Not sure if something happened to Iuri or not. He lives in Brazil. He has helped me with this instance for years. It's a bit unusual for him not to respond, by now. I've been emailing him for several weeks, now with no response. I trust he's ok.

Collapse
Posted by Gustaf Neumann on
The problem was a general communication problem between the webserver and the DB ("failed to open database..."), probably after some upgrades . The pg driver was compiled with PostgreSQL 10, but refused to work with PostgresSQL 13 on this installation.
Collapse
Posted by Kenneth Wyrick on
Gustaf wrote in a mail:
maybe, this is the problem.

Let us recompile the DB driver:
cd /usr/local/src/modules/nsdbpg
export PG=/usr/include/postgresql
make
make install

and restart the instance.

Now we see;
[07/May/2021:18:51:49][32715.7fbbca3c1740][-main:litli-] Notice: nsdbpg: version 2.4 loaded, based on PostgreSQL 13.2 (Ubuntu 13.2-1.pgdg18.04+1) and libbpq 130002

and the error from above is gone.

There is later some error

[07/May/2021:18:51:49][32715.7fbbca3c1740][-main:litli-] Error: Error sourcing /var/www/litli/packages/acs-tcl/tcl> /site-nodes-procs.tcl:
: invalid command name "with_catch"
: while executing
: "with_catch errmsg {

which hints at a version mismatch ...
The function "with_catch" is deprecated and not called by recent code.
You should know better than me, why this is used.
In the NaviServer config file of this site
/usr/local/ns/config-litli.tcl you find the following section, where the deprecated code can be activated.

ns_section ns/server/${server}/acs {
ns_param NsShutdownWithNonZeroExitCode 1
# ns_param WithDeprecatedCode 0
# ns_param LogIncludeUserId 1
#
}

The site seems to work despite this error.