[Problem] T38 Modem und Fax an Fritzbox

MeisterM

Neuer User
Mitglied seit
10 Jun 2006
Beiträge
24
Punkte für Reaktionen
0
Punkte
0
Hallo,

ich habe ein Problem mit der Faxgeschichte. Ich habe das t38modem drei mal mit einem dahinter geschalteten Hylafax Server auf der Asterisk Maschine laufen. Diese t38modem stellen ihre Verbindung zum Asterisk her.
Zusätzlich habe ich eine Fritzbox an den Asterisk mittels SIP verbunden. An dieser Fritzbox hängt über eine ISDN Telefonanlage ein analoges Faxgerät dran. Soweit so gut.

Möchte ich nun von dem t38modem aus ein Fax an das Faxgerät senden, kommt es beim Aufbau der Verbindung zu eine Fehler.

Im folgenden die SIP Debug Log: (Das ganze sieht aus als würde das t38modem auf einmal nicht mehr auf die SIP Nachrichten reagieren (Transmitting). Die Fritzbox scheint aber T38 zu erkennen und auch ordentlich zu antworten.

Code:
<--- SIP read from UDP:127.0.0.1:57977 --->
INVITE sip:[email protected] SIP/2.0
Date: Wed, 13 Jun 2012 08:41:02 GMT
CSeq: 1 INVITE
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;rport
User-Agent: OPAL/2.0
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
To: <sip:[email protected]>
Contact: <sip:[email protected]:57977;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Type: application/sdp
Content-Length: 299
Max-Forwards: 70

v=0
o=- 1339576862 1339576862 IN IP4 127.0.0.1
s=Opal SIP Session
c=IN IP4 127.0.0.1
t=0 0
m=audio 5000 RTP/AVP 0 8 101 100
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15,32-49
a=rtpmap:100 NSE/8000
a=fmtp:100 192-193
m=image 5004 udptl t38
<------------->
[2012-06-13 10:41:02.986] VERBOSE[10414] chan_sip.c: --- (13 headers 13 lines) ---
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Sending to 127.0.0.1:57977 (no NAT)
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Using INVITE request as basis request - e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found peer 'T38modem0' for 'T38modem0' from 127.0.0.1:57977
[2012-06-13 10:41:02.987] VERBOSE[10414] netsock2.c:   == Using SIP RTP CoS mark 5
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found RTP audio format 0
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found RTP audio format 8
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found RTP audio format 101
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found RTP audio format 100
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found audio description format PCMU for ID 0
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found audio description format PCMA for ID 8
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found audio description format telephone-event for ID 101
[2012-06-13 10:41:02.987] VERBOSE[10414] chan_sip.c: Found unknown media description format NSE for ID 100
[2012-06-13 10:41:02.988] VERBOSE[10414] netsock.c:   == Using UDPTL CoS mark 5
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: Got T.38 offer in SDP in dialog e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: Peer audio RTP is at port 127.0.0.1:5000
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: Looking for 20007 in fax-out (domain 127.0.0.1)
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected]:57977;transport=udp>
[2012-06-13 10:41:02.988] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (no NAT) to 127.0.0.1:57977 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-13 10:41:02.996] VERBOSE[2701] pbx.c:     -- Executing [20007@fax-out:1] Dial("SIP/T38modem0-00000016", "SIP/20007") in new stack
[2012-06-13 10:41:02.997] VERBOSE[2701] netsock2.c:   == Using SIP RTP CoS mark 5
[2012-06-13 10:41:02.998] VERBOSE[2701] chan_sip.c: Audio is at 14616
[2012-06-13 10:41:02.999] VERBOSE[2701] chan_sip.c: Adding codec 100003 (ulaw) to SDP
[2012-06-13 10:41:02.999] VERBOSE[2701] chan_sip.c: Adding codec 100008 (g729) to SDP
[2012-06-13 10:41:02.999] VERBOSE[2701] chan_sip.c: Adding codec 100004 (alaw) to SDP
[2012-06-13 10:41:02.999] VERBOSE[2701] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2012-06-13 10:41:03.000] VERBOSE[2701] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.2.19:5060:
INVITE sip:[email protected];uniq=62C14 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK5a1bce51
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Date: Wed, 13 Jun 2012 08:41:02 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Remote-Party-ID: "root" <sip:[email protected]>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 331

v=0
o=root 441915051 441915051 IN IP4 192.168.1.15
s=Asterisk PBX 10.4.0
c=IN IP4 192.168.1.15
t=0 0
m=audio 14616 RTP/AVP 0 18 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

---
[2012-06-13 10:41:03.000] VERBOSE[2701] app_dial.c:     -- Called SIP/20007
[2012-06-13 10:41:03.043] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK5a1bce51
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>
Call-ID: [email protected]:5060
CSeq: 102 INVITE
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-13 10:41:03.043] VERBOSE[10414] chan_sip.c: --- (8 headers 0 lines) ---
[2012-06-13 10:41:04.302] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK5a1bce51
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
Call-ID: [email protected]:5060
CSeq: 102 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-13 10:41:04.302] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-13 10:41:04.302] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
[2012-06-13 10:41:04.302] VERBOSE[2701] app_dial.c:     -- SIP/20007-00000017 is ringing
[2012-06-13 10:41:04.303] VERBOSE[2701] chan_sip.c: 
<--- Transmitting (no NAT) to 127.0.0.1:57977 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-13 10:41:05.929] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK5a1bce51
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
Call-ID: [email protected]:5060
CSeq: 102 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH
Content-Type: application/sdp
Accept: application/sdp, multipart/mixed
Accept-Encoding: identity
Content-Length: 211

v=0
o=user 10589442 10589442 IN IP4 192.168.2.19
s=Asterisk PBX 10.4.0
c=IN IP4 192.168.2.19
t=0 0
m=audio 7078 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtcp:7079
a=ptime:30
<------------->
[2012-06-13 10:41:05.929] VERBOSE[10414] chan_sip.c: --- (15 headers 11 lines) ---
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Found RTP audio format 0
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Found RTP audio format 8
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Found audio description format PCMU for ID 0
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Found audio description format PCMA for ID 8
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: Peer audio RTP is at port 192.168.2.19:7078
[2012-06-13 10:41:05.930] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
[2012-06-13 10:41:05.932] VERBOSE[10414] chan_sip.c: set_destination: Parsing <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B> for address/port to send to
[2012-06-13 10:41:05.932] VERBOSE[10414] chan_sip.c: set_destination: set destination to 192.168.2.19:5060
[2012-06-13 10:41:05.932] VERBOSE[10414] chan_sip.c: Transmitting (no NAT) to 192.168.2.19:5060:
ACK sip:[email protected];uniq=62C14AD77C330A1DB00441795750B SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK509d17f3
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 ACK
User-Agent: Asterisk PBX 10.4.0
Content-Length: 0


---
[2012-06-13 10:41:05.932] VERBOSE[2701] app_dial.c:     -- SIP/20007-00000017 answered SIP/T38modem0-00000016
[2012-06-13 10:41:05.933] VERBOSE[2701] chan_sip.c: Audio is at 14782
[2012-06-13 10:41:05.933] VERBOSE[2701] chan_sip.c: Adding codec 100003 (ulaw) to SDP
[2012-06-13 10:41:05.933] VERBOSE[2701] chan_sip.c: Adding codec 100004 (alaw) to SDP
[2012-06-13 10:41:05.933] VERBOSE[2701] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2012-06-13 10:41:05.933] VERBOSE[2701] chan_sip.c: 
<--- Reliably Transmitting (no NAT) to 127.0.0.1:57977 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

<------------>
[2012-06-13 10:41:05.933] VERBOSE[2701] rtp_engine.c:     -- Locally bridging SIP/T38modem0-00000016 and SIP/20007-00000017
[2012-06-13 10:41:05.960] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
INVITE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.19:5060;rport;branch=z9hG4bK9EB4A477B6D2D716
From: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
To: "root" <sip:[email protected]>;tag=as3932d449
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
Max-Forwards: 70
X-Designated-Service: fax/t38
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH
Content-Type: application/sdp
Accept: application/sdp, multipart/mixed
Accept-Encoding: identity
Content-Length: 337

