rlm_perl add incorrect AVP while receiving acct-packet with VSA. device which sending radius packet use eltex dictionary (dictionary.eltex) --------------------------------------------------------- VENDOR Eltex 35265 BEGIN-VENDOR Eltex ATTRIBUTE Eltex-AVPair 1 string ATTRIBUTE Incoming-SIP-call-id 2 string ATTRIBUTE Outgoing-SIP-call-id 3 string ATTRIBUTE Incoming-RTP-local-address 4 ipaddr ATTRIBUTE Incoming-RTP-remote-address 5 ipaddr ATTRIBUTE Outgoing-RTP-local-address 6 ipaddr ATTRIBUTE Outgoing-RTP-remote-address 7 ipaddr ATTRIBUTE Disconnect-Code-Local 11 integer END-VENDOR Eltex ----------------------------------------------------------- in debug i see good packet received by radius: rad_recv: Accounting-Request packet from host 192.168.243.243 port 44825, id=109, length=997 Acct-Status-Type = Stop User-Name = "123456" Calling-Station-Id = "123456" Called-Station-Id = "89121223456" Acct-Session-Id = "1100037f 52d7b893 6f9a90c4 240760f0" Event-Timestamp = "Jan 16 2014 16:46:55 YEKT" NAS-Port = 285213567 NAS-Port-Type = Async Cisco-NAS-Port = "SIPT:037f" Cisco-AVPair = "xpgk-src-number-in=123456" Cisco-AVPair = "xpgk-src-number-out=83512123456" Cisco-AVPair = "xpgk-dst-number-in=89121223456" Cisco-AVPair = "xpgk-dst-number-out=89121223456" Cisco-AVPair = "xpgk-route-retries=1" Cisco-AVPair = "h323-remote-id=TRUNK_MTT" Cisco-AVPair = "h323-call-id=1100037f 52d7b893 6f9a90c4 240760f0" h323-remote-address = "10.75.130.154" Cisco-AVPair = "h323-incoming-conf-id=1100037f 52d7b893 6f9a90c4 240760f0" h323-conf-id = "1100037f 52d7b893 6f9a90c4 240760f0" h323-setup-time = "16:46:43.000 GMT+6 Thu Jan 16 2014" h323-call-origin = "originate" h323-call-type = "VoIP" h323-connect-time = "16:46:54.000 GMT+6 Thu Jan 16 2014" h323-disconnect-time = "16:46:55.000 GMT+6 Thu Jan 16 2014" h323-disconnect-cause = "10" Cisco-AVPair = "xpgk-local-disconnect-cause=1" Acct-Session-Time = 1 Eltex-AVPair = "session-time=1" Acct-Delay-Time = 5 Incoming-SIP-call-id = "db876304-9012337d@192.168.243.86" Eltex-AVPair = "Incoming-codec=G711.A" Incoming-RTP-local-address = 172.16.0.227 Incoming-RTP-remote-address = 192.168.243.86 Outgoing-SIP-call-id = "1389-869203-968339" Eltex-AVPair = "Outgoing-codec=G711.A" Outgoing-RTP-local-address = 172.16.0.227 Outgoing-RTP-remote-address = 10.75.130.154 NAS-IP-Address = 192.168.243.243 Cisco-AVPair = "h323-gw-address=192.168.243.243" h323-gw-id = "192.168.243.243" All VSA for Eltex in vendor's packet are: Incoming-SIP-call-id = "db876304-9012337d@192.168.243.86" Eltex-AVPair = "Incoming-codec=G711.A" Incoming-RTP-local-address = 172.16.0.227 Incoming-RTP-remote-address = 192.168.243.86 Outgoing-SIP-call-id = "1389-869203-968339" Eltex-AVPair = "Outgoing-codec=G711.A" Outgoing-RTP-local-address = 172.16.0.227 Outgoing-RTP-remote-address = 10.75.130.154 when rlm_perl used in preacc section debug show: Thu Jan 16 17:41:05 2014 : Info: # Executing section preacct from file /etc/freeradius/sites-enabled/default Thu Jan 16 17:41:05 2014 : Info: +- entering group preacct {...} Thu Jan 16 17:41:05 2014 : Info: ++[preprocess] returns ok Thu Jan 16 17:41:05 2014 : Info: [acct_unique] Hashing 'NAS-Port = 285213567,Client-IP-Address = 192.168.243.243,NAS-IP-Address = 192.168.243.24 3,Acct-Session-Id = "1100037f 52d7b893 6f9a90c4 240760f0",User-Name = "123456"' Thu Jan 16 17:41:05 2014 : Info: [acct_unique] Acct-Unique-Session-ID = "68185495bd67a53b". Thu Jan 16 17:41:05 2014 : Info: ++[acct_unique] returns ok Thu Jan 16 17:41:05 2014 : Info: [suffix] No '@' in User-Name = "123456", looking up realm NULL Thu Jan 16 17:41:05 2014 : Info: [suffix] No such realm "NULL" Thu Jan 16 17:41:05 2014 : Info: ++[suffix] returns noop Thu Jan 16 17:41:05 2014 : Info: ++[files] returns noop Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair NAS-Port-Type = Async Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-remote-address = 1389-869203-968339 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-remote-address = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-remote-address = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-gw-id = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Acct-Unique-Session-Id = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Called-Station-Id = 89121223456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-call-type = VoIP Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-call-origin = originate Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = session-time=1 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 5 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = db876304-9012337d@192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = Incoming-codec=G711.A Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 1389-869203-968339 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = Outgoing-codec=G711.A Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Acct-Status-Type = Stop Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair NAS-IP-Address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-disconnect-cause = 10 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Acct-Session-Time = 1 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-incoming-conf-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair User-Name = 123456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 1389-869203-968339 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair SIP-AVP = callernum:123456;calleenum:89121223456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Acct-Session-Id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-connect-time = 16:46:54.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-local-address = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-local-address = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-local-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-local-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Outgoing-RTP-local-address = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Outgoing-RTP-local-address = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-setup-time = 16:46:43.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-NAS-Port = SIPT:037f Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-conf-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-remote-address = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-remote-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-remote-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Outgoing-RTP-remote-address = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Outgoing-RTP-remote-address = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = db876304-9012337d@192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 1389-869203-968339 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Calling-Station-Id = 123456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-disconnect-time = 16:46:55.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-src-number-in=123456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-src-number-out=83512123456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-dst-number-in=89121223456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-dst-number-out=89121223456 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-route-retries=1 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-remote-id=TRUNK_MTT Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-call-id=1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-incoming-conf-id=1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-local-disconnect-cause=1 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-gw-address=192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair h323-remote-address = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Event-Timestamp = Jan 16 2014 16:46:55 YEKT Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair NAS-Port = 285213567 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Acct-Delay-Time = 5 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 192.168.243.86 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-local-address = 1389-869203-968339 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 172.16.0.227 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 10.75.130.154 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 192.168.243.243 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-local-address = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 17:41:05 2014 : Debug: rlm_perl: ERROR: Failed to create pair Incoming-RTP-local-address = 68185495bd67a53b Thu Jan 16 17:41:05 2014 : Info: ++[perl] returns ok i.e. all VSA get more then one values. e.g., Outgoing-SIP-call-id: Outgoing-SIP-call-id = 1389-869203-968339 Outgoing-SIP-call-id = 172.16.0.227 Outgoing-SIP-call-id = 10.75.130.154 Outgoing-SIP-call-id = 192.168.243.243 Outgoing-SIP-call-id = 192.168.243.243 Outgoing-SIP-call-id = 1100037f 52d7b893 6f9a90c4 240760f0 Outgoing-SIP-call-id = 68185495bd67a53b All others VSA is broked also. I dump Accounting-Request packet in text file and "send" it via radclient $ cat pak | radclient localhost acct secret I got the same corruption. BUT!!!! When i change vendor id in dictionary file VENDOR Eltex 35265 to VENDOR Eltex 5265 rlm_perl works fine! Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair NAS-Port-Type = Async Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Incoming-RTP-remote-address = 192.168.243.86 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-gw-id = 192.168.243.243 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Acct-Unique-Session-Id = 68185495bd67a53b Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Called-Station-Id = 89121223456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-call-type = VoIP Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-call-origin = originate Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = session-time=1 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = Incoming-codec=G711.A Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Eltex-AVPair = Outgoing-codec=G711.A Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Acct-Status-Type = Stop Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair NAS-IP-Address = 192.168.243.243 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-disconnect-cause = 10 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Acct-Session-Time = 1 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-incoming-conf-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair User-Name = 123456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 1389-869203-968339 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair SIP-AVP = callernum:123456;calleenum:89121223456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Acct-Session-Id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-connect-time = 16:46:54.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-local-address = 172.16.0.227 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-setup-time = 16:46:43.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-NAS-Port = SIPT:037f Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-conf-id = 1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Outgoing-RTP-remote-address = 10.75.130.154 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Incoming-SIP-call-id = db876304-9012337d@192.168.243.86 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Calling-Station-Id = 123456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-disconnect-time = 16:46:55.000 GMT+6 Thu Jan 16 2014 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-src-number-in=123456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-src-number-out=83512123456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-dst-number-in=89121223456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-dst-number-out=89121223456 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-route-retries=1 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-remote-id=TRUNK_MTT Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-call-id=1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-incoming-conf-id=1100037f 52d7b893 6f9a90c4 240760f0 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = xpgk-local-disconnect-cause=1 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Cisco-AVPair = h323-gw-address=192.168.243.243 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair h323-remote-address = 10.75.130.154 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Event-Timestamp = Jan 16 2014 16:46:55 YEKT Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair NAS-Port = 285213567 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Acct-Delay-Time = 5 Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Incoming-RTP-local-address = 172.16.0.227 only one line Thu Jan 16 18:14:21 2014 : Debug: rlm_perl: Added pair Outgoing-SIP-call-id = 1389-869203-968339 what is wrong? where is bug? Best regards, Michael