Hi ..i'm trying to send INVITE message between alice and bob. and i want to call control using b2bua_radius.py (sippy http://b2bua.org/wiki/B2BUADocumentation) i.e i want call will disconnect after 30 second and radius will generate Start/Stop . i did all the setup and also i don't want to redius server Authentication/Authorization because the my sip proxy i.e open-ims already did Authentication/Authorization sing Md5-digest so i want bypass. so i'm using following command i'm not able to set -s flag for static routing and what will be value for this like b2bua_radius.py ... -s '200110508667@b2bua.org;cli=16046288900;rid=-1;expires=30;np_expires=5;ash=Name%3AValue' . or where radius get for this routing for dynamic routing like this h323-ivr-in = 'Routing:200110508667@b2bua.org;cli=16046288900;rid=-1;expires=30;np_expires=5;ash=Name%3AValue' [root@ngpchn sippy]# python b2bua_radius.py -fDU -l 172.18.3.52 -p 5065 -a 172.18.3.52 -k 3 -A 2 -m 30 i'm not pretty much sure about flag -s and how i will. after successfully running all these component i found when I INVITE for alice to bob i found SIP/2.0 500 Internal Server Error (2) then call able to connect but call not able to disconnect after 30 second e.i my requirement another problem is when i hang up call after 30(manually ) only one side call is dissconnet and another side is continue .. i'm not able rectify the problem. can any help me regarding resolve this problem also what i doing roungh specially senting with -s. i'm attaching log file also.... waiting for positive responce.. Thanks ~Suresh [root@ngpchn sippy]# python b2bua_radius.py -fD -l 172.18.3.52 -p 5065 -a 172.18.3.52 -k 3 -A 2 -m 30 14 Jan 16:03:13/GLOBAL/b2bua: RECEIVED message from 172.18.3.52:6060: INVITE sip:bob@info-spectrum.com SIP/2.0 Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Route: <sip:172.18.3.52:5065;lr>, <sip:iscmark@scscf.info-spectrum.com:6060;lr;s=1;h=0;d=0;a=7369703a616c69636540696e666f2d737065637472756d2e636f6d> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com> Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Max-Forwards: 15 Allow: INVITE,ACK,CANCEL,BYE,MESSAGE,OPTIONS,UPDATE,NOTIFY,PRACK Contact: <sip:alice@172.18.1.197:1976;transport=udp>;expires=1000 User-Agent: Mercuro IMS Client Beta (4.0.1011.0) Supported: sdp-anat Content-Type: application/sdp P-Access-Network-Info: 3GPP-UTRAN-TDD;utran-cell-id-3gpp=00000000 Privacy: none Content-Length: 231 P-Asserted-Identity: <sip:alice@info-spectrum.com> P-Charging-Vector: icid-value="P-CSCFabcd496dbf6900000026";icid-generated-at=172.18.3.52;orig-ioi="info-spectrum.com" Timestamp: 1231929193 v=0 o=- 3344 3344 IN IP4 172.18.1.197 s=Mercuro IMS Client Session t=0 0 m=audio 31562 RTP/AVP 0 8 101 c=IN IP4 172.18.1.197 a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 14 Jan 16:03:13/GLOBAL/b2bua: SENDING message to 172.18.3.52:6060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com> Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Server: Sippy B2BUA (RADIUS) 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: sending AAA request: User-Name = '172.18.3.52' Password = 'cisco' Calling-Station-Id = 'alice' Called-Station-Id = 'bob' h323-conf-id = 'B8377C92 DF6642BB 25A7C3A3 D4E529CE' call-id = '1231924661763@172.18.1.197' h323-remote-address = '172.18.3.52' h323-session-protocol = 'sipv2' 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: AAA request accepted (delay is 0.030), processing response: 14 Jan 16:03:13/GLOBAL/b2bua: SENDING message to 172.18.3.52:6060: SIP/2.0 500 Internal Server Error (2) Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com>;tag=d63760e38a4879ada2cf7f5c137369ac Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Server: Sippy B2BUA (RADIUS) 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: sending Acct Stop (Answer): h323-call-origin = 'answer' h323-call-type = 'VoIP' h323-session-protocol = 'sipv2' h323-setup-time = '10:33:13.000 GMT Wed Jan 14 2009' User-Name = '172.18.3.52' Calling-Station-Id = 'alice' Called-Station-Id = 'bob' h323-conf-id = 'B8377C92 DF6642BB 25A7C3A3 D4E529CE' call-id = '1231924661763@172.18.1.197' Acct-Session-Id = '1231924661763@172.18.1.197' h323-remote-address = '172.18.3.52' h323-disconnect-time = '10:33:13.000 GMT Wed Jan 14 2009' h323-connect-time = '10:33:13.000 GMT Wed Jan 14 2009' Acct-Session-Time = '0' h323-disconnect-cause = '29' Acct-Status-Type = 'Stop' 14 Jan 16:03:13/GLOBAL/b2bua: RECEIVED message from 172.18.3.52:6060: ACK sip:bob@info-spectrum.com SIP/2.0 Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.0 From: <sip:alice@info-spectrum.com>;tag=11382 Call-ID: 1231924661763@172.18.1.197 To: <sip:bob@info-spectrum.com>;tag=d63760e38a4879ada2cf7f5c137369ac CSeq: 901 ACK Route: <sip:orig@scscf.info-spectrum.com:6060;lr> User-Agent: InfoIMS(1.0.0-dev1 InfoIMS (i386/linux)) Content-Length: 0 14 Jan 16:03:13/GLOBAL/b2bua: RECEIVED message from 172.18.3.52:6060: INVITE sip:bob@info-spectrum.com SIP/2.0 Record-Route: <sip:mt@scscf.info-spectrum.com:6060;lr> Route: <sip:172.18.3.52:5065;lr>, <sip:iscmark@scscf.info-spectrum.com:6060;lr;s=1;h=0;d=1;a=7369703a626f6240696e666f2d737065637472756d2e636f6d> Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.9904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.1 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com> Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Max-Forwards: 14 Allow: INVITE,ACK,CANCEL,BYE,MESSAGE,OPTIONS,UPDATE,NOTIFY,PRACK Contact: <sip:alice@172.18.1.197:1976;transport=udp>;expires=1000 User-Agent: Mercuro IMS Client Beta (4.0.1011.0) Supported: sdp-anat Content-Type: application/sdp P-Access-Network-Info: 3GPP-UTRAN-TDD;utran-cell-id-3gpp=00000000 Privacy: none Content-Length: 231 P-Asserted-Identity: <sip:alice@info-spectrum.com> P-Charging-Vector: icid-value="P-CSCFabcd496dbf6900000026";icid-generated-at=172.18.3.52;orig-ioi="info-spectrum.com" Timestamp: 1231929193 v=0 o=- 3344 3344 IN IP4 172.18.1.197 s=Mercuro IMS Client Session t=0 0 m=audio 31562 RTP/AVP 0 8 101 c=IN IP4 172.18.1.197 a=rtpmap:0 PCMU/8000/1 a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 14 Jan 16:03:13/GLOBAL/b2bua: SENDING message to 172.18.3.52:6060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.9904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.1 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 Record-Route: <sip:mt@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com> Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Server: Sippy B2BUA (RADIUS) 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: sending AAA request: User-Name = '172.18.3.52' Password = 'cisco' Calling-Station-Id = 'alice' Called-Station-Id = 'bob' h323-conf-id = '7EAC4F20 651D23F0 75C1FFA6 E6EE4BFA' call-id = '1231924661763@172.18.1.197' h323-remote-address = '172.18.3.52' h323-session-protocol = 'sipv2' 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: AAA request accepted (delay is 0.025), processing response: 14 Jan 16:03:13/GLOBAL/b2bua: SENDING message to 172.18.3.52:6060: SIP/2.0 500 Internal Server Error (2) Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.9904bbf3.0 Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.8904bbf3.1 Via: SIP/2.0/UDP 172.18.3.52:4060;branch=z9hG4bKa35e.28aed705.0 Via: SIP/2.0/UDP 172.18.1.197:1976;rport=1976;branch=z9hG4bK7376 Record-Route: <sip:mt@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@scscf.info-spectrum.com:6060;lr> Record-Route: <sip:mo@pcscf.info-spectrum.com:4060;lr> From: <sip:alice@info-spectrum.com>;tag=11382 To: <sip:bob@info-spectrum.com>;tag=4d778ee83fef7504d306e1345f51b4dd Call-ID: 1231924661763@172.18.1.197 CSeq: 901 INVITE Server: Sippy B2BUA (RADIUS) 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: sending Acct Stop (Answer): h323-call-origin = 'answer' h323-call-type = 'VoIP' h323-session-protocol = 'sipv2' h323-setup-time = '10:33:13.000 GMT Wed Jan 14 2009' User-Name = '172.18.3.52' Calling-Station-Id = 'alice' Called-Station-Id = 'bob' h323-conf-id = '7EAC4F20 651D23F0 75C1FFA6 E6EE4BFA' call-id = '1231924661763@172.18.1.197' Acct-Session-Id = '1231924661763@172.18.1.197' h323-remote-address = '172.18.3.52' h323-disconnect-time = '10:33:13.000 GMT Wed Jan 14 2009' h323-connect-time = '10:33:13.000 GMT Wed Jan 14 2009' Acct-Session-Time = '0' h323-disconnect-cause = '29' Acct-Status-Type = 'Stop' 14 Jan 16:03:13/GLOBAL/b2bua: RECEIVED message from 172.18.3.52:6060: ACK sip:bob@info-spectrum.com SIP/2.0 Via: SIP/2.0/UDP 172.18.3.52:6060;branch=z9hG4bKa35e.9904bbf3.0 From: <sip:alice@info-spectrum.com>;tag=11382 Call-ID: 1231924661763@172.18.1.197 To: <sip:bob@info-spectrum.com>;tag=4d778ee83fef7504d306e1345f51b4dd CSeq: 901 ACK User-Agent: InfoIMS(1.0.0-dev1 InfoIMS (i386/linux)) Content-Length: 0 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: Acct/answer request accepted (delay is 0.083) 14 Jan 16:03:13/1231924661763@172.18.1.197/b2bua: Acct/answer request accepted (delay is 0.071) GC is invoked, 0 calls in map 0 client, 0 server transactions in memory -------------------------------------------------------------------------------------- [root@ngpchn raddb]# radiusd -X FreeRADIUS Version 2.1.3, for host i686-pc-linux-gnu, built on Jan 13 2009 at 11:56:22 Copyright (C) 1999-2008 The FreeRADIUS server project and contributors. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. You may redistribute copies of FreeRADIUS under the terms of the GNU General Public License v2. Starting - reading configuration files ... including configuration file /etc/raddb/radiusd.conf including configuration file /etc/raddb/proxy.conf including configuration file /etc/raddb/clients.conf including files in directory /etc/raddb/modules/ including configuration file /etc/raddb/modules/mac2vlan including configuration file /etc/raddb/modules/counter including configuration file /etc/raddb/modules/passwd including configuration file /etc/raddb/modules/mschap including configuration file /etc/raddb/modules/ldap including configuration file /etc/raddb/modules/wimax including configuration file /etc/raddb/modules/sradutmp including configuration file /etc/raddb/modules/etc_group including configuration file /etc/raddb/modules/unix including configuration file /etc/raddb/modules/radutmp including configuration file /etc/raddb/modules/digest including configuration file /etc/raddb/modules/exec including configuration file /etc/raddb/modules/policy including configuration file /etc/raddb/modules/detail.example.com including configuration file /etc/raddb/modules/detail.log including configuration file /etc/raddb/modules/perl including configuration file /etc/raddb/modules/mac2ip including configuration file /etc/raddb/modules/ippool including configuration file /etc/raddb/modules/inner-eap including configuration file /etc/raddb/modules/acct_unique including configuration file /etc/raddb/modules/sqlcounter_expire_on_login including configuration file /etc/raddb/modules/pap including configuration file /etc/raddb/modules/smbpasswd including configuration file /etc/raddb/modules/expr including configuration file /etc/raddb/modules/linelog including configuration file /etc/raddb/modules/expiration including configuration file /etc/raddb/modules/files including configuration file /etc/raddb/modules/attr_rewrite including configuration file /etc/raddb/modules/logintime including configuration file /etc/raddb/modules/echo including configuration file /etc/raddb/modules/always including configuration file /etc/raddb/modules/chap including configuration file /etc/raddb/modules/realm including configuration file /etc/raddb/modules/preprocess including configuration file /etc/raddb/modules/pam including configuration file /etc/raddb/modules/krb5 including configuration file /etc/raddb/modules/detail including configuration file /etc/raddb/modules/checkval including configuration file /etc/raddb/modules/attr_filter including configuration file /etc/raddb/modules/sql_log including configuration file /etc/raddb/eap.conf including configuration file /etc/raddb/sql.conf including configuration file /etc/raddb/sql/mysql/dialup.conf including configuration file /etc/raddb/sql/mysql/counter.conf including configuration file /etc/raddb/policy.conf including files in directory /etc/raddb/sites-enabled/ including configuration file /etc/raddb/sites-enabled/default including configuration file /etc/raddb/sites-enabled/inner-tunnel including dictionary file /etc/raddb/dictionary main { prefix = "/usr/local" localstatedir = "/var" logdir = "/var/log/radius" libdir = "/usr/local/lib" radacctdir = "/var/log/radius/radacct" hostname_lookups = no max_request_time = 30 cleanup_delay = 5 max_requests = 1024 allow_core_dumps = no pidfile = "/var/run/radiusd/radiusd.pid" checkrad = "/usr/local/sbin/checkrad" debug_level = 0 proxy_requests = yes log { stripped_names = no auth = no auth_badpass = no auth_goodpass = no } security { max_attributes = 200 reject_delay = 1 status_server = yes } } client 172.18.3.52 { ipaddr = 172.18.3.52 require_message_authenticator = no secret = "testing123" shortname = "local" nastype = "portslave" login = "!root" password = "nopassword" } client 172.18.1.197 { ipaddr = 172.18.1.197 require_message_authenticator = no secret = "testing123" shortname = "NTRadPing" nastype = "portslave" login = "!root" password = "nopassword" } radiusd: #### Loading Realms and Home Servers #### proxy server { retry_delay = 5 retry_count = 3 default_fallback = no dead_time = 120 wake_all_if_all_dead = no } home_server localhost { ipaddr = 127.0.0.1 port = 1812 type = "auth" secret = "testing123" response_window = 20 max_outstanding = 65536 zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 num_answers_to_alive = 3 num_pings_to_alive = 3 revive_interval = 120 status_check_timeout = 4 } home_server_pool my_auth_failover { type = fail-over home_server = localhost } realm example.com { auth_pool = my_auth_failover } realm info-spectrum.com { nostrip authhost = LOCAL accthost = LOCAL } realm LOCAL { } radiusd: #### Instantiating modules #### instantiate { Module: Linked to module rlm_exec Module: Instantiating exec exec { wait = no input_pairs = "request" shell_escape = yes } Module: Linked to module rlm_expr Module: Instantiating expr Module: Linked to module rlm_expiration Module: Instantiating expiration expiration { reply-message = "Password Has Expired " } Module: Linked to module rlm_logintime Module: Instantiating logintime logintime { reply-message = "You are calling outside your allowed timespan " minimum-timeout = 60 } } radiusd: #### Loading Virtual Servers #### server inner-tunnel { modules { Module: Checking authenticate {...} for more modules to load Module: Linked to module rlm_pap Module: Instantiating pap pap { encryption_scheme = "auto" auto_header = no } Module: Linked to module rlm_chap Module: Instantiating chap Module: Linked to module rlm_mschap Module: Instantiating mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = no } Module: Linked to module rlm_unix Module: Instantiating unix unix { radwtmp = "/var/log/radius/radwtmp" } Module: Linked to module rlm_eap Module: Instantiating eap eap { default_eap_type = "md5" timer_expire = 60 ignore_unknown_eap_types = no cisco_accounting_username_bug = no max_sessions = 2048 } Module: Linked to sub-module rlm_eap_md5 Module: Instantiating eap-md5 Module: Linked to sub-module rlm_eap_leap Module: Instantiating eap-leap Module: Linked to sub-module rlm_eap_gtc Module: Instantiating eap-gtc gtc { challenge = "Password: " auth_type = "PAP" } Module: Linked to sub-module rlm_eap_tls Module: Instantiating eap-tls tls { rsa_key_exchange = no dh_key_exchange = yes rsa_key_length = 512 dh_key_length = 512 verify_depth = 0 pem_file_type = yes private_key_file = "/etc/raddb/certs/server.pem" certificate_file = "/etc/raddb/certs/server.pem" CA_file = "/etc/raddb/certs/ca.pem" private_key_password = "whatever" dh_file = "/etc/raddb/certs/dh" random_file = "/etc/raddb/certs/random" fragment_size = 1024 include_length = yes check_crl = no cipher_list = "DEFAULT" make_cert_command = "/etc/raddb/certs/bootstrap" cache { enable = no lifetime = 24 max_entries = 255 } } Module: Linked to sub-module rlm_eap_ttls Module: Instantiating eap-ttls ttls { default_eap_type = "md5" copy_request_to_tunnel = no use_tunneled_reply = no virtual_server = "inner-tunnel" } Module: Linked to sub-module rlm_eap_peap Module: Instantiating eap-peap peap { default_eap_type = "mschapv2" copy_request_to_tunnel = no use_tunneled_reply = no proxy_tunneled_request_as_eap = yes virtual_server = "inner-tunnel" } Module: Linked to sub-module rlm_eap_mschapv2 Module: Instantiating eap-mschapv2 mschapv2 { with_ntdomain_hack = no } Module: Checking authorize {...} for more modules to load Module: Linked to module rlm_realm Module: Instantiating suffix realm suffix { format = "suffix" delimiter = "@" ignore_default = no ignore_null = no } Module: Linked to module rlm_files Module: Instantiating files files { usersfile = "/etc/raddb/users" acctusersfile = "/etc/raddb/acct_users" preproxy_usersfile = "/etc/raddb/preproxy_users" compat = "no" } Module: Checking session {...} for more modules to load Module: Linked to module rlm_radutmp Module: Instantiating radutmp radutmp { filename = "/var/log/radius/radutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes perm = 384 callerid = yes } Module: Checking post-proxy {...} for more modules to load Module: Checking post-auth {...} for more modules to load Module: Linked to module rlm_attr_filter Module: Instantiating attr_filter.access_reject attr_filter attr_filter.access_reject { attrsfile = "/etc/raddb/attrs.access_reject" key = "%{User-Name}" } } } modules { Module: Checking authenticate {...} for more modules to load Module: Checking authorize {...} for more modules to load Module: Linked to module rlm_preprocess Module: Instantiating preprocess preprocess { huntgroups = "/etc/raddb/huntgroups" hints = "/etc/raddb/hints" with_ascend_hack = no ascend_channels_per_line = 23 with_ntdomain_hack = no with_specialix_jetstream_hack = no with_cisco_vsa_hack = no with_alvarion_vsa_hack = no } Module: Checking preacct {...} for more modules to load Module: Linked to module rlm_acct_unique Module: Instantiating acct_unique acct_unique { key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port" } Module: Checking accounting {...} for more modules to load Module: Linked to module rlm_detail Module: Instantiating detail detail { detailfile = "/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d" header = "%t" detailperm = 384 dirperm = 493 locking = no log_packet_header = no } Module: Instantiating attr_filter.accounting_response attr_filter attr_filter.accounting_response { attrsfile = "/etc/raddb/attrs.accounting_response" key = "%{User-Name}" } Module: Checking session {...} for more modules to load Module: Checking post-proxy {...} for more modules to load Module: Checking post-auth {...} for more modules to load } radiusd: #### Opening IP addresses and Ports #### listen { type = "auth" ipaddr = 172.18.3.52 port = 1645 } listen { type = "acct" ipaddr = 172.18.3.52 port = 1646 } Listening on authentication address 172.18.3.52 port 1645 Listening on accounting address 172.18.3.52 port 1646 Listening on proxy address 172.18.3.52 port 1647 Ready to process requests. rad_recv: Access-Request packet from host 172.18.3.52 port 32957, id=237, length=247 User-Name = "172.18.3.52" User-Password = "cisco" Calling-Station-Id = "alice" Called-Station-Id = "bob" h323-conf-id = "h323-conf-id=B8377C92 DF6642BB 25A7C3A3 D4E529CE" Cisco-AVPair = "call-id=1231924661763@172.18.1.197" h323-remote-address = "h323-remote-address=172.18.3.52" Cisco-AVPair = "h323-session-protocol=sipv2" NAS-Port = 5060 NAS-IP-Address = 172.18.3.52 +- entering group authorize {...} ++[preprocess] returns ok ++[chap] returns noop ++[mschap] returns noop [suffix] No '@' in User-Name = "172.18.3.52", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] No EAP-Message, not doing EAP ++[eap] returns noop ++[unix] returns notfound [files] users: Matched entry 172.18.3.52 at line 92 ++[files] returns ok ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns updated Found Auth-Type = PAP +- entering group PAP {...} [pap] login attempt with password "cisco" [pap] Using clear text password "cisco" [pap] User authenticated successfully ++[pap] returns ok +- entering group post-auth {...} ++[exec] returns noop Sending Access-Accept of id 237 to 172.18.3.52 port 32957 Finished request 0. Going to the next request Waking up in 4.9 seconds. rad_recv: Accounting-Request packet from host 172.18.3.52 port 32958, id=238, length=540 h323-call-origin = "h323-call-origin=answer" h323-call-type = "h323-call-type=VoIP" Cisco-AVPair = "h323-session-protocol=sipv2" h323-setup-time = "h323-setup-time=10:33:13.000 GMT Wed Jan 14 2009" User-Name = "172.18.3.52" Calling-Station-Id = "alice" Called-Station-Id = "bob" h323-conf-id = "h323-conf-id=B8377C92 DF6642BB 25A7C3A3 D4E529CE" Cisco-AVPair = "call-id=1231924661763@172.18.1.197" Acct-Session-Id = "1231924661763@172.18.1.197" h323-remote-address = "h323-remote-address=172.18.3.52" h323-disconnect-time = "h323-disconnect-time=10:33:13.000 GMT Wed Jan 14 2009" h323-connect-time = "h323-connect-time=10:33:13.000 GMT Wed Jan 14 2009" Acct-Session-Time = 0 h323-disconnect-cause = "h323-disconnect-cause=29" Acct-Status-Type = Stop NAS-Port = 5060 Acct-Delay-Time = 0 NAS-IP-Address = 172.18.3.52 +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 5060,Client-IP-Address = 172.18.3.52,NAS-IP-Address = 172.18.3.52,Acct-Session-Id = "1231924661763@172.18.1.197",User-Name = "172.18.3.52"' [acct_unique] Acct-Unique-Session-ID = "547b4ecb37f1696c". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "172.18.3.52", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop +- entering group accounting {...} [detail] expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/radius/radacct/172.18.3.52/detail-20090114 [detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radius/radacct/172.18.3.52/detail-20090114 [detail] expand: %t -> Wed Jan 14 16:03:13 2009 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 172.18.3.52 rlm_radutmp: Logout for NAS local port 5060, but no Login record ++[radutmp] returns ok [attr_filter.accounting_response] expand: %{User-Name} -> 172.18.3.52 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 238 to 172.18.3.52 port 32958 Finished request 1. Cleaning up request 1 ID 238 with timestamp +54 Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 172.18.3.52 port 32959, id=239, length=247 User-Name = "172.18.3.52" User-Password = "cisco" Calling-Station-Id = "alice" Called-Station-Id = "bob" h323-conf-id = "h323-conf-id=7EAC4F20 651D23F0 75C1FFA6 E6EE4BFA" Cisco-AVPair = "call-id=1231924661763@172.18.1.197" h323-remote-address = "h323-remote-address=172.18.3.52" Cisco-AVPair = "h323-session-protocol=sipv2" NAS-Port = 5060 NAS-IP-Address = 172.18.3.52 +- entering group authorize {...} ++[preprocess] returns ok ++[chap] returns noop ++[mschap] returns noop [suffix] No '@' in User-Name = "172.18.3.52", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] No EAP-Message, not doing EAP ++[eap] returns noop ++[unix] returns notfound [files] users: Matched entry 172.18.3.52 at line 92 ++[files] returns ok ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns updated Found Auth-Type = PAP +- entering group PAP {...} [pap] login attempt with password "cisco" [pap] Using clear text password "cisco" [pap] User authenticated successfully ++[pap] returns ok +- entering group post-auth {...} ++[exec] returns noop Sending Access-Accept of id 239 to 172.18.3.52 port 32959 Finished request 2. Going to the next request Waking up in 4.9 seconds. rad_recv: Accounting-Request packet from host 172.18.3.52 port 32960, id=240, length=540 h323-call-origin = "h323-call-origin=answer" h323-call-type = "h323-call-type=VoIP" Cisco-AVPair = "h323-session-protocol=sipv2" h323-setup-time = "h323-setup-time=10:33:13.000 GMT Wed Jan 14 2009" User-Name = "172.18.3.52" Calling-Station-Id = "alice" Called-Station-Id = "bob" h323-conf-id = "h323-conf-id=7EAC4F20 651D23F0 75C1FFA6 E6EE4BFA" Cisco-AVPair = "call-id=1231924661763@172.18.1.197" Acct-Session-Id = "1231924661763@172.18.1.197" h323-remote-address = "h323-remote-address=172.18.3.52" h323-disconnect-time = "h323-disconnect-time=10:33:13.000 GMT Wed Jan 14 2009" h323-connect-time = "h323-connect-time=10:33:13.000 GMT Wed Jan 14 2009" Acct-Session-Time = 0 h323-disconnect-cause = "h323-disconnect-cause=29" Acct-Status-Type = Stop NAS-Port = 5060 Acct-Delay-Time = 0 NAS-IP-Address = 172.18.3.52 +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 5060,Client-IP-Address = 172.18.3.52,NAS-IP-Address = 172.18.3.52,Acct-Session-Id = "1231924661763@172.18.1.197",User-Name = "172.18.3.52"' [acct_unique] Acct-Unique-Session-ID = "547b4ecb37f1696c". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "172.18.3.52", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop +- entering group accounting {...} [detail] expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/radius/radacct/172.18.3.52/detail-20090114 [detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radius/radacct/172.18.3.52/detail-20090114 [detail] expand: %t -> Wed Jan 14 16:03:13 2009 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 172.18.3.52 rlm_radutmp: Logout for NAS local port 5060, but no Login record ++[radutmp] returns ok [attr_filter.accounting_response] expand: %{User-Name} -> 172.18.3.52 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 240 to 172.18.3.52 port 32960 Finished request 3. Cleaning up request 3 ID 240 with timestamp +54 Going to the next request Waking up in 4.8 seconds. Cleaning up request 0 ID 237 with timestamp +54 Cleaning up request 2 ID 239 with timestamp +54 Ready to process requests.