Ticket #456: messages_ve01_600-750

File messages_ve01_600-750, 9.5 KB (added by roman_zhur, 22 hours ago)
Line 
1Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=48
2Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=28
3Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=255
4Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=254
5Apr 27 10:10:51 sip_ua[391]: sl.cpp:348: SL[2]: duration 50 ms
6Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
7Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=48
8Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
9Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=254
10Apr 27 10:10:51 sip_ua[391]: sl.cpp:348: SL[2]: duration 50 ms
11Apr 27 10:10:51 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone completed, ts=2, flags=0000, data=3
12Apr 27 10:10:52 sip_ua[391]: sl.cpp:187: ts 02: digit '1'
13Apr 27 10:10:52 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
14Apr 27 10:10:52 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=48
15Apr 27 10:10:52 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
16Apr 27 10:10:52 sip_ua[391]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=254
17Apr 27 10:10:52 sip_ua[391]: sl.cpp:348: SL[2]: duration 50 ms
18Apr 27 10:10:52 sip_ua[391]: sl.cpp:187: ts 02: digit '1'
19Apr 27 10:10:52 sip_ua[391]: sl.cpp:81: ts 2: dialing 11
20Apr 27 10:10:52 sip_ua[391]: user_agent.cpp:3892: --> ua_dial_out() -> sip:11@192.168.20.69...
21Apr 27 10:10:52 sip_ua[448]: repro.cpp:608: doSessionAccounting(): Session Created 'branch=z9hG4bK960428373'
22Apr 27 10:10:53 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 2 (New call received!): cid=6, did=7, tid=8, rid=0, sid=0, nid=0
23Apr 27 10:10:53 sip_ua[416]: user_agent.cpp:2272: INVITE received: sip:11@127.0.0.1:6060;transport=udp (Call-ID: 1119275658@(null))
24Apr 27 10:10:53 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=6
25Apr 27 10:10:53 sip_ua[391]: fxs.cpp:1020: channel 1: ringing
26Apr 27 10:10:53 sip_ua[391]: user_agent.cpp:4329: Call 6 routed to TS 1
27Apr 27 10:10:53 sip_ua[416]: 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 10:10:53 sip_ua[416]: user_agent.cpp:2499: ---> ringing with status code 180
29Apr 27 10:10:53 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Calling: Remote is ringing, ts=2, flags=0000, data=5
30Apr 27 10:10:53 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=6, did=7, tid=10, rid=0, sid=0, nid=0
31Apr 27 10:10:53 sip_ua[416]: 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
32Apr 27 10:10:53 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Calling: Message answered 2xx, ts=2, flags=0000, data=5
33Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Ringing: CAS event, ts=1, flags=0000, data=5
34Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:6311: channel 1: answer
35Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=6
36Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7147: --> ts 1: 192.168.20.69[10002] --> 192.168.20.69[10004]
37Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7148: --> ts 1: codec PCMA, VAD is on, red=0
38Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7149: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
39Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7207: ts 1: calling createConnection()
40Apr 27 10:10:55 sip_ua[448]: repro.cpp:832: doSessionAccounting(): Session Established 'branch=z9hG4bK960428373'
41Apr 27 10:10:55 sip_ua[416]: 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
42Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7248: routing 192.168.20.69 to 192.168.20.69 (lo)
43Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7259: getMac(192.168.20.69): 02:ad:c3:00:00:06
44Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7269: ts 1: RTP destination is 02:ad:c3:00:00:06
45Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:6972: ts 1: starting RTP stream
46Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Calling: RTP parameters, ts=2, flags=0000, data=5
47Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7147: --> ts 2: 192.168.20.69[10004] --> 192.168.20.69[10002]
48Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7148: --> ts 2: codec PCMA, VAD is on, red=0
49Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7149: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
50Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7207: ts 2: calling createConnection()
51Apr 27 10:10:55 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 12 (ACK received!): cid=6, did=7, tid=8, rid=0, sid=0, nid=0
52Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7248: routing 192.168.20.69 to 192.168.20.69 (lo)
53Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7259: getMac(192.168.20.69): 02:ad:c3:00:00:06
54Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7269: ts 2: RTP destination is 02:ad:c3:00:00:06
55Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:6972: ts 2: starting RTP stream
56Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=5
57Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Calling: Call answered, ts=2, flags=0000, data=5
58Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=6
59Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7147: --> ts 1: 192.168.20.69[10002] --> 192.168.20.69[10004]
60Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7148: --> ts 1: codec PCMA, VAD is on, red=0
61Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7149: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
62Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7248: routing 192.168.20.69 to 192.168.20.69 (lo)
63Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7259: getMac(192.168.20.69): 02:ad:c3:00:00:06
64Apr 27 10:10:55 sip_ua[391]: comcerto.cpp:7269: ts 1: RTP destination is 02:ad:c3:00:00:06
65Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: ACK received, ts=1, flags=0000, data=6
66Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
67Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
68Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
69Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
70Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
71Apr 27 10:10:55 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
72Apr 27 10:10:55 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Tone completed, ts=2, flags=0000, data=0
73Apr 27 10:10:56 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=0
74Apr 27 10:10:56 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=0
75Apr 27 10:11:00 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
76Apr 27 10:11:00 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
77Apr 27 10:11:00 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
78Apr 27 10:11:00 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
79Apr 27 10:11:01 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=15
80Apr 27 10:11:01 sip_ua[391]: comcerto.cpp:6993: ts 1: stopping RTP stream
81Apr 27 10:11:01 sip_ua[448]: repro.cpp:742: doSessionAccounting(): Session Ended 'branch=z9hG4bK707109920'
82Apr 27 10:11:01 sip_ua[448]: repro.cpp:760: --> duration=6, [SL]tel:ve01@192.168.20.69: ---> [FXS]sip:11@192.168.20.69:
83Apr 27 10:11:01 sip_ua[448]: repro.cpp:1021: --> CDR: {"answer":1745748655,"duration":6,"hangup":1745748661,"org-host":"192.168.20.69","org-scheme":"tel","org-type":"SL","org-user":"ve01","to-host":"192.168.20.69","to-scheme":"sip","to-type":"FXS","to
84Apr 27 10:11:01 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=5, did=8, tid=12, rid=0, sid=0, nid=0
85Apr 27 10:11:01 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 21 (Bye Received!): cid=5, did=8, tid=12, rid=0, sid=0, nid=0
86Apr 27 10:11:01 sip_ua[416]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=6, did=-1, tid=11, rid=0, sid=0, nid=0
87Apr 27 10:11:01 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Call disconnected, ts=1, flags=0000, data=6
88Apr 27 10:11:01 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Connected: Call disconnected, ts=2, flags=0000, data=5
89Apr 27 10:11:01 sip_ua[391]: comcerto.cpp:6993: ts 2: stopping RTP stream
90Apr 27 10:11:01 sip_ua[391]: fxs.cpp:431: ---> ts=1, state=Idle: Message answered 2xx, ts=1, flags=0000, data=6
91Apr 27 10:11:02 sip_ua[391]: sl.cpp:205: ---> ts=2, state=Blocked: Tone completed, ts=2, flags=0000, data=0
92Apr 27 10:11:06 sip_ua[416]: 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