[Freeswitch-users] FS - SIP profiles crashed

29 Apr 2011

      Hi friendds,

the FS running for serval days, today when i checked the "sofia status",
there is no any sip profile existed...
then i checked the log as below (sip profile attached), there is errors when
creating the sip profiles, and FS detected IP changed to 0.0.0.0 before
that, it is very strange...
appreciated if anyone provide any hints, thanks.

Regards,
Charles

2011-04-29 08:16:06.484375 [INFO] mod_sofia.c:4437 EVENT_TRAP: IP change
detected
2011-04-29 08:16:06.484375 [INFO] mod_sofia.c:4438 IP change detected
[172.28.172.128]->[0.0.0.0] []->[]
2011-04-29 08:16:06.671875 [DEBUG] sofia.c:1614 Write lock internalk
2011-04-29 08:16:06.671875 [NOTICE] sofia.c:1621 Waiting for worker thread
2011-04-29 08:16:06.671875 [DEBUG] sofia.c:1678 Write unlock internal
2011-04-29 08:16:06.906250 [DEBUG] sofia.c:1614 Write lock external
2011-04-29 08:16:06.906250 [NOTICE] sofia.c:1621 Waiting for worker thread
2011-04-29 08:16:06.937500 [DEBUG] sofia.c:1614 Write lock internal_6060
2011-04-29 08:16:06.937500 [NOTICE] sofia.c:1621 Waiting for worker thread
2011-04-29 08:16:06.937500 [DEBUG] sofia.c:1678 Write unlock internal_6060
2011-04-29 08:16:07.140625 [DEBUG] sofia.c:1678 Write unlock external
2011-04-29 08:16:07.203125 [NOTICE] sofia_glue.c:4828 Reload XML [Success]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-enabled [no]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-enabled [no]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-step-timeout
[30000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-step-timeout
[30000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-event-timeout
[30000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [5080]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-event-timeout
[30000]
2011-04-29 08:16:07.203125 [INFO] mod_pocketsphinx.c:482 PocketSphinx
Reloaded
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 log-auth-failures [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 log-auth-failures [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
forward-unsolicited-mwi-notify [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [public]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
forward-unsolicited-mwi-notify [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [default]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [default]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [6060]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [6010]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music
[local_stream://moh]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl
[localnet.auto]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs
[G722,PCMU,PCMA,GSM]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation
[generous]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [false]
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music
[local_stream://moh]
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-nat-acl [nat.auto]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music
[local_stream://moh]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-inbound-acl [
192.168.200.0/24]
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0
replaced with 172.28.172.128
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-nat-acl [nat.auto]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl
[localnet.auto]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [60.216.3.72]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-inbound-acl [
172.28.0.0/16]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-path
[c:\vswitch\recordings]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl
[localnet.auto]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [60.216.3.72]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-template
[${caller_id_number}.${target_domain}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-path
[c:\vswitch\recordings]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-template
[${caller_id_number}.${target_domain}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation
[generous]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation
[generous]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params
[transport=tls]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params
[transport=tls]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5081]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5061]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params
[transport=tls]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir
[c:\vswitch/conf/ssl]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir
[c:\vswitch/conf/ssl]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5061]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir
[c:\vswitch/conf/ssl]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-bypass-media [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-proxy-media [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-bypass-media [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-proxy-media [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
NDLB-received-in-nat-reg-contact [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
NDLB-received-in-nat-reg-contact [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
inbound-reg-force-matching-username [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-all-packets [false]
2011-04-29 08:16:07.203125 [ERR] sofia.c:2051 ERROR: username param is
REQUIRED!
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012
inbound-reg-force-matching-username [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [60.216.3.72]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-all-packets [false]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [60.216.3.72]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [auto-nat]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [auto-nat]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-subscription-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-db-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-subscription-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-force-rport [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-db-domain
[0.0.0.0]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 challenge-realm [auto_from]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-force-rport [true]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 challenge-realm [auto_from]
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile external
[sofia_reg_external]
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:2219 Adding Alias [0.0.0.0] for
profile [internal_6060]
2011-04-29 08:16:07.203125 [WARNING] sofia.c:2221 Alias [0.0.0.0] for
profile [internal] (already exists)
2011-04-29 08:16:07.203125 [INFO] switch_time.c:950 Timezone reloaded 530
definitions
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for external
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile
internal_6060 [sofia_reg_internal_6060]
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile internal
[sofia_reg_internal]
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for
internal_6060
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for internal
2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for
profile: external
2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for
profile: internal_6060
2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for
profile: internal
2011-04-29 08:17:06.484375 [INFO] mod_sofia.c:4437 EVENT_TRAP: IP change
detected
2011-04-29 08:17:06.484375 [INFO] mod_sofia.c:4438 IP change detected
[0.0.0.0]->[172.28.172.128] []->[]
2011-04-29 08:17:07.187500 [NOTICE] sofia_glue.c:4828 Reload XML [Success]
2011-04-29 08:17:07.187500 [INFO] mod_pocketsphinx.c:482 PocketSphinx
Reloaded
2011-04-29 08:17:07.187500 [INFO] switch_time.c:950 Timezone reloaded 530
definitions

[Freeswitch-users] FS - SIP profiles crashed

fieldpeak