v=0
o=user 10589442 10589443 IN IP4 192.168.2.19
s=call
c=IN IP4 192.168.2.19
t=0 0
m=image 7078 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxUdpEC:t38UDPRedundancy
a=T38FaxUdpEC:t38UDPFEC
a=T38FaxMaxDatagram:512
a=sendrecv
<------------->
[2012-06-13 10:41:05.960] VERBOSE[10414] chan_sip.c: --- (17 headers 15 lines) ---
[2012-06-13 10:41:05.961] VERBOSE[10414] chan_sip.c: Sending to 192.168.2.19:5060 (no NAT)
[2012-06-13 10:41:05.961] VERBOSE[10414] netsock.c:   == Using UDPTL CoS mark 5
[2012-06-13 10:41:05.961] VERBOSE[10414] chan_sip.c: Got T.38 offer in SDP in dialog [email protected]:5060
[2012-06-13 10:41:05.962] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(nothing)/video=(nothing)/text=(nothing), combined - (nothing)
[2012-06-13 10:41:05.962] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[2012-06-13 10:41:05.962] VERBOSE[10414] chan_sip.c: Got T.38 Re-invite without audio. Keeping RTP active during T.38 session.
[2012-06-13 10:41:05.963] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (no NAT) to 192.168.2.19:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.2.19:5060;branch=z9hG4bK9EB4A477B6D2D716;received=192.168.2.19;rport=5060
From: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
To: "root" <sip:[email protected]>;tag=as3932d449
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-13 10:41:06.033] VERBOSE[10414] chan_sip.c: Retransmitting #1 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:06.233] VERBOSE[10414] chan_sip.c: Retransmitting #2 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:06.633] VERBOSE[10414] chan_sip.c: Retransmitting #3 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:07.433] VERBOSE[10414] chan_sip.c: Retransmitting #4 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:08.496] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6062:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK01ea1b29
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as562f4d6d
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Wed, 13 Jun 2012 08:41:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-13 10:41:08.500] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6062 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK01ea1b29;received=127.0.0.1
From: "asterisk" <sip:[email protected]>;tag=as562f4d6d
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6062;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-13 10:41:08.500] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-13 10:41:08.500] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-13 10:41:08.600] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6061:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK15af476c
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as6c20349b
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Wed, 13 Jun 2012 08:41:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-13 10:41:08.600] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6060:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK6f31e81b
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as43fe7d9e
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Wed, 13 Jun 2012 08:41:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-13 10:41:08.606] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6060 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK6f31e81b;received=127.0.0.1
From: "asterisk" <sip:[email protected]>;tag=as43fe7d9e
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6060;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-13 10:41:08.606] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-13 10:41:08.607] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-13 10:41:08.608] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6061 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK15af476c;received=127.0.0.1
From: "asterisk" <sip:[email protected]>;tag=as6c20349b
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6061;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-13 10:41:08.608] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-13 10:41:08.608] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-13 10:41:09.033] VERBOSE[10414] chan_sip.c: Retransmitting #5 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:10.963] VERBOSE[10414] chan_sip.c: 
<--- Reliably Transmitting (no NAT) to 192.168.2.19:5060 --->
SIP/2.0 488 Not acceptable here
Via: SIP/2.0/UDP 192.168.2.19:5060;branch=z9hG4bK9EB4A477B6D2D716;received=192.168.2.19;rport=5060
From: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
To: "root" <sip:[email protected]>;tag=as3932d449
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


<------------>
[2012-06-13 10:41:10.981] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
ACK sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.19:5060;rport;branch=z9hG4bK9EB4A477B6D2D716
From: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
To: "root" <sip:[email protected]>;tag=as3932d449
Call-ID: [email protected]:5060
CSeq: 103 ACK
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-13 10:41:10.982] VERBOSE[10414] chan_sip.c: --- (8 headers 0 lines) ---
[2012-06-13 10:41:11.728] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]' Method: REGISTER
[2012-06-13 10:41:12.233] VERBOSE[10414] chan_sip.c: Retransmitting #6 (no NAT) to 127.0.0.1:57977:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:57977;branch=z9hG4bKe8ed502d-a1b3-e111-8e41-000c6ef5a49f;received=127.0.0.1;rport=57977
From: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
To: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 307

v=0
o=root 1156100772 1156100772 IN IP4 X.X.X.X
s=Asterisk PBX 10.4.0
c=IN IP4 X.X.X.X
t=0 0
m=audio 14782 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

---
[2012-06-13 10:41:12.332] WARNING[10414] chan_sip.c: Retransmission timeout reached on transmission e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage for seqno 1 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 6399ms with no response
[2012-06-13 10:41:12.333] WARNING[10414] chan_sip.c: Hanging up call e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions).
[2012-06-13 10:41:12.333] VERBOSE[2701] chan_sip.c: Scheduling destruction of SIP dialog '[email protected]:5060' in 32000 ms (Method: ACK)
[2012-06-13 10:41:12.334] VERBOSE[2701] chan_sip.c: set_destination: Parsing <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B> for address/port to send to
[2012-06-13 10:41:12.334] VERBOSE[2701] chan_sip.c: set_destination: set destination to 192.168.2.19:5060
[2012-06-13 10:41:12.334] VERBOSE[2701] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.2.19:5060:
BYE sip:[email protected];uniq=62C14AD77C330A1DB00441795750B SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK0f06a92d;rport
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
Call-ID: [email protected]:5060
CSeq: 103 BYE
User-Agent: Asterisk PBX 10.4.0
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


---
[2012-06-13 10:41:12.335] VERBOSE[2701] pbx.c:   == Spawn extension (fax-out, 20007, 1) exited non-zero on 'SIP/T38modem0-00000016'
[2012-06-13 10:41:12.335] VERBOSE[2701] chan_sip.c: Scheduling destruction of SIP dialog 'e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage' in 6400 ms (Method: INVITE)
[2012-06-13 10:41:12.335] VERBOSE[2701] chan_sip.c: set_destination: Parsing <sip:[email protected]:57977;transport=udp> for address/port to send to
[2012-06-13 10:41:12.336] VERBOSE[2701] chan_sip.c: set_destination: set destination to 127.0.0.1:57977
[2012-06-13 10:41:12.336] VERBOSE[2701] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:57977:
BYE sip:[email protected]:57977;transport=udp SIP/2.0
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK3968c35c;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as0a283501
To: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
CSeq: 102 BYE
User-Agent: Asterisk PBX 10.4.0
X-Asterisk-HangupCause: Protocol error, unspecified
X-Asterisk-HangupCauseCode: 111
Content-Length: 0


---
[2012-06-13 10:41:12.340] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:57977 --->
SIP/2.0 481 Call Leg/Transaction Does Not Exist
CSeq: 102 BYE
Via: SIP/2.0/UDP X.X.X.X:5060;branch=z9hG4bK3968c35c;rport=5060;received=127.0.0.1
From: <sip:[email protected]>;tag=as0a283501
Call-ID: e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage
To: "root" <sip:[email protected]>;tag=6cd4362d-a1b3-e111-8e41-000c6ef5a49f
Contact: <sip:[email protected]:57977;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-13 10:41:12.340] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-13 10:41:12.340] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog 'e8c6362d-a1b3-e111-8e41-000c6ef5a49f@telefonanlage' Method: INVITE
[2012-06-13 10:41:12.369] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK0f06a92d;rport=5060
From: "root" <sip:[email protected]>;tag=as3932d449
To: <sip:[email protected];uniq=62C14>;tag=01E53AFC4324749B
Call-ID: [email protected]:5060
CSeq: 103 BYE
X-RTP-Stat: CS=0;PS=83;ES=214;OS=19920;SP=0/0;SO=0;QS=-;PR=0;ER=322;OR=0;CR=0;SR=0;QR=-;PL=0,0;BL=0;LS=0;RB=0/0;SB=0/0;EN=PCMU,FAX;DE=;JI=0,0;DL=0,0,0;IP=192.168.2.19:7078,192.168.1.15:14616
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Content-Length: 0

<------------->
[2012-06-13 10:41:12.369] VERBOSE[10414] chan_sip.c: --- (11 headers 0 lines) ---
[2012-06-13 10:41:12.369] VERBOSE[10414] chan_sip.c: SIP Response message for INCOMING dialog BYE arrived
[2012-06-13 10:41:12.369] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: ACK

Hier noch meine SIP Konfiguration:

Code:
[general]
context = default

faxdetect = yes				; Erkennt automatisch Faxübertragungen und springt in fax Context
t38pt_udptl = yes				; Aktiviert T38 für Faxübertragung
bindport=5060					; Bindet den Asterisk Server auf Port 5060
srvlookup=yes					; Löst Hostnamen auf
disallow=all					; Codecs abschalten
allow = g729					; Codec G.729 erlauben
allow = ulaw					; Codec ulaw erlauben
allow = alaw					; Codec alaw erlauben
language=de					; Standardsprache deutsch
trustrpid = yes 				; Soll der Remote-Party-ID vertraut werden
sendrpid = yes  				; P-Asserted-Identitiy header benutzen
nat=no						; Nat Standardmäßig aus
externip=X.X.X.X			; Externe Adresse
localnet=192.168.1.0/24			; Lokales Netz
localnet=192.168.2.0/24
localnet=192.168.3.0/24
localnet=192.168.4.0/24
call-limit=3					; Anruferlimit auf 3
directmedia=nonat				; Verhinert das Direkte Verbinden außerhalb des lokalen Netzes
rtcachefriends=yes				; Cacht SIP User aus der Datenbank

[globals]
DYNAMIC_FEATURES=testfeature 

[t38modem-options](!)
type = friend
host = 127.0.0.1
context = fax-out
disallow = all
allow = g729
allow = ulaw
allow = alaw
t38pt_udptl = yes
dtmfmode = rfc2833
qualify = yes
nat = no
directmedia=no

[T38modem0](t38modem-options)
port = 6060
 
[T38modem1](t38modem-options)
port = 6061
 
[T38modem2](t38modem-options)
port = 6062

Habt ihr eine Idee? Danke schonmal im Voraus.

Gruß
MeisterM
 
Hallo,

ich habe festgestellt, dass die lokale IP 127.0.0.1 noch explizit zum localnet hinzugefügt werden muss. Danach stimmen zu mindestens die Adressen wieder.

Leider funktioniert das ganze immer noch nicht. Hier nun nochmal die SIP Log:

