вообщем все так же глухо, накатил новый IOS и все те же грабли, скрипт циски находит юзера, определяет баланс, определяет длительность, но блин в конце выводит, что неправильный пин. хз че делать.
Гляньте логи плиз, куда копать хз5350XM_GL#sh ver
Cisco IOS Software, 5350 Software (C5350-IS-M), Version 12.4(25c), RELEASE SOFTWARE (fc2)
Technical Support: http://www.cisco.com/techsupport
Copyright (c) 1986-2010 by Cisco Systems, Inc.
Compiled Fri 12-Feb-10 05:27 by prod_rel_team
ROM: System Bootstrap, Version 12.3(12r)PI6b, RELEASE SOFTWARE (fc1)
5350XM_GL uptime is 1 hour, 30 minutes
System returned to ROM by reload at 23:52:20 UTC Mon Jul 15 2002
System image file is "flash:c5350-is-mz.124-25c.bin"
Cisco AS5350XM (BCM) processor (revision 0x22) with 393215K/131072K bytes of memory.
Processor board ID JAE1036AZ81
SB-1 CPU at 750MHz, Implementation 1025, Rev 0.3, 256KB L2 Cache
Last reset from IOS reload
Manufacture Cookie Info:
EEPROM Version 0x4, Board ID 0x4C3,
Board Hardware Version 2.7, Item Number 800-6571779-03,
Board Revision A0, Serial Number JAE1036AZ81.
Processor 0x0, MAC Address 0007.0e58.92d6
2 Gigabit Ethernet interfaces
37 Serial interfaces
120 terminal lines
4 Channelized E1/PRI ports
512K bytes of NVRAM.
125440K bytes of ATA External CompactFlash (Read/Write)
Configuration register is 0x2102
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE(0000001A):Orig. component type = VOICE
*Jul 16 01:21:31.799 UTC: RADIUS(0000001A): Config NAS IP: 0.0.0.0
*Jul 16 01:21:31.799 UTC: RADIUS(0000001A): sending
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE: Best Local IP-Address 10.0.1.11 for Radius-Server 192.168.110.98
*Jul 16 01:21:31.799 UTC: RADIUS: No secret to encode request (rctx:0x66499D14)
*Jul 16 01:21:31.799 UTC: RADIUS: Unable to encrypt (rctx:0x66499D14)
*Jul 16 01:21:31.799 UTC: RADIUS(0000001A): Send Accounting-Request to 192.168.110.98:1813 id 1646/51, len 550
*Jul 16 01:21:31.799 UTC: RADIUS: authenticator 00 00 00 00 00 00 00 00 - 00 00 00 00 00 00 00 00
*Jul 16 01:21:31.799 UTC: RADIUS: Acct-Session-Id [44] 10 "00000021"
*Jul 16 01:21:31.799 UTC: RADIUS: Calling-Station-Id [31] 12 "3433100420"
*Jul 16 01:21:31.799 UTC: RADIUS: Called-Station-Id [30] 9 "2786401"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 57
*Jul 16 01:21:31.799 UTC: RADIUS: h323-setup-time [25] 51 "h323-setup-time=*01:21:31.795 UTC Tue Jul 16 2002"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 29
*Jul 16 01:21:31.799 UTC: RADIUS: h323-gw-id [33] 23 "h323-gw-id=5350XM_GL."
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 56
*Jul 16 01:21:31.799 UTC: RADIUS: Conf-Id [24] 50 "h323-conf-id=31F144F2 979111D6 80090007 0E5892D6"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 31
*Jul 16 01:21:31.799 UTC: RADIUS: h323-call-origin [26] 25 "h323-call-origin=answer"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:31.799 UTC: RADIUS: h323-call-type [27] 26 "h323-call-type=Telephony"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 65
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 59 "h323-incoming-conf-id=31F144F2 979111D6 80090007 0E5892D6"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 24 "subscriber=RegularLine"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 40
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 34 "gw-rxd-cdn=ton:0,npi:1,#:2786401"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 26 "calling-party-category=9"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 33
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 27 "transmission-medium-req=0"
*Jul 16 01:21:31.799 UTC: RADIUS: User-Name [1] 12 "3433100420"
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 26 "connect-progress=Call Up"
*Jul 16 01:21:31.799 UTC: RADIUS: Acct-Status-Type [40] 6 Start [1]
*Jul 16 01:21:31.799 UTC: RADIUS: NAS-Port-Type [61] 6 Async [0]
*Jul 16 01:21:31.799 UTC: RADIUS: NAS-Port [5] 6 0
*Jul 16 01:21:31.799 UTC: RADIUS: NAS-Port-Id [87] 14 "ISDN 3/0:D:7"
*Jul 16 01:21:31.799 UTC: RADIUS: Service-Type [6] 6 Login [1]
*Jul 16 01:21:31.799 UTC: RADIUS: NAS-IP-Address [4] 6 10.0.1.11
*Jul 16 01:21:31.799 UTC: RADIUS: Acct-Delay-Time [41] 6 0
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE(0000001B):Orig. component type = VOICE
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE(0000001B): dropping service type, "radius-server attribute 6 on-for-login-auth" is off
*Jul 16 01:21:31.799 UTC: RADIUS(0000001B): Config NAS IP: 0.0.0.0
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE(0000001B): acct_session_id: 34
*Jul 16 01:21:31.799 UTC: RADIUS(0000001B): sending
*Jul 16 01:21:31.799 UTC: RADIUS/ENCODE: Best Local IP-Address 10.0.1.11 for Radius-Server 192.168.110.98
*Jul 16 01:21:31.799 UTC: RADIUS: No secret to encode request (rctx:0x65763168)
*Jul 16 01:21:31.799 UTC: RADIUS: Unable to encrypt (rctx:0x65763168)
*Jul 16 01:21:31.799 UTC: RADIUS(0000001B): Send Access-Request to 192.168.110.98:1812 id 1645/4, len 92
*Jul 16 01:21:31.799 UTC: RADIUS: authenticator 00 00 00 00 00 00 00 00 - 00 00 00 00 00 00 00 00
*Jul 16 01:21:31.799 UTC: RADIUS: User-Name [1] 12 "3433100420"
*Jul 16 01:21:31.799 UTC: RADIUS: User-Password [2] 18 *
*Jul 16 01:21:31.799 UTC: RADIUS: Vendor, Cisco [26] 36
*Jul 16 01:21:31.799 UTC: RADIUS: Cisco AVpair [1] 30 "h323-ivr-out=transactionID:3"
*Jul 16 01:21:31.799 UTC: RADIUS: NAS-IP-Address [4] 6 10.0.1.11
*Jul 16 01:21:31.803 UTC: RADIUS: Received from id 1645/4 192.168.110.98:1812, Access-Accept, len 159
*Jul 16 01:21:31.803 UTC: RADIUS: authenticator 30 9C BC E9 51 26 73 94 - EA 4D E9 34 4F 3F A8 3C
*Jul 16 01:21:31.803 UTC: RADIUS: Service-Type [6] 6 Framed [2]
*Jul 16 01:21:31.803 UTC: RADIUS: Framed-Protocol [7] 6 PPP [1]
*Jul 16 01:21:31.803 UTC: RADIUS: Vendor, Cisco [26] 12
*Jul 16 01:21:31.803 UTC: RADIUS: Cisco AVpair [1] 6 10:" "
*Jul 16 01:21:31.803 UTC: RADIUS: Vendor, Cisco [26] 34
*Jul 16 01:21:31.803 UTC: RADIUS: h323-credit-amount [101] 28 "h323-credit-amount=9998.55"
*Jul 16 01:21:31.803 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:31.803 UTC: RADIUS: h323-credit-time [102] 24 "h323-credit-time=72000"
*Jul 16 01:21:31.803 UTC: RADIUS: Vendor, Cisco [26] 26
*Jul 16 01:21:31.803 UTC: RADIUS: h323-return-code [103] 20 "h323-return-code=0"
*Jul 16 01:21:31.803 UTC: RADIUS: Vendor, Cisco [26] 25
*Jul 16 01:21:31.803 UTC: RADIUS: h323-currency [110] 19 "h323-currency=USD" radius_decrypt: null length
*Jul 16 01:21:31.803 UTC: RADIUS: Response (4) failed decrypt
*Jul 16 01:21:31.803 UTC: RADIUS: Received from id 1646/51 192.168.110.98:1813, Accounting-response, len 20
*Jul 16 01:21:31.803 UTC: RADIUS: authenticator E7 FD 1E DB 67 AB 67 7D - 32 4B 92 7C EE 00 A0 62 radius_decrypt: null length
*Jul 16 01:21:31.803 UTC: RADIUS: Response (51) failed decrypt
*Jul 16 01:21:36.139 UTC: RADIUS: acct-timeout for 202F4D74 now 5, acct-jitter -1, acct-delay-time (at 202F4F94) now 4
*Jul 16 01:21:36.139 UTC: RADIUS: no sg in radius-timers: ctx 0x66499D14 sg 0x0000
*Jul 16 01:21:36.139 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/52
*Jul 16 01:21:36.139 UTC: RADIUS: No secret to encode request (rctx:0x66499D14)
*Jul 16 01:21:36.139 UTC: RADIUS: Unable to encrypt (rctx:0x66499D14)
*Jul 16 01:21:36.363 UTC: RADIUS: no sg in radius-timers: ctx 0x65763168 sg 0x0000
*Jul 16 01:21:36.363 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1645/4
*Jul 16 01:21:36.363 UTC: RADIUS: Received from id 1645/4 192.168.110.98:1812, Access-Accept, len 159
*Jul 16 01:21:36.363 UTC: RADIUS: authenticator 30 9C BC E9 51 26 73 94 - EA 4D E9 34 4F 3F A8 3C
*Jul 16 01:21:36.363 UTC: RADIUS: Service-Type [6] 6 Framed [2]
*Jul 16 01:21:36.363 UTC: RADIUS: Framed-Protocol [7] 6 PPP [1]
*Jul 16 01:21:36.363 UTC: RADIUS: Vendor, Cisco [26] 12
*Jul 16 01:21:36.363 UTC: RADIUS: Cisco AVpair [1] 6 10:" "
*Jul 16 01:21:36.363 UTC: RADIUS: Vendor, Cisco [26] 34
*Jul 16 01:21:36.363 UTC: RADIUS: h323-credit-amount [101] 28 "h323-credit-amount=9998.55"
*Jul 16 01:21:36.363 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:36.363 UTC: RADIUS: h323-credit-time [102] 24 "h323-credit-time=72000"
*Jul 16 01:21:36.363 UTC: RADIUS: Vendor, Cisco [26] 26
*Jul 16 01:21:36.363 UTC: RADIUS: h323-return-code [103] 20 "h323-return-code=0"
*Jul 16 01:21:36.363 UTC: RADIUS: Vendor, Cisco [26] 25
*Jul 16 01:21:36.363 UTC: RADIUS: h323-currency [110] 19 "h323-currency=USD" radius_decrypt: null length
*Jul 16 01:21:36.363 UTC: RADIUS: Response (4) failed decrypt
*Jul 16 01:21:41.179 UTC: RADIUS: acct-timeout for 202F4D74 now 9, acct-jitter 0, acct-delay-time (at 202F4F94) now 9
*Jul 16 01:21:41.179 UTC: RADIUS: no sg in radius-timers: ctx 0x66499D14 sg 0x0000
*Jul 16 01:21:41.179 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/53
*Jul 16 01:21:41.179 UTC: RADIUS: No secret to encode request (rctx:0x66499D14)
*Jul 16 01:21:41.179 UTC: RADIUS: Unable to encrypt (rctx:0x66499D14)
*Jul 16 01:21:41.211 UTC: RADIUS: no sg in radius-timers: ctx 0x65763168 sg 0x0000
*Jul 16 01:21:41.211 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1645/4
*Jul 16 01:21:41.211 UTC: RADIUS: Received from id 1645/4 192.168.110.98:1812, Access-Accept, len 159
*Jul 16 01:21:41.211 UTC: RADIUS: authenticator 30 9C BC E9 51 26 73 94 - EA 4D E9 34 4F 3F A8 3C
*Jul 16 01:21:41.211 UTC: RADIUS: Service-Type [6] 6 Framed [2]
*Jul 16 01:21:41.211 UTC: RADIUS: Framed-Protocol [7] 6 PPP [1]
*Jul 16 01:21:41.211 UTC: RADIUS: Vendor, Cisco [26] 12
*Jul 16 01:21:41.211 UTC: RADIUS: Cisco AVpair [1] 6 10:" "
*Jul 16 01:21:41.211 UTC: RADIUS: Vendor, Cisco [26] 34
*Jul 16 01:21:41.211 UTC: RADIUS: h323-credit-amount [101] 28 "h323-credit-amount=9998.55"
*Jul 16 01:21:41.211 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:41.211 UTC: RADIUS: h323-credit-time [102] 24 "h323-credit-time=72000"
*Jul 16 01:21:41.211 UTC: RADIUS: Vendor, Cisco [26] 26
*Jul 16 01:21:41.211 UTC: RADIUS: h323-return-code [103] 20 "h323-return-code=0"
*Jul 16 01:21:41.211 UTC: RADIUS: Vendor, Cisco [26] 25
*Jul 16 01:21:41.211 UTC: RADIUS: h323-currency [110] 19 "h323-currency=USD" radius_decrypt: null length
*Jul 16 01:21:41.211 UTC: RADIUS: Response (4) failed decrypt
*Jul 16 01:21:45.883 UTC: RADIUS: no sg in radius-timers: ctx 0x65763168 sg 0x0000
*Jul 16 01:21:45.883 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1645/4
*Jul 16 01:21:45.883 UTC: RADIUS: Received from id 1645/4 192.168.110.98:1812, Access-Accept, len 159
*Jul 16 01:21:45.883 UTC: RADIUS: authenticator 30 9C BC E9 51 26 73 94 - EA 4D E9 34 4F 3F A8 3C
*Jul 16 01:21:45.883 UTC: RADIUS: Service-Type [6] 6 Framed [2]
*Jul 16 01:21:45.883 UTC: RADIUS: Framed-Protocol [7] 6 PPP [1]
*Jul 16 01:21:45.883 UTC: RADIUS: Vendor, Cisco [26] 12
*Jul 16 01:21:45.883 UTC: RADIUS: Cisco AVpair [1] 6 10:" "
*Jul 16 01:21:45.883 UTC: RADIUS: Vendor, Cisco [26] 34
*Jul 16 01:21:45.883 UTC: RADIUS: h323-credit-amount [101] 28 "h323-credit-amount=9998.55"
*Jul 16 01:21:45.883 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:45.883 UTC: RADIUS: h323-credit-time [102] 24 "h323-credit-time=72000"
*Jul 16 01:21:45.883 UTC: RADIUS: Vendor, Cisco [26] 26
*Jul 16 01:21:45.883 UTC: RADIUS: h323-return-code [103] 20 "h323-return-code=0"
*Jul 16 01:21:45.883 UTC: RADIUS: Vendor, Cisco [26] 25
*Jul 16 01:21:45.883 UTC: RADIUS: h323-currency [110] 19 "h323-currency=USD" radius_decrypt: null length
*Jul 16 01:21:45.883 UTC: RADIUS: Response (4) failed decrypt
*Jul 16 01:21:46.011 UTC: RADIUS: acct-timeout for 202F4D74 now 14, acct-jitter 0, acct-delay-time (at 202F4F94) now 14
*Jul 16 01:21:46.011 UTC: RADIUS: no sg in radius-timers: ctx 0x66499D14 sg 0x0000
*Jul 16 01:21:46.011 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/54
*Jul 16 01:21:46.011 UTC: RADIUS: No secret to encode request (rctx:0x66499D14)
*Jul 16 01:21:46.011 UTC: RADIUS: Unable to encrypt (rctx:0x66499D14)
*Jul 16 01:21:50.299 UTC: RADIUS: acct-timeout for 202F4D74 now 19, acct-jitter -1, acct-delay-time (at 202F4F94) now 18
*Jul 16 01:21:50.299 UTC: RADIUS: no sg in radius-timers: ctx 0x66499D14 sg 0x0000
*Jul 16 01:21:50.299 UTC: RADIUS: No response from (192.168.110.98:1812,1813) for id 1646/54
*Jul 16 01:21:50.299 UTC: RADIUS/DECODE: No response from radius-server; parse response; FAIL
*Jul 16 01:21:50.299 UTC: RADIUS/DECODE: Case error(no response/ bad packet/ op decode);parse response; FAIL
*Jul 16 01:21:50.363 UTC: RADIUS: no sg in radius-timers: ctx 0x65763168 sg 0x0000
*Jul 16 01:21:50.363: %RADIUS-4-RADIUS_DEAD: RADIUS server 192.168.110.98:1812,1813 is not responding.
*Jul 16 01:21:50.363: %RADIUS-4-RADIUS_ALIVE: RADIUS server 192.168.110.98:1812,1813 is being marked alive.
*Jul 16 01:21:50.363 UTC: RADIUS: No response from (192.168.110.98:1812,1813) for id 1645/4
*Jul 16 01:21:50.363 UTC: RADIUS/DECODE: No response from radius-server; parse response; FAIL
*Jul 16 01:21:50.363 UTC: RADIUS/DECODE: Case error(no response/ bad packet/ op decode);parse response; FAIL
*Jul 16 01:21:52.627 UTC: RADIUS/ENCODE(0000001A):Orig. component type = VOICE
*Jul 16 01:21:52.627 UTC: RADIUS(0000001A): Config NAS IP: 0.0.0.0
*Jul 16 01:21:52.627 UTC: RADIUS(0000001A): sending
*Jul 16 01:21:52.627 UTC: RADIUS/ENCODE: Best Local IP-Address 10.0.1.11 for Radius-Server 192.168.110.98
*Jul 16 01:21:52.627 UTC: RADIUS: No secret to encode request (rctx:0x6570C9BC)
*Jul 16 01:21:52.627 UTC: RADIUS: Unable to encrypt (rctx:0x6570C9BC)
*Jul 16 01:21:52.627 UTC: RADIUS(0000001A): Send Accounting-Request to 192.168.110.98:1813 id 1646/56, len 1188
*Jul 16 01:21:52.627 UTC: RADIUS: authenticator 00 00 00 00 00 00 00 00 - 00 00 00 00 00 00 00 00
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Session-Id [44] 10 "00000021"
*Jul 16 01:21:52.627 UTC: RADIUS: Calling-Station-Id [31] 12 "3433100420"
*Jul 16 01:21:52.627 UTC: RADIUS: Called-Station-Id [30] 9 "2786401"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 57
*Jul 16 01:21:52.627 UTC: RADIUS: h323-setup-time [25] 51 "h323-setup-time=*01:21:31.795 UTC Tue Jul 16 2002"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 29
*Jul 16 01:21:52.627 UTC: RADIUS: h323-gw-id [33] 23 "h323-gw-id=5350XM_GL."
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 56
*Jul 16 01:21:52.627 UTC: RADIUS: Conf-Id [24] 50 "h323-conf-id=31F144F2 979111D6 80090007 0E5892D6"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 31
*Jul 16 01:21:52.627 UTC: RADIUS: h323-call-origin [26] 25 "h323-call-origin=answer"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:52.627 UTC: RADIUS: h323-call-type [27] 26 "h323-call-type=Telephony"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 65
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 59 "h323-incoming-conf-id=31F144F2 979111D6 80090007 0E5892D6"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 24 "subscriber=RegularLine"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 40
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 34 "gw-rxd-cdn=ton:0,npi:1,#:2786401"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 26 "calling-party-category=9"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 33
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 27 "transmission-medium-req=0"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 59
*Jul 16 01:21:52.627 UTC: RADIUS: h323-connect-time [28] 53 "h323-connect-time=*01:21:31.799 UTC Tue Jul 16 2002"
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Input-Octets [42] 6 0
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Output-Octets [43] 6 17520
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Input-Packets [47] 6 0
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Output-Packets [48] 6 73
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Session-Time [46] 6 21
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 62
*Jul 16 01:21:52.627 UTC: RADIUS: h323-disconnect-tim[29] 56 "h323-disconnect-time=*01:21:52.577 UTC Tue Jul 16 2002"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 32
*Jul 16 01:21:52.627 UTC: RADIUS: h323-disconnect-cau[30] 26 "h323-disconnect-cause=10"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 35
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 29 "h323-ivr-out=Tariff:Unknown"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 24
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 18 "release-source=1"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 28
*Jul 16 01:21:52.627 UTC: RADIUS: h323-voice-quality [31] 22 "h323-voice-quality=0"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 20
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 14 "dsp-id=1/1:1"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 43
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 37 "gw-rxd-cgn=ton:0,npi:0,#:3433100420"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 23
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 17 "charged-units=0"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 49
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 43 "disconnect-text=normal call clearing (16)"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 31
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 25 "peer-address=3433100420"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 24
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 18 "info-type=speech"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 17
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 11 "peer-id=3"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 25
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 19 "peer-if-index=196"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 28
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 22 "logical-if-index=138"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 21
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 15 "acom-level=47"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 28
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 22 "coder-type-rate=None"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 30
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 24 "noise-level=4294967244"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 33
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 27 "voice-tx-duration=1000 ms"
*Jul 16 01:21:52.627 UTC: RADIUS: Vendor, Cisco [26] 28
*Jul 16 01:21:52.627 UTC: RADIUS: Cisco AVpair [1] 22 "tx-duration=20665 ms"
*Jul 16 01:21:52.627 UTC: RADIUS: User-Name [1] 12 "3433100420"
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Status-Type [40] 6 Stop [2]
*Jul 16 01:21:52.627 UTC: RADIUS: NAS-Port-Type [61] 6 Async [0]
*Jul 16 01:21:52.627 UTC: RADIUS: NAS-Port [5] 6 0
*Jul 16 01:21:52.627 UTC: RADIUS: NAS-Port-Id [87] 14 "ISDN 3/0:D:7"
*Jul 16 01:21:52.627 UTC: RADIUS: Service-Type [6] 6 Login [1]
*Jul 16 01:21:52.627 UTC: RADIUS: NAS-IP-Address [4] 6 10.0.1.11
*Jul 16 01:21:52.627 UTC: RADIUS: Acct-Delay-Time [41] 6 0
*Jul 16 01:21:52.631 UTC: RADIUS: Received from id 1646/56 192.168.110.98:1813, Accounting-response, len 20
*Jul 16 01:21:52.631 UTC: RADIUS: authenticator AE 20 0A 65 1C C1 E4 33 - 0E A4 C5 0C 17 0F 26 D4 radius_decrypt: null length
*Jul 16 01:21:52.631 UTC: RADIUS: Response (56) failed decrypt
*Jul 16 01:21:57.179 UTC: RADIUS: acct-timeout for 2042BAF4 now 5, acct-jitter -1, acct-delay-time (at 2042BF92) now 4
*Jul 16 01:21:57.179 UTC: RADIUS: no sg in radius-timers: ctx 0x6570C9BC sg 0x0000
*Jul 16 01:21:57.179 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/57
*Jul 16 01:21:57.179 UTC: RADIUS: No secret to encode request (rctx:0x6570C9BC)
*Jul 16 01:21:57.179 UTC: RADIUS: Unable to encrypt (rctx:0x6570C9BC)
*Jul 16 01:21:57.179 UTC: RADIUS: Received from id 1646/57 192.168.110.98:1813, Accounting-response, len 20
*Jul 16 01:21:57.179 UTC: RADIUS: authenticator 70 D6 A8 52 2F 81 00 95 - 4B 48 3E 2E 29 74 25 B0 radius_decrypt: null length
*Jul 16 01:21:57.179 UTC: RADIUS: Response (57) failed decrypt
*Jul 16 01:22:02.203 UTC: RADIUS: acct-timeout for 2042BAF4 now 9, acct-jitter 0, acct-delay-time (at 2042BF92) now 9
*Jul 16 01:22:02.203 UTC: RADIUS: no sg in radius-timers: ctx 0x6570C9BC sg 0x0000
*Jul 16 01:22:02.203 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/58
*Jul 16 01:22:02.203 UTC: RADIUS: No secret to encode request (rctx:0x6570C9BC)
*Jul 16 01:22:02.203 UTC: RADIUS: Unable to encrypt (rctx:0x6570C9BC)
*Jul 16 01:22:02.203 UTC: RADIUS: Received from id 1646/58 192.168.110.98:1813, Accounting-response, len 20
*Jul 16 01:22:02.203 UTC: RADIUS: authenticator FD 90 E8 8D 73 40 7E 90 - 03 64 A9 8A 2B 96 9B 97 radius_decrypt: null length
*Jul 16 01:22:02.203 UTC: RADIUS: Response (58) failed decrypt
*Jul 16 01:22:06.747 UTC: RADIUS: acct-timeout for 2042BAF4 now 14, acct-jitter 0, acct-delay-time (at 2042BF92) now 14
*Jul 16 01:22:06.747 UTC: RADIUS: no sg in radius-timers: ctx 0x6570C9BC sg 0x0000
*Jul 16 01:22:06.747 UTC: RADIUS: Retransmit to (192.168.110.98:1812,1813) for id 1646/59
*Jul 16 01:22:06.747 UTC: RADIUS: No secret to encode request (rctx:0x6570C9BC)
*Jul 16 01:22:06.747 UTC: RADIUS: Unable to encrypt (rctx:0x6570C9BC)
*Jul 16 01:22:06.747 UTC: RADIUS: Received from id 1646/59 192.168.110.98:1813, Accounting-response, len 20
*Jul 16 01:22:06.747 UTC: RADIUS: authenticator 33 EA C2 19 E8 01 6D 7F - 7D 99 FB 67 AC AE 6F 84 radius_decrypt: null length
*Jul 16 01:22:06.747 UTC: RADIUS: Response (59) failed decrypt
*Jul 16 01:22:11.387 UTC: RADIUS: acct-timeout for 2042BAF4 now 19, acct-jitter -1, acct-delay-time (at 2042BF92) now 18
*Jul 16 01:22:11.387 UTC: RADIUS: no sg in radius-timers: ctx 0x6570C9BC sg 0x0000
*Jul 16 01:22:11.387 UTC: RADIUS: No response from (192.168.110.98:1812,1813) for id 1646/59
*Jul 16 01:22:11.387 UTC: RADIUS/DECODE: No response from radius-server; parse response; FAIL
*Jul 16 01:22:11.387 UTC: RADIUS/DECODE: Case error(no response/ bad packet/ op decode);parse response; FAIL
а это логи с UTM сервера
?Debug : Jun 07 15:55:57 Radius: init_session_log id <13>
?Debug : Jun 07 15:55:57 DBCtx: <138653696> SQL query: INSERT INTO tel_sessions_log(account_id,slink_id,recv_date,last_updat>
,'1001002','1026760891')
?Debug : Jun 07 15:55:57 Radius: Dynamic IP binding not called because ip or slink is null ! ip <0> slink <21>
?Debug : Jun 07 15:55:57 DBCtx: <138653696> SQL query: INSERT INTO dhs_access_log(recv_date,User_Name,Service_Type,Framed_Pr>
?Debug : Jun 07 15:56:01 FW@127.0.0.1: Ping reply received
?Debug : Jun 07 15:56:02 DBCtx: <138653696> SQL query: INSERT INTO dhs_access_log(recv_date,User_Name,Service_Type,Framed_Pr>
?Debug : Jun 07 15:56:07 DBCtx: <138653696> SQL query: INSERT INTO dhs_access_log(recv_date,User_Name,Service_Type,Framed_Pr>
?Debug : Jun 07 15:56:11 DBCtx: <138653696> SQL query: INSERT INTO dhs_access_log(recv_date,User_Name,Service_Type,Framed_Pr>
?Debug : Jun 07 15:56:18 DBCtx: <138653696> SQL query: INSERT INTO tel_sessions_detail(dhs_sess_id,disc_per_id,slink_id,recv>
?Debug : Jun 07 15:56:18 UTM5 DBA: DBAccess instance created
?Debug : Jun 07 15:56:18 DBA:Ctx: Looking for free context
?Debug : Jun 07 15:56:18 DBCtx: <138804224> SQL query: BEGIN
?Debug : Jun 07 15:56:18 DBCtx: DB transaction begin
?Debug : Jun 07 15:56:18 UTM5 DBA: discount_from_account tel zoneid <1001002> h.base_cost <1.000000>
?Debug : Jun 07 15:56:18 DBCtx: <138653696> SQL query: UPDATE dtagg_telephony SET discounted='1.400000',discounted_without_t>
?Debug : Jun 07 15:56:18 UTM5 DBA: Charge:0.350000 p.u. for link:21 account 2
?Debug : Jun 07 15:56:18 DBCtx: <138804224> SQL query: UPDATE accounts SET balance='9998.199995370369' WHERE id = '2'
?Debug : Jun 07 15:56:18 DBCtx: <138804224> SQL query: INSERT INTO discount_transactions_all(account_id,incoming_rest,outgoi>
?Debug : Jun 07 15:56:18 UTM5 DBA: Checking for rehash: flags 3, balance 9998.200 (old 9998.550), credit 0.000
?Debug : Jun 07 15:56:18 DBAGiga: Rehash: Target: 10; Action: 1; Ptr: bcff096c
?Debug : Jun 07 15:56:18 Radius: Account '2': 9998.200/0.000 send...
?Debug : Jun 07 15:56:18 BusLogic: BLM(37) pushed (comment: ruh block)
?Debug : Jun 07 15:56:18 DBCtx: <138804224> SQL query: COMMIT
?Debug : Jun 07 15:56:18 BusLogic: try to execute 37
?Debug : Jun 07 15:56:18 BusLogic: hw_block_handler with code 37
?Debug : Jun 07 15:56:18 BusLogic: finished unknown
?Debug : Jun 07 15:56:18 DBCtx: DB transaction commit
?Debug : Jun 07 15:56:18 DBA:Ctx: Pushing back free context
-Stats : Jun 07 15:56:18 UTM5 DBA: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Jun 07 15:56:18 Radius: edit_session_log id <13> input octets <0> output octet <17520>
?Debug : Jun 07 15:56:18 Radius: session log with id <13> found in the cache
?Debug : Jun 07 15:56:18 DBCtx: <138653696> SQL query: UPDATE tel_sessions_log SET account_id='2', slink_id='21', last_upda>
?Debug : Jun 07 15:56:18 Radius: id2core removing key <13>
?Debug : Jun 07 15:56:23 Radius: edit_session_log id <0> input octets <0> output octet <17520>
?Debug : Jun 07 15:56:23 Radius: session log with id <0> found in the cache
?Debug : Jun 07 15:56:23 DBCtx: <138653696> SQL query: UPDATE tel_sessions_log SET account_id='0', slink_id='0', last_updat>
?Debug : Jun 07 15:56:23 Radius: id2core removing key <0>
?Debug : Jun 07 15:56:28 Radius: edit_session_log id <0> input octets <0> output octet <17520>
?Debug : Jun 07 15:56:28 Radius: session log with id <0> not found in the cache, inserting
?Debug : Jun 07 15:56:28 DBCtx: <138653696> SQL query: INSERT INTO tel_sessions_log(account_id,slink_id,recv_date,last_updat>
e Jul 16 2002','h323-disconnect-time=*01\:21\:52.577 UTC Tue Jul 16 2002','h323-disconnect-cause=10','h323-gw-id=5350XM_GL.'>
?Debug : Jun 07 15:56:31 FW@127.0.0.1: Ping reply received
?Debug : Jun 07 15:56:32 Radius: edit_session_log id <0> input octets <0> output octet <17520>
?Debug : Jun 07 15:56:32 Radius: session log with id <0> found in the cache
?Debug : Jun 07 15:56:32 DBCtx: <138653696> SQL query: UPDATE tel_sessions_log SET account_id='0', slink_id='0', last_updat>
?Debug : Jun 07 15:56:32 Radius: id2core removing key <0>