What's in FileLog? To up the debugging, use "kill -TSTP" a few times
(3 should be enough; 2, too little)
On Tue, May 6, 2008 at 6:29 AM, Michał Droździewicz
<[EMAIL PROTECTED]> wrote:
> 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: [EMAIL PROTECTED]
> xmpp/email: [EMAIL PROTECTED]
>
> [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 [EMAIL PROTECTED]"...,
> 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 [EMAIL PROTECTED] \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
> ...>
>
>
:§ T˘ú&j)b b˛ÓŠzpJ)ߢ^§ě˘¸!śÚl˙ůb˛Ű(ĽéÚ~Ę+ůYůb˛Ř§~čĽéÚ~ȧ~