Code:
[2012-06-14 17:51:09.516] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:39500 --->
INVITE sip:[email protected] SIP/2.0
Date: Thu, 14 Jun 2012 15:51:09 GMT
CSeq: 1 INVITE
Via: SIP/2.0/UDP 127.0.0.1:39500;branch=z9hG4bK6c539e6d-a6b4-e111-9220-000c6ef5a49f;rport
User-Agent: OPAL/2.0
From: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
To: <sip:[email protected]>
Contact: <sip:[email protected]:39500;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Type: application/sdp
Content-Length: 299
Max-Forwards: 70

v=0
o=- 1339689069 1339689069 IN IP4 127.0.0.1
s=Opal SIP Session
c=IN IP4 127.0.0.1
t=0 0
m=audio 5000 RTP/AVP 0 8 101 100
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15,32-49
a=rtpmap:100 NSE/8000
a=fmtp:100 192-193
m=image 5004 udptl t38
<------------->
[2012-06-14 17:51:09.516] VERBOSE[10414] chan_sip.c: --- (13 headers 13 lines) ---
[2012-06-14 17:51:09.516] VERBOSE[10414] chan_sip.c: Sending to 127.0.0.1:39500 (no NAT)
[2012-06-14 17:51:09.516] VERBOSE[10414] chan_sip.c: Using INVITE request as basis request - 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
[2012-06-14 17:51:09.516] VERBOSE[10414] chan_sip.c: Found peer 'T38modem0' for 'T38modem0' from 127.0.0.1:39500
[2012-06-14 17:51:09.517] VERBOSE[10414] netsock2.c:   == Using SIP RTP CoS mark 5
[2012-06-14 17:51:09.517] VERBOSE[10414] chan_sip.c: Found RTP audio format 0
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found RTP audio format 8
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found RTP audio format 101
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found RTP audio format 100
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found audio description format PCMU for ID 0
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found audio description format PCMA for ID 8
[2012-06-14 17:51:09.518] VERBOSE[10414] chan_sip.c: Found audio description format telephone-event for ID 101
[2012-06-14 17:51:09.519] VERBOSE[10414] chan_sip.c: Found unknown media description format NSE for ID 100
[2012-06-14 17:51:09.519] VERBOSE[10414] netsock.c:   == Using UDPTL CoS mark 5
[2012-06-14 17:51:09.520] VERBOSE[10414] chan_sip.c: Got T.38 offer in SDP in dialog 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
[2012-06-14 17:51:09.520] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
[2012-06-14 17:51:09.520] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
[2012-06-14 17:51:09.520] VERBOSE[10414] chan_sip.c: Peer audio RTP is at port 127.0.0.1:5000
[2012-06-14 17:51:09.520] VERBOSE[10414] chan_sip.c: Looking for 20007 in fax-out (domain 127.0.0.1)
[2012-06-14 17:51:09.521] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected]:39500;transport=udp>
[2012-06-14 17:51:09.522] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (no NAT) to 127.0.0.1:39500 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 127.0.0.1:39500;branch=z9hG4bK6c539e6d-a6b4-e111-9220-000c6ef5a49f;received=127.0.0.1;rport=39500
From: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
To: <sip:[email protected]>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-14 17:51:09.525] VERBOSE[4286] pbx.c:     -- Executing [20007@fax-out:1] Dial("SIP/T38modem0-00000054", "SIP/20007") in new stack
[2012-06-14 17:51:09.525] VERBOSE[4286] netsock2.c:   == Using SIP RTP CoS mark 5
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Audio is at 13812
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Adding codec 100003 (ulaw) to SDP
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Adding codec 100008 (g729) to SDP
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Adding codec 100004 (alaw) to SDP
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2012-06-14 17:51:09.528] VERBOSE[4286] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.2.19:5060:
INVITE sip:[email protected];uniq=62C14AD77C330A1DB00441795750B SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK2989ebb6
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Date: Thu, 14 Jun 2012 15:51:09 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Remote-Party-ID: "root" <sip:[email protected]>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 333

v=0
o=root 1599927662 1599927662 IN IP4 192.168.1.15
s=Asterisk PBX 10.4.0
c=IN IP4 192.168.1.15
t=0 0
m=audio 13812 RTP/AVP 0 18 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

---
[2012-06-14 17:51:09.529] VERBOSE[4286] app_dial.c:     -- Called SIP/20007
[2012-06-14 17:51:09.565] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK2989ebb6
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
Call-ID: [email protected]:5060
CSeq: 102 INVITE
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-14 17:51:09.565] VERBOSE[10414] chan_sip.c: --- (8 headers 0 lines) ---
[2012-06-14 17:51:10.141] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:46.21.6.206:38596 --->
REGISTER sip:pbx.feuerwehr-maintal.de SIP/2.0
Via: SIP/2.0/UDP 46.21.6.206:38596;branch=z9hG4bK80018b6ea6b4e11182a71a000c1b9c81;rport
From: "PhonerLite" <sip:[email protected]>;tag=3582876368
To: "PhonerLite" <sip:[email protected]>
Call-ID: [email protected]
CSeq: 1878 REGISTER
Contact: <sip:[email protected]:38596>;+sip.instance="<urn:uuid:8035B11D-4FAD-E111-BEFF-1A000C1B9C81>"
Authorization: Digest username="m2-ela", realm="telefonanlage", nonce="248f9cfb", uri="sip:pbx.feuerwehr-maintal.de", response="5da57cfdb854f8bb8d3708527bbdf644", algorithm=MD5
Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY, MESSAGE, UPDATE
Max-Forwards: 70
User-Agent: SIPPER for PhonerLite
Expires: 900
Content-Length: 0

<------------->
[2012-06-14 17:51:10.141] VERBOSE[10414] chan_sip.c: --- (13 headers 0 lines) ---
[2012-06-14 17:51:10.141] VERBOSE[10414] chan_sip.c: Sending to 46.21.6.206:38596 (no NAT)
[2012-06-14 17:51:10.141] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (NAT) to 46.21.6.206:38596 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 46.21.6.206:38596;branch=z9hG4bK80018b6ea6b4e11182a71a000c1b9c81;received=46.21.6.206;rport=38596
From: "PhonerLite" <sip:[email protected]>;tag=3582876368
To: "PhonerLite" <sip:[email protected]>;tag=as34222962
Call-ID: [email protected]
CSeq: 1878 REGISTER
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="telefonanlage", nonce="3cf494dc"
Content-Length: 0


<------------>
[2012-06-14 17:51:10.141] VERBOSE[10414] chan_sip.c: Scheduling destruction of SIP dialog '[email protected]' in 32000 ms (Method: REGISTER)
[2012-06-14 17:51:10.167] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:46.21.6.206:38596 --->
REGISTER sip:pbx.feuerwehr-maintal.de SIP/2.0
Via: SIP/2.0/UDP 46.21.6.206:38596;branch=z9hG4bK80018b6ea6b4e11182a81a000c1b9c81;rport
From: "PhonerLite" <sip:[email protected]>;tag=3582876368
To: "PhonerLite" <sip:[email protected]>
Call-ID: [email protected]
CSeq: 1879 REGISTER
Contact: <sip:[email protected]:38596>;+sip.instance="<urn:uuid:8035B11D-4FAD-E111-BEFF-1A000C1B9C81>"
Authorization: Digest username="m2-ela", realm="telefonanlage", nonce="3cf494dc", uri="sip:pbx.feuerwehr-maintal.de", response="dd0170d721fe7bd30ae37eb2bf156030", algorithm=MD5
Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY, MESSAGE, UPDATE
Max-Forwards: 70
User-Agent: SIPPER for PhonerLite
Expires: 900
Content-Length: 0

<------------->
[2012-06-14 17:51:10.167] VERBOSE[10414] chan_sip.c: --- (13 headers 0 lines) ---
[2012-06-14 17:51:10.167] VERBOSE[10414] chan_sip.c: Sending to 46.21.6.206:38596 (NAT)
[2012-06-14 17:51:10.169] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (NAT) to 46.21.6.206:38596 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 46.21.6.206:38596;branch=z9hG4bK80018b6ea6b4e11182a81a000c1b9c81;received=46.21.6.206;rport=38596
From: "PhonerLite" <sip:[email protected]>;tag=3582876368
To: "PhonerLite" <sip:[email protected]>;tag=as34222962
Call-ID: [email protected]
CSeq: 1879 REGISTER
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Expires: 900
Contact: <sip:[email protected]:38596>;expires=900
Date: Thu, 14 Jun 2012 15:51:10 GMT
Content-Length: 0


<------------>
[2012-06-14 17:51:10.170] VERBOSE[10414] chan_sip.c: Scheduling destruction of SIP dialog '[email protected]' in 32000 ms (Method: REGISTER)
[2012-06-14 17:51:10.824] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK2989ebb6
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
Call-ID: [email protected]:5060
CSeq: 102 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-14 17:51:10.824] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-14 17:51:10.825] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
[2012-06-14 17:51:10.825] VERBOSE[4286] app_dial.c:     -- SIP/20007-00000055 is ringing
[2012-06-14 17:51:10.825] VERBOSE[4286] chan_sip.c: 
<--- Transmitting (no NAT) to 127.0.0.1:39500 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 127.0.0.1:39500;branch=z9hG4bK6c539e6d-a6b4-e111-9220-000c6ef5a49f;received=127.0.0.1;rport=39500
From: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
To: <sip:[email protected]>;tag=as651e214e
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-14 17:51:12.450] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK2989ebb6
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
Call-ID: [email protected]:5060
CSeq: 102 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH
Content-Type: application/sdp
Accept: application/sdp, multipart/mixed
Accept-Encoding: identity
Content-Length: 209

