RADIUS - Call Trace - Pre paid

The following call trace shows a SIP to SIP call with Pre-paid Support enabled. The lines relating to the Pre-paid Support are displayed using a black bold font.

18:07:02.077 CALL(SIP) (01:0001:00) RCVD INVITE from 10.129.44.226:5060 UDP

18:07:02.077 CALL(SIP) (01:0001:00)      with Via sent-by: 10.129.44.226

18:07:02.077 CALL(SIP) (01:0001:00) SENT 100 Trying [] to 10.129.44.226:5060

18:07:02.077 CALL(SIP) (01:0001:00) SENT Route Ctrl to L4

18:07:02.077 CALL(L4)  (01:0001:00) RCVD Route Control from SIP

18:07:02.077 CALL(L4)  (01:0001:00) Accessing Route Table 2

18:07:02.077 CALL(L4)  (01:0001:00) Accessing Resource Table 1

18:07:02.077 CALL(L4)  (01:0001:00) SENT Route Control Ack to SIP

18:07:02.077 CALL(SIP) (01:0001:00) RCVD Route Ctrl Ack from L4

18:07:02.077 CALL(SIP) (01:0001:00) Session Group Profile ID is 0

18:07:02.077 CALL(SIP) (01:0001:00) SENT Route Ctrl to L4

18:07:02.077 CALL(L4)  (01:0001:00) RCVD Route Control from SIP

18:07:02.077 CALL(L4)  (01:0001:00) Accessing IP Bearer Profiles

18:07:02.077 CALL(L4)  (01:0001:00) Profile Id 1 (RG 769)

18:07:02.077 CALL(L4)  (01:0001:00) SENT Route Control Ack to SIP

18:07:02.077 CALL(SIP) (01:0001:00) RCVD Route Ctrl Ack from L4

18:07:02.077 CALL(SIP) (01:0001:00) m line codec list:  0 101

18:07:02.077 CALL(SIP) (01:0001:00) RTP Type: 0, name: PCMU, clk: 8000

18:07:02.077 CALL(SIP) (01:0001:00) RTP Type: 101, name: telephone-event, clk: 8000

18:07:02.077 CALL(SIP) (01:0001:00) Leg 0 associated with hndl(19999), LTS(1792)

18:07:02.077 CALL(SIP) (01:0001:00) SENT Setup to L4

18:07:02.077 CALL(L4)  (01:0001:00) RCVD Setup Ind  from SIP

18:07:02.077 CALL(L4)  (01:0001:00) SENT RFS to GCL

18:07:02.077 CALL(GCL) (00:0000:00) SENT RADIUS AUTH REQUEST

18:07:02.077 CALL(GCL) (01:0001:00) RCVD RFS DN=[4004] ANI=[5084444444] from L4

18:07:02.077 CALL(GCL) (01:0001:00) ANI APRI=[0],SI=[0],Category=[10]

18:07:02.077 CALL(GCL) (01:0001:00) Incoming Channel Group = 10 [4001_SIP_Snom200]

18:07:02.087 CALL(GCL) (01:0001:00) RCVD RADIUS AUTH ACCEPT ACK

18:07:02.087 CALL(GCL) (01:0001:00) Using Radius MaxDurCall=1 seconds

18:07:02.087 CALL(GCL) (01:0001:00) SENT RADIUS ACCT START

18:07:02.087 CALL(L4)  (01:0001:00) RCVD RFS response  from GCL

18:07:02.397 CALL(GCL) (01:0001:00) RCVD RADIUS ACCT START

18:07:02.397 CALL(GCL) (01:0001:01) SENT Route Control to L4

18:07:02.397 CALL(L4)  (01:0001:00) RCVD Route Control from GCL

18:07:02.397 CALL(L4)  (01:0001:00) Accessing Route Table 5

18:07:02.397 CALL(GCL) (01:0001:01) RCVD Mid Stream Router Response

18:07:02.397 CALL(GCL) (01:0001:01) Outgoing Channel Group = 13 [SIP_IBM_5060]

18:07:02.397 CALL(GCL) (01:0001:01) SENT Route Control to L4

18:07:02.397 CALL(L4)  (01:0001:01) RCVD Route Control from GCL

18:07:02.397 CALL(L4)  (01:0001:01) Accessing Resource Table 1

