Radius is running away with the CPU

David david at speedyquick.net
Tue Aug 14 22:31:25 CEST 2007


I found that when running radius -x to the console I see lines like the
following
WARNING: Unresponsive child (id 3074419616) for request 8978

I don't know what they mean. I see lines like 

Dropping conflicting packet from client Bogus:2377 - ID: 195 due to
unfinished request 8978 

above the Warning line but don't see where the original request is and don't
know if it matter?

I am not sure how to use strace I ran it on the pid of the radius server but
don't know what to make of its output. 

Below is a small excerpt of the output

Process 26228 attached - interrupt to quit
select(6, [3 4 5], NULL, NULL, {0, 980000}) = 1 (in [4], left {0, 760000})
time(NULL)                              = 1187123924
recvfrom(4, "\4\16\0\277w\7d\273\17\vh\0\371\311By\203\16#\30\6\6\0"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(3602),
sin_addr=inet_addr("192.168.1.45")}, [16]) = 191
write(1, "rad_recv: Accounting-Request pac"..., 86) = 86
time(NULL)                              = 1187123924
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {1, 0})  = 0 (Timeout)
time(NULL)                              = 1187123925
select(6, [3 4 5], NULL, NULL, {1, 0})  = 0 (Timeout)
time(NULL)                              = 1187123926
select(6, [3 4 5], NULL, NULL, {4, 0})  = 0 (Timeout)
time(NULL)                              = 1187123930
time(NULL)                              = 1187123930
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [3], left {1, 48000})
time(NULL)                              = 1187123934
recvfrom(3, "\1\32\0\225k\341\30\241T\335\330s\355Y\356%\372\222\330"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1460),
sin_addr=inet_addr("192.168.1.10")}, [16]) = 149
write(1, "rad_recv: Access-Request packet "..., 81) = 81
time(NULL)                              = 1187123934
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
time(NULL)                              = 1187123934
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
futex(0x7c37c8, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [4], left {4, 968000})
time(NULL)                              = 1187123934
recvfrom(4, "\4\33\0\222{G\204B\333\200x\226\265\35\3428yZ\371\21\6"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1460),
sin_addr=inet_addr("192.168.1.10")}, [16]) = 146
write(1, "rad_recv: Accounting-Request pac"..., 85) = 85
time(NULL)                              = 1187123934
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [4], left {3, 995000})
time(NULL)                              = 1187123935
recvfrom(4, "\4\33\0\222%\265\374M|\220;\255\0\251\215)\24\\\341J\6"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1460),
sin_addr=inet_addr("192.168.1.10")}, [16]) = 146
write(1, "rad_recv: Accounting-Request pac"..., 85) = 85
time(NULL)                              = 1187123935
write(1, "Dropping conflicting packet from"..., 94) = 94
time(NULL)                              = 1187123935
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [4], left {3, 991000})
time(NULL)                              = 1187123936
recvfrom(4, "\4\33\0\222P%\10\27\nB\4\20I\227\263\33V\210\17M\6\6\0"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1460),
sin_addr=inet_addr("192.168.1.10")}, [16]) = 146
write(1, "rad_recv: Accounting-Request pac"..., 85) = 85
time(NULL)                              = 1187123936
write(1, "Dropping conflicting packet from"..., 94) = 94
select(6, [3 4 5], NULL, NULL, {4, 0})  = 1 (in [4], left {1, 131000})
time(NULL)                              = 1187123939
recvfrom(4, "\4+\0\305\301\t\16\332\256\0\214\363\302]\0\332z\325\1"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1750),
sin_addr=inet_addr("192.168.1.30")}, [16]) = 197
write(1, "rad_recv: Accounting-Request pac"..., 86) = 86
time(NULL)                              = 1187123939
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
time(NULL)                              = 1187123939
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
select(6, [3 4 5], NULL, NULL, {1, 0})  = 0 (Timeout)
time(NULL)                              = 1187123940
time(NULL)                              = 1187123940
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [4], left {4, 83000})
time(NULL)                              = 1187123941
recvfrom(4, "\4,\0\302P\205\334\356\251w\202w\266\357\37\265\260\4\372"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1750),
sin_addr=inet_addr("192.168.1.30")}, [16]) = 194
write(1, "rad_recv: Accounting-Request pac"..., 86) = 86
time(NULL)                              = 1187123941
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
time(NULL)                              = 1187123941
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
time(NULL)                              = 1187123941
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
select(6, [3 4 5], NULL, NULL, {4, 0})  = 0 (Timeout)
time(NULL)                              = 1187123945
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {2, 0})  = 1 (in [4], left {1, 758000})
time(NULL)                              = 1187123946
recvfrom(4, "\4\17\0\304\337#\372#\245=\347F\\\220|\0045\321\221*\6"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(3602),
sin_addr=inet_addr("192.168.1.45")}, [16]) = 196
write(1, "rad_recv: Accounting-Request pac"..., 86) = 86
time(NULL)                              = 1187123946
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
time(NULL)                              = 1187123946
write(1, "WARNING: Unresponsive child (id "..., 61) = 61
futex(0xfb7990, FUTEX_WAKE, 2)          = 2
select(6, [3 4 5], NULL, NULL, {1, 0})  = 0 (Timeout)
time(NULL)                              = 1187123947
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {5, 0})  = 1 (in [3], left {4, 742000})
time(NULL)                              = 1187123947
recvfrom(3, "\1 \0\304\260%\241\17\315i\373q\206\360\346\247\214 at TC"...,
4096, 0, {sa_family=AF_INET, sin_port=htons(1109),
sin_addr=inet_addr("192.168.1.43")}, [16]) = 196
write(1, "rad_recv: Access-Request packet "..., 81) = 81
time(NULL)                              = 1187123947
futex(0xfb7990, FUTEX_WAKE, 1)          = 1
select(6, [3 4 5], NULL, NULL, {5, 0} <unfinished ...>







David





> -----Original Message-----
> From: 
> freeradius-users-bounces+david=speedyquick.net at lists.freeradiu
> s.org 
> [mailto:freeradius-users-bounces+david=speedyquick.net at lists.f
> reeradius.org] On Behalf Of Alan DeKok
> Sent: Tuesday, August 14, 2007 11:20 AM
> To: FreeRadius users mailing list
> Subject: Re: Radius is running away with the CPU
> 
> David wrote:
> > I am not intentionally/manually HUP'ing the server.  The problem 
> > happens pretty much as soon as I start the server.
> 
>   Well, something changed.  It worked before, didn't it?
> 
>   Find out what changed.  Run the server in debugging mode.  
> Use 'strace' to see what it's doing.
> 
>   Alan DeKok.
> -
> List info/subscribe/unsubscribe? See 
> http://www.freeradius.org/list/users.html
> 




More information about the Freeradius-Users mailing list