[OpenAFS] Problem with start of fileserver and volserver

Micha³ Dro¼dziewicz michal@drozdziewicz.pl
Tue, 06 May 2008 12:29:38 +0200


This is a multi-part message in MIME format.
--------------060004090009030700050603
Content-Type: text/plain; charset=ISO-8859-2; format=flowed
Content-Transfer-Encoding: 7bit

Hello,
I have a problem with my openafs server. After power outage fileserver 
and volserver (fs instance) does not start correctly.

File server reports in the logfile that it is starting but nothing more. 
  Volserver is quitting with code 1 because it can not connect to file 
server through port 2040 (I've straced this out).

Stracing fileserver givs only this (see attached file), but I do not 
know what this could possibly be.

Does anybody know how to turn debugging on for fileserver? Running it 
with -d 10 or any other number gives nothing more in the logfile.

This AFS server is running debian sarge. This is one of the 20 server's 
I have and this is the first time I have this kind of a problem. Any 
help would be appreciated.

-- 
xmpp/email: koniczynek@uaznia.net
xmpp/email: koniczynek@gmail.com

--------------060004090009030700050603
Content-Type: text/plain;
 name="fileserver_strace.log"
Content-Transfer-Encoding: 7bit
Content-Disposition: inline;
 filename="fileserver_strace.log"

[pid  4151] <... recvmsg resumed> {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.40.32")}, msg_iov(7)=[{"\201\346\215\206 5\373\4\0\0\0\1\0\0\0\0\0\0\0\30\2!\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\26\7\0\1\1\1\0\0\4\354\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.36.59")}, msg_iov(7)=[{"\244\226\212% \2T\364\0\0\0\1\0\0\0\0\0\0\0\261\2#\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0.gz\0\0\26<\0\0\5\244"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.36.59")}, msg_iov(2)=[{"\244\226\212% \2T\364\0\0\0\1\0\0\0\0\0\0\0\30\2 \0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\261\7\1\1\0\0\0\0\0\26<"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7003), sin_addr=inet_addr("172.22.0.195")}, msg_iov(7)=[{"\234\246\243\350\335\244!D\0\0\0\1\0\0\0\0\0\0\0\6\2\""..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\0\6\1\1\3\0\0\0\0\26<\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7003), sin_addr=inet_addr("172.22.0.195")}, msg_iov(2)=[{"\234\246\243\350\335\244!D\0\0\0\1\0\0\0\0\0\0\0\7\2!\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\6\7\0\1\0\0\0\0\26<\0\0"..., 37}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] gettimeofday({1210068110, 685443}, NULL) = 0
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.38.123")}, msg_iov(7)=[{"\204\250\260K _\357,\0\0\0\1\0\0\0\0\0\0\0\265\2#\0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0\4\1H\0\0\26<\0\0\5"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.38.123")}, msg_iov(2)=[{"\204\250\260K _\357,\0\0\0\1\0\0\0\0\0\0\0\30\2 \0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\265\7\1\1\0\0\0\0\0\26<"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7003), sin_addr=inet_addr("172.22.0.195")}, msg_iov(7)=[{"\234\246\243\350\335\244!D\0\0\0\1\0\0\0\0\0\0\0\7\2 \0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\6\7\1\1\0\0\0\0\0\26<\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] gettimeofday({1210068110, 906697}, NULL) = 0
[pid  4151] time(NULL)                  = 1210068110
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.39.186")}, msg_iov(7)=[{"H\36\245\350 H\36@\0\0\0.\0\0\0\0\0\0\10\210\2#\0\0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0\1\1\1\0\0\4\354\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.39.186")}, msg_iov(2)=[{"H\36\245\350 H\36@\0\0\0.\0\0\0\0\0\0\0\f\2 \0\0\0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\10\210\7\1\1\0\0\0\0\0\26"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.51.56")}, msg_iov(7)=[{"\267\25\243\30 ~JT\0\0\0\1\0\0\0\0\0\0\0\6\2#\0\0\0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0\1\0\0\0\0\4\354\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.51.56")}, msg_iov(2)=[{"\267\25\243\30 ~JT\0\0\0\1\0\0\0\0\0\0\0\5\2 \0\0\0\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\6\7\1\1\0\0\0\0\0\26<\0"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] recvmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.31.103")}, msg_iov(7)=[{"\265\274\377o \250\355,\0\0\0\1\0\0\0\0\0\0\0\3\2#\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0\0\0\0\0\0\4\354\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.31.103")}, msg_iov(2)=[{"\265\274\377o \250\355,\0\0\0\1\0\0\0\0\0\0\0\2\2 \0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\3\7\1\1\0\0\0\0\0\26<\0"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] recvmsg(5,  <unfinished ...>
[pid  4152] <... futex resumed> )       = -1 ETIMEDOUT (Connection timed out)
[pid  4152] futex(0x80fc740, FUTEX_WAKE, 1) = 0
[pid  4152] gettimeofday({1210068111, 212038}, NULL) = 0
[pid  4152] gettimeofday({1210068111, 212073}, NULL) = 0
[pid  4152] gettimeofday({1210068111, 212105}, NULL) = 0
[pid  4152] clock_gettime(CLOCK_REALTIME, {1210068111, 212139000}) = 0
[pid  4152] futex(0x80fc7d0, FUTEX_WAIT, 84, {0, 959569000} <unfinished ...>ons(7001), sin_addr=inet_addr("172.17.31.103")}, msg_iov(7)=[{"\265\274\377o \250\355,\0\0\0\1\0\0\0\0\0\0\0\3\2#\0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\0\0\0\0\0\6\0\0\0\0\0\0\4\354\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1416}, {"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 1420}], msg_controllen=0, msg_flags=0}, 0) = 65
[pid  4151] sendmsg(5, {msg_name(16)={sa_family=AF_INET, sin_port=htons(7001), sin_addr=inet_addr("172.17.31.103")}, msg_iov(2)=[{"\265\274\377o \250\355,\0\0\0\1\0\0\0\0\0\0\0\2\2 \0\0"..., 28}, {"\0\0\0\0\0\0\0\1\0\0\0\1\0\0\0\3\7\1\1\0\0\0\0\0\26<\0"..., 38}], msg_controllen=0, msg_flags=0}, 0) = 66
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] time(NULL)                  = 1210068111
[pid  4151] recvmsg(5,  <unfinished ...>
[pid  4152] <... futex resumed> )       = -1 ETIMEDOUT (Connection timed out)
[pid  4152] futex(0x80fc740, FUTEX_WAKE, 1) = 0
[pid  4152] gettimeofday({1210068111, 212038}, NULL) = 0
[pid  4152] gettimeofday({1210068111, 212073}, NULL) = 0
[pid  4152] gettimeofday({1210068111, 212105}, NULL) = 0
[pid  4152] clock_gettime(CLOCK_REALTIME, {1210068111, 212139000}) = 0
[pid  4152] futex(0x80fc7d0, FUTEX_WAIT, 84, {0, 959569000} <unfinished ...>

--------------060004090009030700050603--