18:07:02.397 CALL(L4)  (01:0001:01) Resource Group ID is 1

18:07:02.407 CALL(L4)  (01:0001:01) SENT Outseize Ctrl to SIP

18:07:02.407 CALL(GCL) (01:0001:01) RCVD CPE of ADDRESS INFO from L4

18:07:02.407 CALL(GCL) (01:0001:01) Leg 1 associated with LTS(1024)

18:07:02.407 CALL(SIP) (01:0001:01) RCVD Outseize Ctrl from L4

18:07:02.407 CALL(SIP) (01:0001:01) SENT Route Ctrl to L4

18:07:02.407 CALL(L4)  (01:0001:01) RCVD Route Control from SIP

18:07:02.407 CALL(L4)  (01:0001:01) Accessing GatewayId to IP Tables

18:07:02.407 CALL(L4)  (01:0001:01) Gateway ID is 1028

18:07:02.407 CALL(L4)  (01:0001:01) SENT Route Control Ack to SIP

18:07:02.407 CALL(SIP) (01:0001:01) RCVD Route Ctrl Ack from L4

18:07:02.407 CALL(SIP) (01:0001:01) Session Group Profile ID is 0

18:07:02.407 CALL(SIP) (01:0001:01) SENT Route Ctrl to L4

18:07:02.407 CALL(L4)  (01:0001:01) RCVD Route Control from SIP

18:07:02.407 CALL(L4)  (01:0001:01) Accessing IP Bearer Profiles

18:07:02.407 CALL(L4)  (01:0001:01) Profile Id 1 (RG 769)

18:07:02.407 CALL(L4)  (01:0001:01) SENT Route Control Ack to SIP

18:07:02.407 CALL(SIP) (01:0001:01) RCVD Route Ctrl Ack from L4

18:07:02.407 CALL(SIP) (01:0001:01) SENT INVITE to 10.129.44.254:5060 UDP

18:07:02.407 CALL(SIP) (01:0001:01)      with R-URI: 10.129.44.254:5060 UDP

18:07:02.517 CALL(SIP) (01:0001:01) RCVD 180 Ringing from 10.129.44.254:5060 UDP

18:07:02.517 CALL(SIP) (01:0001:01) SENT Outseize Ack to L4

18:07:02.517 CALL(SIP) (01:0001:01) SENT Alerting to L4

18:07:02.517 CALL(L4)  (01:0001:01) RCVD Outseize ACK  from SIP

18:07:02.517 CALL(L4)  (01:0001:01) RVCD Alerting  from SIP

18:07:02.517 CALL(GCL) (01:0001:00) SENT Connect Tone to L4

18:07:02.517 CALL(L4)  (01:0001:00) RCVD Connect Tone from GCL

18:07:02.517 CALL(L4)  (01:0001:00) SENT Request DSP Service to SYSRM

18:07:02.517 CALL(MED) (01:0001:00) Transmitting tone 0x2 on (0x1,0x1,0x0)

18:07:02.517 CALL(MED) (01:0001:00) RCVD OUTPULSE CP

18:07:02.517 CALL(GCL) (01:0001:00) SENT Connect w/Pad Response to L4

18:07:02.517 CALL(L4)  (01:0001:00) SENT Progress to SIP

18:07:02.517 CALL(SIP) (01:0001:01) RCVD Host Connect from L4

18:07:02.517 CALL(SIP) (01:0001:00) RCVD Progress from L4

18:07:02.517 CALL(SIP) (01:0001:00) Set Fax Type to Bypass

18:07:02.517 CALL(SIP) (01:0001:00) SENT L3-L3 Outseize Ctrl to VPPL

18:07:02.517 CALL(IP)  (01:0001:00) RCVD Outseize from L3, [vts 768] [m1.0.1]

18:07:02.517 CALL(IP)  (01:0001:00) RTP: (Src) 10.129.44.251:11072

18:07:02.517 CALL(IP)  (01:0001:00) RTP: (Dst) 10.129.44.226:10002

18:07:02.527 CALL(IP)  (01:0001:00) VoIP Codec is G711Mulaw; Payload Size is 20ms

18:07:02.527 CALL(IP)  (01:0001:00) RFC2833 DTMF Relay in use, Dynamic Payload Type is 101

18:07:02.547 CALL(IP)  (01:0001:00) SENT Outseize ACK to L3P, toPvid: x66

