Ticket #456: messages_ve02_1

File messages_ve02_1, 21.7 KB (added by roman_zhur, 28 hours ago)
Line 
1Apr 27 09:15:25 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: CAS event, ts=1, flags=0000, data=5
2Apr 27 09:15:25 sip_ua[454]: fxs.cpp:275: ts 1: dialing 11
3Apr 27 09:15:25 sip_ua[454]: user_agent.cpp:3892: --> ua_dial_out() <sip:22@192.168.20.70> -> sip:11@192.168.20.70...
4Apr 27 09:15:25 sip_ua[520]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK1352488005'
5Apr 27 09:15:25 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 2 (New call received!): cid=6, did=7, tid=8, rid=0, sid=0, nid=0
6Apr 27 09:15:25 sip_ua[478]: user_agent.cpp:2272: INVITE received: sip:11@127.0.0.1:6060;transport=udp (Call-ID: 1744862010@(null))
7Apr 27 09:15:25 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Incoming call, ts=-1, flags=0001, data=6
8Apr 27 09:15:25 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=6
9Apr 27 09:15:25 sip_ua[454]: virtualChannel.cpp:217: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=6
10Apr 27 09:15:25 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Incoming call, ts=-1, flags=0002, data=6
11Apr 27 09:15:25 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0002, data=6
12Apr 27 09:15:25 sip_ua[454]: user_agent.cpp:4329: Call 6 routed to TS 2
13Apr 27 09:15:25 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: CAS event, ts=1, flags=0000, data=5
14Apr 27 09:15:25 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 5 (Call is being processed!): cid=5, did=0, tid=7, rid=0, sid=0, nid=0
15Apr 27 09:15:25 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialing: Tone completed, ts=2, flags=0000, data=0
16Apr 27 09:15:26 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialing: Tone completed, ts=2, flags=0000, data=0
17Apr 27 09:15:27 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialing: Tone completed, ts=2, flags=0000, data=0
18Apr 27 09:15:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: RTP parameters, ts=2, flags=0000, data=6
19Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7297: --> ts 2: 192.168.20.70[10004] --> 192.168.20.70[10002]
20Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7298: --> ts 2: codec PCMA, VAD is on, red=0
21Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
22Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7357: ts 2: calling createConnection()
23Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
24Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
25Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7423: ts 2: RTP destination is 02:ad:c5:00:00:69
26Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7122: ts 2: starting RTP stream
27Apr 27 09:15:28 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 6 (Remote phone is ringing!): cid=5, did=8, tid=7, rid=0, sid=0, nid=0
28Apr 27 09:15:28 sip_ua[478]: user_agent.cpp:2499: ---> ringing with status code 183
29Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP parameters, ts=1, flags=0000, data=5
30Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7297: --> ts 1: 192.168.20.70[10002] --> 192.168.20.70[10004]
31Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7298: --> ts 1: codec PCMA, VAD is on, red=0
32Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
33Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7357: ts 1: calling createConnection()
34Apr 27 09:15:28 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=6, did=7, tid=10, rid=0, sid=0, nid=0
35Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
36Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
37Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7423: ts 1: RTP destination is 02:ad:c5:00:00:69
38Apr 27 09:15:28 sip_ua[454]: comcerto.cpp:7122: ts 1: starting RTP stream
39Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Remote is ringing, ts=1, flags=0000, data=5
40Apr 27 09:15:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
41Apr 27 09:15:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
42Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: CAS event, ts=1, flags=0000, data=5
43Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=1
44Apr 27 09:15:28 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=5, did=8, tid=9, rid=0, sid=0, nid=0
45Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Message answered 2xx, ts=1, flags=0000, data=5
46Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
47Apr 27 09:15:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
48Apr 27 09:15:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: RTP monitor, ts=2, flags=0000, data=1
49Apr 27 09:15:29 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: RTP monitor, ts=2, flags=0000, data=0
50Apr 27 09:15:29 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=0
51Apr 27 09:15:32 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=1
52Apr 27 09:15:33 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
53Apr 27 09:15:33 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
54Apr 27 09:15:33 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
55Apr 27 09:15:33 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
56Apr 27 09:15:33 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=0
57Apr 27 09:15:36 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=1
58Apr 27 09:15:37 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=0
59Apr 27 09:15:38 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
60Apr 27 09:15:38 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Statistics received, ts=2, flags=0000, data=0
61Apr 27 09:15:38 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
62Apr 27 09:15:38 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Statistics received, ts=1, flags=0000, data=0
63Apr 27 09:15:40 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP monitor, ts=1, flags=0000, data=1
64Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Tone detected, ts=2, flags=0000, data=28
65Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Dialed: Tone detected, ts=2, flags=0000, data=255
66Apr 27 09:15:41 sip_ua[454]: sl.cpp:348: SL[2]: duration 90 ms
67Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:6461: channel 2: answer
68Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP parameters, ts=2, flags=0000, data=6
69Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7297: --> ts 2: 192.168.20.70[10004] --> 192.168.20.70[10002]
70Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7298: --> ts 2: codec PCMA, VAD is on, red=0
71Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
72Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
73Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
74Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7423: ts 2: RTP destination is 02:ad:c5:00:00:69
75Apr 27 09:15:41 sip_ua[520]: repro.cpp:868: doSessionAccounting(): Session Established 'branch=z9hG4bK1352488005'
76Apr 27 09:15:41 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=5, did=8, tid=7, rid=0, sid=0, nid=0
77Apr 27 09:15:41 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: RTP parameters, ts=1, flags=0000, data=5
78Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7297: --> ts 1: 192.168.20.70[10002] --> 192.168.20.70[10004]
79Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7298: --> ts 1: codec PCMA, VAD is on, red=0
80Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
81Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
82Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
83Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7423: ts 1: RTP destination is 02:ad:c5:00:00:69
84Apr 27 09:15:41 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Calling: Call answered, ts=1, flags=0000, data=5
85Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
86Apr 27 09:15:41 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 12 (ACK received!): cid=6, did=7, tid=8, rid=0, sid=0, nid=0
87Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP parameters, ts=2, flags=0000, data=6
88Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7297: --> ts 2: 192.168.20.70[10004] --> 192.168.20.70[10002]
89Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7298: --> ts 2: codec PCMA, VAD is on, red=0
90Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
91Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
92Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
93Apr 27 09:15:41 sip_ua[454]: comcerto.cpp:7423: ts 2: RTP destination is 02:ad:c5:00:00:69
94Apr 27 09:15:41 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: ACK received, ts=2, flags=0000, data=6
95Apr 27 09:15:42 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=0
96Apr 27 09:15:42 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=0
97Apr 27 09:15:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
98Apr 27 09:15:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
99Apr 27 09:15:43 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
100Apr 27 09:15:43 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
101Apr 27 09:15:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
102Apr 27 09:15:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
103Apr 27 09:15:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
104Apr 27 09:15:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
105Apr 27 09:15:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
106Apr 27 09:15:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
107Apr 27 09:15:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
108Apr 27 09:15:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
109Apr 27 09:15:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
110Apr 27 09:15:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
111Apr 27 09:15:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
112Apr 27 09:15:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
113Apr 27 09:16:03 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
114Apr 27 09:16:03 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
115Apr 27 09:16:03 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
116Apr 27 09:16:03 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
117Apr 27 09:16:03 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
118Apr 27 09:16:03 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=28
119Apr 27 09:16:04 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=18
120Apr 27 09:16:04 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: PassThru mode autoswitch, ts=2, flags=0000, data=1
121Apr 27 09:16:04 sip_ua[454]: comcerto.cpp:6132: ts 2: PassThru mode autoswitch to 1
122Apr 27 09:16:04 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=255
123Apr 27 09:16:04 sip_ua[454]: sl.cpp:348: SL[2]: duration 150 ms
124Apr 27 09:16:04 sip_ua[454]: sl.cpp:391: SL[2]: unexpected short pulse received in state Connected
125Apr 27 09:16:04 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: PassThru mode autoswitch, ts=1, flags=0000, data=2
126Apr 27 09:16:04 sip_ua[454]: comcerto.cpp:6132: ts 1: PassThru mode autoswitch to 2
127Apr 27 09:16:04 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
128Apr 27 09:16:04 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
129Apr 27 09:16:04 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Tone detected, ts=1, flags=0000, data=16
130Apr 27 09:16:04 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Tone detected, ts=1, flags=0000, data=255
131Apr 27 09:16:05 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: TDM Call Progress detected, ts=1, flags=0000, data=81
132Apr 27 09:16:05 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: PassThru mode autoswitch, ts=1, flags=0000, data=0
133Apr 27 09:16:05 sip_ua[454]: comcerto.cpp:6132: ts 1: PassThru mode autoswitch to 0
134Apr 27 09:16:05 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
135Apr 27 09:16:05 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: PassThru mode autoswitch, ts=2, flags=0000, data=0
136Apr 27 09:16:05 sip_ua[454]: comcerto.cpp:6132: ts 2: PassThru mode autoswitch to 0
137Apr 27 09:16:05 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
138Apr 27 09:16:05 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=0
139Apr 27 09:16:05 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=0
140Apr 27 09:16:08 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
141Apr 27 09:16:08 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
142Apr 27 09:16:08 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
143Apr 27 09:16:08 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
144Apr 27 09:16:13 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
145Apr 27 09:16:13 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
146Apr 27 09:16:13 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
147Apr 27 09:16:13 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
148Apr 27 09:16:18 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
149Apr 27 09:16:18 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
150Apr 27 09:16:18 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
151Apr 27 09:16:18 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
152Apr 27 09:16:23 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
153Apr 27 09:16:23 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
154Apr 27 09:16:23 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
155Apr 27 09:16:23 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
156Apr 27 09:16:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
157Apr 27 09:16:28 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
158Apr 27 09:16:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
159Apr 27 09:16:28 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
160Apr 27 09:16:33 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
161Apr 27 09:16:33 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
162Apr 27 09:16:33 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
163Apr 27 09:16:33 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
164Apr 27 09:16:38 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
165Apr 27 09:16:38 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
166Apr 27 09:16:38 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
167Apr 27 09:16:38 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
168Apr 27 09:16:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
169Apr 27 09:16:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
170Apr 27 09:16:43 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
171Apr 27 09:16:43 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
172Apr 27 09:16:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
173Apr 27 09:16:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
174Apr 27 09:16:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
175Apr 27 09:16:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
176Apr 27 09:16:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
177Apr 27 09:16:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
178Apr 27 09:16:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
179Apr 27 09:16:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
180Apr 27 09:16:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
181Apr 27 09:16:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
182Apr 27 09:16:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
183Apr 27 09:16:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
184Apr 27 09:17:03 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
185Apr 27 09:17:03 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
186Apr 27 09:17:03 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
187Apr 27 09:17:03 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
188Apr 27 09:17:06 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=15
189Apr 27 09:17:06 sip_ua[454]: comcerto.cpp:7143: ts 1: stopping RTP stream
190Apr 27 09:17:07 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: Call disconnected, ts=1, flags=0000, data=5
191Apr 27 09:17:07 sip_ua[520]: repro.cpp:778: doSessionAccounting(): Session Ended 'branch=z9hG4bK1818803728'
192Apr 27 09:17:07 sip_ua[520]: repro.cpp:796: --> duration=86, [FXS]tel:22@192.168.20.70: ---> [SL]tel:11@192.168.20.70:
193Apr 27 09:17:07 sip_ua[520]: repro.cpp:1057: --> CDR: {"answer":1745745341,"duration":86,"hangup":1745745427,"org-host":"192.168.20.70","org-scheme":"tel","org-type":"FXS","org-user":"22","to-host":"192.168.20.70","to-scheme":"tel","to-type":"SL","to-
194Apr 27 09:17:07 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=6, did=7, tid=12, rid=0, sid=0, nid=0
195Apr 27 09:17:07 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 21 (Bye Received!): cid=6, did=7, tid=12, rid=0, sid=0, nid=0
196Apr 27 09:17:07 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Call disconnected, ts=2, flags=0000, data=6
197Apr 27 09:17:07 sip_ua[454]: comcerto.cpp:7143: ts 2: stopping RTP stream
198Apr 27 09:17:07 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=5, did=-1, tid=11, rid=0, sid=0, nid=0
199Apr 27 09:17:07 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: Message answered 2xx, ts=1, flags=0000, data=5
200Apr 27 09:17:07 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Blocked: Tone completed, ts=2, flags=0000, data=0
201Apr 27 09:17:23 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 22 (Call Context is released!): cid=5, did=0, tid=0, rid=0, sid=0, nid=0
202Apr 27 09:17:49 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 22 (Call Context is released!): cid=6, did=0, tid=0, rid=0, sid=0, nid=0