v=0
o=user 2596168 2596168 IN IP4 192.168.2.19
s=Asterisk PBX 10.4.0
c=IN IP4 192.168.2.19
t=0 0
m=audio 7082 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtcp:7083
a=ptime:30
<------------->
[2012-06-14 17:51:12.450] VERBOSE[10414] chan_sip.c: --- (15 headers 11 lines) ---
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Found RTP audio format 0
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Found RTP audio format 8
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Found audio description format PCMU for ID 0
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Found audio description format PCMA for ID 8
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: Peer audio RTP is at port 192.168.2.19:7082
[2012-06-14 17:51:12.451] VERBOSE[10414] chan_sip.c: list_route: hop: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
[2012-06-14 17:51:12.452] VERBOSE[10414] chan_sip.c: set_destination: Parsing <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B> for address/port to send to
[2012-06-14 17:51:12.452] VERBOSE[10414] chan_sip.c: set_destination: set destination to 192.168.2.19:5060
[2012-06-14 17:51:12.452] VERBOSE[10414] chan_sip.c: Transmitting (no NAT) to 192.168.2.19:5060:
ACK sip:[email protected];uniq=62C14AD77C330A1DB00441795750B SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK37e4529f
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 ACK
User-Agent: Asterisk PBX 10.4.0
Content-Length: 0


---
[2012-06-14 17:51:12.453] VERBOSE[4286] app_dial.c:     -- SIP/20007-00000055 answered SIP/T38modem0-00000054
[2012-06-14 17:51:12.453] VERBOSE[4286] chan_sip.c: Audio is at 13602
[2012-06-14 17:51:12.453] VERBOSE[4286] chan_sip.c: Adding codec 100003 (ulaw) to SDP
[2012-06-14 17:51:12.453] VERBOSE[4286] chan_sip.c: Adding codec 100004 (alaw) to SDP
[2012-06-14 17:51:12.453] VERBOSE[4286] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2012-06-14 17:51:12.453] VERBOSE[4286] chan_sip.c: 
<--- Reliably Transmitting (no NAT) to 127.0.0.1:39500 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:39500;branch=z9hG4bK6c539e6d-a6b4-e111-9220-000c6ef5a49f;received=127.0.0.1;rport=39500
From: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
To: <sip:[email protected]>;tag=as651e214e
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Type: application/sdp
Content-Length: 301

v=0
o=root 1969098984 1969098984 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=audio 13602 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
m=image 0 udptl t38

<------------>
[2012-06-14 17:51:12.454] VERBOSE[4286] rtp_engine.c:     -- Locally bridging SIP/T38modem0-00000054 and SIP/20007-00000055
[2012-06-14 17:51:12.459] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:39500 --->
ACK sip:[email protected]:5060 SIP/2.0
CSeq: 1 ACK
Via: SIP/2.0/UDP 127.0.0.1:39500;branch=z9hG4bK008e696f-a6b4-e111-9220-000c6ef5a49f;rport
From: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
To: <sip:[email protected]>;tag=as651e214e
Contact: <sip:[email protected]:39500;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0
Max-Forwards: 70

<------------->
[2012-06-14 17:51:12.460] VERBOSE[10414] chan_sip.c: --- (10 headers 0 lines) ---
[2012-06-14 17:51:12.506] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
INVITE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.19:5060;rport;branch=z9hG4bK13478FEDE4AFD921
From: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
To: "root" <sip:[email protected]>;tag=as28cb3a9c
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Contact: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>
Max-Forwards: 70
X-Designated-Service: fax/t38
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH
Content-Type: application/sdp
Accept: application/sdp, multipart/mixed
Accept-Encoding: identity
Content-Length: 335

v=0
o=user 2596168 2596169 IN IP4 192.168.2.19
s=call
c=IN IP4 192.168.2.19
t=0 0
m=image 7082 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxUdpEC:t38UDPRedundancy
a=T38FaxUdpEC:t38UDPFEC
a=T38FaxMaxDatagram:512
a=sendrecv
<------------->
[2012-06-14 17:51:12.506] VERBOSE[10414] chan_sip.c: --- (17 headers 15 lines) ---
[2012-06-14 17:51:12.506] VERBOSE[10414] chan_sip.c: Sending to 192.168.2.19:5060 (no NAT)
[2012-06-14 17:51:12.507] VERBOSE[10414] netsock.c:   == Using UDPTL CoS mark 5
[2012-06-14 17:51:12.507] VERBOSE[10414] chan_sip.c: Got T.38 offer in SDP in dialog [email protected]:5060
[2012-06-14 17:51:12.507] VERBOSE[10414] chan_sip.c: Capabilities: us - (ulaw|alaw|g729), peer - audio=(nothing)/video=(nothing)/text=(nothing), combined - (nothing)
[2012-06-14 17:51:12.507] VERBOSE[10414] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[2012-06-14 17:51:12.507] VERBOSE[10414] chan_sip.c: Got T.38 Re-invite without audio. Keeping RTP active during T.38 session.
[2012-06-14 17:51:12.508] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (no NAT) to 192.168.2.19:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.2.19:5060;branch=z9hG4bK13478FEDE4AFD921;received=192.168.2.19;rport=5060
From: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
To: "root" <sip:[email protected]>;tag=as28cb3a9c
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-14 17:51:12.509] VERBOSE[4286] chan_sip.c: set_destination: Parsing <sip:[email protected]:39500;transport=udp> for address/port to send to
[2012-06-14 17:51:12.509] VERBOSE[4286] chan_sip.c: set_destination: set destination to 127.0.0.1:39500
[2012-06-14 17:51:12.509] VERBOSE[4286] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:12.609] VERBOSE[10414] chan_sip.c: Retransmitting #1 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:12.808] VERBOSE[10414] chan_sip.c: Retransmitting #2 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:13.209] VERBOSE[10414] chan_sip.c: Retransmitting #3 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:14.009] VERBOSE[10414] chan_sip.c: Retransmitting #4 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:14.950] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6062:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK630bc4b8
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as35c58972
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Thu, 14 Jun 2012 15:51:14 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-14 17:51:14.953] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6062 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK630bc4b8
From: "asterisk" <sip:[email protected]>;tag=as35c58972
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6062;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-14 17:51:14.953] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-14 17:51:14.953] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-14 17:51:15.609] VERBOSE[10414] chan_sip.c: Retransmitting #5 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:17.509] VERBOSE[10414] chan_sip.c: 
<--- Reliably Transmitting (no NAT) to 192.168.2.19:5060 --->
SIP/2.0 488 Not acceptable here
Via: SIP/2.0/UDP 192.168.2.19:5060;branch=z9hG4bK13478FEDE4AFD921;received=192.168.2.19;rport=5060
From: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
To: "root" <sip:[email protected]>;tag=as28cb3a9c
Call-ID: [email protected]:5060
CSeq: 103 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


<------------>
[2012-06-14 17:51:17.539] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
ACK sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.19:5060;rport;branch=z9hG4bK13478FEDE4AFD921
From: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
To: "root" <sip:[email protected]>;tag=as28cb3a9c
Call-ID: [email protected]:5060
CSeq: 103 ACK
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Content-Length: 0

<------------->
[2012-06-14 17:51:17.539] VERBOSE[10414] chan_sip.c: --- (8 headers 0 lines) ---
[2012-06-14 17:51:18.809] VERBOSE[10414] chan_sip.c: Retransmitting #6 (no NAT) to 127.0.0.1:39500:
INVITE sip:[email protected]:39500;transport=udp SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK37368d39;rport
Max-Forwards: 70
From: <sip:[email protected]>;tag=as651e214e
To: "root" <sip:[email protected]>;tag=7066826d-a6b4-e111-9220-000c6ef5a49f
Contact: <sip:[email protected]:5060>
Call-ID: 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage
CSeq: 102 INVITE
User-Agent: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
X-asterisk-Info: SIP re-invite (External RTP bridge)
Content-Type: application/sdp
Content-Length: 281

v=0
o=root 1969098984 1969098985 IN IP4 127.0.0.1
s=Asterisk PBX 10.4.0
c=IN IP4 127.0.0.1
t=0 0
m=image 4418 udptl t38
a=T38FaxVersion:1
a=T38MaxBitRate:14400
a=T38FaxTranscodingMMR
a=T38FaxTranscodingJBIG
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:255

---
[2012-06-14 17:51:18.910] WARNING[10414] chan_sip.c: Retransmission timeout reached on transmission 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 6400ms with no response
[2012-06-14 17:51:18.910] WARNING[10414] chan_sip.c: Hanging up call 8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions).
[2012-06-14 17:51:18.911] VERBOSE[4286] chan_sip.c: Scheduling destruction of SIP dialog '[email protected]:5060' in 32000 ms (Method: ACK)
[2012-06-14 17:51:18.911] VERBOSE[4286] chan_sip.c: set_destination: Parsing <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B> for address/port to send to
[2012-06-14 17:51:18.911] VERBOSE[4286] chan_sip.c: set_destination: set destination to 192.168.2.19:5060
[2012-06-14 17:51:18.911] VERBOSE[4286] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.2.19:5060:
BYE sip:[email protected];uniq=62C14AD77C330A1DB00441795750B SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK3cdfbee0;rport
Max-Forwards: 70
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
Call-ID: [email protected]:5060
CSeq: 103 BYE
User-Agent: Asterisk PBX 10.4.0
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


