FAQ  |  Search  |  Register  |  Profile  |  Log in to check your private messages  |  Log in
Internal error 500

 
Post new topic   Reply to topic    Aprelium Forum Index -> ASP.NET
View previous topic :: View next topic  
Author Message
feniks
-


Joined: 17 Jul 2006
Posts: 3
PostPosted: Tue Jul 18, 2006 12:23 am    Post subject: Internal error 500 Reply with quote
I am running asp.net application in our intranet, approx. 50 users. Everything is working fine when testing, however in real use we get quite frequently "internal error 500". Next try (refresh or next post) is usually OK.

Error 500 is usually happening when more users at the same time access the web server. My application have some common global variables and open files and cannot run in more than one instance. Is more instances of asp.net application possible, and how can I prevent starting second instance?

The same application is running without without problems in IIS on Windows XP professional, therefore i think the problem is not in the application itself.

I am just guessing the reason for error 500. How can I get more details? I allready checked windows event log, abyss fastcgi.log and my application log file, and cannot find anything, except error 500 in fastcgi.log.

Best regards,
Benjamin
Back to top View user's profile Send private message
aprelium
-


Joined: 22 Mar 2002
Posts: 6800
PostPosted: Tue Jul 18, 2006 1:59 pm    Post subject: Re: Internal error 500 Reply with quote
feniks wrote:
I am just guessing the reason for error 500. How can I get more details? I allready checked windows event log, abyss fastcgi.log and my application log file, and cannot find anything, except error 500 in fastcgi.log.


Can you post here the contents of your fastcgi.log? Error 500 usually means that the server was unable to connect to the ASP.NET engine for some reason, the log there will help us determine the cause.

Try also raising the level of FastCGI debugging and error reporting to have more details about the cause of the failure.
_________________
Support Team
Aprelium - http://www.aprelium.com
Back to top View user's profile Send private message Send e-mail
feniks
-


Joined: 17 Jul 2006
Posts: 3
PostPosted: Tue Jul 18, 2006 4:06 pm    Post subject: Reply with quote
Yesterday evening I've set Parameters Timeout=90000 seconds and made some small changes in asp.net code (some files are not permanently open anymore, now they are open/close when needed). It is much better now (fewer error 500) but still some of them. Yesterday, I didn't get any error messages in fastcgi.log (only to access.log). As I wrote, asp.net application relys on some common global variables (for all sessions), because they are needed for communication interface to another system (includes locking logic). More instances of asp.net code is potencialy a big problem.

fastcgi.log is currently "errors only", here is complete fastcgi.log from today

fastcgi.log
Code:

18/Jul/2006:10:03:47 +0200   SUID: 1   PUID: 1   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Writing 1032 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:03:47 +0200   SUID: 1   PUID: 1   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Writing 48 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:03:47 +0200   SUID: 1   PUID: 1   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Writing 8 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:03:47 +0200   SUID: 1   PUID: 1   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Reading 8 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:16:13 +0200   SUID: 3   PUID: 3   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Writing 455 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:16:13 +0200   SUID: 3   PUID: 3   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Writing 8 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:10:16:13 +0200   SUID: 3   PUID: 3   RUID: 2   URI: /baanserver5/hra_proizvodne.aspx   Reading 8 bytes failed = The process cannot access the file because it is being used by another process.


It's interesting, on error 500 there are usually no messages in fastcgi.log.
This is a part of access.log corresponding to fastcgi.log

