Ticket #476: messages_20.50.txt

File messages_20.50.txt, 9.4 KB (added by roman_zhur, 20 hours ago)
Line 
1Jun 3 06:28:16 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: DTMF detected, ts=2, flags=0000, data=12
2Jun 3 06:28:16 sip_ua[391]: ds.cpp:78: ts 2: dialing op2@192.168.20.50
3Jun 3 06:28:16 sip_ua[391]: user_agent.cpp:3907: --> ua_dial_out() <sip:00@192.168.20.40> -> sip:op2@192.168.20.50...
4Jun 3 06:28:16 sip_ua[448]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK1303151064'
5Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 2 (New call received!): cid=65, did=66, tid=101, rid=0, sid=0, nid=0
6Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2289: INVITE received: sip:op2@127.0.0.1:6060;transport=udp (Call-ID: 1509161711@(null))
7Jun 3 06:28:17 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=65
8Jun 3 06:28:17 sip_ua[391]: fxs.cpp:1020: channel 1: ringing
9Jun 3 06:28:17 sip_ua[391]: user_agent.cpp:4351: Call 65 routed to TS 1
10Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 5 (Call is being processed!): cid=64, did=0, tid=100, rid=0, sid=0, nid=0
11Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 6 (Remote phone is ringing!): cid=64, did=67, tid=100, rid=0, sid=0, nid=0
12Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2516: ---> ringing with status code 180
13Jun 3 06:28:17 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: Remote is ringing, ts=2, flags=0000, data=64
14Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 14 (New request received!): cid=65, did=66, tid=103, rid=0, sid=0, nid=0
15Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 16 (2xx received for request!): cid=64, did=67, tid=102, rid=0, sid=0, nid=0
16Jun 3 06:28:17 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: Message answered 2xx, ts=2, flags=0000, data=64
17Jun 3 06:28:17 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: Tone detected, ts=2, flags=0000, data=255
18Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Ringing: CAS event, ts=1, flags=0000, data=7
19Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:6314: channel 1: answer
20Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=65
21Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7150: --> ts 1: 192.168.20.50[10002] --> 192.168.20.50[10004]
22Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7151: --> ts 1: codec PCMA, VAD is on, red=0
23Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7152: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
24Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7211: ts 1: calling createConnection()
25Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7253: routing 192.168.20.50 to 192.168.20.50 (lo)
26Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7264: getMac(192.168.20.50): 02:ad:c3:00:00:ac
27Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7274: ts 1: RTP destination is 02:ad:c3:00:00:ac
28Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:6975: ts 1: starting RTP stream
29Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=7
30Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
31Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
32Jun 3 06:28:18 sip_ua[448]: repro.cpp:846: doSessionAccounting(): Session Established 'branch=z9hG4bK1303151064'
33Jun 3 06:28:18 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=64, did=67, tid=100, rid=0, sid=0, nid=0
34Jun 3 06:28:18 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: RTP parameters, ts=2, flags=0000, data=64
35Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7150: --> ts 2: 192.168.20.50[10004] --> 192.168.20.50[10002]
36Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7151: --> ts 2: codec PCMA, VAD is on, red=0
37Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7152: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
38Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7211: ts 2: calling createConnection()
39Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7253: routing 192.168.20.50 to 192.168.20.50 (lo)
40Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7264: getMac(192.168.20.50): 02:ad:c3:00:00:ac
41Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:7274: ts 2: RTP destination is 02:ad:c3:00:00:ac
42Jun 3 06:28:18 sip_ua[391]: comcerto.cpp:6975: ts 2: starting RTP stream
43Jun 3 06:28:18 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: Call answered, ts=2, flags=0000, data=64
44Jun 3 06:28:18 sip_ua[391]: ds.cpp:78: ts 2: dialing 00
45Jun 3 06:28:18 sip_ua[391]: user_agent.cpp:3907: --> ua_dial_out() -> sip:00@192.168.20.40...
46Jun 3 06:28:18 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
47Jun 3 06:28:18 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
48Jun 3 06:28:18 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
49Jun 3 06:28:19 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 12 (ACK received!): cid=65, did=66, tid=101, rid=0, sid=0, nid=0
50Jun 3 06:28:19 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: ACK received, ts=1, flags=0000, data=65
51Jun 3 06:28:19 sip_ua[448]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK102163749'
52Jun 3 06:28:19 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 9 (4xx received for Call!): cid=68, did=0, tid=104, rid=0, sid=0, nid=0
53Jun 3 06:28:19 sip_ua[448]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK1134240875'
54Jun 3 06:28:19 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 5 (Call is being processed!): cid=68, did=0, tid=105, rid=0, sid=0, nid=0
55Jun 3 06:28:19 sip_ua[448]: repro.cpp:846: doSessionAccounting(): Session Established 'branch=z9hG4bK1134240875'
56Jun 3 06:28:19 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=68, did=69, tid=105, rid=0, sid=0, nid=0
57Jun 3 06:28:19 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: RTP parameters, ts=2, flags=0000, data=68
58Jun 3 06:28:19 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Call answered, ts=2, flags=0000, data=68
59Jun 3 06:28:23 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
60Jun 3 06:28:23 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
61Jun 3 06:28:23 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
62Jun 3 06:28:23 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
63Jun 3 06:28:26 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=15
64Jun 3 06:28:26 sip_ua[391]: comcerto.cpp:6996: ts 1: stopping RTP stream
65Jun 3 06:28:26 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Call disconnected, ts=1, flags=0000, data=65
66Jun 3 06:28:26 sip_ua[448]: repro.cpp:756: doSessionAccounting(): Session Ended 'branch=z9hG4bK589143414'
67Jun 3 06:28:26 sip_ua[448]: repro.cpp:774: --> duration=8, [DS]tel:00@192.168.20.40: ---> [FXS]sip:op2@192.168.20.50:
68Jun 3 06:28:26 sip_ua[448]: repro.cpp:1035: --> CDR: {"answer":1780468098,"duration":8,"hangup":1780468106,"org-host":"192.168.20.40","org-scheme":"tel","org-type":"DS","org-user":"00","to-host":"192.168.20.50","to-scheme":"sip","to-type":"FXS","to-u
69Jun 3 06:28:26 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 14 (New request received!): cid=64, did=67, tid=107, rid=0, sid=0, nid=0
70Jun 3 06:28:26 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 21 (Bye Received!): cid=64, did=67, tid=107, rid=0, sid=0, nid=0
71Jun 3 06:28:26 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Call disconnected, ts=2, flags=0000, data=64
72Jun 3 06:28:26 sip_ua[391]: comcerto.cpp:6996: ts 2: stopping RTP stream
73Jun 3 06:28:26 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: Call disconnected, ts=2, flags=0000, data=68
74Jun 3 06:28:26 sip_ua[448]: repro.cpp:756: doSessionAccounting(): Session Ended 'branch=z9hG4bK1989200479'
75Jun 3 06:28:26 sip_ua[448]: repro.cpp:774: --> duration=7, [DS]tel:2@192.168.20.40: ---> []tel:00@192.168.20.40:
76Jun 3 06:28:26 sip_ua[448]: repro.cpp:1035: --> CDR: {"answer":1780468099,"duration":7,"hangup":1780468106,"org-host":"192.168.20.40","org-scheme":"tel","org-type":"DS","org-user":"2","to-host":"192.168.20.40","to-scheme":"tel","to-user":"00","type":
77Jun 3 06:28:26 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 16 (2xx received for request!): cid=65, did=-1, tid=106, rid=0, sid=0, nid=0
78Jun 3 06:28:26 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Message answered 2xx, ts=1, flags=0000, data=65
79Jun 3 06:28:26 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 16 (2xx received for request!): cid=68, did=-1, tid=108, rid=0, sid=0, nid=0
80Jun 3 06:28:26 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: Message answered 2xx, ts=2, flags=0000, data=68
81Jun 3 06:28:26 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: RTP monitor, ts=2, flags=0000, data=0
82Jun 3 06:28:31 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=65, did=0, tid=0, rid=0, sid=0, nid=0
83Jun 3 06:28:31 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=68, did=0, tid=0, rid=0, sid=0, nid=0
84Jun 3 06:28:58 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=64, did=0, tid=0, rid=0, sid=0, nid=0