Ticket #476: messages_20.60.txt

File messages_20.60.txt, 8.3 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 op3@192.168.20.60
3Jun 3 06:28:16 sip_ua[391]: user_agent.cpp:3907: --> ua_dial_out() <sip:00@192.168.20.40> -> sip:op3@192.168.20.60...
4Jun 3 06:28:16 sip_ua[450]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK1830764452'
5Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 2 (New call received!): cid=50, did=51, tid=87, rid=0, sid=0, nid=0
6Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2289: INVITE received: sip:op3@127.0.0.1:6060;transport=udp (Call-ID: 1027022968@(null))
7Jun 3 06:28:17 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=50
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 50 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=49, did=0, tid=86, 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=49, did=52, tid=86, 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=49
14Jun 3 06:28:17 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 14 (New request received!): cid=50, did=51, tid=89, 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=49, did=52, tid=88, 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=49
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:19 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Ringing: Caller ID sending complete, ts=1, flags=0000, data=0
19Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Ringing: CAS event, ts=1, flags=0000, data=7
20Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:6314: channel 1: answer
21Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=50
22Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7150: --> ts 1: 192.168.20.60[10002] --> 192.168.20.60[10004]
23Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7151: --> ts 1: codec PCMA, VAD is on, red=0
24Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7152: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
25Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7211: ts 1: calling createConnection()
26Jun 3 06:28:21 sip_ua[450]: repro.cpp:846: doSessionAccounting(): Session Established 'branch=z9hG4bK1830764452'
27Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=49, did=52, tid=86, rid=0, sid=0, nid=0
28Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 12 (ACK received!): cid=50, did=51, tid=87, rid=0, sid=0, nid=0
29Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7253: routing 192.168.20.60 to 192.168.20.60 (lo)
30Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7264: getMac(192.168.20.60): 02:ad:c3:00:00:06
31Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7274: ts 1: RTP destination is 02:ad:c3:00:00:06
32Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:6975: ts 1: starting RTP stream
33Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: RTP parameters, ts=2, flags=0000, data=49
34Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7150: --> ts 2: 192.168.20.60[10004] --> 192.168.20.60[10002]
35Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7151: --> ts 2: codec PCMA, VAD is on, red=0
36Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7152: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
37Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7211: ts 2: calling createConnection()
38Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7253: routing 192.168.20.60 to 192.168.20.60 (lo)
39Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7264: getMac(192.168.20.60): 02:ad:c3:00:00:06
40Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:7274: ts 2: RTP destination is 02:ad:c3:00:00:06
41Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:6975: ts 2: starting RTP stream
42Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Calling: Call answered, ts=2, flags=0000, data=49
43Jun 3 06:28:21 sip_ua[391]: ds.cpp:78: ts 2: dialing 00
44Jun 3 06:28:21 sip_ua[391]: user_agent.cpp:3907: --> ua_dial_out() -> sip:00@192.168.20.40...
45Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: ACK received, ts=1, flags=0000, data=50
46Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=7
47Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
48Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
49Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
50Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
51Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
52Jun 3 06:28:21 sip_ua[450]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK403010529'
53Jun 3 06:28:21 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
54Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 9 (4xx received for Call!): cid=53, did=0, tid=90, rid=0, sid=0, nid=0
55Jun 3 06:28:21 sip_ua[450]: repro.cpp:622: doSessionAccounting(): Session Created 'branch=z9hG4bK1049753513'
56Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 5 (Call is being processed!): cid=53, did=0, tid=91, rid=0, sid=0, nid=0
57Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 9 (4xx received for Call!): cid=53, did=0, tid=91, rid=0, sid=0, nid=0
58Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Connected: Call disconnected, ts=2, flags=0000, data=53
59Jun 3 06:28:21 sip_ua[391]: comcerto.cpp:6996: ts 2: stopping RTP stream
60Jun 3 06:28:21 sip_ua[450]: repro.cpp:756: doSessionAccounting(): Session Ended 'branch=z9hG4bK632651689'
61Jun 3 06:28:21 sip_ua[450]: repro.cpp:774: --> duration=0, [DS]tel:00@192.168.20.40: ---> [FXS]sip:op3@192.168.20.60:
62Jun 3 06:28:21 sip_ua[450]: repro.cpp:1035: --> CDR: {"answer":1780468101,"duration":0,"hangup":1780468101,"org-host":"192.168.20.40","org-scheme":"tel","org-type":"DS","org-user":"00","to-host":"192.168.20.60","to-scheme":"sip","to-type":"FXS","to-u
63Jun 3 06:28:21 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: Call disconnected, ts=2, flags=0000, data=49
64Jun 3 06:28:21 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 14 (New request received!): cid=50, did=51, tid=93, rid=0, sid=0, nid=0
65Jun 3 06:28:22 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 21 (Bye Received!): cid=50, did=51, tid=93, rid=0, sid=0, nid=0
66Jun 3 06:28:22 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Call disconnected, ts=1, flags=0000, data=50
67Jun 3 06:28:22 sip_ua[391]: comcerto.cpp:6996: ts 1: stopping RTP stream
68Jun 3 06:28:22 sip_ua[391]: comcerto.cpp:6996: ts 1: stopping RTP stream
69Jun 3 06:28:22 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 16 (2xx received for request!): cid=49, did=-1, tid=92, rid=0, sid=0, nid=0
70Jun 3 06:28:22 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: Message answered 2xx, ts=2, flags=0000, data=49
71Jun 3 06:28:22 sip_ua[391]: ds.cpp:102: ---> ts=2, state=Idle: RTP monitor, ts=2, flags=0000, data=0
72Jun 3 06:28:22 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Busy: RTP monitor, ts=1, flags=0000, data=0
73Jun 3 06:28:24 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Busy: CAS event, ts=1, flags=0000, data=15
74Jun 3 06:28:27 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=49, did=0, tid=0, rid=0, sid=0, nid=0
75Jun 3 06:29:03 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=53, did=0, tid=0, rid=0, sid=0, nid=0
76Jun 3 06:29:03 sip_ua[416]: user_agent.cpp:2151: ---> transport 0: SIP event 22 (Call Context is released!): cid=50, did=0, tid=0, rid=0, sid=0, nid=0