---
[2012-06-14 17:51:18.912] VERBOSE[4286] pbx.c:   == Spawn extension (fax-out, 20007, 1) exited non-zero on 'SIP/T38modem0-00000054'
[2012-06-14 17:51:18.936] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:192.168.2.19:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5060;branch=z9hG4bK3cdfbee0;rport=5060
From: "root" <sip:[email protected]>;tag=as28cb3a9c
To: <sip:[email protected];uniq=62C14AD77C330A1DB00441795750B>;tag=EB0A78E320E013DF
Call-ID: [email protected]:5060
CSeq: 103 BYE
X-RTP-Stat: CS=0;PS=84;ES=216;OS=20160;SP=0/0;SO=0;QS=-;PR=317;ER=324;OR=50720;CR=0;SR=0;QR=-;PL=0,0;BL=0;LS=0;RB=0/0;SB=-/-;EN=PCMU,FAX;DE=PCMU;JI=83,0;DL=0,0,0;IP=192.168.2.19:7082,192.168.1.15:13812
User-Agent: AVM FRITZ!Box Fon WLAN 7390 84.05.20 (Feb 27 2012)
Supported: 100rel,replaces
Allow-Events: telephone-event,refer
Content-Length: 0

<------------->
[2012-06-14 17:51:18.936] VERBOSE[10414] chan_sip.c: --- (11 headers 0 lines) ---
[2012-06-14 17:51:18.936] VERBOSE[10414] chan_sip.c: SIP Response message for INCOMING dialog BYE arrived
[2012-06-14 17:51:18.936] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage' Method: ACK
[2012-06-14 17:51:18.936] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: ACK
[2012-06-14 17:51:30.027] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6061:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK2c325cae
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as07ffefd6
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Thu, 14 Jun 2012 15:51:30 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-14 17:51:30.028] VERBOSE[10414] chan_sip.c: Reliably Transmitting (no NAT) to 127.0.0.1:6060:
OPTIONS sip:127.0.0.1 SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK4c609255
Max-Forwards: 70
From: "asterisk" <sip:[email protected]>;tag=as526aaa5f
To: <sip:127.0.0.1>
Contact: <sip:[email protected]:5060>
Call-ID: [email protected]:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 10.4.0
Date: Thu, 14 Jun 2012 15:51:30 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---
[2012-06-14 17:51:30.032] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6061 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK2c325cae
From: "asterisk" <sip:[email protected]>;tag=as07ffefd6
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6061;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-14 17:51:30.032] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-14 17:51:30.032] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-14 17:51:30.034] VERBOSE[10414] chan_sip.c: 
<--- SIP read from UDP:127.0.0.1:6060 --->
SIP/2.0 200 OK
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK4c609255
From: "asterisk" <sip:[email protected]>;tag=as526aaa5f
Call-ID: [email protected]:5060
To: <sip:127.0.0.1>
Contact: <sip:127.0.0.1:6060;transport=udp>
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,NOTIFY,REFER,MESSAGE,INFO,PING,PUBLISH
Content-Length: 0

<------------->
[2012-06-14 17:51:30.034] VERBOSE[10414] chan_sip.c: --- (9 headers 0 lines) ---
[2012-06-14 17:51:30.035] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]:5060' Method: OPTIONS
[2012-06-14 17:51:31.155] VERBOSE[10414] chan_sip.c: 
<--- Transmitting (no NAT) to 127.0.0.1:50992 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 127.0.0.1:50992;branch=z9hG4bK2af95d97-f0b3-e111-925a-000c6ef5a49f;received=127.0.0.1;rport=50992
From: "root" <sip:[email protected]>;tag=3a2b5d97-f0b3-e111-925a-000c6ef5a49f
To: <sip:[email protected]>;tag=as5a9bdbdb
Call-ID: a8215d97-f0b3-e111-925a-000c6ef5a49f@telefonanlage
CSeq: 1 INVITE
Server: Asterisk PBX 10.4.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:[email protected]:5060>
Content-Length: 0


<------------>
[2012-06-14 17:51:42.169] VERBOSE[10414] chan_sip.c: Really destroying SIP dialog '[email protected]' Method: REGISTER

Die t38modem Log:

