Forum OpenACS Q&A: Re: Res: Errors are seen by everybody

Collapse
2: Re: Res: Errors are seen by everybody (response to 1)
Posted by unuser u on 08/14/09 01:30 PM
I have seen other problem,

I cant set a error page, always appears the

'The requested URL cannot be accessed due to a system error on
this server. '

in the error.log i can see how the server is trying to reach the file i set in the config, however it fails so always shows the message above.

Someone has info about these issues? In the bug tracker they dont appear so i dont know why these problems.I think i have installed correctly the system...

Collapse
3: Re: Res: Errors are seen by everybody (response to 2)
Posted by Brian Fenton on 08/27/09 01:23 PM
Hi,

Maybe something is going wrong during startup. Are there are any errors in the AOLserver error log during start-up?

cheers
Brian

Collapse
4: Re: Res: Re: Res: Errors are seen by everybody (response to 3)
Posted by unuser u on 08/28/09 11:43 AM
Hi

In the log you can see the aolserver+openacs load process and the failed attempt trying to get the error file. I have edited some relevant things.

Whatever name the 404 has, it fails. It is not a production server, but it will be. If i cant find the error i will have to user 5.3.2.

[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: nsmain: AOLserver/4.5.1 starting
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: nsmain: security info: uid=xxxx, euid=xxxx, gid=xxxx, egid=xxxx
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: nsmain: max files: FD_SETSIZE = 1024, rl_cur = 1024, rl_max = 1024
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: encoding: loaded: utf-8
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: fastpath[nmysite]: mapped GET /
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: fastpath[nmysite]: mapped HEAD /
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: fastpath[nmysite]: mapped POST /
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: adp[nmysite]: mapped GET /*.adp
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: adp[nmysite]: mapped HEAD /*.adp
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: adp[nmysite]: mapped POST /*.adp
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/usr/lib/aolserver4/bin/nssock.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/usr/lib/aolserver4/bin/nslog.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: nslog: opened '/var/lib/aolserver/nmysite/log/nmysite.log'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/usr/lib/aolserver4/bin/nssha1.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/usr/lib/aolserver4/bin/nsdb.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/usr/lib/aolserver4/bin/nspostgres.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: PostgreSQL loaded.
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: modload: loading '/var/lib/aolserver/nmysite/test/libthread2.6.5-aolserver.so'
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: conf: [ns/server/nmysite]enabletclpages = 0
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: default thread pool: minthreads 5 maxthreads 100 idle 0 current 0 maxconns 150 queued 0 timeout 150 spread 20
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: Loading OpenACS, rooted at /var/lib/aolserver/nmysite
[28/Aug/2009:08:07:56][5605.3083388592][-main-] Notice: Sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/bootstrap.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/tcl/10-utilities-procs.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/tcl/20-db-bootstrap-procs.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/tcl/30-apm-load-procs.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: sourcing /var/lib/aolserver/nmysite/packages/acs-bootstrap-installer/tcl/40-db-query-dispatcher-procs.tcl
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Database API: For database 'main', the following pools are available: pool1 pool2 pool3
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Database API: For database 'dbpool2', the following pools are available: db1 db2 db3
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Database API: For database 'dbpool3', the following pools are available: db4 db5 db6
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Database API: Default database (dbn) is: 'main'
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Database API: The following pools are available for OpenACS: pool1 pool2 pool3
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: dbdrv: opening database 'db+ip'
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Opening nmysite on ip, port
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Ns_PgOpenDb(postgres): Openned connection to db+ip.
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: dbdrv: opening database 'db+ip'
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Opening nmysite on ip, port
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Ns_PgOpenDb(postgres): Openned connection to db+ip.
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: dbdrv: opening database 'postgres:ip::nmysite'
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Opening nmysite on ip, port
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Ns_PgOpenDb(postgres): Openned connection to db+ip.
[28/Aug/2009:08:07:57][5605.3083388592][-main-] Notice: Bootstrap: Loading acs-tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/00-database-procs-postgresql.tcl

Loading a lot of packages....

[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/pools-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Default Pool: minthreads 5 maxthreads 100 idle 0 current 0 maxconns 150 queued 0 timeout 150 spread 20
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/request-processor-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/rollout-email-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/security-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: security-init.tcl: Creating secret_tokens ns_cache...
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: security-init.tcl: Populating secret_tokens ns_cache...
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/site-nodes-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/utilities-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-tcl/tcl/whos-online-init.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-automated-testing specially so other packages can define tests...
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-automated-testing/tcl/aa-test-procs.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-automated-testing/tcl/example-procs.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-automated-testing/tcl/filter-procs.tcl
[28/Aug/2009:08:07:58][5605.3083388592][-main-] Notice: Loading acs-automated-testing/tcl/tclwebtest-procs.tcl
[28/Aug/2009:08:08:00][5605.3083388592][-main-] Notice: Loading packages/acs-bootstrap-installer/tcl/00-proc-procs.tcl...

loading a lot of packages....

[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/search/tcl/search-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/search/tcl/search-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-content-repository/tcl/acs-content-repository-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: cr_scan_mime_types: inserting MIME TYPE - .pcd maps to image/x-photo-cd
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: cr_scan_mime_types: inserting MIME TYPE - .prc maps to application/x-pilot
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: cr_scan_mime_types: inserting MIME TYPE - .xls maps to application/vnd.ms-excel
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: cr_scan_mime_types: inserting MIME TYPE - .doc maps to application/vnd.ms-word
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-content-repository/tcl/acs-content-repository-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-messaging/tcl/acs-messaging-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-messaging/tcl/acs-messaging-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-subsite/tcl/acs-subsite-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-subsite/tcl/acs-subsite-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-subsite/tcl/approval-expiration-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-subsite/tcl/approval-expiration-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/acs-integration-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/acs-integration-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/acs-templating-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/acs-templating-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/date-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/date-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/spellcheck-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/spellcheck-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/tag-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/tag-init.tcl.
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loading packages/acs-templating/tcl/template-init.tcl...
[28/Aug/2009:08:08:04][5605.3083388592][-main-] Notice: Loaded packages/acs-templating/tcl/template-init.tcl.
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Bootstrap: Done loading OpenACS.
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Sourcing files for postload...
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Done.
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Executing initialization code blocks...
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Executing initialization code block filters_register in /var/lib/aolserver/nmysite/packages/acs-tcl/tcl/request-processor-init.tcl
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: Executing initialization code block procs_register in /var/lib/aolserver/nmysite/packages/acs-tcl/tcl/request-processor-init.tcl
[28/Aug/2009:08:08:05][5605.3064634256][-default:0-] Notice: random: generating 1 seed
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: nsmain: AOLserver/4.5.1 running
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: nsmain: security info: uid=xxxx, euid=xxxx, gid=xxxx, egid=xxxx
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Notice: driver: starting: nssock
[28/Aug/2009:08:08:05][5605.3072940944][-sched-] Notice: sched: starting
[28/Aug/2009:08:08:05][5605.3059350416][-nssock:driver-] Notice: starting
[28/Aug/2009:08:08:05][5605.3059350416][-nssock:driver-] Notice: nssock: listening on someip
[28/Aug/2009:08:08:05][5605.3083388592][-main-] Warning: prebind: closed unused: someip = 5
[28/Aug/2009:08:09:04][5605.3063577488][-sched:idle0-] Notice: starting
[28/Aug/2009:08:20:56][5605.3065691024][-default:1-] Notice: -- creating per thread sequence table
[28/Aug/2009:08:20:56][5605.3061463952][-default:3-] Notice: dbdrv: opening database 'somedbonsomeip'
[28/Aug/2009:08:20:56][5605.3061463952][-default:3-] Notice: Opening nmysite on someip, port
[28/Aug/2009:08:20:56][5605.3061463952][-default:3-] Notice: Ns_PgOpenDb(postgres): Openned connection to somedbonsomeip.
[28/Aug/2009:08:21:00][5605.3064634256][-default:0-] Error: return: failed to redirect 'GET /global/nfound.html': exceeded recursion limit of 3
[28/Aug/2009:08:21:13][5605.3061463952][-default:3-] Notice: dbdrv: opening database 'somedbonsomeip'
[28/Aug/2009:08:21:13][5605.3061463952][-default:3-] Notice: Opening db on someip, port port
[28/Aug/2009:08:21:13][5605.3061463952][-default:3-] Notice: Ns_PgOpenDb(postgres): Openned connection to somedbsomeip
[28/Aug/2009:08:21:13][5605.3061463952][-default:3-] Notice: dbdrv: opening database 'somedbonsomeip'
[28/Aug/2009:08:21:13][5605.3061463952][-default:3-] Notice: Opening db3 on someip, port port
[28/Aug/2009:08:21:14][5605.3061463952][-default:3-] Notice: Ns_PgOpenDb(postgres): Openned connection to somedbonsomeip
[28/Aug/2009:08:26:45][5605.3064634256][-default:0-] Error: return: failed to redirect 'GET /global/nfound.html': exceeded recursion limit of 3
[28/Aug/2009:08:26:47][5605.3061463952][-default:3-] Error: return: failed to redirect 'GET /global/nfound.html': exceeded recursion limit of 3
[28/Aug/2009:08:27:09][5605.3065691024][-default:1-] Error: return: failed to redirect 'GET /global/nfound.html': exceeded recursion limit of 3
[28/Aug/2009:10:12:53][5605.3060407184][-default:4-] Notice: -- creating per thread sequence table
[28/Aug/2009:10:13:07][5605.3064634256][-default:0-] Notice: -- creating per thread sequence table