18:07:02.547 CALL(SIP) (01:0001:00) RCVD Outseize Ack from VPPL

18:07:02.547 CALL(SIP) (01:0001:00) SENT 183 Session Progress to 10.129.44.226:5060 UDP

18:07:02.547 CALL(SIP) (01:0001:00) RCVD Cut Thru from VPPL

18:07:02.547 CALL(SIP) (01:0001:00) RCVD Connect from VPPL

18:07:06.337 CALL(SIP) (01:0001:01) RCVD 200 OK from 10.129.44.254:5060 UDP

18:07:06.337 CALL(SIP) (01:0001:01) SENT ACK to 10.129.44.254:5060 UDP

18:07:06.337 CALL(SIP) (01:0001:01)      with R-URI: 10.129.44.254:5060 UDP

18:07:06.337 CALL(SIP) (01:0001:01) m line codec list:  0

18:07:06.337 CALL(SIP) (01:0001:01) RTP Type: 0, name: PCMU, clk: 8000

18:07:06.337 CALL(SIP) (01:0001:01) Set Fax Type to Bypass

18:07:06.337 CALL(SIP) (01:0001:01) SENT L3-L3 Outseize Ctrl to VPPL

18:07:06.337 CALL(IP)  (01:0001:01) RCVD Outseize from L3, [vts 0] [m0.0.1]

18:07:06.337 CALL(IP)  (01:0001:01) RTP: (Src) 10.129.44.241:8000

18:07:06.337 CALL(IP)  (01:0001:01) RTP: (Dst) 10.129.44.254:29574

18:07:06.347 CALL(IP)  (01:0001:01) VoIP Codec is G711Mulaw; Payload Size is 20ms

18:07:06.347 CALL(IP)  (01:0001:01) RFC2833 DTMF Relay in use, Dynamic Payload Type is 120

18:07:06.367 CALL(IP)  (01:0001:01) SENT Outseize ACK to L3P, toPvid: x66

18:07:06.367 CALL(SIP) (01:0001:01) RCVD Outseize Ack from VPPL

18:07:06.367 CALL(SIP) (01:0001:01) SENT Connect to L4

18:07:06.367 CALL(SIP) (01:0001:01) RCVD Cut Thru from VPPL

18:07:06.367 CALL(SIP) (01:0001:01) RCVD Connect from VPPL

18:07:06.367 CALL(L4)  (01:0001:01) RCVD Connect  from SIP

18:07:06.367 CALL(L4)  (01:0001:01) SENT CPE of ANSWER  to GCL

18:07:06.367 CALL(GCL) (01:0001:01) RCVD CPE of ANSWER  from L4

18:07:06.367 CALL(GCL) (01:0001:01) SENT RADIUS ACCT START

18:07:06.367 CALL(GCL) (01:0001:01) RCVD RADIUS ACCT START

18:07:06.367 CALL(GCL) (01:0001:00) SENT Disconnect Tone to L4

18:07:06.367 CALL(L4)  (01:0001:00) RCVD Disconnect Tone from GCL

18:07:06.367 CALL(L4)  (01:0001:00) SENT Cancel DSP Service to SYSRM

18:07:06.367 CALL(MED) (01:0001:00) RCVD CANCEL OUTPULSE CP

18:07:06.367 CALL(MED) (01:0001:00) RCVD CANCEL OUTPULSE DIGITS

18:07:06.367 CALL(GCL) (01:0001:00) SENT CPE of ANSWER  to L4

18:07:06.367 CALL(L4)  (01:0001:00) RCVD CPE of ANSWER from GCL

18:07:06.367 CALL(L4)  (01:0001:00) SENT Connect to SIP

18:07:06.367 CALL(L4)  (01:0001:01) SENT Connect to SIP

18:07:06.367 CALL(SIP) (01:0001:00) RCVD Connect from L4

18:07:06.367 CALL(SIP) (01:0001:00) SENT 200 OK to 10.129.44.226:5060 UDP

18:07:06.367 CALL(SIP) (01:0001:01) RCVD Connect from L4

18:07:06.437 CALL(SIP) (01:0001:00) RCVD ACK from 10.129.44.226 UDP

18:07:06.437 CALL(SIP) (01:0001:00)      with Via sent-by: 10.129.44.226

