RE: New isapi_redirect.dll has problems
Hello; I would agree with you except... I switched back to the release version Friday afternoon and the size of the logfile since then has been 0 bytes - nothing. I will leave it this way until Wednesday evening and then switch back to the new one again for a day to see what happens. Thanks - dave David Thielen www.windwardreports.com 303-499-2544 -Original Message- From: Mark Thomas [mailto:[EMAIL PROTECTED] Sent: Sunday, February 19, 2006 4:26 PM To: Tomcat Users List Subject: Re: New isapi_redirect.dll has problems David, I have taken some time to look through the information you have provided and have come to the conclusion that there are 2 issues here. The first is the connection errors of the form: [Mon Feb 13 07:56:51 2006] [info] jk_ajp_common.c (1749): Sending request to tomcat failed, recoverable operation attempt=3 [Mon Feb 13 07:56:51 2006] [error] jk_ajp_common.c (1758): Error connecting to tomcat. Tomcat is probably not started or is listening on the wrong port. worker=ajp13w failed Looking at the more detailed log file you placed in the zip file, this looks like it only happens just after IIS is started/restarted. Can you confirm this? What state is Tomcat in at this time? If Tomcat has been restarted as well, it is possible that Tomcat isn't quite ready to serve requests. The second is the warnings of the form: [Mon Feb 13 17:27:46 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.enemynations.com is invalid. Uri must start with / The more I look at this, the more I think that these messages are caused by a misbehaving robot. My reasons for thinking this are: - The requests come in very quick succession, far faster than a normal user would navigate - The http in the url. JK basically does: if (host.length() 0) { searchUri = / + host + / + requestUri } else { searchUri = requestUri } There is nowhere I can see where the protocol could get added to the start of the URI. Additionally, I have also checked through every conditional debug log call in JK and there are a few places where it does more than just make a logging call but all are explainable and none have any impact on what IIS logs. I need to do some testing to confirm how IIS behaves if URLs that do not map to workers are requested. This might lead to an explanation of why some these odd requests are not logged in IIS. Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED] - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
Re: New isapi_redirect.dll has problems
David, I have taken some time to look through the information you have provided and have come to the conclusion that there are 2 issues here. The first is the connection errors of the form: [Mon Feb 13 07:56:51 2006] [info] jk_ajp_common.c (1749): Sending request to tomcat failed, recoverable operation attempt=3 [Mon Feb 13 07:56:51 2006] [error] jk_ajp_common.c (1758): Error connecting to tomcat. Tomcat is probably not started or is listening on the wrong port. worker=ajp13w failed Looking at the more detailed log file you placed in the zip file, this looks like it only happens just after IIS is started/restarted. Can you confirm this? What state is Tomcat in at this time? If Tomcat has been restarted as well, it is possible that Tomcat isn't quite ready to serve requests. The second is the warnings of the form: [Mon Feb 13 17:27:46 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.enemynations.com is invalid. Uri must start with / The more I look at this, the more I think that these messages are caused by a misbehaving robot. My reasons for thinking this are: - The requests come in very quick succession, far faster than a normal user would navigate - The http in the url. JK basically does: if (host.length() 0) { searchUri = / + host + / + requestUri } else { searchUri = requestUri } There is nowhere I can see where the protocol could get added to the start of the URI. Additionally, I have also checked through every conditional debug log call in JK and there are a few places where it does more than just make a logging call but all are explainable and none have any impact on what IIS logs. I need to do some testing to confirm how IIS behaves if URLs that do not map to workers are requested. This might lead to an explanation of why some these odd requests are not logged in IIS. Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
Re: New isapi_redirect.dll has problems
David Thielen wrote: Hi; Ok, I went back to Info and it is happening again. I think it's the logging because the IIS logs don't match the isapi log. Not only does the list of files not match (these are the only places most of these filenames occur) but there are files listed in the isapi log that never appear in the IIS log. Given the previous problem was log generation related, it seems a reasonable bet that this issue has a similar cause. Just to confirm: - with logging set to debug, the IIS and JK logs agree - with logging set to info, the IIS and JK logs do not agree The logs you provided in your post refer to different times. Can you provide the other log for each time so I can do a compare and contrast? Cheers, Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
RE: New isapi_redirect.dll has problems
Hi; Well it's been running for almost 24 hours and the only error is (got this 10 times) below. I will turn off debug and see if that causes it to come back. [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_isapi_plugin.c (835): Default redirection of / [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (449): Attempting to map URI '/' from 9 maps [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/WindwardReportsServlet/*' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/WindwardReportsJsp/*' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/forums/*' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/store/*' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/track/*' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/*.faces' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/forums' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/store' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/*.jsp' [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_isapi_plugin.c (845): check if [/] is points to the web-inf directory [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_isapi_plugin.c (948): [/] is not a servlet url [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_worker.c (111): did not find a worker ajp13 [Thu Feb 16 11:37:46 2006] [1680:2112] [debug] jk_isapi_plugin.c (1024): could not get a worker for name ajp13 [Thu Feb 16 11:37:46 2006] [1680:2112] [error] jk_isapi_plugin.c (1049): could not get a worker for name ajp13 [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_isapi_plugin.c (762): Filter started [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_isapi_plugin.c (828): Virtual Host redirection of /www.enemynations.com/ [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (449): Attempting to map URI '/www.enemynations.com/' from 9 maps [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/WindwardReportsServlet/*' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/WindwardReportsJsp/*' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/forums/*' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/store/*' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/track/*' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/*.faces' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/forums' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/store' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_uri_worker_map.c (461): Attempting to map context URI '/*.jsp' [Thu Feb 16 11:37:47 2006] [1680:2112] [debug] jk_isapi_plugin.c (835): Default redirection of / David Thielen www.windwardreports.com 303-499-2544 -Original Message- From: Mark Thomas [mailto:[EMAIL PROTECTED] Sent: Wednesday, February 15, 2006 12:46 PM To: Tomcat Users List Subject: Re: New isapi_redirect.dll has problems One more thing, turn up the logging level to debug and post the sequence of log messages associated with one of these odd URLs. Cheers, Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED] - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
RE: New isapi_redirect.dll has problems
Hi; Ok, I went back to Info and it is happening again. I think it's the logging because the IIS logs don't match the isapi log. Not only does the list of files not match (these are the only places most of these filenames occur) but there are files listed in the isapi log that never appear in the IIS log. Here is the isapi log (part): [Thu Feb 16 14:22:45 2006] [error] jk_isapi_plugin.c (1049): could not get a worker for name ajp13 [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/experiment.htm is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/comments.htm is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/editorials.htm is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/articles.htm is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/\ is invalid. Uri must start with / [Thu Feb 16 17:57:49 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/index.htm is invalid. Uri must start with / [Thu Feb 16 17:57:50 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/ is invalid. Uri must start with / [Thu Feb 16 17:57:50 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.barbiesciencefair.com/26elett.html is invalid. Uri must start with / Here is the only IIS log with some of the same file names: 2006-02-16 22:19:01 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/26elett.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:01 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/16eedit.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:02 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/18elett.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:02 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/01eedit.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:02 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/16elett.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:02 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/edits0221b.htm - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:07 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/04egw.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:07 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/05elett.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 2006-02-16 22:19:09 W3SVC1915441627 JASMINE 192.168.200.10 GET /barbie/03elett.html - 80 - 38.118.42.38 Mozilla/4.0+(compatible;+MSIE+6.0;+Windows+XP) - http://www.thielen.com/barbie/editorials.htm www.thielen.com 200 0 0 ??? - thanks - dave - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
Re: New isapi_redirect.dll has problems
David Thielen wrote: Hi; I checked the registry - it's using the workers.properties.minimal I believe (but I would be happier if it logged the files it uses). The problem with the urls it should not touch only showed up with the new version from Mark - that never happened before. As to the thread count, if someone tells me how to raise this, I will do so. But we get very low volume on this so I would be surprised if that is it. Any other ideas anyone? Can you post the following: worker.properties the AJP connector element from server.xml Also, are you able to provide a test case that reproduces the errors you are seeing? Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
Re: New isapi_redirect.dll has problems
One more thing, turn up the logging level to debug and post the sequence of log messages associated with one of these odd URLs. Cheers, Mark - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
RE: New isapi_redirect.dll has problems
Hi; I checked the registry - it's using the workers.properties.minimal I believe (but I would be happier if it logged the files it uses). The problem with the urls it should not touch only showed up with the new version from Mark - that never happened before. As to the thread count, if someone tells me how to raise this, I will do so. But we get very low volume on this so I would be surprised if that is it. Any other ideas anyone? Thanks - dave David Thielen www.windwardreports.com 303-499-2544 -Original Message- From: Ian Buzer [mailto:[EMAIL PROTECTED] Sent: Tuesday, February 14, 2006 12:21 AM To: 'Tomcat Users List' Subject: RE: New isapi_redirect.dll has problems OK, first I'll point out that I'm pretty new to Tomcat myself workers.properties.minimal: Is jk even using this config file? Normally it would use workers.properties unless it was configured otherwise. [Mon Feb 13 07:56:49 2006] [info] jk_ajp_common.c (1248): Error connecting to the Tomcat process. These errors suggest that jk is sending threads to tomcat, but tomcat does not have enough threads to provide a response. You might want to try adjusting the backlog, maxThreads and all the other threads properties for your connector in /conf/server.xml I've noticed that if jk cannot receive any more threads from the web server (worker.ajp13w.cachesize too small) or tomcat cannot respond to all the threads that are sent to it (maxThreads too small), it just doesn't seem to respond correctly, leading either to a host not available error in IE or a blank page in Firefox. I personally feel that it would be better if jk could respond with some kind of 500 error. [Mon Feb 13 17:03:09 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.windwardreports.com/root.htm?source=googleid=540 is invalid. Uri must start with / This is a bit weird. Is your web server doing any URL rewriting? You haven't got any links in your application that might end up looking like this: http://www.somehost.com/http://www.windwardreports.com/root.htm?... or even this: /http://www.windwardreports.com/root.htm?... Ian - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED] - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]
RE: New isapi_redirect.dll has problems
OK, first I'll point out that I'm pretty new to Tomcat myself workers.properties.minimal: Is jk even using this config file? Normally it would use workers.properties unless it was configured otherwise. [Mon Feb 13 07:56:49 2006] [info] jk_ajp_common.c (1248): Error connecting to the Tomcat process. These errors suggest that jk is sending threads to tomcat, but tomcat does not have enough threads to provide a response. You might want to try adjusting the backlog, maxThreads and all the other threads properties for your connector in /conf/server.xml I've noticed that if jk cannot receive any more threads from the web server (worker.ajp13w.cachesize too small) or tomcat cannot respond to all the threads that are sent to it (maxThreads too small), it just doesn't seem to respond correctly, leading either to a host not available error in IE or a blank page in Firefox. I personally feel that it would be better if jk could respond with some kind of 500 error. [Mon Feb 13 17:03:09 2006] [warn] jk_uri_worker_map.c (429): Uri http://www.windwardreports.com/root.htm?source=googleid=540 is invalid. Uri must start with / This is a bit weird. Is your web server doing any URL rewriting? You haven't got any links in your application that might end up looking like this: http://www.somehost.com/http://www.windwardreports.com/root.htm?... or even this: /http://www.windwardreports.com/root.htm?... Ian - To unsubscribe, e-mail: [EMAIL PROTECTED] For additional commands, e-mail: [EMAIL PROTECTED]