-----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@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@212.6.95.198:6918;rinstance=ed95615e61a548cd>;expires=0 To: "v101"<sip:v101@sip0.en.ewetel.de> From: "v101"<sip:v101@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@sip0.en.ewetel.de>;tag=497e5f4f To: "v101" <sip:v101@sip0.en.ewetel.de>;tag=HHtv5a3K11v2D Call-ID: dc3df7379631d740NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE. CSeq: 2 REGISTER Contact: <sip:v101@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@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@212.6.95.198:11266;rinstance=b2c8de3a695d0066> To: "v101"<sip:v101@sip0.en.ewetel.de> From: "v101"<sip:v101@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@sip0.en.ewetel.de] Contact: ["v101" <sip:v101@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@sip0.en.ewetel.de>;tag=483e903b To: "v101" <sip:v101@sip0.en.ewetel.de>;tag=jtKN75KQyaKNS Call-ID: 877fc656f5490672NTA0NmE0M2ZkM2Y4MTg0YmU4NjQzNTllM2Q1YzliZGE. CSeq: 1 REGISTER Contact: <sip:v101@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@sip0.en.ewetel.de SIP/2.0 Via: SIP/2.0/UDP 212.6.123.118:5080;branch=z9hG4bKbe45.84c4b584.0 To: sip:v101@sip0.en.ewetel.de From: sip:v101@sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA CSeq: 1 INVITE Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA@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@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@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@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@sip0.en.ewetel.de:5060) State NEW nta: timer set next to 12401 ms ##################-> shutdown freeSWITCH (strg+c) freeswitch@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@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@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@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@sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA To: <sip:v101@sip0.en.ewetel.de>;tag=K3ce904tUK97m Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA@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@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@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@sip0.en.ewetel.de:5060 2007-05-16 13:52:29 [DEBUG] sofia.c:999 sofia_handle_sip_i_state() Channel sofia/sip/v101@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@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@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@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@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@sip0.en.ewetel.de SIP/2.0 Via: SIP/2.0/UDP 212.6.123.118:5080;branch=z9hG4bKbe45.84c4b584.0 From: sip:v101@sip0.en.ewetel.de;tag=703D07FF49872B16ED42E5C516E3FDDA Call-ID: BDEFDFEF6350A4B3079F53FFD0FB52AA@212.6.123.118 To: <sip:v101@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@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@sipgate.de>;tag=FZ7a2m1c7FgXp To: <sip:3224437@sipgate.de> Call-ID: 983d59b2-7e46-122a-8e9c-005056947ed9 CSeq: 83539804 REGISTER Contact: <sip:3224437@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@sip01.voice.ewetel.de>;tag=g8033Fjg4r6Fj To: <sip:032223930016@sip01.voice.ewetel.de:5060> Call-ID: 983d75c7-7e46-122a-8e9c-005056947ed9 CSeq: 83539804 REGISTER Contact: <sip:032223930016@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-----