18:07:07.387 CALL(GCL) (01:0001:00) Releasing Call,Radius MaxCallDuration=1 secs elapsed

18:07:07.387 CALL(GCL) (01:0001:00) SENT Park Port to L4

18:07:07.387 CALL(L4)  (01:0001:00) RCVD Park  from GCL

18:07:07.387 CALL(GCL) (01:0001:01) SENT Clear Response to L4

18:07:07.387 CALL(GCL) (01:0001:00) SENT Clear Response to L4

18:07:07.387 CALL(L4)  (01:0001:01) RCVD Clear  from GCL

18:07:07.387 CALL(L4)  (01:0001:01) SENT Clear Request to SIP

18:07:07.387 CALL(L4)  (01:0001:00) RCVD Clear  from GCL

18:07:07.387 CALL(L4)  (01:0001:00) SENT Clear Request to SIP

18:07:07.387 CALL(SIP) (01:0001:01) RCVD Clear Request from L4

18:07:07.387 CALL(SIP) (01:0001:01) SENT BYE to 10.129.44.254:5060 UDP

18:07:07.387 CALL(SIP) (01:0001:01)      with R-URI: 10.129.44.254:5060 UDP

18:07:07.387 CALL(SIP) (01:0001:00) RCVD Clear Request from L4

18:07:07.387 CALL(SIP) (01:0001:00) SENT BYE to 10.129.44.226:5060 UDP

18:07:07.387 CALL(SIP) (01:0001:00)      with R-URI: 10.129.44.226:5060 UDP

18:07:07.437 CALL(SIP) (01:0001:00) RCVD 200 OK from 10.129.44.226:5060 UDP

18:07:07.437 CALL(SIP) (01:0001:00) SENT L3-L3 Clear Req to VPPL

18:07:07.437 CALL(IP)  (01:0001:00) RCVD Clear Request from L3

18:07:07.437 CALL(IP)  (01:0001:00) RTCP STATS: TxPackets=244; RxPackets=241; lostPackets=0

18:07:07.437 CALL(IP)  (01:0001:00) RTCP/T38 Packet STATS: TxPackets=244; RxPackets=241; lostPackets=0

18:07:07.437 CALL(SIP) (01:0001:00) RCVD Clear Req from VPPL

18:07:07.437 CALL(SIP) (01:0001:00) SENT Clear Request to L4

18:07:07.437 CALL(L4)  (01:0001:00) RCVD Clear request  from SIP

18:07:07.437 CALL(L4)  (01:0001:00) SENT Channel Release w/data to GCL

18:07:07.437 CALL(GCL) (01:0001:00) RCVD Channel Released w/data from L4

18:07:07.437 CALL(GCL) (01:0001:00) Call Duration(sec): 1

18:07:07.437 CALL(GCL) (01:0001:00) Radius Call Duration(sec): 1

18:07:07.437 CALL(GCL) (01:0001:00) SENT RADIUS ACCT STOP

18:07:07.557 CALL(SIP) (01:0001:01) RCVD 200 OK from 10.129.44.254:5060 UDP

18:07:07.557 CALL(SIP) (01:0001:01) SENT L3-L3 Clear Req to VPPL

18:07:07.557 CALL(IP)  (01:0001:01) RCVD Clear Request from L3

18:07:07.557 CALL(IP)  (01:0001:01) RTCP STATS: TxPackets=59; RxPackets=49; lostPackets=0

18:07:07.557 CALL(IP)  (01:0001:01) RTCP/T38 Packet STATS: TxPackets=59; RxPackets=49; lostPackets=0

18:07:07.557 CALL(SIP) (01:0001:01) RCVD Clear Req from VPPL

18:07:07.557 CALL(SIP) (01:0001:01) SENT Clear Request to L4

18:07:07.557 CALL(L4)  (01:0001:01) RCVD Clear request  from SIP

18:07:07.557 CALL(L4)  (01:0001:01) SENT Channel Release w/data to GCL

18:07:07.557 CALL(GCL) (01:0001:01) RCVD Channel Released w/data from L4

18:07:07.557 CALL(GCL) (01:0001:01) Call Duration(sec): 1

18:07:07.557 CALL(GCL) (01:0001:01) Radius Call Duration(sec): 1

18:07:07.557 CALL(GCL) (01:0001:01) SENT RADIUS ACCT STOP