Code:
2012/06/14 17:51:04.635	ttyT38-0(e...3062057840	--> ATZ
2012/06/14 17:51:04.635	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:07.743	ttyT38-0(e...3062057840	--> ATS0=0
2012/06/14 17:51:07.743	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:07.851	ttyT38-0(e...3062057840	--> ATE0
2012/06/14 17:51:07.851	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:07.959	ttyT38-0(e...3062057840	--> ATV1
2012/06/14 17:51:07.959	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:08.067	ttyT38-0(e...3062057840	--> ATQ0
2012/06/14 17:51:08.067	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:08.175	ttyT38-0(e...3062057840	--> ATS8=2
2012/06/14 17:51:08.175	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:08.283	ttyT38-0(e...3062057840	--> ATS7=60
2012/06/14 17:51:08.283	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:08.391	ttyT38-0(e...3062057840	--> AT+FCLASS=?
2012/06/14 17:51:08.391	ttyT38-0(e...3062057840	<--  {
  0d 0a 31 2c 38 0d 0a 4f  4b 0d 0a                  ..1,8..OK.. }
2012/06/14 17:51:08.499	ttyT38-0(e...3062057840	--> AT+FCLASS=1
2012/06/14 17:51:08.499	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:08.607	ttyT38-0(e...3062057840	--> ATI3
2012/06/14 17:51:08.607	ttyT38-0(e...3062057840	<--  {
  0d 0a 56 79 61 63 68 65  73 6c 61 76 20 46 72 6f   ..Vyacheslav Fro
  6c 6f 76 0d 0a 4f 4b 0d  0a                        lov..OK.. }
2012/06/14 17:51:08.715	ttyT38-0(e...3062057840	--> ATI0
2012/06/14 17:51:08.715	ttyT38-0(e...3062057840	<--  {
  0d 0a 54 33 38 46 41 58  0d 0a 4f 4b 0d 0a         ..T38FAX..OK.. }
2012/06/14 17:51:08.823	ttyT38-0(e...3062057840	--> AT+FREV?
2012/06/14 17:51:08.823	ttyT38-0(e...3062057840	<--  {
  0d 0a 31 2e 30 2e 30 0d  0a 4f 4b 0d 0a            ..1.0.0..OK.. }
2012/06/14 17:51:08.931	ttyT38-0(e...3062057840	--> AT+FTM=?
2012/06/14 17:51:08.931	ttyT38-0(e...3062057840	<--  {
  0d 0a 32 34 2c 34 38 2c  37 32 2c 37 33 2c 37 34   ..24,48,72,73,74
  2c 39 36 2c 39 37 2c 39  38 2c 31 32 31 2c 31 32   ,96,97,98,121,12
  32 2c 31 34 35 2c 31 34  36 0d 0a 4f 4b 0d 0a      2,145,146..OK.. }
2012/06/14 17:51:09.039	ttyT38-0(e...3062057840	--> AT+FRM=?
2012/06/14 17:51:09.039	ttyT38-0(e...3062057840	<--  {
  0d 0a 32 34 2c 34 38 2c  37 32 2c 37 33 2c 37 34   ..24,48,72,73,74
  2c 39 36 2c 39 37 2c 39  38 2c 31 32 31 2c 31 32   ,96,97,98,121,12
  32 2c 31 34 35 2c 31 34  36 0d 0a 4f 4b 0d 0a      2,145,146..OK.. }
2012/06/14 17:51:09.147	ttyT38-0(e...3062057840	--> ATL0M1
2012/06/14 17:51:09.147	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:09.255	ttyT38-0(e...3062057840	--> AT+FCLASS=1
2012/06/14 17:51:09.255	ttyT38-0(e...3062057840	<--  {
  0d 0a 4f 4b 0d 0a                                  ..OK.. }
2012/06/14 17:51:09.263	ttyT38-0(e...3062057840	--> ATDF20007
2012/06/14 17:51:09.263	ttyT38-0(e...3062057840	ModemEndPoint::OnMyCallback command=dial extra=3
2012/06/14 17:51:09.263	ttyT38-0(e...3062057840	PseudoModemQ::Dequeue ttyT38-0
2012/06/14 17:51:09.263	ttyT38-0(e...3062057840	MyManager::OnMyCallback SetUpCall(20007)
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	OpalMan	Set up call from modem: to 20007
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	Call	Created Call[1]
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	OpalMan	Set up connection to "modem:"
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	ModemEndPoint::MakeConnection modem:
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	OpalCon	Created connection Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	ModemConnection::ModemConnection Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.264	ttyT38-0(e...3062057840	ModemConnection::SetUpConnection Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	OpalCon	SetPhase from UninitialisedPhase to SetUpPhase
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	OpalMan	On incoming connection Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	Call	GetOtherPartyConnection Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	Call[1] from modem: to 20007, route to sip:[email protected]
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	OpalMan	Set up connection to "sip:[email protected]"
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	MySIPEndPoint::CreateConnection for Call[1]
2012/06/14 17:51:09.265	ttyT38-0(e...3062057840	OpalCon	Created connection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:09.444	ttyT38-0(e...3062057840	Outgoing call routed to 20007 for Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.444	ttyT38-0(e...3062057840	Call	OnSetUp Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.444	ttyT38-0(e...3062057840	MySIPConnection::SetUpConnection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] name=T38modem0
2012/06/14 17:51:09.444	ttyT38-0(e...3062057840	SIP	SetUpConnection: <sip:[email protected]>
2012/06/14 17:51:09.445	ttyT38-0(e...3062057840	OpalUDP	Binding to interface: 127.0.0.1:54961
2012/06/14 17:51:09.446	ttyT38-0(e...3062057840	OpalUDP	Started connect to 127.0.0.1:5060
2012/06/14 17:51:09.446	ttyT38-0(e...3062057840	OpalUDP	Connect on pre-bound interface: 127.0.0.1
2012/06/14 17:51:09.449	ttyT38-0(e...3062057840	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 1
2012/06/14 17:51:09.449	ttyT38-0(e...3062057840	OpalMan	IsMediaBypassPossible: session 1
2012/06/14 17:51:09.449	ttyT38-0(e...3062057840	MySIPConnection::CreateSession 1 t=udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:09.449	ttyT38-0(e...3062057840	RTP_UDP	Session 1 created: 127.0.0.1:5000-5001 ssrc=1953045079
2012/06/14 17:51:09.449	ttyT38-0(e...3062057840	RTP	Adding session RTP_UDP
2012/06/14 17:51:09.450	ttyT38-0(e...3062057840	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.450	ttyT38-0(e...3062057840	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:09.468	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove PCM-16
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-16k
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-24k
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-32k
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-40k
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-06.10
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-AMR
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-13k3
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-15k2
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove LPC-10
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-GSM
2012/06/14 17:51:09.469	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-IMA-ADPCM
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-11k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-15k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-18.2k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-24.6k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-5.95k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-8k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexNB
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexWNarrow-8k
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove T.38-IFP-PRE
2012/06/14 17:51:09.470	ttyT38-0(e...3062057840	Call	GetMediaFormats for Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
G.711-uLaw-64k
G.711-ALaw-64k
T.38-IFP-COR

2012/06/14 17:51:09.471	ttyT38-0(e...3062057840	SIP	Using RTP payload [pt=101] for NTE
2012/06/14 17:51:09.471	ttyT38-0(e...3062057840	SIP	Using RTP payload [pt=100] for NSE
2012/06/14 17:51:09.471	ttyT38-0(e...3062057840	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 2
2012/06/14 17:51:09.471	ttyT38-0(e...3062057840	OpalMan	IsMediaBypassPossible: session 2
2012/06/14 17:51:09.471	ttyT38-0(e...3062057840	MySIPConnection::CreateSession 2 t=udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:09.472	ttyT38-0(e...3062057840	RTP_UDP	Session 2 created: 127.0.0.1:5002-5003 ssrc=1750319688
2012/06/14 17:51:09.472	ttyT38-0(e...3062057840	RTP	Adding session RTP_UDP
2012/06/14 17:51:09.472	ttyT38-0(e...3062057840	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.472	ttyT38-0(e...3062057840	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove PCM-16
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-16k
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-24k
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-32k
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-40k
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-06.10
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-AMR
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-13k3
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-15k2
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove LPC-10
2012/06/14 17:51:09.491	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-GSM
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-IMA-ADPCM
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-11k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-15k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-18.2k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-24.6k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-5.95k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-8k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexNB
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexWNarrow-8k
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove T.38-IFP-PRE
2012/06/14 17:51:09.492	ttyT38-0(e...3062057840	Call	GetMediaFormats for Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
G.711-uLaw-64k
G.711-ALaw-64k
T.38-IFP-COR

2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 3
2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	OpalMan	IsMediaBypassPossible: session 3
2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	MySIPConnection::CreateSession 3 t=udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	Call	GetOtherPartyConnection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	MyT38PseudoRTP::SetRedundancy indication=3 low_speed=0 high_speed=0 repeat_interval=0
2012/06/14 17:51:09.493	ttyT38-0(e...3062057840	RTP_UDP	Session 3 created: 127.0.0.1:5004-5005 ssrc=1552632272
2012/06/14 17:51:09.494	ttyT38-0(e...3062057840	CreateSessionT38 created MyT38PseudoRTP [pt=96]
2012/06/14 17:51:09.494	ttyT38-0(e...3062057840	RTP	Adding session MyT38PseudoRTP
2012/06/14 17:51:09.494	ttyT38-0(e...3062057840	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:09.494	ttyT38-0(e...3062057840	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:09.512	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove PCM-16
2012/06/14 17:51:09.512	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-16k
2012/06/14 17:51:09.512	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-24k
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-32k
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove G.726-40k
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-06.10
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove GSM-AMR
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-13k3
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove iLBC-15k2
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove LPC-10
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-GSM
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove MS-IMA-ADPCM
2012/06/14 17:51:09.513	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-11k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-15k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-18.2k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-24.6k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-5.95k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexIETFNarrow-8k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexNB
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove SpeexWNarrow-8k
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	MySIPConnection::AdjustMediaFormats Remove T.38-IFP-PRE
2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	Call	GetMediaFormats for Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
G.711-uLaw-64k
G.711-ALaw-64k
T.38-IFP-COR

2012/06/14 17:51:09.514	ttyT38-0(e...3062057840	SIP	Creating INVITE request
2012/06/14 17:51:09.515	ttyT38-0(e...3062057840	SIP	No authentication information present
2012/06/14 17:51:09.516	ttyT38-0(e...3062057840	SIP	Sending PDU INVITE sip:[email protected] on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:09.521	ttyT38-0(e...3062057840	OpalCon	OnSetUpConnectionCall[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:09.521	ttyT38-0(e...3062057840	OpalEP	OnSetUpConnection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:09.521	ttyT38-0(e...3062057840	OpalMan	SetUpCall succeeded, call=Call[1]
2012/06/14 17:51:09.521	ttyT38-0(e...3062057840	ttyT38-0 T38Engine::T38Engine
2012/06/14 17:51:09.522	ttyT38-0(e...3062057840	ModemEndPoint::OnMyCallback request={
calltoken=modem:/1/0
localpartyname=
command=dial
response=confirm
number=20007
modemtoken=ttyT38-0
}
2012/06/14 17:51:09.523	SIP Transp...rt:90493e0	SIP	PDU Received SIP/2.0 100 Trying on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:09.523	SIP Transp...rt:90493e0	OpalUDP	Ended connect, selecting 127.0.0.1:39500
2012/06/14 17:51:09.524	SIP Handle...er:904ad58	SIP	Transaction 1 INVITE proceeding.
2012/06/14 17:51:09.526	SIP Handle...er:904ad58	SIP	Received Trying response
2012/06/14 17:51:10.826	SIP Transp...rt:90493e0	SIP	PDU Received SIP/2.0 180 Ringing on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:10.827	SIP Handle...er:904ad58	SIP	Transaction 1 INVITE proceeding.
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	SIP	Received Ringing response
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	OpalCon	SetPhase from UninitialisedPhase to AlertingPhase
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	OpalMan	OnAlerting Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	Call	OnAlerting Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	ModemConnection::SetAlerting Call[1]-EP<modem>[modem:/1/0][email protected] 0
2012/06/14 17:51:10.828	SIP Handle...er:904ad58	OpalCon	SetPhase from SetUpPhase to AlertingPhase
2012/06/14 17:51:12.454	SIP Transp...rt:90493e0	SIP	PDU Received SIP/2.0 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:12.455	SIP Transp...rt:90493e0	SDP	Adding media session with 3 formats
2012/06/14 17:51:12.455	SIP Transp...rt:90493e0	SDP	Unknown media attribute silenceSupp:off - - - -
2012/06/14 17:51:12.455	SIP Transp...rt:90493e0	SDP	Adding media session with 0 formats
2012/06/14 17:51:12.457	SIP Handle...er:904ad58	SIP	Transaction 1 INVITE completed.
2012/06/14 17:51:12.458	SIP Handle...er:904ad58	SIP	Sending PDU ACK sip:[email protected]:5060 on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:12.459	SIP Handle...er:904ad58	SIP	Received INVITE OK response
2012/06/14 17:51:12.459	SIP Handle...er:904ad58	SIP	Received INVITE OK response
2012/06/14 17:51:12.459	SIP Handle...er:904ad58	SIP	RTP payload type PCMU matched to codec G.711-uLaw-64k
2012/06/14 17:51:12.459	SIP Handle...er:904ad58	SIP	RTP payload type PCMA matched to codec G.711-ALaw-64k
2012/06/14 17:51:12.460	SIP Handle...er:904ad58	Call	GetOtherPartyConnection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.461	SIP Handle...er:904ad58	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 1
2012/06/14 17:51:12.461	SIP Handle...er:904ad58	OpalMan	IsMediaBypassPossible: session 1
2012/06/14 17:51:12.461	SIP Handle...er:904ad58	RTP	Found existing session 1
2012/06/14 17:51:12.461	SIP Handle...er:904ad58	RTP_UDP	SetRemoteSocketInfo: session=1 data channel, new=127.0.0.1:13602, local=127.0.0.1:5000-5001, remote=0.0.0.0:0-0
2012/06/14 17:51:12.461	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k,G.711-ALaw-64k
2012/06/14 17:51:12.462	SIP Handle...er:904ad58	OpalCon	OpenSourceMediaStream for session 1 on Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.462	SIP Handle...er:904ad58	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.462	SIP Handle...er:904ad58	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:12.463	SIP Handle...er:904ad58	OpalCon	Selected media stream PCM-16 -> G.711-uLaw-64k
2012/06/14 17:51:12.463	SIP Handle...er:904ad58	ModemConnection::CreateMediaStream Call[1]-EP<modem>[modem:/1/0] mediaFormat=PCM-16 sessionID=1 isSource=1
2012/06/14 17:51:12.463	SIP Handle...er:904ad58	OpalMan	OnOpenMediaStream Call[1]-EP<modem>[modem:/1/0],AudioModemMediaStream-Source-PCM-16
2012/06/14 17:51:12.463	SIP Handle...er:904ad58	Call	PatchMediaStreams Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.463	SIP Handle...er:904ad58	OpalCon	OpenSinkMediaStream Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session=1
2012/06/14 17:51:12.464	SIP Handle...er:904ad58	OpalCon	OpenSinkMediaStream, selected PCM-16 -> G.711-uLaw-64k
2012/06/14 17:51:12.464	SIP Handle...er:904ad58	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 1
2012/06/14 17:51:12.464	SIP Handle...er:904ad58	OpalMan	IsMediaBypassPossible: session 1
2012/06/14 17:51:12.464	SIP Handle...er:904ad58	RTP	Found existing session 1
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	RTP	Found existing session 1
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalMan	OnOpenMediaStream Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage],OpalRTPMediaStream-Sink-G.711-uLaw-64k
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalCon	Opened sink stream 1_1
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	Patch	Added sink
  from PCM-16
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 16
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
    to G.711-uLaw-64k
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 8
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30

2012/06/14 17:51:12.465	SIP Handle...er:904ad58	Codec	G711-uLaw-64k encoder created
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	Patch	Added media stream sink OpalRTPMediaStream-Sink-G.711-uLaw-64k using transcoder PCM-16->G.711-uLaw-64k
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalCon	New patch created
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalCon	New patch created
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalCon	Adding RFC2833 transmit handler
2012/06/14 17:51:12.465	SIP Handle...er:904ad58	OpalCon	Adding Cisco NSE transmit handler
2012/06/14 17:51:12.466	SIP Handle...er:904ad58	OpalCon	Opened source stream 1_1
2012/06/14 17:51:12.466	SIP Handle...er:904ad58	Call	GetOtherPartyConnection Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.466	SIP Handle...er:904ad58	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.466	SIP Handle...er:904ad58	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:12.466	SIP Handle...er:904ad58	OpalCon	OpenSourceMediaStream for session 1 on Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	OpalCon	Selected media stream G.711-uLaw-64k -> PCM-16
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	Call	CanDoMediaBypass Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage] session 1
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	OpalMan	IsMediaBypassPossible: session 1
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	RTP	Found existing session 1
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	RTP	Found existing session 1
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	OpalMan	OnOpenMediaStream Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage],OpalRTPMediaStream-Source-G.711-uLaw-64k
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	Call	PatchMediaStreams Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	OpalCon	OpenSinkMediaStream Call[1]-EP<modem>[modem:/1/0] session=1
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.467	SIP Handle...er:904ad58	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:12.468	SIP Handle...er:904ad58	OpalCon	OpenSinkMediaStream, selected G.711-uLaw-64k -> PCM-16
2012/06/14 17:51:12.468	SIP Handle...er:904ad58	ModemConnection::CreateMediaStream Call[1]-EP<modem>[modem:/1/0] mediaFormat=PCM-16 sessionID=1 isSource=0
2012/06/14 17:51:12.468	SIP Handle...er:904ad58	ModemEngineBody::Attach audioEngine
2012/06/14 17:51:12.468	SIP Handle...er:904ad58	ttyT38-0 AudioEngine::Attach
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	ttyT38-0 AudioClass=FALSE
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	ttyT38-0 AudioEngine::SendOnIdle 2
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	ModemEngineBody::Attach audioEngine Attached
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalMan	OnOpenMediaStream Call[1]-EP<modem>[modem:/1/0],AudioModemMediaStream-Sink-PCM-16
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalCon	Opened sink stream 1_1
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	Patch	Added sink
  from G.711-uLaw-64k
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 64000
         Max Frame Size = 8
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30
    to PCM-16
         Clock Rate = 8000
         Frame Time = 8
         Max Bit Rate = 128000
         Max Frame Size = 16
         Needs Jitter = 1
         Rx Frames Per Packet = 240
         Tx Frames Per Packet = 30

2012/06/14 17:51:12.469	SIP Handle...er:904ad58	Codec	G711-uLaw-64k decoder created
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	Patch	Added media stream sink AudioModemMediaStream-Sink-PCM-16 using transcoder G.711-uLaw-64k->PCM-16
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalCon	New patch created
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalCon	New patch created
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalCon	Adding RFC2833 receive handler
2012/06/14 17:51:12.469	SIP Handle...er:904ad58	OpalCon	Adding Cisco NSE receive handler
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalCon	Opened source stream 1_1
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	SIP	Could not find SDP media description for Video
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	SIP	Could not find media formats in SDP media description for session 3
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalMan	OnConnected Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	Call	OnConnected Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	ModemConnection::SetConnected Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalCon	SetPhase from AlertingPhase to ConnectedPhase
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalCon	SetPhase from ConnectedPhase to EstablishedPhase
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	ModemConnection::OnEstablished Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	ModemEngineBody::Request request={
calltoken=modem:/1/0
command=established
}
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	OpalMan	OnEstablished Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.470	SIP Handle...er:904ad58	Call	OnEstablished Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.471	SIP Handle...er:904ad58	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.471	SIP Handle...er:904ad58	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:12.495	SIP Handle...er:904ad58	Call	GetMediaFormats for Call[1]-EP<modem>[modem:/1/0]
G.711-uLaw-64k
G.711-ALaw-64k
PCM-16

2012/06/14 17:51:12.495	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k,G.711-ALaw-64k,PCM-16
2012/06/14 17:51:12.496	SIP Handle...er:904ad58	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.496	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k,G.711-ALaw-64k,PCM-16
2012/06/14 17:51:12.496	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 3 with media G.711-uLaw-64k,G.711-ALaw-64k,PCM-16
2012/06/14 17:51:12.496	SIP Handle...er:904ad58	ModemConnection::GetMediaFormats Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.496	SIP Handle...er:904ad58	ModemEndPoint::GetMediaFormats
2012/06/14 17:51:12.510	SIP Transp...rt:90493e0	SIP	PDU Received INVITE sip:[email protected]:39500;transport=udp SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:39500>
2012/06/14 17:51:12.510	SIP Transp...rt:90493e0	SDP	Adding media session with 1 formats
[B][COLOR="#FF0000"]2012/06/14 17:51:12.510	SIP Transp...rt:90493e0	SDP	Malformed media attribute T38FaxTranscodingMMR
2012/06/14 17:51:12.510	SIP Transp...rt:90493e0	SDP	Malformed media attribute T38FaxTranscodingJBIG[/COLOR][/B]
2012/06/14 17:51:12.526	SIP Handle...er:904ad58	MySIPConnection::AdjustMediaFormats Remove PCM-16
2012/06/14 17:51:12.526	SIP Handle...er:904ad58	Call	GetMediaFormats for Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
G.711-uLaw-64k
G.711-ALaw-64k

2012/06/14 17:51:12.526	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 1 with media G.711-uLaw-64k,G.711-ALaw-64k
2012/06/14 17:51:12.526	SIP Handle...er:904ad58	OpalCon	OpenSourceMediaStream (already opened) for session 1 on Call[1]-EP<modem>[modem:/1/0]
2012/06/14 17:51:12.526	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 2 with media G.711-uLaw-64k,G.711-ALaw-64k
2012/06/14 17:51:12.526	SIP Handle...er:904ad58	Call	OpenSourceMediaStreams for session 3 with media G.711-uLaw-64k,G.711-ALaw-64k
2012/06/14 17:51:12.527	SIP Handle...er:904ad58	OpalCon	Media stream threads started.
2012/06/14 17:51:12.527	SIP Handle...er:904ad58	OpalCon	Media stream threads started.
2012/06/14 17:51:12.527	SIP Handle...er:904ad58	OpalCon	SetPhase from AlertingPhase to EstablishedPhase
2012/06/14 17:51:12.527	SIP Handle...er:904ad58	OpalMan	OnEstablished Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.527	SIP Handle...er:904ad58	Call	OnEstablished Call[1]-EP<sip>[8a5b826d-a6b4-e111-9220-000c6ef5a49f@telefonanlage]
2012/06/14 17:51:12.527	Media Patc...ch:9051a98	RTP	First sent data: ver=2 pt=PCMU psz=160 m=1 x=0 seq=50802 ts=0 src=1953045079 ccnt=0
2012/06/14 17:51:12.576	Media Patc...ch:907d440	RTP	First receive data: ver=2 pt=PCMU psz=240 m=1 x=0 seq=4 ts=960 src=40430865 ccnt=0
2012/06/14 17:51:13.470	 Housekeeper	ModemEngineBody::OnTimerCallback Timeout 0
2012/06/14 17:51:13.471	ttyT38-0(e...3062057840	ModemEndPoint::OnMyCallback command=requestmode extra=4
2012/06/14 17:51:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=101 octets=16160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:16.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=201 octets=32160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:51:17.458	 Housekeeper	SIP	Set state Terminated_Success for transaction 1 INVITE
2012/06/14 17:51:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=301 octets=48160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=401 octets=64160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=501 octets=80160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:24.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=601 octets=96160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=701 octets=112160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=801 octets=128160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:30.030	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:51:30.032	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:51:30.033	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:51:30.034	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:51:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=901 octets=144160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1001 octets=160160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:34.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1101 octets=176160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:36.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1201 octets=192160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:38.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1301 octets=208160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:51:40.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1401 octets=224160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:42.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1501 octets=240160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:44.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1601 octets=256160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:46.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1701 octets=272160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:48.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1801 octets=288160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:50.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=1901 octets=304160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:52.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2001 octets=320160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:54.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2101 octets=336160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:51:56.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2201 octets=352160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:51:58.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2301 octets=368160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:00.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2401 octets=384160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:02.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2501 octets=400160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:04.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2601 octets=416160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:06.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2701 octets=432160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:08.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2801 octets=448160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:10.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=2901 octets=464160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:12.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3001 octets=480160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3101 octets=496160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:16.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3201 octets=512160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3301 octets=528160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3401 octets=544160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3501 octets=560160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:24.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3601 octets=576160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3701 octets=592160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3801 octets=608160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:30.035	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:52:30.036	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:52:30.037	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:52:30.037	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:52:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=3901 octets=624160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4001 octets=640160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:34.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4101 octets=656160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:52:36.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4201 octets=672160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:38.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4301 octets=688160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:40.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4401 octets=704160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:42.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4501 octets=720160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:44.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4601 octets=736160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:52:46.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4701 octets=752160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:52:48.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4801 octets=768160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:50.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=4901 octets=784160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:52.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5001 octets=800160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:54.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5101 octets=816160 avgTime=19 maxTime=28 minTime=12
2012/06/14 17:52:56.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5201 octets=832160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:52:58.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5301 octets=848160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:00.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5401 octets=864160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:02.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5501 octets=880160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:04.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5601 octets=896160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:06.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5701 octets=912160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:08.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5801 octets=928160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:10.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=5901 octets=944160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:12.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6001 octets=960160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6101 octets=976160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:16.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6201 octets=992160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6301 octets=1008160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6401 octets=1024160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6501 octets=1040160 avgTime=20 maxTime=20 minTime=20
2012/06/14 17:53:24.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6601 octets=1056160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:53:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6701 octets=1072160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6801 octets=1088160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:30.039	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:53:30.040	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:53:30.041	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:53:30.044	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:53:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=6901 octets=1104160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7001 octets=1120160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:34.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7101 octets=1136160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:36.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7201 octets=1152160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:38.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7301 octets=1168160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:40.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7401 octets=1184160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:42.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7501 octets=1200160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:44.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7601 octets=1216160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:46.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7701 octets=1232160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:48.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7801 octets=1248160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:50.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=7901 octets=1264160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:52.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8001 octets=1280160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:54.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8101 octets=1296160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:56.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8201 octets=1312160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:53:58.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8301 octets=1328160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:00.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8401 octets=1344160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:02.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8501 octets=1360160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:04.528	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8601 octets=1376160 avgTime=20 maxTime=23 minTime=17
2012/06/14 17:54:06.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8701 octets=1392160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:54:08.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8801 octets=1408160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:10.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=8901 octets=1424160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:12.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9001 octets=1440160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9101 octets=1456160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:54:15.262	ttyT38-0(i...3061525360	--> read ERROR -1 Input/output error
2012/06/14 17:54:15.262	ttyT38-0(i...3061525360	--> Stopped
2012/06/14 17:54:15.263	ttyT38-0(b...3062856560	PWLib	Destroyed thread 0x903eab0 ttyT38-0(i):3061525360(id = 0)
2012/06/14 17:54:15.263	ttyT38-0(o...3061791600	<-- Stopped
2012/06/14 17:54:15.273	ttyT38-0(b...3062856560	PWLib	Destroyed thread 0x903f268 ttyT38-0(o):3061791600(id = 0)
2012/06/14 17:54:16.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9201 octets=1472160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9301 octets=1488160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9401 octets=1504160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9501 octets=1520160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:24.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9601 octets=1536160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:54:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9701 octets=1552160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9801 octets=1568160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:30.044	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:54:30.045	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:54:30.048	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:54:30.049	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:54:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=9901 octets=1584160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:54:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10001 octets=1600160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:34.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10101 octets=1616160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:36.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10201 octets=1632160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:38.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10301 octets=1648160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:54:40.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10401 octets=1664160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:42.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10501 octets=1680160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:44.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10601 octets=1696160 avgTime=19 maxTime=26 minTime=14
2012/06/14 17:54:46.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10701 octets=1712160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:48.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10801 octets=1728160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:50.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=10901 octets=1744160 avgTime=20 maxTime=20 minTime=20
2012/06/14 17:54:52.528	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11001 octets=1760160 avgTime=20 maxTime=21 minTime=20
2012/06/14 17:54:54.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11101 octets=1776160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:54:56.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11201 octets=1792160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:54:58.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11301 octets=1808160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:00.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11401 octets=1824160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:02.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11501 octets=1840160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:04.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11601 octets=1856160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:06.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11701 octets=1872160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:08.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11801 octets=1888160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:10.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=11901 octets=1904160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:12.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12001 octets=1920160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12101 octets=1936160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:16.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12201 octets=1952160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12301 octets=1968160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12401 octets=1984160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12501 octets=2000160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:24.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12601 octets=2016160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12701 octets=2032160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12801 octets=2048160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:30.048	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:55:30.049	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:55:30.053	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:55:30.053	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:55:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=12901 octets=2064160 avgTime=20 maxTime=27 minTime=13
2012/06/14 17:55:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13001 octets=2080160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:34.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13101 octets=2096160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:36.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13201 octets=2112160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:38.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13301 octets=2128160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:40.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13401 octets=2144160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:42.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13501 octets=2160160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:44.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13601 octets=2176160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:46.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13701 octets=2192160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:48.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13801 octets=2208160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:50.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=13901 octets=2224160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:52.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14001 octets=2240160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:54.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14101 octets=2256160 avgTime=20 maxTime=28 minTime=12
2012/06/14 17:55:56.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14201 octets=2272160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:55:58.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14301 octets=2288160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:00.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14401 octets=2304160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:02.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14501 octets=2320160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:04.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14601 octets=2336160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:56:06.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14701 octets=2352160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:08.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14801 octets=2368160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:10.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=14901 octets=2384160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:12.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15001 octets=2400160 avgTime=20 maxTime=22 minTime=18
2012/06/14 17:56:14.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15101 octets=2416160 avgTime=20 maxTime=25 minTime=15
2012/06/14 17:56:16.526	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15201 octets=2432160 avgTime=19 maxTime=21 minTime=19
2012/06/14 17:56:18.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15301 octets=2448160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:20.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15401 octets=2464160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:22.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15501 octets=2480160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:24.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15601 octets=2496160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:26.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15701 octets=2512160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:28.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15801 octets=2528160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:30.055	Opal Liste...er:903d918	OpalUDP	Pre-bound to interface: 127.0.0.1:6060
2012/06/14 17:56:30.056	Opal Liste...er:903d918	SIP	PDU Received OPTIONS sip:127.0.0.1 SIP/2.0 on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:56:30.057	Opal Liste...er:903d918	SIP	Sending PDU 200 OK on udp$127.0.0.1:5060<if=udp$127.0.0.1:6060>
2012/06/14 17:56:30.058	Opal Liste...er:903d918	Opal	Transport clean up on termination
2012/06/14 17:56:30.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=15901 octets=2544160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:32.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=16001 octets=2560160 avgTime=20 maxTime=21 minTime=19
2012/06/14 17:56:34.527	Media Patc...ch:9051a98	RTP	Transmit statistics:  packets=16101 octets=2576160 avgTime=20 maxTime=21 minTime=19

Dabei ist mir eine Stelle merkwürdig aufgefallen. Diese habe ich mal rot markiert.
 
konntest Du das Problem lösen ?

hG
Walter
 
Holen Sie sich 3CX - völlig kostenlos!
Verbinden Sie Ihr Team und Ihre Kunden Telefonie Livechat Videokonferenzen

Gehostet oder selbst-verwaltet. Für bis zu 10 Nutzer dauerhaft kostenlos. Keine Kreditkartendetails erforderlich. Ohne Risiko testen.

3CX
Für diese E-Mail-Adresse besteht bereits ein 3CX-Konto. Sie werden zum Kundenportal weitergeleitet, wo Sie sich anmelden oder Ihr Passwort zurücksetzen können, falls Sie dieses vergessen haben.