Hi friendds,<br><br>the FS running for serval days, today when i checked the &quot;sofia status&quot;, there is no any sip profile existed...<br>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...<br>
appreciated if anyone provide any hints, thanks.<br><br>Regards,<br>Charles<br><br><br>2011-04-29 08:16:06.484375 [INFO] mod_sofia.c:4437 <span style="background-color: rgb(255, 255, 51);">EVENT_TRAP: IP change detected</span><br>
2011-04-29 08:16:06.484375 [INFO] mod_sofia.c:4438 <span style="background-color: rgb(255, 255, 51);">IP change detected [172.28.172.128]-&gt;[0.0.0.0] </span>[]-&gt;[]<br>2011-04-29 08:16:06.671875 [DEBUG] sofia.c:1614 Write lock internalk<br>
2011-04-29 08:16:06.671875 [NOTICE] sofia.c:1621 Waiting for worker thread<br>2011-04-29 08:16:06.671875 [DEBUG] sofia.c:1678 Write unlock internal<br>2011-04-29 08:16:06.906250 [DEBUG] sofia.c:1614 Write lock external<br>
2011-04-29 08:16:06.906250 [NOTICE] sofia.c:1621 Waiting for worker thread<br>2011-04-29 08:16:06.937500 [DEBUG] sofia.c:1614 Write lock internal_6060<br>2011-04-29 08:16:06.937500 [NOTICE] sofia.c:1621 Waiting for worker thread<br>
2011-04-29 08:16:06.937500 [DEBUG] sofia.c:1678 Write unlock internal_6060<br>2011-04-29 08:16:07.140625 [DEBUG] sofia.c:1678 Write unlock external<br>2011-04-29 08:16:07.203125 [NOTICE] sofia_glue.c:4828 Reload XML [Success]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 debug [0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-trace [no]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-enabled [no]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-enabled [no]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-step-timeout [30000]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-step-timeout [30000]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-event-timeout [30000]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [5080]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 watchdog-event-timeout [30000]<br>
2011-04-29 08:16:07.203125 [INFO] mod_pocketsphinx.c:482 PocketSphinx Reloaded<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 log-auth-failures [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 log-auth-failures [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 forward-unsolicited-mwi-notify [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [public]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 forward-unsolicited-mwi-notify [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [default]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 context [default]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rfc2833-pt [101]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [6060]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-port [6010]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music [local_stream://moh]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dialplan [XML]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 dtmf-duration [2000]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl [localnet.auto]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 outbound-codec-prefs [G722,PCMU,PCMA,GSM]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation [generous]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timer-name [soft]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [false]<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>
2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-ip [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music [local_stream://moh]<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:3260 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-nat-acl [nat.auto]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 sip-ip [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 hold-music [local_stream://moh]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-inbound-acl [<a href="http://192.168.200.0/24">192.168.200.0/24</a>]<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:3273 Invalid IP 0.0.0.0 replaced with 172.28.172.128<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-nat-acl [nat.auto]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl [localnet.auto]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [60.216.3.72]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 apply-inbound-acl [<a href="http://172.28.0.0/16">172.28.0.0/16</a>]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-path [c:\vswitch\recordings]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 local-network-acl [localnet.auto]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [60.216.3.72]<br>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]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 record-path [c:\vswitch\recordings]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]<br>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]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation [generous]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 manage-presence [false]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-codec-negotiation [generous]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params [transport=tls]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params [transport=tls]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5081]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5061]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-bind-params [transport=tls]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir [c:\vswitch/conf/ssl]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir [c:\vswitch/conf/ssl]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-sip-port [5061]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-cert-dir [c:\vswitch/conf/ssl]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-bypass-media [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 tls-version [tlsv1]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-proxy-media [true]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-bypass-media [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-proxy-media [true]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-received-in-nat-reg-contact [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 nonce-ttl [60]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [true]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-received-in-nat-reg-contact [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-reg-force-matching-username [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-calls [true]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-all-packets [false]<br>2011-04-29 08:16:07.203125 [ERR] sofia.c:2051 ERROR: username param is REQUIRED!<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 inbound-reg-force-matching-username [true]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [60.216.3.72]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 auth-all-packets [false]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [60.216.3.72]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-rtp-ip [auto-nat]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 ext-sip-ip [auto-nat]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-timeout-sec [300]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-domain [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 rtp-hold-timeout-sec [1800]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-subscription-domain [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-domain [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-db-domain [0.0.0.0]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-subscription-domain [0.0.0.0]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-force-rport [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 force-register-db-domain [0.0.0.0]<br>
2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 challenge-realm [auto_from]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 NDLB-force-rport [true]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:3012 challenge-realm [auto_from]<br>
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile external [sofia_reg_external]<br>2011-04-29 08:16:07.203125 [NOTICE] sofia.c:2219 Adding Alias [0.0.0.0] for profile [internal_6060]<br>2011-04-29 08:16:07.203125 [WARNING] sofia.c:2221 Alias [0.0.0.0] for profile [internal] (already exists)<br>
2011-04-29 08:16:07.203125 [INFO] switch_time.c:950 Timezone reloaded 530 definitions<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for external<br>2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile internal_6060 [sofia_reg_internal_6060]<br>
2011-04-29 08:16:07.203125 [NOTICE] sofia.c:3883 Started Profile internal [sofia_reg_internal]<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for internal_6060<br>2011-04-29 08:16:07.203125 [DEBUG] sofia.c:1430 Creating agent for internal<br>
<span style="background-color: rgb(255, 255, 51);">2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for profile: external</span><br style="background-color: rgb(255, 255, 51);"><span style="background-color: rgb(255, 255, 51);">2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for profile: internal_6060</span><br style="background-color: rgb(255, 255, 51);">
<span style="background-color: rgb(255, 255, 51);">2011-04-29 08:16:07.265625 [ERR] sofia.c:1492 Error Creating SIP UA for profile: internal</span><br>2011-04-29 08:17:06.484375 [INFO] mod_sofia.c:4437 EVENT_TRAP: IP change detected<br>
2011-04-29 08:17:06.484375 [INFO] mod_sofia.c:4438 IP change detected [0.0.0.0]-&gt;[172.28.172.128] []-&gt;[]<br>2011-04-29 08:17:07.187500 [NOTICE] sofia_glue.c:4828 Reload XML [Success]<br>2011-04-29 08:17:07.187500 [INFO] mod_pocketsphinx.c:482 PocketSphinx Reloaded<br>
2011-04-29 08:17:07.187500 [INFO] switch_time.c:950 Timezone reloaded 530 definitions<br><br>