[svn.haxx.se] · SVN Dev · SVN Users · SVN Org · TSVN Dev · TSVN Users · Subclipse Dev · Subclipse Users · this month's index

three locks and apache restart

From: Potts, Michael _at_ AS <_at_>
Date: 2007-03-13 18:27:31 CET

Hello,

I've run into an interesting situation (I think) with apache/svn.
We've been using subversion for over two years
and have been very happy with it.

Our server details are: Windows 2003 Server, svn 1.3.2 (r19776),
and apache 2.0.54, SSL required, and authenticated via SSPI.
Clients are: svn 1.3.2 (r19776) and TortoiseSVN 1.3.5 (Build6804).

I believe that users have (occasionally) been able to restart apache
by simply clicking on a link.
We've only seen about a dozen sets of these (total) for all of 2006,
with one particular user causing 5 sets of these restarts in 1 day.
That particular user did not know svn, he was clicking
(in outlook, I believe) on a document-link e-mailed to him.

When I logged into the server, windows reported that an apache error
occurred at 2:51:08pm, and then reported another at 2:51:57pm.
I forgot to screen capture those dialogs.
I did capture the SSL and error logs from apache, added below.
I've tried to hand abbreviate the data in the SSL log,
so any inconsistencies are mine.

What looks strange to me is that there are three LOCKS in the log,
followed approx. one minute later by three UNLOCKS.
The LOCK times are exact with the times that windows reported,
while the UNLOCK times are slightly skewed from windows by six seconds.

The apache error log also seems to show two restarts,
but they are at 2:51:56 and at 2:52:02. Strange.
I believe the apache exit codes translate to 0xC00000005.
This user reported that it took "some time" for his doc to be returned.
(There is a GET near the bottom of the SSL log.)

We will probably move to 1.4.3 when the windows setup.exe comes out.
I'm stuck as to what is going on here,
and figured that it was time to ask about this situation.

Sorry about the long post. Anybody have any ideas?

-Mike

3_Lock_SSL_Log.
[14:51:07] .56.169 SSLv3 RC4-MD5 "GET /svn/sd/etc/code.py HTTP/1.1"
20008
[14:51:08] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/StructDefs.h HTTP/1.1" 878
[14:51:08] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/!svn/vcc/default HTTP/1.1" 414
[14:51:08] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/bln/12927 HTTP/1.1" 473
[14:51:08] .55.241 SSLv3 RC4-MD5 "LOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 550
[14:51:08] .55.241 SSLv3 RC4-MD5 "LOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 550
[14:51:08] .55.241 SSLv3 RC4-MD5 "LOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 419
[14:51:08] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/SAStructDefins.h HTTP/1.1" 878
[14:51:09] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/vcc/default HTTP/1.1" 473
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/bc/12927/branches/ESAStructDefs.h HTTP/1.1" 892
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/branches/ESAStructDefs.h HTTP/1.1" 878
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/vcc/default HTTP/1.1" 473
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/bc/12927/branches/ESAStructDefs.h HTTP/1.1" 2038
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/branches/dev/ESAStructDefs.h HTTP/1.1" 878
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/vcc/default HTTP/1.1" 473
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/!svn/bc/12927/branches/ESAStructDefs.h HTTP/1.1" 565
[14:51:53] .63.153 TLSv1 DHE-RSA-AES256-SHA "GET
/svn/sd/src/!svn/bc/12927/branches/ESAStructDefs.h HTTP/1.1" 21552
[14:52:03] .55.241 SSLv3 RC4-MD5 "UNLOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 550
[14:52:03] .55.241 SSLv3 RC4-MD5 "UNLOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 550
[14:52:03] .55.241 SSLv3 RC4-MD5 "UNLOCK /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" -
[14:52:03] .55.241 SSLv3 RC4-MD5 "GET /svn/sd/docs/00302007601_TC.doc
HTTP/1.1" 582144
[14:52:36] .48.30 TLSv1 DHE-RSA-AES256-SHA "PROPFIND
/svn/sd/src/FIFO/r12726 HTTP/1.1" 778

3_Lock_ERROR_Log.
[14:51:56] [notice] Parent: child process exited with status 3221225477
-- Restarting.
[14:51:57] [notice] Apache/2.0.54 (Win32) DAV/2 mod_ssl/2.0.54
OpenSSL/0.9.8 PHP/5.0.4 SVN/1.3.2 mod_auth_sspi/1.0.1 configured --
resuming normal operations
[14:51:57] [notice] Server built: Apr 16 2005 14:25:31
[14:51:57] [notice] Parent: Created child process 4256
[14:51:57] [notice] Child 4256: Child process is running
[14:51:57] [notice] Child 4256: Acquired the start mutex.
[14:51:57] [notice] Child 4256: Starting 250 worker threads.
[14:52:02] [notice] Parent: child process exited with status 3221225477
-- Restarting.
[14:52:02] [notice] Apache/2.0.54 (Win32) DAV/2 mod_ssl/2.0.54
OpenSSL/0.9.8 PHP/5.0.4 SVN/1.3.2 mod_auth_sspi/1.0.1 configured --
resuming normal operations
[14:52:02] [notice] Server built: Apr 16 2005 14:25:31
[14:52:02] [notice] Parent: Created child process 1144
[14:52:03] [notice] Child 1144: Child process is running
[14:52:03] [notice] Child 1144: Acquired the start mutex.
[14:52:03] [notice] Child 1144: Starting 250 worker threads.

---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@subversion.tigris.org
For additional commands, e-mail: users-help@subversion.tigris.org
Received on Tue Mar 13 18:28:09 2007

This is an archived mail posted to the Subversion Users mailing list.

This site is subject to the Apache Privacy Policy and the Apache Public Forum Archive Policy.