Webinator HTTP 500 errors

john208 · Post by **john208** » Thu Jan 12, 2006 6:52 pm

Hello,

We found the following entries in our IIS log files.

2006-01-12 07:25:45 W3SVC1123456789 SERVER1 172.16.1.14 GET /webinator/bar1.gif - 80 - 221.146.210.71 HTTP/1.1 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+NT+5.1;+.NET+CLR+1.1.4322) ASPSESSIONIDCQRRDBQT=OFPPMOOCLEGCLAGNFDANBENI http://www.choate.edu/SCRIPTS/texis.exe ... cq=&jump=0 www.choate.edu 200 0 0 289 475 328
2006-01-12 07:25:45 W3SVC1123456789 SERVER1 172.16.1.14 GET /webinator/bar0.gif - 80 - 221.146.210.71 HTTP/1.1 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+NT+5.1;+.NET+CLR+1.1.4322) ASPSESSIONIDCQRRDBQT=OFPPMOOCLEGCLAGNFDANBENI http://www.choate.edu/SCRIPTS/texis.exe ... cq=&jump=0 www.choate.edu 200 0 0 289 475 328
2006-01-12 07:25:45 W3SVC1123456789 SERVER1 172.16.1.14 GET /SCRIPTS/texis.exe/Webinator/search query=late+application&pr=ChoateDB&prox=page&rorder=500&rprox=500&rdfreq=500&rwfreq=500&rlead=500&sufs=0&order=r&cq=&jump=0 80 - 221.146.210.71 HTTP/1.1 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+NT+5.1;+.NET+CLR+1.1.4322) ASPSESSIONIDCQRRDBQT=OFPPMOOCLEGCLAGNFDANBENI http://www.choate.edu/SCRIPTS/texis.exe ... q=&jump=10 www.choate.edu 200 0 109 31941 614 1046
2006-01-12 07:25:45 W3SVC1123456789 SERVER1 172.16.1.14 GET /SCRIPTS/texis.exe/Webinator/ - 80 - 221.146.210.71 HTTP/1.1 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+NT+5.1;+.NET+CLR+1.1.4322) ASPSESSIONIDCQRRDBQT=OFPPMOOCLEGCLAGNFDANBENI http://www.choate.edu/SCRIPTS/texis.exe ... cq=&jump=0 www.choate.edu 500 0 64 0 485 656

I think the 500 near the end of the the last line means there was an HTTP 500 error. Does that mean the webinator is generating the 500 error?

Thanks.

Post by **mark** » Fri Jan 13, 2006 12:40 am

I don't know IIS log format, but if that 500 is HTTP error then it would seem so. Check vortex.log to see if there's anything logged there for the same time.

john208 · Post by **john208** » Fri Jan 13, 2006 10:20 am

Yep, I'm getting "permission denied" errors, and "no SYSTABLES in the function ddopen" errors. Why would we get these?

002 2006-01-12 02:23:35 /Webinator: Can't open source file: Permission denied
002 2006-01-12 02:25:45 /Webinator: Can't open source file: Permission denied
002 2006-01-12 02:25:48 /Webinator: Can't open source file: Permission denied
002 2006-01-12 02:26:36 /Webinator: Can't open source file: Permission denied
002 2006-01-12 02:26:50 /Webinator: Can't open source file: Permission denied
002 2006-01-12 02:26:53 /Webinator: Can't open source file: Permission denied
000 2006-01-12 17:19:30 /Webinator/search:754: Vortex (3828) ABEND: exception 0xC0000005 (ACCESS_VIOLATION)
000 2006-01-12 17:36:14 /Webinator/search

Vortex (6740) ABEND: exception 0xC0000005 (ACCESS_VIOLATION)
002 2006-01-12 19:00:01 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk

can't open D:\Texis\Altamont\db2\: no SYSTABLES in the function ddopen
000 2006-01-12 19:00:01 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk

Could not connect to D:\Texis/Altamont/db2 in the function openntexis
002 2006-01-12 19:00:01 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk

can't open D:\Texis\Altamont\db2\: no SYSTABLES in the function ddopen
000 2006-01-12 19:00:01 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk

Could not connect to D:\Texis/Altamont/db2 in the function openntexis

john208 · Post by **john208** » Fri Jan 13, 2006 10:56 am

We use <form method="get" action="/SCRIPTS/texis.exe/Webinator/search">

Is this correct? Are you saying sometimes we just have action="/SCRIPTS/texis.exe/Webinator" without the search?

What about the permissions error? Why would we only sometimes have a problem with permissions?

Thanks, John

john208 · Post by **john208** » Fri Jan 13, 2006 11:18 am

Aha. I have a D:\Texis\Altamont\db2 folder but it is empty. The db2.long file contains:

<pre>
Webinator Walk Report for Altamont

Creating database D:\Texis/Altamont/db2...
100 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk(createdb) 1752: License Violation in the function createdb

002 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk(maketables) 1808: can't open D:\Texis\Altamont\db2\: no SYSTABLES in the function ddopen

000 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk(maketables) 1808: Could not connect to D:\Texis/Altamont/db2 in the function openntexis

002 C:\Program Files\Thunderstone Software\Webinator\texis\scripts/Webinator/dowalk(maketables) 1826: can't open D:\Texis\Altamont\db2\: no SYSTABLES in the function ddopen

...

So it seemed Webinator tried to create db2 earlier this week and failed. Usually the search uses db1 but sometimes it uses db2. How did this happen and what do I do now?

Post by **mark** » Fri Jan 13, 2006 11:35 am

Try removing the db2 directory completely so it'll get recreated.

Also run
texis -license
from the dos prompt to check your license status and if you're still in violation. If you're in violation don't expect much to work right.

john208 · Post by **john208** » Fri Jan 13, 2006 11:50 am

In the vortex.log, I see "License Violation in the function createdb" starting 12/18/2005. We got a new copy of our licence 12/15/2005. That was to remove the copyright comment from the results page because those comments were causing issues with our css. 12/18 was the first time we tried to start a new walk.

Every time the License Violation occurs, the empty db1 or db2 folder is created with the above errors. So basically we can't start a new walk anymore. Sounds like there is a problem with the license file that was sent to us on 12/15.

Here is the output.

Texis Web Script (Vortex) Copyright (c) 1996-2004 Thunderstone - EPI, Inc.
Webinator Professional Version 5.00.1092695634 20040816 (i686-intel-winnt-64-32)

License Information

Current time is: Jan 13 2006 11:42:13 Eastern Standard Time
Init since boot: Jan 11 2006 23:39:42 Eastern Standard Time
License created: Sep 7 2004 13:54:33 Eastern Daylight Time
License expires: never
License verified: Jan 12 2006 17:28:36 Eastern Standard Time
Maximum version: Aug 20 2004 23:59:59 Eastern Daylight Time
Serial number: 12261
Maximum hits a day: 25000
Current table rows: 0
Maximum table rows: 50000
Flags: Non-intranetable Auto growth
Texis flags: Index Trig Del Upd Ins Sel Grant Revoke Viol. no create SSL Schema-restricted
Vortex flags: Create Webinator tables
Texis monitor process: pid 2068

Post by **mark** » Fri Jan 13, 2006 12:00 pm

Shutting down creation of new databases when in violation is expected.

According to the above you're not in violation now. What's the stated reason when it is in violation?

john208 · Post by **john208** » Fri Jan 13, 2006 12:16 pm

Well as far as I know, we're not violating our license. We've been running the Webinator since late last year. Haven't gotten that violation error until after we installed the new license. So I'm assuming that's what caused it.

There is no stated reason. The errors I posted are the ones from dbX.long and vortex.log. Sometimes I see permissions errors before, and then can't open the SYSTABLES after. Is there some place where I can find the reason?

Post by **mark** » Fri Jan 13, 2006 12:51 pm

texis -license
shows the reason. Also the dowalk interface should show it.

Maybe you're getting more hits than you're licensed for intermittently.