FreeRADIUS ( 2 ) and SNMP - "broken pipe error" - password not accepted

Edvin Seferovic edvin.seferovic at kolp.at
Sun Dec 2 09:53:07 CET 2007 

Hello,

I have set up FreeRADIUS ( pre2 ) and activated SNMP ( rebuilt it with
--with-snmp ... ). The snmpd is also configured with the smuxpeer and the
correct password, but password seems to be rejected. I am using snmpd-5.3.1
on Debian Etch ( AMD64 ). Both passwords are the same. Does anyone have an
idea what might be wrong?

Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: Listening on authentication address
172.19.10.3 port 1812 as server mac-auth
Sun Dec  2 09:47:20 2007 : Debug: Listening on accounting address
172.19.10.3 port 1813 as server mac-auth
Sun Dec  2 09:47:20 2007 : Debug: Listening on SNMP SMUX with OID
.1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX read len: 3
Sun Dec  2 09:47:20 2007 : Debug: SMUX message received type: 0 rest len: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX Unknown type: 0
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX connection closed: 12
Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX read len: 3
Sun Dec  2 09:47:20 2007 : Debug: SMUX message received type: 0 rest len: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX Unknown type: 0
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX connection closed: 12
Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX read len: 3
Sun Dec  2 09:47:20 2007 : Debug: SMUX message received type: 0 rest len: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX Unknown type: 0
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX connection closed: 12
Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX read len: 3
Sun Dec  2 09:47:20 2007 : Debug: SMUX message received type: 0 rest len: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX Unknown type: 0
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX connection closed: 12
Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX read len: 3
Sun Dec  2 09:47:20 2007 : Debug: SMUX message received type: 0 rest len: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX Unknown type: 0
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: SMUX read start
Sun Dec  2 09:47:20 2007 : Debug: SMUX connection closed: 12
Sun Dec  2 09:47:20 2007 : Debug: SMUX connect try 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX open oid:
1.3.6.1.4.1.11344.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX open progname: radiusd
Sun Dec  2 09:47:20 2007 : Debug: SMUX open password: rad
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.1.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX SMUX register oid:
1.3.6.1.2.1.67.2.1.1.1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register priority: -1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register operation: 1
Sun Dec  2 09:47:20 2007 : Debug: SMUX register message send failed: Broken
pipe
Sun Dec  2 09:47:20 2007 : Debug: Ready to process requests.
Sun Dec  2 09:47:20 2007 : Debug: Exiting...

Dec  2 09:34:22 sphinx snmpd[8966]: [smux_accept] Calling accept() 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_accept] accepted fd 10 from
127.0.0.1:37448 
Dec  2 09:34:22 sphinx snmpd[8966]: dumpx_recv:
Dec  2 09:34:22 sphinx snmpd[8966]: 02 01 00 
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: dumpv_recv:
Dec  2 09:34:22 sphinx snmpd[8966]:   Integer:^I0 (0x00) 
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 763: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] version 0, len 26,
type 2 
Dec  2 09:34:22 sphinx snmpd[8966]: dumpx_recv:
Dec  2 09:34:22 sphinx snmpd[8966]: 06 0A 2B 06 01 04 01 D8 50 01 01 01 
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: dumpv_recv:
Dec  2 09:34:22 sphinx snmpd[8966]:   ObjID: 
Dec  2 09:34:22 sphinx snmpd[8966]: SNMPv2-SMI::enterprises.11344.1.1.1
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 776: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] smux peer:
SNMPv2-SMI::enterprises.11344.1.1.1 
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 778: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] len 14, type 6 
Dec  2 09:34:22 sphinx snmpd[8966]: dumpx_recv:
Dec  2 09:34:22 sphinx snmpd[8966]: 04 07 72 61 64 69 75 73 64 
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: dumpv_recv:
Dec  2 09:34:22 sphinx snmpd[8966]:   String:^Iradiusd 
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 790: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] smux peer descr: 
Dec  2 09:34:22 sphinx snmpd[8966]: r
Dec  2 09:34:22 sphinx snmpd[8966]: a
Dec  2 09:34:22 sphinx snmpd[8966]: d
Dec  2 09:34:22 sphinx snmpd[8966]: i
Dec  2 09:34:22 sphinx snmpd[8966]: u
Dec  2 09:34:22 sphinx snmpd[8966]: s
Dec  2 09:34:22 sphinx snmpd[8966]: d
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 795: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] len 5, type 4 
Dec  2 09:34:22 sphinx snmpd[8966]: dumpx_recv:
Dec  2 09:34:22 sphinx snmpd[8966]: 04 03 72 61 64 
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: dumpv_recv:
Dec  2 09:34:22 sphinx snmpd[8966]:   String:^Irad 
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 808: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] smux peer passwd: 
Dec  2 09:34:22 sphinx snmpd[8966]: r
Dec  2 09:34:22 sphinx snmpd[8966]: a
Dec  2 09:34:22 sphinx snmpd[8966]: d
Dec  2 09:34:22 sphinx snmpd[8966]:  
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_open_process():
mibgroup/smux/smux.c, 813: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_open_process] len 0, type 4 
Dec  2 09:34:22 sphinx snmpd[8966]: refused smux peer: oid
SNMPv2-SMI::enterprises.11344.1.1.1, descr radiusd 
Dec  2 09:34:22 sphinx snmpd[8966]: trace: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux_send_close(): mibgroup/smux/smux.c,
844: 
Dec  2 09:34:22 sphinx snmpd[8966]: smux: 
Dec  2 09:34:22 sphinx snmpd[8966]: [smux_close] sending close to fd 10,
reason 5

Regards,
E:S

More information about the Freeradius-Users mailing list