Ticket #270: messages_busy

File messages_busy, 93.8 KB (added by san, 7 years ago)
Line 
1May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS A activity detected, ts=29, flags=0000, data=0
2May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS event, ts=29, flags=0000, data=7
3May 23 11:40:44 sip_ua[363]: fxs.cpp:702: ==> ts 29: manual CAS event processing (abcd=15)
4May 23 11:40:44 sip_ua[363]: fxs.cpp:241: ts 29: dialing 400
5May 23 11:40:44 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:129@192.168.0.95> -> sip:400@192.168.0.95 ()...
6May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: CAS event, ts=29, flags=0000, data=7
7May 23 11:40:44 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK1235274424'
8May 23 11:40:44 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 1457362234@(null))
9May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=734
10May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=734
11May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=734
12May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=734
13May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=734
14May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=734
15May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=734
16May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=734
17May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=734
18May 23 11:40:44 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=734
19May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
20May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
21May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent to originator)
22May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
23May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 8e]
24May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
25May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < ChanSel: As indicated in following octets
26May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Coding: 0 Number Specified Channel Type: 3
27May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Channel: 14 Type: CPE]
28May 23 11:40:45 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_PROCEEDING
29May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
30May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
31May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent to originator)
32May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: ALERTING (1)
33May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < [1e 02 81 88]
34May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1)
35May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ]
36May 23 11:40:45 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_RINGING
37May 23 11:40:45 sip_ua[363]: comcerto.cpp:6606: --> ts 142: 192.168.0.95[10284] --> 192.168.0.95[10058]
38May 23 11:40:45 sip_ua[363]: comcerto.cpp:6607: --> ts 142: codec PCMA, VAD is on
39May 23 11:40:45 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
40May 23 11:40:45 sip_ua[387]: user_agent.cpp:2132: ---> ringing with status code 180
41May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: RTP parameters, ts=29, flags=0000, data=733
42May 23 11:40:45 sip_ua[363]: comcerto.cpp:6606: --> ts 29: 192.168.0.95[10058] --> 192.168.0.95[10284]
43May 23 11:40:45 sip_ua[363]: comcerto.cpp:6607: --> ts 29: codec PCMA, VAD is on
44May 23 11:40:45 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
45May 23 11:40:45 sip_ua[363]: comcerto.cpp:6723: ts 29: starting RTP stream to 02:ad:c3:00:00:e0
46May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Remote is ringing, ts=29, flags=0000, data=733
47May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Statistics received, ts=29, flags=0000, data=0
48May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Statistics received, ts=29, flags=0000, data=0
49May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: CAS event, ts=29, flags=0000, data=15
50May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Call disconnected, ts=29, flags=0000, data=733
51May 23 11:40:45 sip_ua[476]: repro.cpp:552: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK1235274424'
52May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
53May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
54May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
55May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent from originator)
56May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
57May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
58May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
59May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent from originator)
60May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
61May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
62May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
63May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
64May 23 11:40:45 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Call disconnected, ts=29, flags=0000, data=733
65May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
66May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
67May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent to originator)
68May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE (77)
69May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
70May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
71May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
72May 23 11:40:45 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP
73May 23 11:40:45 sip_ua[363]: pri.cpp:503: --> channel=14, cause=Normal, unspecified
74May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]:
75May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
76May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
77May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 208/0xD0) (Sent from originator)
78May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
79May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
80May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
81May 23 11:40:45 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
82May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS A activity detected, ts=28, flags=0000, data=0
83May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS A activity detected, ts=29, flags=0000, data=0
84May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS event, ts=28, flags=0000, data=7
85May 23 11:41:01 sip_ua[363]: fxs.cpp:702: ==> ts 28: manual CAS event processing (abcd=15)
86May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS event, ts=29, flags=0000, data=7
87May 23 11:41:01 sip_ua[363]: fxs.cpp:702: ==> ts 29: manual CAS event processing (abcd=15)
88May 23 11:41:01 sip_ua[363]: fxs.cpp:241: ts 28: dialing 400
89May 23 11:41:01 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:128@192.168.0.95> -> sip:400@192.168.0.95 ()...
90May 23 11:41:01 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK1430164737'
91May 23 11:41:01 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 1783069087@(null))
92May 23 11:41:01 sip_ua[363]: fxs.cpp:241: ts 29: dialing 400
93May 23 11:41:01 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:129@192.168.0.95> -> sip:400@192.168.0.95 ()...
94May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=7
95May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=738
96May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=738
97May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=738
98May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=738
99May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=738
100May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=738
101May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=738
102May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=738
103May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=738
104May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=738
105May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=738
106May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=12, state=Idle: Incoming call, ts=-1, flags=0001, data=738
107May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=13, state=Idle: Incoming call, ts=-1, flags=0001, data=738
108May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=14, state=Idle: Incoming call, ts=-1, flags=0001, data=738
109May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: Incoming call, ts=-1, flags=0001, data=738
110May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=16, state=Idle: Incoming call, ts=-1, flags=0001, data=738
111May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0001, data=738
112May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0001, data=738
113May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0001, data=738
114May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0001, data=738
115May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0001, data=738
116May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=36, state=Idle: Incoming call, ts=-1, flags=0001, data=738
117May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=37, state=Idle: Incoming call, ts=-1, flags=0001, data=738
118May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=38, state=Idle: Incoming call, ts=-1, flags=0001, data=738
119May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=39, state=Idle: Incoming call, ts=-1, flags=0001, data=738
120May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=40, state=Idle: Incoming call, ts=-1, flags=0001, data=738
121May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=41, state=Idle: Incoming call, ts=-1, flags=0001, data=738
122May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=42, state=Idle: Incoming call, ts=-1, flags=0001, data=738
123May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=55, state=Idle: Incoming call, ts=-1, flags=0001, data=738
124May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=56, state=Idle: Incoming call, ts=-1, flags=0001, data=738
125May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=57, state=Idle: Incoming call, ts=-1, flags=0001, data=738
126May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=58, state=Idle: Incoming call, ts=-1, flags=0001, data=738
127May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=59, state=Idle: Incoming call, ts=-1, flags=0001, data=738
128May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=60, state=Idle: Incoming call, ts=-1, flags=0001, data=738
129May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=61, state=Idle: Incoming call, ts=-1, flags=0001, data=738
130May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=62, state=Idle: Incoming call, ts=-1, flags=0001, data=738
131May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=77, state=Idle: Incoming call, ts=-1, flags=0001, data=738
132May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=78, state=Idle: Incoming call, ts=-1, flags=0001, data=738
133May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=79, state=Idle: Incoming call, ts=-1, flags=0001, data=738
134May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=80, state=Idle: Incoming call, ts=-1, flags=0001, data=738
135May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=81, state=Idle: Incoming call, ts=-1, flags=0001, data=738
136May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=82, state=Idle: Incoming call, ts=-1, flags=0001, data=738
137May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=83, state=Idle: Incoming call, ts=-1, flags=0001, data=738
138May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=84, state=Idle: Incoming call, ts=-1, flags=0001, data=738
139May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=85, state=Idle: Incoming call, ts=-1, flags=0001, data=738
140May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=99, state=Idle: Incoming call, ts=-1, flags=0001, data=738
141May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=100, state=Idle: Incoming call, ts=-1, flags=0001, data=738
142May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=101, state=Idle: Incoming call, ts=-1, flags=0001, data=738
143May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=102, state=Idle: Incoming call, ts=-1, flags=0001, data=738
144May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=103, state=Idle: Incoming call, ts=-1, flags=0001, data=738
145May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=104, state=Idle: Incoming call, ts=-1, flags=0001, data=738
146May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=105, state=Idle: Incoming call, ts=-1, flags=0001, data=738
147May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=106, state=Idle: Incoming call, ts=-1, flags=0001, data=738
148May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=107, state=Idle: Incoming call, ts=-1, flags=0001, data=738
149May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=108, state=Idle: Incoming call, ts=-1, flags=0001, data=738
150May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=109, state=Idle: Incoming call, ts=-1, flags=0001, data=738
151May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=122, state=Idle: Incoming call, ts=-1, flags=0001, data=738
152May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=123, state=Idle: Incoming call, ts=-1, flags=0001, data=738
153May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=124, state=Idle: Incoming call, ts=-1, flags=0001, data=738
154May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=125, state=Idle: Incoming call, ts=-1, flags=0001, data=738
155May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=126, state=Idle: Incoming call, ts=-1, flags=0001, data=738
156May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=127, state=Idle: Incoming call, ts=-1, flags=0001, data=738
157May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=128, state=Idle: Incoming call, ts=-1, flags=0001, data=738
158May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=129, state=Idle: Incoming call, ts=-1, flags=0001, data=738
159May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=130, state=Idle: Incoming call, ts=-1, flags=0001, data=738
160May 23 11:41:01 sip_ua[363]: pri.cpp:582: ---> PRI[144]: Incoming call, ts=-1, flags=0001, data=738
161May 23 11:41:01 sip_ua[363]: virtualChannel.cpp:135: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=738
162May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0002, data=738
163May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0002, data=738
164May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0002, data=738
165May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=20, state=Idle: Incoming call, ts=-1, flags=0002, data=738
166May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=21, state=Idle: Incoming call, ts=-1, flags=0002, data=738
167May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=22, state=Idle: Incoming call, ts=-1, flags=0002, data=738
168May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=23, state=Idle: Incoming call, ts=-1, flags=0002, data=738
169May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=24, state=Idle: Incoming call, ts=-1, flags=0002, data=738
170May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=25, state=Idle: Incoming call, ts=-1, flags=0002, data=738
171May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=26, state=Idle: Incoming call, ts=-1, flags=0002, data=738
172May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=27, state=Idle: Incoming call, ts=-1, flags=0002, data=738
173May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Incoming call, ts=-1, flags=0002, data=738
174May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=30, state=Idle: Incoming call, ts=-1, flags=0002, data=738
175May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=31, state=Idle: Incoming call, ts=-1, flags=0002, data=738
176May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0002, data=738
177May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0002, data=738
178May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0002, data=738
179May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=36, state=Idle: Incoming call, ts=-1, flags=0002, data=738
180May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=37, state=Idle: Incoming call, ts=-1, flags=0002, data=738
181May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=38, state=Idle: Incoming call, ts=-1, flags=0002, data=738
182May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=39, state=Idle: Incoming call, ts=-1, flags=0002, data=738
183May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=40, state=Idle: Incoming call, ts=-1, flags=0002, data=738
184May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=41, state=Idle: Incoming call, ts=-1, flags=0002, data=738
185May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=42, state=Idle: Incoming call, ts=-1, flags=0002, data=738
186May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=43, state=Idle: Incoming call, ts=-1, flags=0002, data=738
187May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=44, state=Idle: Incoming call, ts=-1, flags=0002, data=738
188May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=45, state=Idle: Incoming call, ts=-1, flags=0002, data=738
189May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=46, state=Idle: Incoming call, ts=-1, flags=0002, data=738
190May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=47, state=Idle: Incoming call, ts=-1, flags=0002, data=738
191May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=59, state=Idle: Incoming call, ts=-1, flags=0002, data=738
192May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=60, state=Idle: Incoming call, ts=-1, flags=0002, data=738
193May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=61, state=Idle: Incoming call, ts=-1, flags=0002, data=738
194May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=62, state=Idle: Incoming call, ts=-1, flags=0002, data=738
195May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=63, state=Idle: Incoming call, ts=-1, flags=0002, data=738
196May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=65, state=Idle: Incoming call, ts=-1, flags=0002, data=738
197May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=66, state=Idle: Incoming call, ts=-1, flags=0002, data=738
198May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=67, state=Idle: Incoming call, ts=-1, flags=0002, data=738
199May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=68, state=Idle: Incoming call, ts=-1, flags=0002, data=738
200May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=69, state=Idle: Incoming call, ts=-1, flags=0002, data=738
201May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=70, state=Idle: Incoming call, ts=-1, flags=0002, data=738
202May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=71, state=Idle: Incoming call, ts=-1, flags=0002, data=738
203May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=83, state=Idle: Incoming call, ts=-1, flags=0002, data=738
204May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=84, state=Idle: Incoming call, ts=-1, flags=0002, data=738
205May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=85, state=Idle: Incoming call, ts=-1, flags=0002, data=738
206May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=86, state=Idle: Incoming call, ts=-1, flags=0002, data=738
207May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=87, state=Idle: Incoming call, ts=-1, flags=0002, data=738
208May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=88, state=Idle: Incoming call, ts=-1, flags=0002, data=738
209May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=89, state=Idle: Incoming call, ts=-1, flags=0002, data=738
210May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=90, state=Idle: Incoming call, ts=-1, flags=0002, data=738
211May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=91, state=Idle: Incoming call, ts=-1, flags=0002, data=738
212May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=92, state=Idle: Incoming call, ts=-1, flags=0002, data=738
213May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=93, state=Idle: Incoming call, ts=-1, flags=0002, data=738
214May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=122, state=Idle: Incoming call, ts=-1, flags=0002, data=738
215May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=123, state=Idle: Incoming call, ts=-1, flags=0002, data=738
216May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=124, state=Idle: Incoming call, ts=-1, flags=0002, data=738
217May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=125, state=Idle: Incoming call, ts=-1, flags=0002, data=738
218May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=126, state=Idle: Incoming call, ts=-1, flags=0002, data=738
219May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=127, state=Idle: Incoming call, ts=-1, flags=0002, data=738
220May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=128, state=Idle: Incoming call, ts=-1, flags=0002, data=738
221May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=129, state=Idle: Incoming call, ts=-1, flags=0002, data=738
222May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=130, state=Idle: Incoming call, ts=-1, flags=0002, data=738
223May 23 11:41:01 sip_ua[363]: pri.cpp:582: ---> PRI[144]: Incoming call, ts=-1, flags=0002, data=738
224May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]:
225May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
226May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=29
227May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
228May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: SETUP (5)
229May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]:
230May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=29
231May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
232May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: SETUP (5)
233May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > [04 03 80 90 a3]
234May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Bearer Capability (len= 5) [ Ext: 1 Coding-Std: 0 Info transfer capability: Speech (0)
235May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16)
236May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > User information layer 1: A-Law (35)
237May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > [18 03 a9 83 8f]
238May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > ChanSel: As indicated in following octets
239May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Coding: 0 Number Specified Channel Type: 3
240May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Channel: 15 Type: CPE]
241May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > [6c 05 00 81 31 32 38]
242May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Calling Party Number (len= 7) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0)
243May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Presentation: Presentation allowed, User-provided, verified and passed (1) '128' ]
244May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > [70 04 80 34 30 30]
245May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Called Party Number (len= 6) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '400' ]
246May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > [a1]
247May 23 11:41:01 sip_ua[363]: pri.cpp:544: PRI[144]: > Sending Complete (len= 1)
248May 23 11:41:01 sip_ua[363]: user_agent.cpp:3484: Call 738 routed to TS 143
249May 23 11:41:01 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK741787404'
250May 23 11:41:01 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 1901682736@(null))
251May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=741
252May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=741
253May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=741
254May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=741
255May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=741
256May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=741
257May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=741
258May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=741
259May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=741
260May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=741
261May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=741
262May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=12, state=Idle: Incoming call, ts=-1, flags=0001, data=741
263May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=13, state=Idle: Incoming call, ts=-1, flags=0001, data=741
264May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=14, state=Idle: Incoming call, ts=-1, flags=0001, data=741
265May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: Incoming call, ts=-1, flags=0001, data=741
266May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=16, state=Idle: Incoming call, ts=-1, flags=0001, data=741
267May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0001, data=741
268May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0001, data=741
269May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0001, data=741
270May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=20, state=Idle: Incoming call, ts=-1, flags=0001, data=741
271May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=21, state=Idle: Incoming call, ts=-1, flags=0001, data=741
272May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=22, state=Idle: Incoming call, ts=-1, flags=0001, data=741
273May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=23, state=Idle: Incoming call, ts=-1, flags=0001, data=741
274May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=24, state=Idle: Incoming call, ts=-1, flags=0001, data=741
275May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=31, state=Idle: Incoming call, ts=-1, flags=0001, data=741
276May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0001, data=741
277May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0001, data=741
278May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0001, data=741
279May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=36, state=Idle: Incoming call, ts=-1, flags=0001, data=741
280May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=37, state=Idle: Incoming call, ts=-1, flags=0001, data=741
281May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=38, state=Idle: Incoming call, ts=-1, flags=0001, data=741
282May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=39, state=Idle: Incoming call, ts=-1, flags=0001, data=741
283May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=51, state=Idle: Incoming call, ts=-1, flags=0001, data=741
284May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=52, state=Idle: Incoming call, ts=-1, flags=0001, data=741
285May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=53, state=Idle: Incoming call, ts=-1, flags=0001, data=741
286May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=54, state=Idle: Incoming call, ts=-1, flags=0001, data=741
287May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=55, state=Idle: Incoming call, ts=-1, flags=0001, data=741
288May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=56, state=Idle: Incoming call, ts=-1, flags=0001, data=741
289May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=57, state=Idle: Incoming call, ts=-1, flags=0001, data=741
290May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=58, state=Idle: Incoming call, ts=-1, flags=0001, data=741
291May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=59, state=Idle: Incoming call, ts=-1, flags=0001, data=741
292May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=60, state=Idle: Incoming call, ts=-1, flags=0001, data=741
293May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=61, state=Idle: Incoming call, ts=-1, flags=0001, data=741
294May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0002, data=741
295May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0002, data=741
296May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=20, state=Idle: Incoming call, ts=-1, flags=0002, data=741
297May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=21, state=Idle: Incoming call, ts=-1, flags=0002, data=741
298May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=22, state=Idle: Incoming call, ts=-1, flags=0002, data=741
299May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=23, state=Idle: Incoming call, ts=-1, flags=0002, data=741
300May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=24, state=Idle: Incoming call, ts=-1, flags=0002, data=741
301May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=25, state=Idle: Incoming call, ts=-1, flags=0002, data=741
302May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=26, state=Idle: Incoming call, ts=-1, flags=0002, data=741
303May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=27, state=Idle: Incoming call, ts=-1, flags=0002, data=741
304May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Incoming call, ts=-1, flags=0002, data=741
305May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=52, state=Idle: Incoming call, ts=-1, flags=0002, data=741
306May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=53, state=Idle: Incoming call, ts=-1, flags=0002, data=741
307May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=54, state=Idle: Incoming call, ts=-1, flags=0002, data=741
308May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=55, state=Idle: Incoming call, ts=-1, flags=0002, data=741
309May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=56, state=Idle: Incoming call, ts=-1, flags=0002, data=741
310May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=57, state=Idle: Incoming call, ts=-1, flags=0002, data=741
311May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=58, state=Idle: Incoming call, ts=-1, flags=0002, data=741
312May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=59, state=Idle: Incoming call, ts=-1, flags=0002, data=741
313May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=60, state=Idle: Incoming call, ts=-1, flags=0002, data=741
314May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=61, state=Idle: Incoming call, ts=-1, flags=0002, data=741
315May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=62, state=Idle: Incoming call, ts=-1, flags=0002, data=741
316May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=63, state=Idle: Incoming call, ts=-1, flags=0002, data=741
317May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=65, state=Idle: Incoming call, ts=-1, flags=0002, data=741
318May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=66, state=Idle: Incoming call, ts=-1, flags=0002, data=741
319May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=67, state=Idle: Incoming call, ts=-1, flags=0002, data=741
320May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=68, state=Idle: Incoming call, ts=-1, flags=0002, data=741
321May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=69, state=Idle: Incoming call, ts=-1, flags=0002, data=741
322May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=70, state=Idle: Incoming call, ts=-1, flags=0002, data=741
323May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=71, state=Idle: Incoming call, ts=-1, flags=0002, data=741
324May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=72, state=Idle: Incoming call, ts=-1, flags=0002, data=741
325May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=73, state=Idle: Incoming call, ts=-1, flags=0002, data=741
326May 23 11:41:01 sip_ua[363]: fxs.cpp:419: ---> ts=74, state=Idle: Incoming call, ts=-1, flags=0002, data=741
327May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Bearer Capability (len= 5) [ Ext: 1 Coding-Std: 0 Info transfer capability: Speech (0)
328May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16)
329May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > User information layer 1: A-Law (35)
330May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [18 03 a9 83 91]
331May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
332May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > ChanSel: As indicated in following octets
333May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Coding: 0 Number Specified Channel Type: 3
334May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Channel: 17 Type: CPE]
335May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [6c 05 00 81 31 32 39]
336May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Calling Party Number (len= 7) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0)
337May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Presentation: Presentation allowed, User-provided, verified and passed (1) '129' ]
338May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [70 04 80 34 30 30]
339May 23 11:41:02 sip_ua[363]: user_agent.cpp:3484: Call 741 routed to TS 145
340May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
341May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
342May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent to originator)
343May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
344May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 8f]
345May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
346May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < ChanSel: As indicated in following octets
347May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Coding: 0 Number Specified Channel Type: 3
348May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Channel: 15 Type: CPE]
349May 23 11:41:02 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_PROCEEDING
350May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [1e 02 81 88]
351May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1)
352May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ]
353May 23 11:41:02 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_RINGING
354May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: CAS event, ts=29, flags=0000, data=15
355May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
356May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
357May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 210/0xD2) (Sent to originator)
358May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
359May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 91]
360May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
361May 23 11:41:02 sip_ua[363]: comcerto.cpp:6723: ts 143: starting RTP stream to 02:ad:c3:00:00:e0
362May 23 11:41:02 sip_ua[387]: user_agent.cpp:2132: ---> ringing with status code 180
363May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: RTP parameters, ts=28, flags=0000, data=737
364May 23 11:41:02 sip_ua[363]: comcerto.cpp:6606: --> ts 28: 192.168.0.95[10056] --> 192.168.0.95[10286]
365May 23 11:41:02 sip_ua[363]: comcerto.cpp:6607: --> ts 28: codec PCMA, VAD is on
366May 23 11:41:02 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
367May 23 11:41:02 sip_ua[363]: comcerto.cpp:6723: ts 28: starting RTP stream to 02:ad:c3:00:00:e0
368May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Remote is ringing, ts=28, flags=0000, data=737
369May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
370May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
371May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 210/0xD2) (Sent to originator)
372May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: DISCONNECT (69)
373May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
374May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
375May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
376May 23 11:41:02 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP_REQ
377May 23 11:41:02 sip_ua[363]: pri.cpp:503: --> channel=17, cause=Normal, unspecified
378May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
379May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
380May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 210/0xD2) (Sent from originator)
381May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE (77)
382May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
383May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
384May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 210/0xD2) (Sent from originator)
385May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE (77)
386May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
387May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
388May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
389May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
390May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
391May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Call disconnected, ts=29, flags=0000, data=740
392May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=15
393May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
394May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
395May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 210/0xD2) (Sent to originator)
396May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE COMPLETE (90)
397May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
398May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
399May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
400May 23 11:41:02 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP_ACK
401May 23 11:41:02 sip_ua[363]: pri.cpp:503: --> channel=17, cause=Normal, unspecified
402May 23 11:41:02 sip_ua[476]: repro.cpp:552: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK1430164737'
403May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=737
404May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
405May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
406May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
407May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
408May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
409May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
410May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
411May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
412May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
413May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
414May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
415May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
416May 23 11:41:02 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=737
417May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
418May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
419May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent to originator)
420May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE (77)
421May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
422May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
423May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
424May 23 11:41:02 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP
425May 23 11:41:02 sip_ua[363]: pri.cpp:503: --> channel=15, cause=Normal, unspecified
426May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
427May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
428May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
429May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
430May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
431May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]:
432May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
433May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 209/0xD1) (Sent from originator)
434May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
435May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
436May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
437May 23 11:41:02 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
438May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS A activity detected, ts=28, flags=0000, data=0
439May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS event, ts=28, flags=0000, data=7
440May 23 11:41:07 sip_ua[363]: fxs.cpp:702: ==> ts 28: manual CAS event processing (abcd=15)
441May 23 11:41:07 sip_ua[363]: fxs.cpp:241: ts 28: dialing 400
442May 23 11:41:07 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:128@192.168.0.95> -> sip:400@192.168.0.95 ()...
443May 23 11:41:07 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK2066261981'
444May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=7
445May 23 11:41:07 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 511510748@(null))
446May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=745
447May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=745
448May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=745
449May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=745
450May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=745
451May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=745
452May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=745
453May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=745
454May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=745
455May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=745
456May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=745
457May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0001, data=745
458May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0001, data=745
459May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0001, data=745
460May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=20, state=Idle: Incoming call, ts=-1, flags=0001, data=745
461May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=21, state=Idle: Incoming call, ts=-1, flags=0001, data=745
462May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=22, state=Idle: Incoming call, ts=-1, flags=0001, data=745
463May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=23, state=Idle: Incoming call, ts=-1, flags=0001, data=745
464May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=24, state=Idle: Incoming call, ts=-1, flags=0001, data=745
465May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=25, state=Idle: Incoming call, ts=-1, flags=0001, data=745
466May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=26, state=Idle: Incoming call, ts=-1, flags=0001, data=745
467May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=27, state=Idle: Incoming call, ts=-1, flags=0001, data=745
468May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=41, state=Idle: Incoming call, ts=-1, flags=0001, data=745
469May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=42, state=Idle: Incoming call, ts=-1, flags=0001, data=745
470May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=43, state=Idle: Incoming call, ts=-1, flags=0001, data=745
471May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=44, state=Idle: Incoming call, ts=-1, flags=0001, data=745
472May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=45, state=Idle: Incoming call, ts=-1, flags=0001, data=745
473May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=46, state=Idle: Incoming call, ts=-1, flags=0001, data=745
474May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=47, state=Idle: Incoming call, ts=-1, flags=0001, data=745
475May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=48, state=Idle: Incoming call, ts=-1, flags=0001, data=745
476May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=49, state=Idle: Incoming call, ts=-1, flags=0001, data=745
477May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=61, state=Idle: Incoming call, ts=-1, flags=0001, data=745
478May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=62, state=Idle: Incoming call, ts=-1, flags=0001, data=745
479May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=63, state=Idle: Incoming call, ts=-1, flags=0001, data=745
480May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=65, state=Idle: Incoming call, ts=-1, flags=0001, data=745
481May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=66, state=Idle: Incoming call, ts=-1, flags=0001, data=745
482May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=67, state=Idle: Incoming call, ts=-1, flags=0001, data=745
483May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=68, state=Idle: Incoming call, ts=-1, flags=0001, data=745
484May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=69, state=Idle: Incoming call, ts=-1, flags=0001, data=745
485May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=70, state=Idle: Incoming call, ts=-1, flags=0001, data=745
486May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=71, state=Idle: Incoming call, ts=-1, flags=0001, data=745
487May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=72, state=Idle: Incoming call, ts=-1, flags=0001, data=745
488May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=84, state=Idle: Incoming call, ts=-1, flags=0001, data=745
489May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=85, state=Idle: Incoming call, ts=-1, flags=0001, data=745
490May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=86, state=Idle: Incoming call, ts=-1, flags=0001, data=745
491May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=87, state=Idle: Incoming call, ts=-1, flags=0001, data=745
492May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=88, state=Idle: Incoming call, ts=-1, flags=0001, data=745
493May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=89, state=Idle: Incoming call, ts=-1, flags=0001, data=745
494May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=90, state=Idle: Incoming call, ts=-1, flags=0001, data=745
495May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=91, state=Idle: Incoming call, ts=-1, flags=0001, data=745
496May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=92, state=Idle: Incoming call, ts=-1, flags=0001, data=745
497May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=93, state=Idle: Incoming call, ts=-1, flags=0001, data=745
498May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=94, state=Idle: Incoming call, ts=-1, flags=0001, data=745
499May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=109, state=Idle: Incoming call, ts=-1, flags=0001, data=745
500May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=110, state=Idle: Incoming call, ts=-1, flags=0001, data=745
501May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=111, state=Idle: Incoming call, ts=-1, flags=0001, data=745
502May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=112, state=Idle: Incoming call, ts=-1, flags=0001, data=745
503May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=113, state=Idle: Incoming call, ts=-1, flags=0001, data=745
504May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=114, state=Idle: Incoming call, ts=-1, flags=0001, data=745
505May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=115, state=Idle: Incoming call, ts=-1, flags=0001, data=745
506May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=116, state=Idle: Incoming call, ts=-1, flags=0001, data=745
507May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=117, state=Idle: Incoming call, ts=-1, flags=0001, data=745
508May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=118, state=Idle: Incoming call, ts=-1, flags=0001, data=745
509May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=119, state=Idle: Incoming call, ts=-1, flags=0001, data=745
510May 23 11:41:07 sip_ua[363]: pri.cpp:582: ---> PRI[144]: Incoming call, ts=-1, flags=0001, data=745
511May 23 11:41:07 sip_ua[363]: virtualChannel.cpp:135: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=745
512May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0002, data=745
513May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0002, data=745
514May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0002, data=745
515May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0002, data=745
516May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0002, data=745
517May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0002, data=745
518May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0002, data=745
519May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0002, data=745
520May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0002, data=745
521May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=27, state=Idle: Incoming call, ts=-1, flags=0002, data=745
522May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Incoming call, ts=-1, flags=0002, data=745
523May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Incoming call, ts=-1, flags=0002, data=745
524May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=30, state=Idle: Incoming call, ts=-1, flags=0002, data=745
525May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=31, state=Idle: Incoming call, ts=-1, flags=0002, data=745
526May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0002, data=745
527May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0002, data=745
528May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0002, data=745
529May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=36, state=Idle: Incoming call, ts=-1, flags=0002, data=745
530May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=37, state=Idle: Incoming call, ts=-1, flags=0002, data=745
531May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=38, state=Idle: Incoming call, ts=-1, flags=0002, data=745
532May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=39, state=Idle: Incoming call, ts=-1, flags=0002, data=745
533May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=40, state=Idle: Incoming call, ts=-1, flags=0002, data=745
534May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=41, state=Idle: Incoming call, ts=-1, flags=0002, data=745
535May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=42, state=Idle: Incoming call, ts=-1, flags=0002, data=745
536May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=43, state=Idle: Incoming call, ts=-1, flags=0002, data=745
537May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=44, state=Idle: Incoming call, ts=-1, flags=0002, data=745
538May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=45, state=Idle: Incoming call, ts=-1, flags=0002, data=745
539May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=46, state=Idle: Incoming call, ts=-1, flags=0002, data=745
540May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=47, state=Idle: Incoming call, ts=-1, flags=0002, data=745
541May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=48, state=Idle: Incoming call, ts=-1, flags=0002, data=745
542May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=72, state=Idle: Incoming call, ts=-1, flags=0002, data=745
543May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=73, state=Idle: Incoming call, ts=-1, flags=0002, data=745
544May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=74, state=Idle: Incoming call, ts=-1, flags=0002, data=745
545May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=75, state=Idle: Incoming call, ts=-1, flags=0002, data=745
546May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=76, state=Idle: Incoming call, ts=-1, flags=0002, data=745
547May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=77, state=Idle: Incoming call, ts=-1, flags=0002, data=745
548May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=78, state=Idle: Incoming call, ts=-1, flags=0002, data=745
549May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=79, state=Idle: Incoming call, ts=-1, flags=0002, data=745
550May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=80, state=Idle: Incoming call, ts=-1, flags=0002, data=745
551May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=81, state=Idle: Incoming call, ts=-1, flags=0002, data=745
552May 23 11:41:07 sip_ua[363]: fxs.cpp:419: ---> ts=82, state=Idle: Incoming call, ts=-1, flags=0002, data=745
553May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]:
554May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
555May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=29
556May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent from originator)
557May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: SETUP (5)
558May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]:
559May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=29
560May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent from originator)
561May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: SETUP (5)
562May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > [04 03 80 90 a3]
563May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Bearer Capability (len= 5) [ Ext: 1 Coding-Std: 0 Info transfer capability: Speech (0)
564May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Coding: 0 Number Specified Channel Type: 3
565May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Channel: 18 Type: CPE]
566May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > [6c 05 00 81 31 32 38]
567May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Calling Party Number (len= 7) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0)
568May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Presentation: Presentation allowed, User-provided, verified and passed (1) '128' ]
569May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > [70 04 80 34 30 30]
570May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Called Party Number (len= 6) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '400' ]
571May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > [a1]
572May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: > Sending Complete (len= 1)
573May 23 11:41:07 sip_ua[363]: user_agent.cpp:3484: Call 745 routed to TS 146
574May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]:
575May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
576May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent to originator)
577May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
578May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 92]
579May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
580May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < ChanSel: As indicated in following octets
581May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Coding: 0 Number Specified Channel Type: 3
582May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Channel: 18 Type: CPE]
583May 23 11:41:07 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_PROCEEDING
584May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]:
585May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
586May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent to originator)
587May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: ALERTING (1)
588May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < [1e 02 81 88]
589May 23 11:41:07 sip_ua[363]: pri.cpp:544: PRI[144]: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1)
590May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ]
591May 23 11:41:08 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_RINGING
592May 23 11:41:08 sip_ua[363]: comcerto.cpp:6606: --> ts 146: 192.168.0.95[10292] --> 192.168.0.95[10056]
593May 23 11:41:08 sip_ua[363]: comcerto.cpp:6607: --> ts 146: codec PCMA, VAD is on
594May 23 11:41:08 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
595May 23 11:41:08 sip_ua[363]: comcerto.cpp:6661: ts 146: calling createConnection()
596May 23 11:41:08 sip_ua[363]: comcerto.cpp:6723: ts 146: starting RTP stream to 02:ad:c3:00:00:e0
597May 23 11:41:08 sip_ua[387]: user_agent.cpp:2132: ---> ringing with status code 180
598May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: RTP parameters, ts=28, flags=0000, data=744
599May 23 11:41:08 sip_ua[363]: comcerto.cpp:6606: --> ts 28: 192.168.0.95[10056] --> 192.168.0.95[10292]
600May 23 11:41:08 sip_ua[363]: comcerto.cpp:6607: --> ts 28: codec PCMA, VAD is on
601May 23 11:41:08 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
602May 23 11:41:08 sip_ua[363]: comcerto.cpp:6723: ts 28: starting RTP stream to 02:ad:c3:00:00:e0
603May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Remote is ringing, ts=28, flags=0000, data=744
604May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
605May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
606May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=15
607May 23 11:41:08 sip_ua[476]: repro.cpp:552: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK2066261981'
608May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=744
609May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]:
610May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
611May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
612May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent from originator)
613May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
614May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]:
615May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
616May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent from originator)
617May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
618May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
619May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
620May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
621May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=744
622May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]:
623May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
624May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent to originator)
625May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE (77)
626May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
627May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
628May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
629May 23 11:41:08 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP
630May 23 11:41:08 sip_ua[363]: pri.cpp:503: --> channel=18, cause=Normal, unspecified
631May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]:
632May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
633May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
634May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 211/0xD3) (Sent from originator)
635May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
636May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]:
637May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
638May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
639May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
640May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
641May 23 11:41:08 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
642May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS A activity detected, ts=29, flags=0000, data=0
643May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS event, ts=29, flags=0000, data=7
644May 23 11:41:08 sip_ua[363]: fxs.cpp:702: ==> ts 29: manual CAS event processing (abcd=15)
645May 23 11:41:08 sip_ua[363]: fxs.cpp:241: ts 29: dialing 400
646May 23 11:41:08 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:129@192.168.0.95> -> sip:400@192.168.0.95 ()...
647May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: CAS event, ts=29, flags=0000, data=7
648May 23 11:41:08 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK1296565588'
649May 23 11:41:08 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 1648051607@(null))
650May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=749
651May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=749
652May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=749
653May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=749
654May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=749
655May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=749
656May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=749
657May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=749
658May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=749
659May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=749
660May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0001, data=749
661May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=16, state=Idle: Incoming call, ts=-1, flags=0001, data=749
662May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0001, data=749
663May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0001, data=749
664May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=19, state=Idle: Incoming call, ts=-1, flags=0001, data=749
665May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=20, state=Idle: Incoming call, ts=-1, flags=0001, data=749
666May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=21, state=Idle: Incoming call, ts=-1, flags=0001, data=749
667May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=22, state=Idle: Incoming call, ts=-1, flags=0001, data=749
668May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=23, state=Idle: Incoming call, ts=-1, flags=0001, data=749
669May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=24, state=Idle: Incoming call, ts=-1, flags=0001, data=749
670May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=40, state=Idle: Incoming call, ts=-1, flags=0001, data=749
671May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=41, state=Idle: Incoming call, ts=-1, flags=0001, data=749
672May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=42, state=Idle: Incoming call, ts=-1, flags=0001, data=749
673May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=43, state=Idle: Incoming call, ts=-1, flags=0001, data=749
674May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=44, state=Idle: Incoming call, ts=-1, flags=0001, data=749
675May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=77, state=Idle: Incoming call, ts=-1, flags=0001, data=749
676May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=78, state=Idle: Incoming call, ts=-1, flags=0001, data=749
677May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=79, state=Idle: Incoming call, ts=-1, flags=0001, data=749
678May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=80, state=Idle: Incoming call, ts=-1, flags=0001, data=749
679May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=81, state=Idle: Incoming call, ts=-1, flags=0001, data=749
680May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=82, state=Idle: Incoming call, ts=-1, flags=0001, data=749
681May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=83, state=Idle: Incoming call, ts=-1, flags=0001, data=749
682May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=84, state=Idle: Incoming call, ts=-1, flags=0001, data=749
683May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=85, state=Idle: Incoming call, ts=-1, flags=0001, data=749
684May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=86, state=Idle: Incoming call, ts=-1, flags=0001, data=749
685May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=94, state=Idle: Incoming call, ts=-1, flags=0001, data=749
686May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=95, state=Idle: Incoming call, ts=-1, flags=0001, data=749
687May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=97, state=Idle: Incoming call, ts=-1, flags=0001, data=749
688May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=98, state=Idle: Incoming call, ts=-1, flags=0001, data=749
689May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=99, state=Idle: Incoming call, ts=-1, flags=0001, data=749
690May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=100, state=Idle: Incoming call, ts=-1, flags=0001, data=749
691May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=111, state=Idle: Incoming call, ts=-1, flags=0001, data=749
692May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=112, state=Idle: Incoming call, ts=-1, flags=0001, data=749
693May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=113, state=Idle: Incoming call, ts=-1, flags=0001, data=749
694May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=114, state=Idle: Incoming call, ts=-1, flags=0001, data=749
695May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=115, state=Idle: Incoming call, ts=-1, flags=0001, data=749
696May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=116, state=Idle: Incoming call, ts=-1, flags=0001, data=749
697May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=117, state=Idle: Incoming call, ts=-1, flags=0001, data=749
698May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=118, state=Idle: Incoming call, ts=-1, flags=0001, data=749
699May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=119, state=Idle: Incoming call, ts=-1, flags=0001, data=749
700May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=120, state=Idle: Incoming call, ts=-1, flags=0001, data=749
701May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=128, state=Idle: Incoming call, ts=-1, flags=0001, data=749
702May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=129, state=Idle: Incoming call, ts=-1, flags=0001, data=749
703May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=130, state=Idle: Incoming call, ts=-1, flags=0001, data=749
704May 23 11:41:08 sip_ua[363]: pri.cpp:582: ---> PRI[144]: Incoming call, ts=-1, flags=0001, data=749
705May 23 11:41:08 sip_ua[363]: virtualChannel.cpp:135: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=749
706May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0002, data=749
707May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0002, data=749
708May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0002, data=749
709May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0002, data=749
710May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=11, state=Idle: Incoming call, ts=-1, flags=0002, data=749
711May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=12, state=Idle: Incoming call, ts=-1, flags=0002, data=749
712May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=13, state=Idle: Incoming call, ts=-1, flags=0002, data=749
713May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=14, state=Idle: Incoming call, ts=-1, flags=0002, data=749
714May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=15, state=Idle: Incoming call, ts=-1, flags=0002, data=749
715May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=16, state=Idle: Incoming call, ts=-1, flags=0002, data=749
716May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=17, state=Idle: Incoming call, ts=-1, flags=0002, data=749
717May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=18, state=Idle: Incoming call, ts=-1, flags=0002, data=749
718May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Incoming call, ts=-1, flags=0002, data=749
719May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=30, state=Idle: Incoming call, ts=-1, flags=0002, data=749
720May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=31, state=Idle: Incoming call, ts=-1, flags=0002, data=749
721May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=33, state=Idle: Incoming call, ts=-1, flags=0002, data=749
722May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=34, state=Idle: Incoming call, ts=-1, flags=0002, data=749
723May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=35, state=Idle: Incoming call, ts=-1, flags=0002, data=749
724May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=36, state=Idle: Incoming call, ts=-1, flags=0002, data=749
725May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=37, state=Idle: Incoming call, ts=-1, flags=0002, data=749
726May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=66, state=Idle: Incoming call, ts=-1, flags=0002, data=749
727May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=67, state=Idle: Incoming call, ts=-1, flags=0002, data=749
728May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=68, state=Idle: Incoming call, ts=-1, flags=0002, data=749
729May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=69, state=Idle: Incoming call, ts=-1, flags=0002, data=749
730May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=70, state=Idle: Incoming call, ts=-1, flags=0002, data=749
731May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=71, state=Idle: Incoming call, ts=-1, flags=0002, data=749
732May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=72, state=Idle: Incoming call, ts=-1, flags=0002, data=749
733May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=73, state=Idle: Incoming call, ts=-1, flags=0002, data=749
734May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=74, state=Idle: Incoming call, ts=-1, flags=0002, data=749
735May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=75, state=Idle: Incoming call, ts=-1, flags=0002, data=749
736May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=76, state=Idle: Incoming call, ts=-1, flags=0002, data=749
737May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=106, state=Idle: Incoming call, ts=-1, flags=0002, data=749
738May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=107, state=Idle: Incoming call, ts=-1, flags=0002, data=749
739May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=108, state=Idle: Incoming call, ts=-1, flags=0002, data=749
740May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=109, state=Idle: Incoming call, ts=-1, flags=0002, data=749
741May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=110, state=Idle: Incoming call, ts=-1, flags=0002, data=749
742May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=111, state=Idle: Incoming call, ts=-1, flags=0002, data=749
743May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=112, state=Idle: Incoming call, ts=-1, flags=0002, data=749
744May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=113, state=Idle: Incoming call, ts=-1, flags=0002, data=749
745May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=114, state=Idle: Incoming call, ts=-1, flags=0002, data=749
746May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=115, state=Idle: Incoming call, ts=-1, flags=0002, data=749
747May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=116, state=Idle: Incoming call, ts=-1, flags=0002, data=749
748May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=123, state=Idle: Incoming call, ts=-1, flags=0002, data=749
749May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=124, state=Idle: Incoming call, ts=-1, flags=0002, data=749
750May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=125, state=Idle: Incoming call, ts=-1, flags=0002, data=749
751May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=126, state=Idle: Incoming call, ts=-1, flags=0002, data=749
752May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=127, state=Idle: Incoming call, ts=-1, flags=0002, data=749
753May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=128, state=Idle: Incoming call, ts=-1, flags=0002, data=749
754May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=129, state=Idle: Incoming call, ts=-1, flags=0002, data=749
755May 23 11:41:08 sip_ua[363]: fxs.cpp:419: ---> ts=130, state=Idle: Incoming call, ts=-1, flags=0002, data=749
756May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Presentation: Presentation allowed, User-provided, verified and passed (1) '129' ]
757May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > [70 04 80 34 30 30]
758May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Called Party Number (len= 6) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '400' ]
759May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > [a1]
760May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Sending Complete (len= 1)
761May 23 11:41:09 sip_ua[363]: user_agent.cpp:3484: Call 749 routed to TS 147
762May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: CAS event, ts=29, flags=0000, data=15
763May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
764May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
765May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent to originator)
766May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
767May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 93]
768May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
769May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < ChanSel: As indicated in following octets
770May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Coding: 0 Number Specified Channel Type: 3
771May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Channel: 19 Type: CPE]
772May 23 11:41:09 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_PROCEEDING
773May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
774May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
775May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent to originator)
776May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: ALERTING (1)
777May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < [1e 02 81 88]
778May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1)
779May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ]
780May 23 11:41:09 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_RINGING
781May 23 11:41:09 sip_ua[363]: comcerto.cpp:6606: --> ts 147: 192.168.0.95[10294] --> 192.168.0.95[10058]
782May 23 11:41:09 sip_ua[363]: comcerto.cpp:6607: --> ts 147: codec PCMA, VAD is on
783May 23 11:41:09 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
784May 23 11:41:09 sip_ua[363]: comcerto.cpp:6661: ts 147: calling createConnection()
785May 23 11:41:09 sip_ua[363]: comcerto.cpp:6723: ts 147: starting RTP stream to 02:ad:c3:00:00:e0
786May 23 11:41:09 sip_ua[387]: user_agent.cpp:2132: ---> ringing with status code 180
787May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: RTP parameters, ts=29, flags=0000, data=748
788May 23 11:41:09 sip_ua[363]: comcerto.cpp:6606: --> ts 29: 192.168.0.95[10058] --> 192.168.0.95[10294]
789May 23 11:41:09 sip_ua[363]: comcerto.cpp:6607: --> ts 29: codec PCMA, VAD is on
790May 23 11:41:09 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
791May 23 11:41:09 sip_ua[363]: comcerto.cpp:6723: ts 29: starting RTP stream to 02:ad:c3:00:00:e0
792May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Remote is ringing, ts=29, flags=0000, data=748
793May 23 11:41:09 sip_ua[476]: repro.cpp:552: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK1296565588'
794May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Statistics received, ts=29, flags=0000, data=0
795May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Statistics received, ts=29, flags=0000, data=0
796May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Call disconnected, ts=29, flags=0000, data=748
797May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
798May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
799May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
800May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent from originator)
801May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
802May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
803May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
804May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent from originator)
805May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
806May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
807May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
808May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
809May 23 11:41:09 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: Call disconnected, ts=29, flags=0000, data=748
810May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
811May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
812May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent to originator)
813May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE (77)
814May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
815May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
816May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
817May 23 11:41:09 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP
818May 23 11:41:09 sip_ua[363]: pri.cpp:503: --> channel=19, cause=Normal, unspecified
819May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]:
820May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
821May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
822May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 212/0xD4) (Sent from originator)
823May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: RELEASE COMPLETE (90)
824May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
825May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
826May 23 11:41:09 sip_ua[363]: pri.cpp:544: PRI[144]: > Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
827May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS A activity detected, ts=28, flags=0000, data=0
828May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: CAS event, ts=28, flags=0000, data=7
829May 23 11:41:13 sip_ua[363]: fxs.cpp:702: ==> ts 28: manual CAS event processing (abcd=15)
830May 23 11:41:13 sip_ua[363]: fxs.cpp:241: ts 28: dialing 400
831May 23 11:41:13 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:128@192.168.0.95> -> sip:400@192.168.0.95 ()...
832May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=7
833May 23 11:41:13 sip_ua[476]: repro.cpp:435: doSessionAccounting(): Session Created 'branch=z9hG4bK1656721393'
834May 23 11:41:13 sip_ua[387]: user_agent.cpp:1987: INVITE received: sip:400@127.0.0.1:6060;transport=udp (Call-ID: 95392737@(null))
835May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=1, state=Idle: Incoming call, ts=-1, flags=0001, data=753
836May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=753
837May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=3, state=Idle: Incoming call, ts=-1, flags=0001, data=753
838May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=4, state=Idle: Incoming call, ts=-1, flags=0001, data=753
839May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=5, state=Idle: Incoming call, ts=-1, flags=0001, data=753
840May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=6, state=Idle: Incoming call, ts=-1, flags=0001, data=753
841May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=7, state=Idle: Incoming call, ts=-1, flags=0001, data=753
842May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=8, state=Idle: Incoming call, ts=-1, flags=0001, data=753
843May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=9, state=Idle: Incoming call, ts=-1, flags=0001, data=753
844May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=10, state=Idle: Incoming call, ts=-1, flags=0001, data=753
845May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=15
846May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Idle: CAS event, ts=29, flags=0000, data=7
847May 23 11:41:13 sip_ua[363]: fxs.cpp:241: ts 29: dialing 400
848May 23 11:41:13 sip_ua[363]: user_agent.cpp:3099: --> ua_dial_out() <sip:129@192.168.0.95> -> sip:400@192.168.0.95 ()...
849May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]:
850May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=10
851May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 213/0xD5) (Sent to originator)
852May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: CALL PROCEEDING (2)
853May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < [18 03 a9 83 94]
854May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
855May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < ChanSel: As indicated in following octets
856May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Coding: 0 Number Specified Channel Type: 3
857May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Channel: 20 Type: CPE]
858May 23 11:41:13 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_PROCEEDING
859May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=7
860May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: RTP parameters, ts=28, flags=0000, data=752
861May 23 11:41:13 sip_ua[363]: comcerto.cpp:6606: --> ts 28: 192.168.0.95[10056] --> 192.168.0.95[10296]
862May 23 11:41:13 sip_ua[363]: comcerto.cpp:6607: --> ts 28: codec PCMA, VAD is on
863May 23 11:41:13 sip_ua[363]: comcerto.cpp:6608: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
864May 23 11:41:13 sip_ua[363]: comcerto.cpp:6723: ts 28: starting RTP stream to 02:ad:c3:00:00:e0
865May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Remote is ringing, ts=28, flags=0000, data=752
866May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: CAS event, ts=28, flags=0000, data=15
867May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
868May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Calling: Statistics received, ts=28, flags=0000, data=0
869May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]:
870May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
871May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 214/0xD6) (Sent to originator)
872May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: DISCONNECT (69)
873May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
874May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
875May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
876May 23 11:41:13 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP_REQ
877May 23 11:41:13 sip_ua[363]: pri.cpp:503: --> channel=21, cause=Normal, unspecified
878May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]:
879May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
880May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]:
881May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
882May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 214/0xD6) (Sent to originator)
883May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE COMPLETE (90)
884May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
885May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
886May 23 11:41:13 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
887May 23 11:41:13 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP_ACK
888May 23 11:41:13 sip_ua[363]: pri.cpp:503: --> channel=21, cause=Normal, unspecified
889May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=29, state=Calling: Call disconnected, ts=29, flags=0000, data=755
890May 23 11:41:13 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=752
891May 23 11:41:13 sip_ua[476]: repro.cpp:552: doSessionAccounting(): Session Cancelled 'branch=z9hG4bK1656721393'
892May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]:
893May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request
894May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
895May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 213/0xD5) (Sent from originator)
896May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
897May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]:
898May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > Protocol Discriminator: Q.931 (8) len=9
899May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > TEI=0 Call Ref: len= 2 (reference 213/0xD5) (Sent from originator)
900May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > Message Type: DISCONNECT (69)
901May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > [08 02 81 9f]
902May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
903May 23 11:41:14 sip_ua[363]: fxs.cpp:419: ---> ts=28, state=Idle: Call disconnected, ts=28, flags=0000, data=752
904May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]:
905May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < Protocol Discriminator: Q.931 (8) len=9
906May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < TEI=0 Call Ref: len= 2 (reference 213/0xD5) (Sent to originator)
907May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < Message Type: RELEASE (77)
908May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < [08 02 81 9f]
909May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
910May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: < Ext: 1 Cause: Normal, unspecified (31), class = Normal Event (1) ]
911May 23 11:41:14 sip_ua[363]: pri.cpp:200: --> PRI[144]: PRI event: PRI_EVENT_HANGUP
912May 23 11:41:14 sip_ua[363]: pri.cpp:503: --> channel=20, cause=Normal, unspecified
913May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]:
914May 23 11:41:14 sip_ua[363]: pri.cpp:544: PRI[144]: > DL-DATA request