[Freeswitch-users] [FS-JIRA] Commented: (MODENDP-12) [feature request] 3pcc support (RFC3725)

Helmut Kuper helmut.kuper at ewetel.de
Mon May 21 02:07:28 PDT 2007


-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

Hi freeSWITCHer,

as requested I testet build 5183 and party A still doesn't
ring resp. freeswitch doesn't send an INVITE without SDP out to party A
(212.6.95.198).

According to RFC 3725 the SIP flow is as follows:

1. 3pcc Client (212.6.123.118) sends an INVITE without SDP to party A
2. Party A rings, answeres the call and sends a 200 message with SDP
offer back to 3pcc Client
3. 3pcc Client sends an INVITE with SDP from party A offer to party B
4. Party B rings and picks up the phone

freeSWITCH failed in step 2. No INVITE is send out to Party A.

When I shutdown freeSWITCH, it sends a 482 Message back to 3pcc server.


regards
helmut




Here is the log:

FreeSWITCH Version 1.0.5183 Started.
Crash Protection [Disabled]
Max Sessions[1000]


freeswitch at vm-en-test0> nta: timer set next to 4502 ms
nta: timer K fired, terminate REGISTER (83539802)
outgoing_reclaim_all((nil), (nil), 0x413e02f4)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/4 term, 1/4 free
nta: timer set next to 11 ms
nta: timer K fired, terminate REGISTER (83539803)
outgoing_reclaim_all((nil), (nil), 0x413e02f4)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/3 term, 1/3 free
nta: timer set next to 11 ms
nta: timer K fired, terminate REGISTER (83539802)
outgoing_reclaim_all((nil), (nil), 0x413e02f4)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
nta: timer set next to 2 ms
nta: timer K fired, terminate REGISTER (83539803)
outgoing_reclaim_all((nil), (nil), 0x413e02f4)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
nta: timer not set
tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x80952d8 from (udp/212.6.123.118:5060)
has 560 bytes, veclen = 1
recv 560 bytes from udp/[212.6.95.198]:6918 at 11:51:32.369307:
   ------------------------------------------------------------------------
   REGISTER sip:sip0.en.ewetel.de SIP/2.0
   Via: SIP/2.0/UDP
212.6.95.198:6918;branch=z9hG4bK-d87543-382f38251a596112-1--d87543-;rport
   Max-Forwards: 70
   Contact:
<sip:v101 at 212.6.95.198:6918;rinstance=ed95615e61a548cd>;expires=0
   To: "v101"<sip:v101 at sip0.en.ewetel.de>
   From: "v101"<sip:v101 at sip0.en.ewetel.de>;tag=497e5f4f
   Call-ID: dc3df7379631d740NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE.
   CSeq: 2 REGISTER
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO
   User-Agent: X-Lite release 1003l stamp 30942
   Content-Length: 0

   ------------------------------------------------------------------------

tport_deliver(0x8092960): msg 0x80952d8 (560 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta: received REGISTER sip:sip0.en.ewetel.de SIP/2.0 (CSeq 2)
nta: REGISTER (2) 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::0x8090670, 0x8092e48, 0x80b5808) called
soa_set_params(static::0x809ea88, ...) called
soa_set_params(static::0x809ea88, ...) called
nua(0x80b5808): event i_register 100 Trying
nua: nua_event: entering
nua: nua_respond: entering
nua(0x80b5808): signal r_respond
nua(0x80b5808): recv r_respond
nua(0x80b5808): signal r_respond 200 OK
nua: nua_stack_set_params: entering
soa_set_params(static::0x809ea88, ...) called
tport_tsend(0x8092960) tpn = UDP/212.6.95.198:6918
tport_resolve addrinfo = 212.6.95.198:6918
tport_by_addrinfo(0x8092960): not found by name UDP/212.6.95.198:6918
tport_vsend(0x8092960): 598 bytes of 598 to UDP/212.6.95.198:6918
tport_vsend returned 598
send 598 bytes to udp/[212.6.95.198]:6918 at 11:51:32.374170:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP
212.6.95.198:6918;branch=z9hG4bK-d87543-382f38251a596112-1--d87543-;rport=6918
   From: "v101"<sip:v101 at sip0.en.ewetel.de>;tag=497e5f4f
   To: "v101" <sip:v101 at sip0.en.ewetel.de>;tag=HHtv5a3K11v2D
   Call-ID: dc3df7379631d740NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE.
   CSeq: 2 REGISTER
   Contact:
