[Freeswitch-users] Freeswitch as b2bua
Helmut Kuper
helmut.kuper at ewetel.de
Wed Feb 28 02:17:33 PST 2007
-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1
Hi,
here it is: (I dialed 2850 on softphone)
> This is how it should work but that totally depends on config. can
> you provide that also?
sofia config:
<configuration name="sofia.conf" description="sofia Endpoint">
<profiles>
<profile name="sip">
<!-- EDIT: You will need to uncomment one of the following SIP provider -->
<!-- registrations and configure your authentication data as
supplied -->
<!-- by your provider. The following are examples only. -->
<!-- Sample configuration for Asterlink. www.asterlink.com -->
<registrations>
<registration name="EWE TEL">
<param name="register-scheme" value="Digest"/>
<param name="register-realm" value="ewetel.de"/>
<param name="register-username" value="032223930016"/>
<param name="register-password" value="xxxxxx"/>
<param name="register-from"
value="sip:032223930016 at sip01.voice.ewetel.de"/>
<param name="register-to"
value="sip:032223930016 at sip01.voice.ewetel.de"/>
<param name="register-proxy"
value="sip:sip01.voice.ewetel.de:5060"/>
<param name="register-frequency" value="600"/>
</registration>
</registrations>
<settings>
<param name="debug" value="1"/>
<param name="rfc2833-pt" value="101"/>
<param name="sip-port" value="5060"/>
<param name="dialplan" value="XML"/>
<param name="dtmf-duration" value="100"/>
<param name="codec-prefs" value="PCMU,speex"/>
<param name="codec-ms" value="20"/>
<param name="use-rtp-timer" value="true"/>
<param name="rtp-timer-name" value="soft"/>
<param name="manage-presence" value="true"/>
<!-- EDIT: If you want the destination address to be the
full sip URI -->
<!-- dialed (123 at abc.org) instead of just 123,
uncomment the following line -->
param name="full-id-in-dialplan" value="true"/>
<!-- EDIT: The settings below need to be set to your IP
address -->
<!-- If you are using a NAT these must be the
internal IP on your server -->
<param name="rtp-ip" value="sip0.en.ewetel.de"/>
<param name="sip-ip" value="sip0.en.ewetel.de"/>
<!-- EDIT: The setting below lets any phone register
with your server. -->
<!-- This may be convenient for testing but may
pose a security risk if -->
<!-- your server is accessable from the public
internet -->
<!-- comment the next line and uncomment one or
both of the other 2 lines for call authentication -->
<param name="accept-blind-reg" value="true"/>
<param name="auth-calls" value="false"/>
<!-- on authed calls, authenticate *all* the packets not
just invite -->
<!--<param name="auth-all-packets" value="true"/>-->
<!-- optional ; -->
<!-- <param name="ext-rtp-ip"
value="stun:stun.server.com"/>-->
<!-- <param name="ext-rtp-ip" value="100.101.102.103"/> -->
<!-- VAD choose one (out is a good choice); -->
<!-- <param name="vad" value="in"/> -->
<!-- <param name="vad" value="out"/> -->
<!-- <param name="vad" value="both"/> -->
<!--<param name="alias" value="sip:10.0.1.251:5555"/>-->
</settings>
</profile>
</profiles>
</configuration>
-
------------------------------------------------------------------------------------------------
Dialplan extract:
<!-- Dial any 7 digit number (2850) as 10 digit
dialing but pass to a local itsp-->
<extension name="Local Dial">
<!-- <condition
field="destination_number" expression="^([0-9]{7})$">-->
<condition
field="destination_number" expression="^2850$">
<!-- Set your outgoing caller ID
name here -->
<action application="set"
data="effective_caller_id_name=032223930016"/>
<!-- Your SIP provider probably
expects a phone number or username
for this setting. It is
used in the from URL phonenumber at mysipprovider.com -->
<action application="set"
data="effective_caller_id_number=101"/>
<!-- If your provider does not
provide ringback (180 or 183) you may simulateringback by uncommenting
the following line. -->
<!--action
application="ringback"/>-->
<!-- Call the bridge app. Set
data to endpoint/profile/[Areacode]$1 at mysipprovider.com -->
<!-- Note: the area code is
getting prepended to the dialstring variable $1 -->
<!-- EDIT: Change the area code
and domain of your SIP provider. -->
<action application="bridge"
data="sofia/sip/044180002850 at sip01.voice.ewetel.de"/>
</condition>
</extension>
-
---------------------------------------------------------------------------------
> Can you provide log output so we can see what is going on.
LOG:
- -------------------------------------------------------
SecRECV[ ]
tport_wakeup_pri(0x80abbd0): events IN
tport_recv_event(0x80abbd0)
tport_recv_iovec(0x80abbd0) msg 0x80ae178 from (udp/212.6.123.118:5060)
has 997 bytes, veclen = 1
recv 997 bytes from udp/[212.6.95.198]:9330 at 10:09:39.985008:
------------------------------------------------------------------------
PUBLISH sip:101 at sip0.en.ewetel.de SIP/2.0
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-62137a1b22287041-1--d87543-;rport
Max-Forwards: 70
Contact: <sip:101 at 212.6.95.198:9330>
To: "101"<sip:101 at sip0.en.ewetel.de>
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=6163fc3b
Call-ID: NzEwZTExYzBkMDJmZjE5ZDgxNzhlNTJjMjYzMDc0M2Q.
CSeq: 1 PUBLISH
Expires: 60
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO
Content-Type: application/pidf+xml
User-Agent: X-Lite release 1006e stamp 34025
Event: presence
Content-Length: 425
<?xml version='1.0' encoding='UTF-8'?><presence
xmlns='urn:ietf:params:xml:ns:pidf'
xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
xmlns:c='urn:ietf:params:xml:ns:pidf:cipid'
entity='pres:101 at sip0.en.ewetel.de'><tuple
id='t84368671'><status><basic>open</basic></status></tuple><dm:person
id='p670b1859'><rpid:activities><rpid:unknown/></rpid:activities></dm:person></presence>
------------------------------------------------------------------------
tport_deliver(0x80abbd0): msg 0x80ae178 (997 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta: received PUBLISH sip:101 at sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: canonizing sip:101 at sip0.en.ewetel.de with contact
nta: PUBLISH (1) going to a default leg
nua: nua_stack_process_request: entering
nua: nh_create: entering
nua: nh_create_handle: entering
nua: nua_stack_set_params: entering
soa_clone(static::0x809d4d0, 0x809b690, 0x80d1160) called
soa_set_params(static::0x80af000, ...) called
soa_set_params(static::0x80af000, ...) called
nua: nua_stack_event: entering
nua(0x80d1160): i_publish 100 Trying
nua: nua_event: entering
nua: nua_respond: entering
nua(0x80d1160): signal r_respond 200 OK
tport_tsend(0x80abbd0) tpn = UDP/212.6.95.198:9330
tport_resolve addrinfo = 212.6.95.198:9330
tport_by_addrinfo(0x80abbd0): not found by name UDP/212.6.95.198:9330
tport_vsend(0x80abbd0): 541 bytes of 541 to UDP/212.6.95.198:9330
tport_vsend returned 541
send 541 bytes to udp/[212.6.95.198]:9330 at 10:09:39.988395:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-62137a1b22287041-1--d87543-;rport=9330
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=6163fc3b
To: "101" <sip:101 at sip0.en.ewetel.de>;tag=raFDate1Qa2Zj
Call-ID: NzEwZTExYzBkMDJmZjE5ZDgxNzhlNTJjMjYzMDc0M2Q.
CSeq: 1 PUBLISH
User-Agent: FreeSWITCH(mod_sofia)
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: 100rel, precondition
Allow-Events: presence, presence.winfo
Content-Length: 0
------------------------------------------------------------------------
nta: sent 200 OK for PUBLISH (1)
tport_wakeup_pri(0x80abbd0): events IN
tport_recv_event(0x80abbd0)
tport_recv_iovec(0x80abbd0) msg 0x80afd20 from (udp/212.6.123.118:5060)
has 813 bytes, veclen = 1
recv 813 bytes from udp/[212.6.95.198]:9330 at 10:09:40.090389:
------------------------------------------------------------------------
INVITE sip:2850 at sip0.en.ewetel.de SIP/2.0
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-a87fcd2a9168d35c-1--d87543-;rport
Max-Forwards: 70
Contact: <sip:101 at 212.6.95.198:9330>
To: "2850"<sip:2850 at sip0.en.ewetel.de>
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=a6275625
Call-ID: YmI1MGY0ODQ1ZjYzZWU4ODI5YWNhOGViY2VmM2RiYTg.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO
Content-Type: application/sdp
User-Agent: X-Lite release 1006e stamp 34025
Content-Length: 275
v=0
o=- 6 2 IN IP4 212.6.95.198
s=CounterPath X-Lite 3.0
c=IN IP4 212.6.95.198
t=0 0
m=audio 54092 RTP/AVP 107 119 0 98 8 3 101
a=fmtp:101 0-15
a=rtpmap:107 BV32/16000
a=rtpmap:119 BV32-FEC/16000
a=rtpmap:98 iLBC/8000
a=rtpmap:101 telephone-event/8000
a=sendrecv
------------------------------------------------------------------------
tport_deliver(0x80abbd0): msg 0x80afd20 (813 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta: received INVITE sip:2850 at sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: canonizing sip:2850 at sip0.en.ewetel.de with contact
nta: INVITE (1) going to a default leg
nua: nua_stack_process_request: entering
nua: nh_create: entering
nua: nh_create_handle: entering
nua: nua_stack_set_params: entering
soa_clone(static::0x809d4d0, 0x809b690, 0x80a6ba8) called
soa_set_params(static::0x80b0088, ...) called
soa_set_params(static::0x80b0088, ...) called
nta_leg_create(0x80b0298)
soa_init_offer_answer(static::0x80b0088) called
soa_set_remote_sdp(static::0x80b0088, (nil), 0x80a2aea, 275) called
nua(0x80a6ba8): adding session usage
tport_tsend(0x80abbd0) tpn = UDP/212.6.95.198:9330
tport_resolve addrinfo = 212.6.95.198:9330
tport_by_addrinfo(0x80abbd0): not found by name UDP/212.6.95.198:9330
tport_vsend(0x80abbd0): 337 bytes of 337 to UDP/212.6.95.198:9330
tport_vsend returned 337
send 337 bytes to udp/[212.6.95.198]:9330 at 10:09:40.092277:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-a87fcd2a9168d35c-1--d87543-;rport=9330
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=a6275625
To: "2850"<sip:2850 at sip0.en.ewetel.de>
Call-ID: YmI1MGY0ODQ1ZjYzZWU4ODI5YWNhOGViY2VmM2RiYTg.
CSeq: 1 INVITE
User-Agent: FreeSWITCH(mod_sofia)
Content-Length: 0
------------------------------------------------------------------------
nta: sent 100 Trying for INVITE (1)
nua: nua_stack_event: entering
nua(0x80a6ba8): i_invite 100 Trying
nua(0x80a6ba8): call state changed: init -> received, received offer
soa_get_remote_sdp(static::0x80b0088, [0x40983c08], [0x40983c04],
[(nil)]) called
nua: nua_stack_event: entering
nua(0x80a6ba8): i_state 100 Trying
nua: nua_event: entering
nua: nua_handle_bind: entering
nua: nua_event: entering
2007-02-28 11:09:40 [NOTICE] switch_channel.c:347
switch_channel_set_name() New Chan sofia/sip/101 at sip0.en.ewetel.de:5060
[cd5789d0-c713-11db-8be0-6116055f8452]
2007-02-28 11:09:40 [WARNING] mod_sofia.c:680 find_reg_url() Cannot
locate registered user 101 at sip0.en.ewetel.de
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2815 sip_i_state() Channel
sofia/sip/101 at sip0.en.ewetel.de:5060 entering state [received]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2820 sip_i_state() Remote SDP:
v=0
o=- 6 2 IN IP4 212.6.95.198
s=CounterPath X-Lite 3.0
c=IN IP4 212.6.95.198
t=0 0
m=audio 54092 RTP/AVP 107 119 0 98 8 3 101
a=rtpmap:107 BV32/16000
a=rtpmap:119 BV32-FEC/16000
a=rtpmap:98 iLBC/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2420 negotiate_sdp() Codec
Compare [BV32:107]/[PCMU:0]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2420 negotiate_sdp() Codec
Compare [BV32-FEC:119]/[PCMU:0]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2420 negotiate_sdp() Codec
Compare [PCMU:0]/[PCMU:0]
2007-02-28 11:09:40 [INFO] mod_sofia.c:1483 tech_set_codec() Set Codec
sofia/sip/101 at sip0.en.ewetel.de:5060 PCMU/8000 20 ms
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2924 sip_i_state()
sofia/sip/101 at sip0.en.ewetel.de:5060 State Change CS_NEW -> CS_INIT
2007-02-28 11:09:40 [DEBUG] switch_core.c:3225 switch_core_session_run()
(sofia/sip/101 at sip0.en.ewetel.de:5060) State INIT
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1226 sofia_on_init() SOFIA INIT
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1237 sofia_on_init()
sofia/sip/101 at sip0.en.ewetel.de:5060 State Change CS_INIT -> CS_RING
2007-02-28 11:09:40 [DEBUG] switch_core.c:3261 switch_core_session_run()
(sofia/sip/101 at sip0.en.ewetel.de:5060) State RING
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1252 sofia_on_ring() SOFIA RING
2007-02-28 11:09:40 [DEBUG] switch_core.c:2890
switch_core_standard_on_ring() Standard RING
sofia/sip/101 at sip0.en.ewetel.de:5060
2007-02-28 11:09:40 [INFO] mod_dialplan_xml.c:219 dialplan_hunt()
Processing 101->2850!
2007-02-28 11:09:40 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test
conditions destination_number(2850) =~ /(.*)/
2007-02-28 11:09:40 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test
conditions destination_number(2850) =~ /^(1[0-9]{2})$/
2007-02-28 11:09:40 [DEBUG] mod_dialplan_xml.c:122 parse_exten() Regex
mismatch
2007-02-28 11:09:40 [DEBUG] mod_dialplan_xml.c:120 parse_exten() test
conditions destination_number(2850) =~ /^2850$/
2007-02-28 11:09:40 [DEBUG] mod_dialplan_xml.c:355 dialplan_hunt()
sofia/sip/101 at sip0.en.ewetel.de:5060 State Change CS_RING -> CS_EXECUTE
2007-02-28 11:09:40 [DEBUG] switch_core.c:3297 switch_core_session_run()
(sofia/sip/101 at sip0.en.ewetel.de:5060) State EXECUTE
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1269 sofia_on_execute() SOFIA
EXECUTE
2007-02-28 11:09:40 [DEBUG] switch_core.c:2949
switch_core_standard_on_execute() Standard EXECUTE
2007-02-28 11:09:40 [NOTICE] switch_core.c:2959
switch_core_standard_on_execute() Execute info()
2007-02-28 11:09:40 [CRIT] mod_dptools.c:302 info_function() CHANNEL_DATA:
Channel-State: CS_EXECUTE
Channel-State-Number: 4
Channel-Name: sofia/sip/101%40sip0.en.ewetel.de%3A5060
Unique-ID: cd5789d0-c713-11db-8be0-6116055f8452
Channel-Read-Codec-Name: PCMU
Channel-Read-Codec-Rate: 8000
Channel-Write-Codec-Name: PCMU
Channel-Write-Codec-Rate: 8000
Caller-Username: 101
Caller-Dialplan: XML
Caller-Caller-ID-Name: 101
Caller-Caller-ID-Number: 101
Caller-Network-Addr: 212.6.95.198
Caller-Destination-Number: 2850
Caller-Unique-ID: cd5789d0-c713-11db-8be0-6116055f8452
Caller-Source: mod_sofia
Caller-Context: default
Caller-Channel-Name: sofia/sip/101%40sip0.en.ewetel.de%3A5060
Caller-Screen-Bit: yes
Caller-Privacy-Hide-Name: no
Caller-Privacy-Hide-Number: no
variable_"sip_from"_host: sip0.en.ewetel.de
variable_"sip_to"_uri: 2850%40sip0.en.ewetel.de%3A5060
variable_"sip_from"_user: 101
variable_sip_via_rport: 9330
variable_remote_media_ip: 212.6.95.198
variable_"sip_req"_uri: 2850%40sip0.en.ewetel.de%3A5060
variable_sip_from_user_stripped: 101
variable_"sip_from"_port: 5060
variable_sip_via_host: 212.6.95.198
variable_switch_r_sdp:
v%3D0%0D%0Ao%3D-%206%202%20IN%20IP4%20212.6.95.198%0D%0As%3DCounterPath%20X-Lite%203.0%0D%0Ac%3DIN%20IP4%20212.6.95.198%0D%0At%3D0%200%0D%0Am%3Daudio%2054092%20RTP/AVP%20107%20119%200%2098%208%203%20101%0D%0Aa%3Drtpmap%3A107%20BV32/16000%0D%0Aa%3Drtpmap%3A119%20BV32-FEC/16000%0D%0Aa%3Drtpmap%3A98%20iLBC/8000%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0A
variable_"sip_contact"_uri: 101%40212.6.95.198%3A9330
variable_max_forwards: 70
variable_"sip_to"_host: sip0.en.ewetel.de
variable_sip_via_port: 9330
variable_remote_media_port: 54092
variable_"sip_to"_user: 2850
variable_"sip_from"_uri: 101%40sip0.en.ewetel.de%3A5060
variable_sip_call_id: YmI1MGY0ODQ1ZjYzZWU4ODI5YWNhOGViY2VmM2RiYTg.
variable_"sip_req"_host: sip0.en.ewetel.de
variable_"sip_req"_user: 2850
variable_endpoint_disposition: RECEIVED
variable_"sip_to"_port: 5060
variable_"sip_contact"_host: 212.6.95.198
variable_"sip_contact"_user: 101
variable_"sip_req"_port: 5060
variable_"sip_contact"_port: 9330
2007-02-28 11:09:40 [NOTICE] switch_core.c:2959
switch_core_standard_on_execute() Execute
set(effective_caller_id_name=032223930016)
2007-02-28 11:09:40 [DEBUG] mod_dptools.c:208 set_function() SET
[effective_caller_id_name]=[032223930016]
2007-02-28 11:09:40 [NOTICE] switch_core.c:2959
switch_core_standard_on_execute() Execute
set(effective_caller_id_number=101)
2007-02-28 11:09:40 [DEBUG] mod_dptools.c:208 set_function() SET
[effective_caller_id_number]=[101]
2007-02-28 11:09:40 [NOTICE] switch_core.c:2959
switch_core_standard_on_execute() Execute
bridge(sofia/sip/044180002850 at sip01.voice.ewetel.de)
2007-02-28 11:09:40 [NOTICE] switch_channel.c:347
switch_channel_set_name() New Chan
sofia/sip/044180002850 at sip01.voice.ewetel.de
[cd59a13e-c713-11db-8be0-6116055f8452]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2323 sofia_outgoing_channel()
sofia/sip/044180002850 at sip01.voice.ewetel.de State Change CS_NEW -> CS_INIT
2007-02-28 11:09:40 [DEBUG] switch_core.c:3225 switch_core_session_run()
(sofia/sip/044180002850 at sip01.voice.ewetel.de) State INIT
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1226 sofia_on_init() SOFIA INIT
nua: nh_create_handle: entering
nua: nua_handle_bind: entering
nua: nua_invite: entering
nua(0x80dbc10): signal r_invite
nua: nua_stack_set_params: entering
soa_clone(static::0x809d4d0, 0x809b690, 0x80dbc10) called
soa_set_params(static::0x80da7a8, ...) called
soa_set_user_sdp(static::0x80da7a8, (nil), 0x80d4d50, -1) called
soa_set_capability_sdp(static::0x80da7a8, (nil), 0x80d4d50, -1) called
soa_set_params(static::0x80da7a8, ...) called
soa_set_user_sdp(static::0x80da7a8, (nil), 0x80d4d50, -1) called
nua(0x80dbc10): adding session usage
nta_leg_create(0x80df188)
soa_init_offer_answer(static::0x80da7a8) called
soa_generate_offer(static::0x80da7a8, 0, (nil)) called
soa_static_offer_answer_action(0x80da7a8, soa_generate_offer): called
soa_static(0x80da7a8, soa_generate_offer): generating local description
soa_static(0x80da7a8, soa_generate_offer): upgrade with local description
soa_sdp_mode_set_is_needed(0x4098410c, (nil), ""): called
soa_static(0x80da7a8, soa_generate_offer): storing local description
nua(): refresh session after 66 seconds (in [60..90])
soa_get_local_sdp(static::0x80da7a8, [(nil)], [0x409841ac],
[0x409841a8]) called
nta: selecting scheme sip
sres_cache_get(0x809c6d8, NAPTR, "sip01.voice.ewetel.de.") called
nta: for "sip01.voice.ewetel.de" query "sip01.voice.ewetel.de" NAPTR
sres_query(0x809d420, 0x40b68bb4, 0x80e99b0, NAPTR,
"sip01.voice.ewetel.de") called
sres_send_dns_query(0x809d420, 0x80e9a68) called
sres_send_dns_query(0x809d420, 0x80e9a68) id=30815 NAPTR
sip01.voice.ewetel.de (to [192.168.8.193]:53)
nua(0x80dbc10): call state changed: init -> calling, sent offer
soa_get_local_sdp(static::0x80da7a8, [0x409841e0], [0x409841dc],
[(nil)]) called
nua: nua_stack_event: entering
nua(0x80dbc10): i_state INVITE sent
nua: nua_event: entering
sres_resolver_receive(0x809d420, 7) called
RR received ewetel.de. SOA IN 5113 rdlen=39
sres(q=0x80e9a68): reporting errors for 35 sip01.voice.ewetel.de
sres_cache_get(0x809c6d8, SRV, "_sip._udp.sip01.voice.ewetel.de.") called
nta: for "sip01.voice.ewetel.de" query "_sip._udp.sip01.voice.ewetel.de" SRV
sres_query(0x809d420, 0x40b69194, 0x80e99b0, SRV,
"_sip._udp.sip01.voice.ewetel.de") called
sres_send_dns_query(0x809d420, 0x80e8930) called
sres_send_dns_query(0x809d420, 0x80e8930) id=30816 SRV
_sip._udp.sip01.voice.ewetel.de (to [192.168.8.193]:53)
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:4715 event_callback() event
[nua_i_state] status [0][INVITE sent] session:
sofia/sip/044180002850 at sip01.voice.ewetel.de
sres_resolver_receive(0x809d420, 7) called
RR received ewetel.de. SOA IN 5113 rdlen=39
sres(q=0x80e8930): reporting errors for 33 _sip._udp.sip01.voice.ewetel.de
sres_cache_get(0x809c6d8, SRV, "_sip._tcp.sip01.voice.ewetel.de.") called
nta: for "sip01.voice.ewetel.de" query "_sip._tcp.sip01.voice.ewetel.de" SRV
sres_query(0x809d420, 0x40b69194, 0x80e99b0, SRV,
"_sip._tcp.sip01.voice.ewetel.de") called
sres_send_dns_query(0x809d420, 0x80d4e48) called
sres_send_dns_query(0x809d420, 0x80d4e48) id=30817 SRV
_sip._tcp.sip01.voice.ewetel.de (to [192.168.8.193]:53)
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2815 sip_i_state() Channel
sofia/sip/044180002850 at sip01.voice.ewetel.de entering state [calling]
sres_resolver_receive(0x809d420, 7) called
RR received ewetel.de. SOA IN 5113 rdlen=39
sres(q=0x80d4e48): reporting errors for 33 _sip._tcp.sip01.voice.ewetel.de
sres_cache_get(0x809c6d8, A, "sip01.voice.ewetel.de.") called
rr found in cache: sip01.voice.ewetel.de. 01
sres_cache_get(0x809c6d8, A, "sip01.voice.ewetel.de.") returned 1 entries
nta: for "sip01.voice.ewetel.de" query "sip01.voice.ewetel.de" A (cached)
nta: sip01.voice.ewetel.de. IN A 213.168.198.84
tport(0x80abbd0): EXPENSIVE unresolved */213.168.198.84:
tport_tsend(0x80abbd0) tpn = */213.168.198.84:5060
tport_resolve addrinfo = 213.168.198.84:5060
tport_by_addrinfo(0x80abbd0): not found by name */213.168.198.84:5060
tport_vsend(0x80abbd0): 1001 bytes of 1001 to */213.168.198.84:5060
tport_vsend returned 1001
send 1001 bytes to udp/[213.168.198.84]:5060 at 10:09:40.113177:
------------------------------------------------------------------------
INVITE sip:044180002850 at sip01.voice.ewetel.de SIP/2.0
Via: SIP/2.0/UDP sip0.en.ewetel.de;rport;branch=z9hG4bKSg09vUrc0XjNK
Max-Forwards: 69
From: "032223930016" <sip:101 at sip0.en.ewetel.de>;tag=tv1yDgg8Hve5S
To: <sip:044180002850 at sip01.voice.ewetel.de>
Call-ID: a4b859ca-41b6-122a-5dbb-005056947ed9
CSeq: 80210354 INVITE
Contact: <sip:mod_sofia at sip0.en.ewetel.de:5060>
User-Agent: FreeSWITCH(mod_sofia)
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: 100rel, precondition
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 258
Remote-Party-ID: "032223930016"
<sip:101 at sip0.en.ewetel.de>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 9158490845426534834 2884113177161000930 IN IP4 212.6.123.118
s=FreeSWITCH
c=IN IP4 sip0.en.ewetel.de
t=0 0
a=sendrecv
m=audio 16384 RTP/AVP 0 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
------------------------------------------------------------------------
nta: sent INVITE (80210354) to */213.168.198.84:5060
tport_pend(0x80abbd0): pending 0x80e8740 for udp/212.6.123.118:5060
(already 0)
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1237 sofia_on_init()
sofia/sip/044180002850 at sip01.voice.ewetel.de State Change CS_INIT -> CS_RING
tport_wakeup_pri(0x80abbd0): events IN
tport_recv_event(0x80abbd0)
tport_recv_iovec(0x80abbd0) msg 0x80ea7e0 from (udp/212.6.123.118:5060)
has 304 bytes, veclen = 1
recv 304 bytes from udp/[213.168.198.84]:5060 at 10:09:40.116247:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
sip0.en.ewetel.de;received=212.6.123.118;branch=z9hG4bKSg09vUrc0XjNK;rport=5060
From: "032223930016" <sip:101 at sip0.en.ewetel.de>;tag=tv1yDgg8Hve5S
To: <sip:044180002850 at sip01.voice.ewetel.de>
Call-ID: a4b859ca-41b6-122a-5dbb-005056947ed9
CSeq: 80210354 INVITE
------------------------------------------------------------------------
tport_deliver(0x80abbd0): msg 0x80ea7e0 (304 bytes) from
udp/213.168.198.84:5060/sip next=(nil)
nta: received 100 Trying for INVITE (80210354)
nta: 100 Trying going to a transaction
nta_outgoing: RTT is 3.632 ms
tport_release(0x80abbd0): 0x80e8740 by 0x80e99b0 with 0x80ea7e0
(preliminary)
2007-02-28 11:09:40 [DEBUG] switch_core.c:3261 switch_core_session_run()
(sofia/sip/044180002850 at sip01.voice.ewetel.de) State RING
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1252 sofia_on_ring() SOFIA RING
2007-02-28 11:09:40 [DEBUG] switch_ivr.c:2189 originate_on_ring()
sofia/sip/044180002850 at sip01.voice.ewetel.de State Change CS_RING -> CS_HOLD
tport_wakeup_pri(0x80abbd0): events IN
tport_recv_event(0x80abbd0)
tport_recv_iovec(0x80abbd0) msg 0x80eab88 from (udp/212.6.123.118:5060)
has 432 bytes, veclen = 1
recv 432 bytes from udp/[213.168.198.84]:5060 at 10:09:40.118239:
------------------------------------------------------------------------
SIP/2.0 488 Invalid Session Description
Via: SIP/2.0/UDP
sip0.en.ewetel.de;received=212.6.123.118;branch=z9hG4bKSg09vUrc0XjNK;rport=5060
From: "032223930016" <sip:101 at sip0.en.ewetel.de>;tag=tv1yDgg8Hve5S
To: <sip:044180002850 at sip01.voice.ewetel.de>;tag=aprqngfrt-iei473g07eq5b
Call-ID: a4b859ca-41b6-122a-5dbb-005056947ed9
CSeq: 80210354 INVITE
Warning: 301 213.168.198.84 "invalid transport IP address"
Content-Length: 0
------------------------------------------------------------------------
tport_deliver(0x80abbd0): msg 0x80eab88 (432 bytes) from
udp/213.168.198.84:5060/sip next=(nil)
nta: received 488 Invalid Session Description for INVITE (80210354)
nta: 488 Invalid Session Description going to a transaction
tport_release(0x80abbd0): 0x80e8740 by 0x80e99b0 with 0x80eab88
tport(0x80abbd0): EXPENSIVE unresolved UDP/213.168.198.84:5060
tport_tsend(0x80abbd0) tpn = UDP/213.168.198.84:5060
tport_resolve addrinfo = 213.168.198.84:5060
tport_by_addrinfo(0x80abbd0): not found by name UDP/213.168.198.84:5060
tport_vsend(0x80abbd0): 370 bytes of 370 to UDP/213.168.198.84:5060
tport_vsend returned 370
send 370 bytes to udp/[213.168.198.84]:5060 at 10:09:40.118997:
------------------------------------------------------------------------
ACK sip:044180002850 at sip01.voice.ewetel.de SIP/2.0
Via: SIP/2.0/UDP sip0.en.ewetel.de;rport;branch=z9hG4bKSg09vUrc0XjNK
Max-Forwards: 70
From: "032223930016" <sip:101 at sip0.en.ewetel.de>;tag=tv1yDgg8Hve5S
To: <sip:044180002850 at sip01.voice.ewetel.de>;tag=aprqngfrt-iei473g07eq5b
Call-ID: a4b859ca-41b6-122a-5dbb-005056947ed9
CSeq: 80210354 ACK
Content-Length: 0
------------------------------------------------------------------------
nta: sent ACK (80210354) to UDP/213.168.198.84:5060
nta: outgoing_free(0x80ebe80)
nua: nua_stack_event: entering
nua(0x80dbc10): r_invite 488 Invalid Session Description
nua(0x80dbc10): call state changed: calling -> terminated
nua: nua_stack_event: entering
nua(0x80dbc10): i_state 488 Invalid Session Description
nua: nua_stack_event: entering
nua(0x80dbc10): i_terminated 488 Invalid Session Description
nua(0x80dbc10): removing session usage
nta_leg_destroy(0x80df188)
nua: nua_event: entering
nua: nua_event: entering
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:4715 event_callback() event
[nua_r_invite] status [488][Invalid Session Description] session:
sofia/sip/044180002850 at sip01.voice.ewetel.de
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:4715 event_callback() event
[nua_i_state] status [488][Invalid Session Description] session:
sofia/sip/044180002850 at sip01.voice.ewetel.de
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2815 sip_i_state() Channel
sofia/sip/044180002850 at sip01.voice.ewetel.de entering state [terminated]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:883 terminate_session() Term
called from line: 3084
nua: nua_handle_bind: entering
nua: nua_handle_destroy: entering
nua: nua_event: entering
nua(0x80dbc10): signal r_destroy
nua nh_destroy(0x80dbc10): entering
soa_destroy(static::0x80da7a8) called
2007-02-28 11:09:40 [NOTICE] mod_sofia.c:893 terminate_session() Hangup
sofia/sip/044180002850 at sip01.voice.ewetel.de [CS_HOLD] [UNKNOWN]
2007-02-28 11:09:40 [INFO] switch_channel.c:992
switch_channel_perform_hangup() Kill
sofia/sip/044180002850 at sip01.voice.ewetel.de [1]
2007-02-28 11:09:40 [DEBUG] switch_core.c:3188 switch_core_session_run()
(sofia/sip/044180002850 at sip01.voice.ewetel.de) State HANGUP
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1349 sofia_on_hangup() Channel
sofia/sip/044180002850 at sip01.voice.ewetel.de hanging up, cause: UNKNOWN
2007-02-28 11:09:40 [DEBUG] switch_core.c:2880
switch_core_standard_on_hangup() Standard HANGUP
sofia/sip/044180002850 at sip01.voice.ewetel.de, cause: UNKNOWN
2007-02-28 11:09:40 [DEBUG] switch_core.c:3631
switch_core_session_thread() Session 2
(sofia/sip/044180002850 at sip01.voice.ewetel.de) Locked, Waiting on
external entities
2007-02-28 11:09:40 [DEBUG] switch_ivr.c:2841 switch_ivr_originate() Raw
Codec Activation Success L16 at 8000hz 1 channel 20ms
2007-02-28 11:09:40 [DEBUG] switch_ivr.c:3108 switch_ivr_originate()
Originate Resulted in Error Cause: 65 [UNKNOWN]
2007-02-28 11:09:40 [INFO] mod_bridgecall.c:74 audio_bridge_function()
Originate Failed. Cause: UNKNOWN
2007-02-28 11:09:40 [NOTICE] mod_bridgecall.c:78 audio_bridge_function()
Hangup sofia/sip/101 at sip0.en.ewetel.de:5060 [CS_EXECUTE] [UNKNOWN]
2007-02-28 11:09:40 [INFO] switch_channel.c:992
switch_channel_perform_hangup() Kill
sofia/sip/101 at sip0.en.ewetel.de:5060 [1]
2007-02-28 11:09:40 [DEBUG] switch_core.c:3188 switch_core_session_run()
(sofia/sip/101 at sip0.en.ewetel.de:5060) State HANGUP
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1349 sofia_on_hangup() Channel
sofia/sip/101 at sip0.en.ewetel.de:5060 hanging up, cause: UNKNOWN
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:1369 sofia_on_hangup()
Responding to INVITE with: 488
nua: nua_respond: entering
nua(0x80a6ba8): signal r_respond 488
nua: respond_to_invite: entering
nua: nua_stack_set_params: entering
soa_set_params(static::0x80b0088, ...) called
soa_clear_remote_sdp(static::0x80b0088) called
tport_tsend(0x80abbd0) tpn = UDP/212.6.95.198:9330
tport_resolve addrinfo = 212.6.95.198:9330
tport_by_addrinfo(0x80abbd0): not found by name UDP/212.6.95.198:9330
tport_vsend(0x80abbd0): 519 bytes of 519 to UDP/212.6.95.198:9330
tport_vsend returned 519
send 519 bytes to udp/[212.6.95.198]:9330 at 10:09:40.137641:
------------------------------------------------------------------------
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-a87fcd2a9168d35c-1--d87543-;rport=9330
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=a6275625
To: "2850" <sip:2850 at sip0.en.ewetel.de>;tag=SK85BNZ4mKrje
Call-ID: YmI1MGY0ODQ1ZjYzZWU4ODI5YWNhOGViY2VmM2RiYTg.
CSeq: 1 INVITE
User-Agent: FreeSWITCH(mod_sofia)
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: 100rel, precondition
Content-Length: 0
------------------------------------------------------------------------
nta: sent 488 Not Acceptable Here for INVITE (1)
nua(0x80a6ba8): call state changed: received -> init
nua: nua_stack_event: entering
nua(0x80a6ba8): i_state 488 Call state
nua: nua_stack_event: entering
nua(0x80a6ba8): i_terminated 488 Call state
soa_init_offer_answer(static::0x80b0088) called
soa_destroy(static::0x80b0088) called
nua(0x80a6ba8): removing session usage
nta_leg_destroy(0x80b0298)
nua: terminated session 0x80a6ba8
nua: nua_event: entering
nua: nua_handle_bind: entering
nua: nua_handle_destroy: entering
nua: nua_event: entering
nua(0x80a6ba8): signal r_destroy
nua nh_destroy(0x80a6ba8): entering
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:4715 event_callback() event
[nua_i_state] status [488][Call state] session:
sofia/sip/101 at sip0.en.ewetel.de:5060
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:2815 sip_i_state() Channel
sofia/sip/101 at sip0.en.ewetel.de:5060 entering state [terminated]
2007-02-28 11:09:40 [DEBUG] mod_sofia.c:883 terminate_session() Term
called from line: 3084
tport_wakeup_pri(0x80abbd0): events IN
tport_recv_event(0x80abbd0)
tport_recv_iovec(0x80abbd0) msg 0x80b0088 from (udp/212.6.123.118:5060)
has 333 bytes, veclen = 1
recv 333 bytes from udp/[212.6.95.198]:9330 at 10:09:40.140328:
------------------------------------------------------------------------
ACK sip:2850 at sip0.en.ewetel.de SIP/2.0
Via: SIP/2.0/UDP
212.6.95.198:9330;branch=z9hG4bK-d87543-a87fcd2a9168d35c-1--d87543-;rport
To: "2850" <sip:2850 at sip0.en.ewetel.de>;tag=SK85BNZ4mKrje
From: "101"<sip:101 at sip0.en.ewetel.de>;tag=a6275625
Call-ID: YmI1MGY0ODQ1ZjYzZWU4ODI5YWNhOGViY2VmM2RiYTg.
CSeq: 1 ACK
Content-Length: 0
------------------------------------------------------------------------
tport_deliver(0x80abbd0): msg 0x80b0088 (333 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta: received ACK sip:2850 at sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: ACK (1) is going to INVITE (1)
2007-02-28 11:09:40 [DEBUG] switch_core.c:2880
switch_core_standard_on_hangup() Standard HANGUP
sofia/sip/101 at sip0.en.ewetel.de:5060, cause: UNKNOWN
2007-02-28 11:09:40 [DEBUG] switch_core.c:3631
switch_core_session_thread() Session 1
(sofia/sip/101 at sip0.en.ewetel.de:5060) Locked, Waiting on external entities
2007-02-28 11:09:40 [INFO] switch_core.c:3636
switch_core_session_thread() Session 1
(sofia/sip/101 at sip0.en.ewetel.de:5060) Ended
2007-02-28 11:09:40 [NOTICE] switch_core.c:3512
switch_core_session_destroy() Close Channel
sofia/sip/101 at sip0.en.ewetel.de:5060
2007-02-28 11:09:40 [INFO] switch_core.c:3636
switch_core_session_thread() Session 2
(sofia/sip/044180002850 at sip01.voice.ewetel.de) Ended
2007-02-28 11:09:40 [NOTICE] switch_core.c:3512
switch_core_session_destroy() Close Channel
sofia/sip/044180002850 at sip01.voice.ewetel.de
-
---------------------------------------------------------------------------------------------------------
> It already does what you want where its totally in the middle.
Nice to know!
regards
helmut
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.5 (MingW32)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org
iD8DBQFF5Va64tZeNddg3dwRAqzEAJ4yojq7DQC2WrBljZ8S0lsJuW5IKQCdEN/e
grchlyd3k1lGsN17YPkDK3U=
=Yl31
-----END PGP SIGNATURE-----
More information about the FreeSWITCH-users
mailing list