Ticket #455: messages_VE-02

File messages_VE-02, 12.1 KB (added by roman_zhur, 40 hours ago)
Line 
1May 13 10:35:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=28
2May 13 10:35:43 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Idle: Tone detected, ts=2, flags=0000, data=255
3May 13 10:35:43 sip_ua[454]: sl.cpp:348: SL[2]: duration 90 ms
4May 13 10:35:44 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
5May 13 10:35:44 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
6May 13 10:35:44 sip_ua[454]: sl.cpp:348: SL[2]: duration 50 ms
7May 13 10:35:44 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone completed, ts=2, flags=0000, data=3
8May 13 10:35:44 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
9May 13 10:35:44 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
10May 13 10:35:44 sip_ua[454]: sl.cpp:348: SL[2]: duration 50 ms
11May 13 10:35:45 sip_ua[454]: sl.cpp:187: ts 02: digit '2'
12May 13 10:35:45 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
13May 13 10:35:45 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
14May 13 10:35:45 sip_ua[454]: sl.cpp:348: SL[2]: duration 50 ms
15May 13 10:35:45 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=28
16May 13 10:35:45 sip_ua[454]: sl.cpp:205: ---> ts=2, state=NumRecv: Tone detected, ts=2, flags=0000, data=255
17May 13 10:35:45 sip_ua[454]: sl.cpp:348: SL[2]: duration 50 ms
18May 13 10:35:46 sip_ua[454]: sl.cpp:187: ts 02: digit '2'
19May 13 10:35:46 sip_ua[454]: sl.cpp:81: ts 2: dialing 22
20May 13 10:35:46 sip_ua[454]: user_agent.cpp:3892: --> ua_dial_out() -> sip:22@192.168.20.70...
21May 13 10:35:46 sip_ua[524]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK32677361'
22May 13 10:35:46 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 2 (New call received!): cid=64, did=65, tid=90, rid=0, sid=0, nid=0
23May 13 10:35:46 sip_ua[478]: user_agent.cpp:2272: INVITE received: sip:22@127.0.0.1:6060;transport=udp (Call-ID: 737421430@(null))
24May 13 10:35:46 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=64
25May 13 10:35:46 sip_ua[454]: fxs.cpp:1023: channel 1: ringing
26May 13 10:35:46 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 6 (Remote phone is ringing!): cid=63, did=66, tid=89, rid=0, sid=0, nid=0
27May 13 10:35:46 sip_ua[478]: user_agent.cpp:2499: ---> ringing with status code 180
28May 13 10:35:46 sip_ua[454]: user_agent.cpp:4329: Call 64 routed to TS 1
29May 13 10:35:46 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Calling: Remote is ringing, ts=2, flags=0000, data=63
30May 13 10:35:46 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=64, did=65, tid=92, rid=0, sid=0, nid=0
31May 13 10:35:46 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=63, did=66, tid=91, rid=0, sid=0, nid=0
32May 13 10:35:46 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Calling: Message answered 2xx, ts=2, flags=0000, data=63
33May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Ringing: CAS event, ts=1, flags=0000, data=7
34May 13 10:35:48 sip_ua[454]: comcerto.cpp:6461: channel 1: answer
35May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=64
36May 13 10:35:48 sip_ua[454]: comcerto.cpp:7297: --> ts 1: 192.168.20.70[10002] --> 192.168.20.70[10004]
37May 13 10:35:48 sip_ua[454]: comcerto.cpp:7298: --> ts 1: codec PCMA, VAD is on, red=0
38May 13 10:35:48 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
39May 13 10:35:48 sip_ua[454]: comcerto.cpp:7357: ts 1: calling createConnection()
40May 13 10:35:48 sip_ua[524]: repro.cpp:868: doSessionAccounting(): Session Established 'branch=z9hG4bK32677361'
41May 13 10:35:48 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=63, did=66, tid=89, rid=0, sid=0, nid=0
42May 13 10:35:48 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 12 (ACK received!): cid=64, did=65, tid=90, rid=0, sid=0, nid=0
43May 13 10:35:48 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
44May 13 10:35:48 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
45May 13 10:35:48 sip_ua[454]: comcerto.cpp:7423: ts 1: RTP destination is 02:ad:c5:00:00:69
46May 13 10:35:48 sip_ua[454]: comcerto.cpp:7122: ts 1: starting RTP stream
47May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Calling: RTP parameters, ts=2, flags=0000, data=63
48May 13 10:35:48 sip_ua[454]: comcerto.cpp:7297: --> ts 2: 192.168.20.70[10004] --> 192.168.20.70[10002]
49May 13 10:35:48 sip_ua[454]: comcerto.cpp:7298: --> ts 2: codec PCMA, VAD is on, red=0
50May 13 10:35:48 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
51May 13 10:35:48 sip_ua[454]: comcerto.cpp:7357: ts 2: calling createConnection()
52May 13 10:35:48 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
53May 13 10:35:48 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
54May 13 10:35:48 sip_ua[454]: comcerto.cpp:7423: ts 2: RTP destination is 02:ad:c5:00:00:69
55May 13 10:35:48 sip_ua[454]: comcerto.cpp:7122: ts 2: starting RTP stream
56May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Calling: Call answered, ts=2, flags=0000, data=63
57May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP parameters, ts=1, flags=0000, data=64
58May 13 10:35:48 sip_ua[454]: comcerto.cpp:7297: --> ts 1: 192.168.20.70[10002] --> 192.168.20.70[10004]
59May 13 10:35:48 sip_ua[454]: comcerto.cpp:7298: --> ts 1: codec PCMA, VAD is on, red=0
60May 13 10:35:48 sip_ua[454]: comcerto.cpp:7299: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
61May 13 10:35:48 sip_ua[454]: comcerto.cpp:7401: routing 192.168.20.70 to 192.168.20.70 (lo)
62May 13 10:35:48 sip_ua[454]: comcerto.cpp:7413: getMac(192.168.20.70): 02:ad:c5:00:00:69
63May 13 10:35:48 sip_ua[454]: comcerto.cpp:7423: ts 1: RTP destination is 02:ad:c5:00:00:69
64May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: ACK received, ts=1, flags=0000, data=64
65May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=7
66May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
67May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
68May 13 10:35:48 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
69May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
70May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
71May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
72May 13 10:35:48 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone completed, ts=2, flags=0000, data=0
73May 13 10:35:49 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=0
74May 13 10:35:50 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
75May 13 10:35:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
76May 13 10:35:53 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
77May 13 10:35:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
78May 13 10:35:53 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
79May 13 10:35:54 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=28
80May 13 10:35:54 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=18
81May 13 10:35:54 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: PassThru mode autoswitch, ts=2, flags=0000, data=1
82May 13 10:35:54 sip_ua[454]: comcerto.cpp:6132: ts 2: PassThru mode autoswitch to 1
83May 13 10:35:54 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
84May 13 10:35:54 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Tone detected, ts=2, flags=0000, data=255
85May 13 10:35:54 sip_ua[454]: sl.cpp:348: SL[2]: duration 170 ms
86May 13 10:35:54 sip_ua[454]: sl.cpp:391: SL[2]: unexpected short pulse received in state Connected
87May 13 10:35:54 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: PassThru mode autoswitch, ts=1, flags=0000, data=2
88May 13 10:35:54 sip_ua[454]: comcerto.cpp:6132: ts 1: PassThru mode autoswitch to 2
89May 13 10:35:54 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
90May 13 10:35:54 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Tone detected, ts=1, flags=0000, data=16
91May 13 10:35:55 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Tone detected, ts=1, flags=0000, data=255
92May 13 10:35:56 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: TDM Call Progress detected, ts=1, flags=0000, data=81
93May 13 10:35:56 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: PassThru mode autoswitch, ts=1, flags=0000, data=0
94May 13 10:35:56 sip_ua[454]: comcerto.cpp:6132: ts 1: PassThru mode autoswitch to 0
95May 13 10:35:56 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=1
96May 13 10:35:56 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: PassThru mode autoswitch, ts=2, flags=0000, data=0
97May 13 10:35:56 sip_ua[454]: comcerto.cpp:6132: ts 2: PassThru mode autoswitch to 0
98May 13 10:35:56 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: RTP monitor, ts=2, flags=0000, data=1
99May 13 10:35:57 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: RTP monitor, ts=1, flags=0000, data=0
100May 13 10:35:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
101May 13 10:35:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: Statistics received, ts=1, flags=0000, data=0
102May 13 10:35:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Connected: CAS event, ts=1, flags=0000, data=15
103May 13 10:35:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
104May 13 10:35:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Statistics received, ts=2, flags=0000, data=0
105May 13 10:35:58 sip_ua[454]: comcerto.cpp:7143: ts 1: stopping RTP stream
106May 13 10:35:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: Call disconnected, ts=1, flags=0000, data=64
107May 13 10:35:58 sip_ua[524]: repro.cpp:778: doSessionAccounting(): Session Ended 'branch=z9hG4bK538071444'
108May 13 10:35:58 sip_ua[524]: repro.cpp:796: --> duration=10, [SL]tel:ve02@192.168.20.70: ---> [FXS]sip:22@192.168.20.70:
109May 13 10:35:58 sip_ua[524]: repro.cpp:1057: --> CDR: {"answer":1747132548,"duration":10,"hangup":1747132558,"org-host":"192.168.20.70","org-scheme":"tel","org-type":"SL","org-user":"ve02","to-host":"192.168.20.70","to-scheme":"sip","to-type":"FXS","t
110May 13 10:35:58 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=63, did=66, tid=94, rid=0, sid=0, nid=0
111May 13 10:35:58 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 21 (Bye Received!): cid=63, did=66, tid=94, rid=0, sid=0, nid=0
112May 13 10:35:58 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Connected: Call disconnected, ts=2, flags=0000, data=63
113May 13 10:35:58 sip_ua[454]: comcerto.cpp:7143: ts 2: stopping RTP stream
114May 13 10:35:58 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=64, did=-1, tid=93, rid=0, sid=0, nid=0
115May 13 10:35:58 sip_ua[454]: fxs.cpp:434: ---> ts=1, state=Idle: Message answered 2xx, ts=1, flags=0000, data=64
116May 13 10:35:59 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Blocked: RTP monitor, ts=2, flags=0000, data=0
117May 13 10:35:59 sip_ua[454]: sl.cpp:205: ---> ts=2, state=Blocked: Tone completed, ts=2, flags=0000, data=0
118May 13 10:36:03 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 22 (Call Context is released!): cid=64, did=0, tid=0, rid=0, sid=0, nid=0