Code:
10.107.10.181 - - [18/Jul/2006:10:03:41 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 200 15926 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"
10.107.10.181 - - [18/Jul/2006:10:03:41 +0200] "GET /baanserver5/WebResource.axd?d=b65fKCBCXOse7cXbvZhTgw2&t=632732672122628904 HTTP/1.1" 200 21011 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"
10.107.10.181 - - [18/Jul/2006:10:03:46 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 500 0 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"
10.107.10.181 - - [18/Jul/2006:10:03:46 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 200 15171 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"



and example of 500 from today without messages in fastcgi.log

Code:
10.107.10.181 - - [18/Jul/2006:11:01:55 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 200 15531 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"
10.107.10.181 - - [18/Jul/2006:11:01:56 +0200] "GET /baanserver5/WebResource.axd?d=b65fKCBCXOse7cXbvZhTgw2&t=632732672122628904 HTTP/1.1" 200 21011 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)"
10.107.34.12 - - [18/Jul/2006:11:04:17 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 500 0 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1; .NET CLR 2.0.50727)"
10.107.34.12 - - [18/Jul/2006:11:04:15 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 200 0 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1; .NET CLR 2.0.50727)"
10.107.34.12 - - [18/Jul/2006:11:04:49 +0200] "POST /baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx HTTP/1.1" 200 15770 "http://prs07/baanserver5/hra_proizvodne.aspx?parent=hra_menu.aspx" "Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1; .NET CLR 2.0.50727)"
1


I don't know a way how to reproduce error 500, it occures sometimes on client screens. I assume, messages with 500 in access.log corresponds with real errors on client browsers.


Regards,
Benjamin
Back to top View user's profile Send private message
feniks
-


Joined: 17 Jul 2006
Posts: 3
PostPosted: Tue Jul 18, 2006 9:42 pm    Post subject: Reply with quote
Here is part of (detailed) fastcgi.log. It seems, that it cannot write to one local file. I have an application log file permanently open, and I assume here is my problem.

Code:
18/Jul/2006:21:58:55 +0200   SUID: 1
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="INSTANCE_ID", value="1")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_TOTAL", value="6450")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_ERROR", value="21")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_HTML", value="277")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_IMAGE", value="778")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_NOTMODIFIED", value="262")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_OUTPUT", value="84677329")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_UPTIME", value="78381")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_SERVER_CURRENT_UPTIME", value="17428")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_TOTAL", value="6450")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_ERROR", value="21")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_HTML", value="277")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_IMAGE", value="778")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_NOTMODIFIED", value="262")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_OUTPUT", value="84677329")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_UPTIME", value="78381")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   send_table_item(key="X_ABYSS_STATS_HOST_CURRENT_UPTIME", value="17428")
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   Writing 7499 bytes failed = The process cannot access the file because it is being used by another process.
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   disconnect()
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   RUID: 2   free_request()
18/Jul/2006:21:58:55 +0200   SUID: 1   PUID: 1   process_shutdown_now()
18/Jul/2006:21:58:55 +0200   SUID: 2   server_init() = {mutex=1752/6d8}
18/Jul/2006:21:58:55 +0200   SUID: 2   server_bind() = {pipe="\\.\pipe\abws-fcgi-00000002-01c6aa7c04d9707f00000ef4"}
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   process_init() = {event=1612/64c}
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   process_start(cmdline=""C:\Program Files\Abyss Web Server\adn/fcgidotnet_2_0.exe" ") = OK
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   connect() = OK
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table(type=9, size=90 bytes, items=5)
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_item(key="FCGI_MAX_CONNS", value="")
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_item(key="FCGI_MAX_REQS", value="")
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_item(key="FCGI_MPXS_CONNS", value="")
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_item(key="X_ABYSS_ALIAS_V", value="")
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_item(key="X_ABYSS_ALIAS_R", value="")
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table_end()
18/Jul/2006:21:58:55 +0200   SUID: 2   PUID: 2   RUID: 0   send_table(type=9, size=8 byte


I will probably change logic and do open/close of that file (it can be very frequent). I see that abyss is somehow starting/shutdown asp.net application as fcgidotnet_2_0.exe. The only reason for error accesing the file which I can imagine is, this file is allready open in another instance of fcgidotnet_2_0.exe?!

My question now is, what is happening with global variables and other static variables? If I understand correctly, my Timeout of 90.000 seconds (approx. 1 day) means, that abyss should keep for that period of time fcgidotnet_2_0.exe running also in case without real web hits - that way it will keep also all global variables.

Regards,
Benjamin
Back to top View user's profile Send private message
aprelium
-


Joined: 22 Mar 2002
Posts: 6800
PostPosted: Wed Jul 19, 2006 12:34 pm    Post subject: Reply with quote
feniks wrote:
18/Jul/2006:21:58:55 +0200 SUID: 1 PUID: 1 RUID: 2 Writing 7499 bytes failed = The process cannot access the file because it is being used by another process.


This error message is not related to your ASP.NET script. It is a problem between Abyss Web Server and FCGIDotNet_X_Y.exe.

The file that is referred to in the error message is the pipe that is used to communicate between the web server and the ASP.NET connector FCGIDotNet_X_Y.exe.

Could you please let the fastcgi.log file collect debugging information and send it to support@aprelium.com after a handful of error 500 occurrences (compressed using WinRAR or 7Zip to achieve a higher ratio of compression because this file can grow to several MB). Please do not forget to add a reference to this forum message in your email.

Thanks.
_________________
Support Team
Aprelium - http://www.aprelium.com
Back to top View user's profile Send private message Send e-mail
sabvr
-


Joined: 02 Aug 2006
Posts: 21
PostPosted: Sat Aug 05, 2006 9:20 am    Post subject: Reply with quote
is there any update on this issue, as I have the same problem and I do not use ASP but rather PHP:

05/Aug/2006:06:29:33 +0100 SUID: 143 PUID: 143 RUID: 0 URI: timeout-header2!
05/Aug/2006:07:25:05 +0100 SUID: 144 PUID: 144 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:07:25:05 +0100 SUID: 144 PUID: 144 RUID: 0 URI: timeout-header2!
05/Aug/2006:07:25:32 +0100 SUID: 145 PUID: 145 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:07:25:32 +0100 SUID: 145 PUID: 145 RUID: 0 URI: timeout-header2!
05/Aug/2006:08:29:07 +0100 SUID: 146 PUID: 146 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:08:29:07 +0100 SUID: 146 PUID: 146 RUID: 0 URI: timeout-header2!
05/Aug/2006:08:46:41 +0100 SUID: 147 PUID: 147 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:08:46:41 +0100 SUID: 147 PUID: 147 RUID: 0 URI: timeout-header2!
05/Aug/2006:08:47:17 +0100 SUID: 148 PUID: 148 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:08:47:17 +0100 SUID: 148 PUID: 148 RUID: 0 URI: timeout-header2!
05/Aug/2006:09:04:30 +0100 SUID: 149 PUID: 149 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:09:04:30 +0100 SUID: 149 PUID: 149 RUID: 0 URI: timeout-header2!
05/Aug/2006:09:04:51 +0100 SUID: 150 PUID: 150 RUID: 0 URI: Reading 56 bytes failed = The process cannot access the file because it is being used by another process.
05/Aug/2006:09:04:51 +0100 SUID: 150 PUID: 150 RUID: 0 URI: timeout-header2!
Back to top View user's profile Send private message Visit poster's website
aprelium
-


Joined: 22 Mar 2002
Posts: 6800
PostPosted: Sat Aug 05, 2006 4:28 pm    Post subject: Reply with quote
sabvr,

We have sent you an email this week about this issue:

Quote:
Many thanks for sending us this access.log file. It will help us a lot track and fix this problem.

Meanwhile we strongly suggest that you set the PHP interpreter's interface to use CGI/ISAPI instead of FastCGI. This will make the Error 500 errors disappear.


We are still investigating it and will keep you updated about our findings (actually we were unable to reproduce it on our test systems).
_________________
Support Team
Aprelium - http://www.aprelium.com
Back to top View user's profile Send private message Send e-mail
Display posts from previous:   
Post new topic   Reply to topic    Aprelium Forum Index -> ASP.NET All times are GMT + 1 Hour
Page 1 of 1

 
Jump to:  
You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot vote in polls in this forum


Powered by phpBB phpBB Group