<sip:v101 at 212.6.95.198:6918;rinstance=ed95615e61a548cd>;expires=0
   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 200 OK for REGISTER (2)
nta: timer set to 32000 ms

freeswitch at vm-en-test0> tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x808d3f8 from (udp/212.6.123.118:5060)
has 565 bytes, veclen = 1
recv 565 bytes from udp/[212.6.95.198]:11266 at 11:51:44.402848:
   ------------------------------------------------------------------------
   REGISTER sip:sip0.en.ewetel.de SIP/2.0
   Via: SIP/2.0/UDP
212.6.95.198:11266;branch=z9hG4bK-d87543-8f52f16d745acf3f-1--d87543-;rport
   Max-Forwards: 70
   Contact: <sip:v101 at 212.6.95.198:11266;rinstance=b2c8de3a695d0066>
   To: "v101"<sip:v101 at sip0.en.ewetel.de>
   From: "v101"<sip:v101 at sip0.en.ewetel.de>;tag=483e903b
   Call-ID: 877fc656f5490672NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE.
   CSeq: 1 REGISTER
   Expires: 10
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO
   User-Agent: X-Lite release 1003l stamp 30942
   Content-Length: 0

   ------------------------------------------------------------------------
tport_deliver(0x8092960): msg 0x808d3f8 (565 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta: received REGISTER sip:sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: REGISTER (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::0x8090670, 0x8092e48, 0x8098650) called
soa_set_params(static::0x8098038, ...) called
soa_set_params(static::0x8098038, ...) called
nua(0x8098650): event i_register 100 Trying
nua: nua_event: entering
2007-05-16 13:51:44 [DEBUG] sofia_reg.c:416 sofia_reg_handle_register()
Register:
From:    [v101 at sip0.en.ewetel.de]
Contact: ["v101" <sip:v101 at 212.6.95.198:11266;rinstance=b2c8de3a695d0066>]
Expires: [10]
nua: nua_respond: entering
nua(0x8098650): signal r_respond
nua(0x8098650): recv r_respond
nua(0x8098650): signal r_respond 200 OK
nua: nua_stack_set_params: entering
soa_set_params(static::0x8098038, ...) called
tport_tsend(0x8092960) tpn = UDP/212.6.95.198:11266
tport_resolve addrinfo = 212.6.95.198:11266
tport_by_addrinfo(0x8092960): not found by name UDP/212.6.95.198:11266
tport_vsend(0x8092960): 591 bytes of 591 to UDP/212.6.95.198:11266
tport_vsend returned 591
send 591 bytes to udp/[212.6.95.198]:11266 at 11:51:44.457069:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP
212.6.95.198:11266;branch=z9hG4bK-d87543-8f52f16d745acf3f-1--d87543-;rport=11266
   From: "v101"<sip:v101 at sip0.en.ewetel.de>;tag=483e903b
   To: "v101" <sip:v101 at sip0.en.ewetel.de>;tag=jtKN75KQyaKNS
   Call-ID: 877fc656f5490672NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE.
   CSeq: 1 REGISTER
   Contact: <sip:v101 at 212.6.95.198:11266;rinstance=b2c8de3a695d0066>
   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 200 OK for REGISTER (1)
tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x80b2a28 from (udp/212.6.123.118:5060)
has 374 bytes, veclen = 1
recv 374 bytes from udp/[212.6.123.118]:5080 at 11:51:51.768462:
nta: sent 200 OK for REGISTER (1)
tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x80b2a28 from (udp/212.6.123.118:5060)
has 374 bytes, veclen = 1
recv 374 bytes from udp/[212.6.123.118]:5080 at 11:51:51.768462:
   ------------------------------------------------------------------------
   INVITE sip:v101 at sip0.en.ewetel.de SIP/2.0
   Via: SIP/2.0/UDP 212.6.123.118:5080;branch=z9hG4bKbe45.84c4b584.0
   To: sip:v101 at sip0.en.ewetel.de
   From: sip:v101 at sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA
   CSeq: 1 INVITE
   Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA at 212.6.123.118
   Content-Length: 0
   Max-Forwards: 70
   Contact: <sip:212.6.123.118:5080;transport=udp>

   ------------------------------------------------------------------------
tport_deliver(0x8092960): msg 0x80b2a28 (374 bytes) from
udp/212.6.123.118:5060/sip next=(nil)
nta: received INVITE sip:v101 at sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: INVITE (1) going to a default leg
nta: timer shortened to 200 ms
nua: nua_stack_process_request: entering
nua: nh_create: entering
nua: nh_create_handle: entering
nua: nua_stack_set_params: entering
soa_clone(static::0x8090670, 0x8092e48, 0x8097a28) called
soa_set_params(static::0x8097428, ...) called
soa_set_params(static::0x8097428, ...) called
nta_leg_create(0x8097ab8)
soa_init_offer_answer(static::0x8097428) called
nua(0x8097a28): adding session usage
tport_tsend(0x8092960) tpn = UDP/212.6.123.118:5080
tport_resolve addrinfo = 212.6.123.118:5080
tport_by_addrinfo(0x8092960): not found by name UDP/212.6.123.118:5080
tport_vsend(0x8092960): 319 bytes of 319 to UDP/212.6.123.118:5080
tport_vsend returned 319
send 319 bytes to udp/[212.6.123.118]:5080 at 11:51:51.769475:
   ------------------------------------------------------------------------
nta: sent 100 Trying for INVITE (1)
nua(0x8097a28): event i_invite 100 Trying
nua(0x8097a28): call state changed: init -> received
nua(0x8097a28): event i_state 100 Trying
nua: nua_event: entering
nua: nua_handle_bind: entering
nua: nua_event: entering
2007-05-16 13:51:51 [NOTICE] switch_channel.c:372
switch_channel_set_name() New Chan sofia/sip/v101 at sip0.en.ewetel.de:5060
[d5e9eb8e-03a3-11dc-aed8-5fdff7544ba7]
2007-05-16 13:51:51 [DEBUG] sofia.c:999 sofia_handle_sip_i_state()
Channel sofia/sip/v101 at sip0.en.ewetel.de:5060 entering state [received]
2007-05-16 13:51:51 [DEBUG] switch_core_state_machine.c:336
switch_core_session_run() (sofia/sip/v101 at sip0.en.ewetel.de:5060) State NEW
nta: timer set next to 12401 ms




##################-> shutdown freeSWITCH (strg+c)




freeswitch at vm-en-test0> nta: timer J fired, terminate 200 response
incoming_reclaim_all((nil), (nil), 0x413e0228)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/3 free
nta: timer set next to 12074 ms
tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x80ba5a0 from (udp/212.6.123.118:5060)
has 4 bytes, veclen = 1
tport_deliver(0x8092960): bad msg 0x80ba5a0 (4 bytes) from
udp/212.6.95.198:5060/sip next=(nil)
nta_agent: received garbage from udp/212.6.95.198:5060/sip
nta: timer J fired, terminate 200 response
incoming_reclaim_all((nil), (nil), 0x413e0228)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/2 free
nta: timer not set
2007-05-16 13:52:29 [CONSOLE] switch_core.c:647 switch_core_destroy()
End existing sessions
2007-05-16 13:52:29 [NOTICE] switch_core_session.c:89
switch_core_session_hupall() Hangup
sofia/sip/v101 at sip0.en.ewetel.de:5060 [CS_NEW] [SYSTEM_SHUTDOWN]
2007-05-16 13:52:29 [INFO] switch_channel.c:1055
switch_channel_perform_hangup() Kill
sofia/sip/v101 at sip0.en.ewetel.de:5060 [KILL]
2007-05-16 13:52:29 [INFO] switch_core_session.c:90
switch_core_session_hupall() Kill sofia/sip/v101 at sip0.en.ewetel.de:5060
[KILL]
nua: nua_respond: entering
nua(0x8097a28): signal r_respond
nua(0x8097a28): recv r_respond
nua(0x8097a28): signal r_respond 480
nua: nua_stack_set_params: entering
soa_set_params(static::0x8097428, ...) called
nua: nua_invite_server_respond: entering
soa_clear_remote_sdp(static::0x8097428) called
tport_tsend(0x8092960) tpn = UDP/212.6.123.118:5080
tport_resolve addrinfo = 212.6.123.118:5080
tport_by_addrinfo(0x8092960): not found by name UDP/212.6.123.118:5080
tport_vsend(0x8092960): 531 bytes of 531 to UDP/212.6.123.118:5080
tport_vsend returned 531
send 531 bytes to udp/[212.6.123.118]:5080 at 11:52:29.333968:
   ------------------------------------------------------------------------
   SIP/2.0 480 Temporarily Unavailable
   Via: SIP/2.0/UDP 212.6.123.118:5080;branch=z9hG4bKbe45.84c4b584.0
   From: sip:v101 at sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA
   To: <sip:v101 at sip0.en.ewetel.de>;tag=K3ce904tUK97m
   Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA at 212.6.123.118
   CSeq: 1 INVITE
   User-Agent: FreeSWITCH(mod_sofia)
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: 100rel, precondition
   Content-Length: 0

   ------------------------------------------------------------------------
nta: sent 480 Temporarily Unavailable for INVITE (1)
nta: timer set to 500 ms
nua(0x8097a28): removing session usage
soa_destroy(static::0x8097428) called
nta_leg_destroy(0x8097ab8)
nua(0x8097a28): call state changed: init -> terminated
nua(0x8097a28): event i_state 480 Call state
nua(0x8097a28): event i_terminated 480 Call state
nua: nua_event: entering
nua: nua_handle_bind: entering
nua: nua_handle_destroy: entering
nua(0x8097a28): signal r_destroy
nua: nua_event: entering
nua(0x8097a28): event i_terminated dropped
nua(0x8097a28): recv r_destroy
nua(0x8097a28): signal r_destroy
nta_leg_destroy((nil))
2007-05-16 13:52:29 [DEBUG] switch_core_state_machine.c:341
switch_core_session_run() (sofia/sip/v101 at sip0.en.ewetel.de:5060) State
HANGUP
2007-05-16 13:52:29 [DEBUG] mod_sofia.c:213 sofia_on_hangup() Channel
sofia/sip/v101 at sip0.en.ewetel.de:5060 hanging up, cause: SYSTEM_SHUTDOWN
2007-05-16 13:52:29 [DEBUG] mod_sofia.c:233 sofia_on_hangup() Responding
to INVITE with: 480
2007-05-16 13:52:29 [DEBUG] sofia.c:71 sofia_event_callback() event
[nua_i_state] status [480][Call state] session:
sofia/sip/v101 at sip0.en.ewetel.de:5060
2007-05-16 13:52:29 [DEBUG] sofia.c:999 sofia_handle_sip_i_state()
Channel sofia/sip/v101 at sip0.en.ewetel.de:5060 entering state [terminated]
2007-05-16 13:52:29 [DEBUG] switch_core_state_machine.c:45
switch_core_standard_on_hangup() Standard HANGUP
sofia/sip/v101 at sip0.en.ewetel.de:5060, cause: SYSTEM_SHUTDOWN
2007-05-16 13:52:29 [DEBUG] switch_core_session.c:704
switch_core_session_thread() Session 1
(sofia/sip/v101 at sip0.en.ewetel.de:5060) Locked, Waiting on external entities
2007-05-16 13:52:29 [INFO] switch_core_session.c:710
switch_core_session_thread() Session 1
(sofia/sip/v101 at sip0.en.ewetel.de:5060) Ended
2007-05-16 13:52:29 [NOTICE] switch_core_session.c:712
switch_core_session_thread() Close Channel
sofia/sip/v101 at sip0.en.ewetel.de:5060 [CS_HANGUP]
tport_wakeup_pri(0x8092960): events IN
tport_recv_event(0x8092960)
tport_recv_iovec(0x8092960) msg 0x80952d8 from (udp/212.6.123.118:5060)
has 369 bytes, veclen = 1
recv 369 bytes from udp/[212.6.123.118]:5080 at 11:52:29.336295:
   ------------------------------------------------------------------------
   ACK sip:v101 at sip0.en.ewetel.de SIP/2.0
   Via: SIP/2.0/UDP 212.6.123.118:5080;branch=z9hG4bKbe45.84c4b584.0
   From: sip:v101 at sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA
   Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA at 212.6.123.118
   To: <sip:v101 at sip0.en.ewetel.de>;tag=K3ce904tUK97m
   CSeq: 1 ACK
   User-Agent: OpenSER (1.2.0-notls (i386/linux))
   Content-Length: 0

   ------------------------------------------------------------------------
tport_deliver(0x8092960): msg 0x80952d8 (369 bytes) from
udp/212.6.123.118:5060/sip next=(nil)
nta: received ACK sip:v101 at sip0.en.ewetel.de SIP/2.0 (CSeq 1)
nta: ACK (1) is going to INVITE (1)
2007-05-16 13:52:29 [CONSOLE] switch_core.c:649 switch_core_destroy()
Clean up modules.
2007-05-16 13:52:29 [CONSOLE] switch_loadable_module.c:1077
do_shutdown() Stopping: mod_sofia
2007-05-16 13:52:29 [NOTICE] switch_loadable_module.c:410
switch_loadable_module_unprocess() Deleting Endpoint 'sofia'
2007-05-16 13:52:29 [NOTICE] switch_loadable_module.c:503
switch_loadable_module_unprocess() Deleting API Function 'sofia'
2007-05-16 13:52:29 [NOTICE] switch_loadable_module.c:589
switch_loadable_module_unprocess() Deleting Chat interface 'sip'
2007-05-16 13:52:29 [NOTICE] switch_loadable_module.c:621
switch_loadable_module_unprocess() Deleting Management interface
'mod_sofia' OID[.1.3.6.1.4.1.27880.1]
nta: timer set next to 4501 ms
nua: nua_handle_bind: entering
nua: nua_handle_destroy: entering
nua(0x8090378): signal r_destroy
nua(0x8090378): recv r_destroy
nua(0x8090378): signal r_destroy
auth_digest_a1() has A1 = MD5(3224437:sipgate.de:9GEDE9) =
68854d5578f43b283e377bda410fb634
A2 = MD5(REGISTER:sip:sipgate.de)
auth_response: df0f7a3c5365a5405d388e19040811e5 =
MD5(68854d5578f43b283e377bda410fb634:464af16070ab1ca078cbb54c7e9d4327d7428c62:35dc1f77430c737a5c85bd2ac2bd3f59)
(qop=NONE)
nta: selecting scheme sip
sres_cache_get(0x8091a68, NAPTR, "sipgate.de.") called
rr found in cache: sipgate.de. 35
sres_cache_get(0x8091a68, NAPTR, "sipgate.de.") returned 1 entries
nta: for "sipgate.de" query "sipgate.de" NAPTR (cached)
sres_cache_get(0x8091a68, SRV, "_sip._udp.sipgate.de.") called
rr found in cache: _sip._udp.sipgate.de. 33
sres_cache_get(0x8091a68, SRV, "_sip._udp.sipgate.de.") returned 1 entries
nta: for "sipgate.de" query "_sip._udp.sipgate.de" SRV (cached)
nta: _sip._udp.sipgate.de IN SRV 0 0  5060 sipgate.de. (udp)
sres_cache_get(0x8091a68, A, "sipgate.de.") called
rr found in cache: sipgate.de. 01
sres_cache_get(0x8091a68, A, "sipgate.de.") returned 1 entries
nta: for "sipgate.de" query "sipgate.de." A (cached)
nta: sipgate.de. IN A 217.10.79.9
tport(0x8092960): EXPENSIVE unresolved udp/217.10.79.9:5060
tport_tsend(0x8092960) tpn = udp/217.10.79.9:5060
tport_resolve addrinfo = 217.10.79.9:5060
tport_by_addrinfo(0x8092960): not found by name udp/217.10.79.9:5060
tport_vsend(0x8092960): 730 bytes of 730 to udp/217.10.79.9:5060
tport_vsend returned 730
send 730 bytes to udp/[217.10.79.9]:5060 at 11:52:30.336368:
   ------------------------------------------------------------------------
   REGISTER sip:sipgate.de SIP/2.0
   Via: SIP/2.0/UDP 212.6.123.118;rport;branch=z9hG4bKKZZHKp216Nm8H
   Max-Forwards: 70
   From: <sip:3224437 at sipgate.de>;tag=FZ7a2m1c7FgXp
   To: <sip:3224437 at sipgate.de>
   Call-ID: 983d59b2-7e46-122a-8e9c-005056947ed9
   CSeq: 83539804 REGISTER
   Contact: <sip:3224437 at 212.6.123.118:5060>
   Expires: 0
   User-Agent: FreeSWITCH(mod_sofia)
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: 100rel, precondition, path
   Authorization: Digest username="3224437", realm="sipgate.de",
nonce="464af16070ab1ca078cbb54c7e9d4327d7428c62", algorithm=MD5,
uri="sip:sipgate.de", response="df0f7a3c5365a5405d388e19040811e5"
   Content-Length: 0

   ------------------------------------------------------------------------
nta: sent REGISTER (83539804) to udp/217.10.79.9:5060
tport_pend(0x8092960): pending 0x80ba5a0 for udp/212.6.123.118:5060
(already 0)
nta: timer shortened to 500 ms
nua(0x8090378): removing register usage
nta_leg_destroy(0x808e208)
soa_destroy(static::0x8090408) called
nua: nua_handle_bind: entering
nua: nua_handle_destroy: entering
nua(0x8065b70): signal r_destroy
nua: nua_shutdown: entering
nua((nil)): signal r_shutdown
2007-05-16 13:52:30 [DEBUG] sofia.c:370 sofia_profile_thread_run() Write
lock sip
nua(0x8065b70): recv r_destroy
nua(0x8065b70): signal r_destroy
auth_digest_a1() has A1 = MD5(032223930016:ewetel.de:1234abc) =
e8eec070edf87efb34fbd86185bb0e3d
A2 = MD5(REGISTER:sip:sip01.voice.ewetel.de:5060)
auth_response: 19297f9df075426778a78fae99b14406 =
MD5(e8eec070edf87efb34fbd86185bb0e3d:3150564114:1d237d9df566660a25cd2fb6ed2c6b13)
(qop=NONE)
nta: selecting scheme sip
sres_cache_get(0x8091a68, A, "sip01.voice.ewetel.de.") called
rr found in cache: sip01.voice.ewetel.de. 01
sres_cache_get(0x8091a68, 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(0x8092960): EXPENSIVE unresolved */213.168.198.84:5060
tport_tsend(0x8092960) tpn = */213.168.198.84:5060
tport_resolve addrinfo = 213.168.198.84:5060
tport_by_addrinfo(0x8092960): not found by name */213.168.198.84:5060
tport_vsend(0x8092960): 778 bytes of 778 to */213.168.198.84:5060
tport_vsend returned 778
send 778 bytes to udp/[213.168.198.84]:5060 at 11:52:30.340375:
   ------------------------------------------------------------------------
   REGISTER sip:sip01.voice.ewetel.de:5060 SIP/2.0
   Via: SIP/2.0/UDP 212.6.123.118;rport;branch=z9hG4bKm8raNHK53yaUD
   Max-Forwards: 70
   From: <sip:032223930016 at sip01.voice.ewetel.de>;tag=g8033Fjg4r6Fj
   To: <sip:032223930016 at sip01.voice.ewetel.de:5060>
   Call-ID: 983d75c7-7e46-122a-8e9c-005056947ed9
   CSeq: 83539804 REGISTER
   Contact: <sip:032223930016 at 212.6.123.118:5060>
   Expires: 0
   User-Agent: FreeSWITCH(mod_sofia)
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: 100rel, precondition, path
   Authorization: Digest username="032223930016", realm="ewetel.de",
nonce="3150564114", algorithm=MD5, uri="sip:sip01.voice.ewetel.de:5060",
response="19297f9df075426778a78fae99b14406"
   Content-Length: 0

   ------------------------------------------------------------------------
nta: sent REGISTER (83539804) to */213.168.198.84:5060
tport_pend(0x8092960): pending 0x80952d8 for udp/212.6.123.118:5060
(already 1)
nua(0x8065b70): removing register usage
nta_leg_destroy(0x8094c70)
soa_destroy(static::0x80945d8) called
nua((nil)): recv r_shutdown
nua((nil)): signal r_shutdown
nua: nua_stack_shutdown: entering
soa_destroy(static::0x8090670) called
soa_destroy(static::0x809ea88) called
soa_destroy(static::0x8098038) called
nta: incoming_free(0x80b3110)
nta: outgoing_free(0x80941b8)
tport_release(0x8092960): 0x80952d8 by 0x80941b8 with (nil)
nta: outgoing_free(0x80ba4b8)
tport_release(0x8092960): 0x80ba5a0 by 0x80ba4b8 with (nil)
sres_sofia_update(0x8092288, -1, -1)
sres_sofia_update((nil), -1, 7)
sres_sofia_update((nil), -1, -1)
tport_destroy(0x8092498)
nua((nil)): event r_shutdown 200 Shutdown successful
nua: nua_event: entering
nua: nua_destroy: entering
nua: nua_stack_deinit: entering
su_epoll_port_deinit(0x8090b28) called
su_epoll_port_deinit(0x80658b8) called

-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.5 (MingW32)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org

iD8DBQFGUWFP4tZeNddg3dwRAqsrAKCDL7MK0CkQ6L90M6RdaxiP8WLp8wCfTQ8X
RMhFCbdDhnnZ0BjUtUxd3JU=
=5ot4
-----END PGP SIGNATURE-----




More information about the FreeSWITCH-users mailing list