[Freeswitch-users] FS - SIP profiles crashed

fieldpeak fieldpeak at gmail.com
Sat Apr 30 07:34:34 MSD 2011


oh, looks i found the root cause,

after i unplug the network cable and wait around 20 seconds, FS show ' IP
address changed to '0.0.0.0', then try to load profiles, however, due to
wrong IP address, load failure.
and then i re-plugin the cable, FS detected the IP change back, and
reloadxml, however, did not restart the profiles, so caused profiles
crashed... attached is the log for throughout the procedure...

the resolution is set

in the sofia.conf.xml file:

<param name="auto-restart" value="false"/>

welcome to any comment,

thanks.

Regards,
Charles



2011/4/30 fieldpeak <fieldpeak at gmail.com>

> really want to know what caused that the IP address changed to '0.0.0.0',
> very odd...
> i tried even unplug and plugin the network cable, it will not change the
> IP...let alone 0.0.0.0...
>
>
> 2011/4/30 fieldpeak <fieldpeak at gmail.com>
>
>> Thanks all for information, it definitely help a lot. i will try...
>>
>> meanwhile, i found this link
>> http://lists.freeswitch.org/pipermail/freeswitch-users/2008-May/003086.html
>>
>> it looks not so special resolve this issue...
>>
>> i would like to know what is use for "bind_server_ip=auto" and where and
>> when FS get the value of $${local_ip_v4}? and if it will changed when
>> physical IP changed?
>>
>> Thanks!
>>
>> Regards,
>> Charles
>>
>> 2011/4/30 Grmt <garmt.noname at gmail.com>
>>
>>>
>>> http://wiki.freeswitch.org/wiki/Sofia#Forcing_SIP_profile_to_use_a_static_IP_address
>>>
>>>
>>>
>>> *From:* freeswitch-users-bounces at lists.freeswitch.org [mailto:
>>> freeswitch-users-bounces at lists.freeswitch.org] *On Behalf Of *Michael
>>> Collins
>>> *Sent:* Friday, 29 April, 2011 19:35
>>> *To:* FreeSWITCH Users Help
>>> *Subject:* Re: [Freeswitch-users] FS - SIP profiles crashed
>>>
>>>
>>>
>>>
>>>
>>> On Fri, Apr 29, 2011 at 8:22 AM, Jeff Lenk <jeff at jefflenk.com> wrote:
>>>
>>> If your box is configured with a static IP do this.
>>>
>>> conf/autoload_configs/sofia.conf.xml --
>>>
>>>
>>>
>>> Jeff, was there more to this message?
>>>
>>> -MC
>>>
>>> _______________________________________________
>>> FreeSWITCH-users mailing list
>>> FreeSWITCH-users at lists.freeswitch.org
>>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>>> http://www.freeswitch.org
>>>
>>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20110430/6e092091/attachment-0001.html 
-------------- next part --------------
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 30ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 40ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 50ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 60ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 70ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 80ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 90ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 100ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 110ms 64000bps
2011-04-30 11:07:27.937500 [NOTICE] switch_loadable_module.c:185 Adding Codec PC
MA 8 G.711 alaw 8000hz 120ms 64000bps
2011-04-30 11:07:27.968750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_console]
2011-04-30 11:07:27.968750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_logfile]
2011-04-30 11:07:27.984375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_xml_rpc]
2011-04-30 11:07:27.984375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_event_socket]
2011-04-30 11:07:29.578125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_sofia]
2011-04-30 11:07:29.593750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_loopback]
2011-04-30 11:07:29.859375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_commands]
2011-04-30 11:07:29.937500 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_conference]
2011-04-30 11:07:29.937500 [CONSOLE] sofia_presence.c:946 Event Thread Started
2011-04-30 11:07:29.937500 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_dptools]
2011-04-30 11:07:29.953125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_esf]
2011-04-30 11:07:29.968750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_expr]
2011-04-30 11:07:30.000000 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_spandsp]
2011-04-30 11:07:30.031250 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_fifo]
2011-04-30 11:07:30.046875 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_voicemail]
2011-04-30 11:07:30.078125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_hash]
2011-04-30 11:07:30.078125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_vmd]
2011-04-30 11:07:30.078125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_valet_parking]
2011-04-30 11:07:30.093750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_directory]
2011-04-30 11:07:30.093750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_distributor]
2011-04-30 11:07:30.093750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_dialplan_xml]
2011-04-30 11:07:30.109375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_voipcodecs]
2011-04-30 11:07:30.125000 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_g723_1]
2011-04-30 11:07:30.125000 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_g729]
2011-04-30 11:07:30.125000 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_amr]
2011-04-30 11:07:30.140625 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_ilbc]
2011-04-30 11:07:30.140625 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_speex]
2011-04-30 11:07:30.140625 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_siren]
2011-04-30 11:07:30.156250 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_h26x]
2011-04-30 11:07:30.156250 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_sndfile]
2011-04-30 11:07:30.171875 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_native_file]
2011-04-30 11:07:30.171875 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_shout]
2011-04-30 11:07:30.187500 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_local_stream]
2011-04-30 11:07:30.187500 [CONSOLE] mod_local_stream.c:161 Can't open directory
: C:\FreeSWITCH\sounds/music/16000
2011-04-30 11:07:30.187500 [CONSOLE] mod_local_stream.c:161 Can't open directory
: C:\FreeSWITCH\sounds/music/32000
2011-04-30 11:07:30.187500 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_tone_stream]
2011-04-30 11:07:30.203125 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_lua]
2011-04-30 11:07:30.218750 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_flite]
2011-04-30 11:07:30.234375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_pocketsphinx]
2011-04-30 11:07:30.234375 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_say_en]
2011-04-30 11:07:30.250000 [CONSOLE] switch_loadable_module.c:950 Successfully L
oaded [mod_xml_cdr]
2011-04-30 11:07:30.250000 [CONSOLE] switch_loadable_module.c:123 Starting runti
me thread for CORE_SOFTTIMER_MODULE
2011-04-30 11:07:30.250000 [CONSOLE] switch_loadable_module.c:123 Starting runti
me thread for mod_event_socket
2011-04-30 11:07:30.250000 [CONSOLE] switch_loadable_module.c:123 Starting runti
me thread for mod_xml_rpc
Created Mutex ok

2011-04-30 11:07:30.250000 [CONSOLE] switch_core.c:1111 Created ip list lan defa
ult (allow)
2011-04-30 11:07:30.250000 [CONSOLE] switch_core.c:1111 Created ip list domains
default (deny)
2011-04-30 11:07:30.250000 [CONSOLE] switch_core.c:1829
************************************************************

2011-04-30 11:07:30.250000 [CONSOLE] switch_core.c:1832
FreeSWITCH Version 1.0.head (git-0f22877 2011-04-04 00-00-08 +0800) Started.
Max Sessions[10]
Session Rate[30]
SQL [Enabled]

FreeSWITCH at ibm>

                     Name          Type                                       Da
ta      State
================================================================================
=================
                 external       profile         sip:mod_sofia at 192.168.200.101:50
80      RUNNING (0)
                 internal       profile         sip:mod_sofia at 192.168.200.101:50
60      RUNNING (0)
          192.168.200.101         alias                                   intern
al      ALIASED
================================================================================
=================
2 profiles 1 alias



+OK console log level set to DEBUG

2011-04-30 11:08:23.296875 [INFO] mod_sofia.c:4785 EVENT_TRAP: IP change detecte
d
2011-04-30 11:08:23.296875 [INFO] mod_sofia.c:4786 IP change detected [192.168.2
00.101]->[0.0.0.0] []->[]
2011-04-30 11:08:23.671875 [NOTICE] sofia_glue.c:5119 Reload XML [Success]
2011-04-30 11:08:23.671875 [INFO] mod_pocketsphinx.c:482 PocketSphinx Reloaded
2011-04-30 11:08:23.671875 [INFO] switch_time.c:999 Timezone reloaded 530 defini
tions
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:1661 Write lock external
2011-04-30 11:08:24.156250 [NOTICE] sofia.c:1668 Waiting for worker thread
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:1725 Write unlock external
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 debug [0]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-trace [no]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rfc2833-pt [101]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-port [5080]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 dialplan [XML]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:1661 Write lock internal
2011-04-30 11:08:24.156250 [NOTICE] sofia.c:1668 Waiting for worker thread
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 context [public]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 dtmf-duration [2000]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 inbound-codec-prefs [PCMA,PCMU,G
729,G723,G722,GSM]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 outbound-codec-prefs [PCMA,PCMU,
G729,G723,G722,GSM]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 hold-music [local_stream://moh]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-timer-name [soft]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 local-network-acl [localnet.auto
]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 manage-presence [false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:1725 Write unlock internal
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 context [default]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-port [5060]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-ip [0.0.0.0]
2011-04-30 11:08:24.156250 [WARNING] sofia.c:3378 Invalid IP 0.0.0.0 replaced wi
th 192.168.200.101
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-ip [0.0.0.0]
2011-04-30 11:08:24.156250 [WARNING] sofia.c:3391 Invalid IP 0.0.0.0 replaced wi
th 192.168.200.101
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 apply-inbound-acl [172.28.0.0/16
]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 inbound-bypass-media [false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 inbound-proxy-media [true]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 NDLB-received-in-nat-reg-contact
 [true]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 NDLB-force-rport [true]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 user-agent-string [FreeSWITCH]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 debug [0]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 inbound-codec-negotiation [gener
ous]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 nonce-ttl [60]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 auth-calls [false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-ip [0.0.0.0]
2011-04-30 11:08:24.156250 [WARNING] sofia.c:3378 Invalid IP 0.0.0.0 replaced wi
th 192.168.200.101
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-ip [0.0.0.0]
2011-04-30 11:08:24.156250 [WARNING] sofia.c:3391 Invalid IP 0.0.0.0 replaced wi
th 192.168.200.101
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 ext-rtp-ip [auto-nat]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 ext-sip-ip [auto-nat]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-timeout-sec [300]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-hold-timeout-sec [1800]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 tls [false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 tls-bind-params [transport=tls]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 tls-sip-port [5081]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 tls-cert-dir [C:\FreeSWITCH/conf/ss
l]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 tls-version [tlsv1]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 sip-trace [no]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 watchdog-enabled [no]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 watchdog-step-timeout [30000]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 watchdog-event-timeout [30000]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 log-auth-failures [true]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 forward-unsolicited-mwi-notify [
false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rfc2833-pt [101]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 dtmf-duration [2000]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 dialplan [XML]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 inbound-codec-prefs [PCMA,PCMU,G
722,GSM]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 outbound-codec-prefs [PCMA,PCMU,
G722,GSM]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 rtp-timer-name [soft]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 hold-music [local_stream://moh]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 apply-nat-acl [nat.auto]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 local-network-acl [localnet.auto
]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 record-path [C:\FreeSWITCH\recordin
gs]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 record-template [${caller_id_num
ber}.${target_domain}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:3087 manage-presence [false]
2011-04-30 11:08:24.156250 [DEBUG] sofia.c:1476 Creating agent for external
2011-04-30 11:08:24.156250 [NOTICE] sofia.c:4009 Started Profile external [sofia
_reg_external]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 inbound-codec-negotiation [gener
ous]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 tls [false]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 tls-bind-params [transport=tls]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 tls-sip-port [5061]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 tls-cert-dir [C:\FreeSWITCH/conf/ss
l]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 tls-version [tlsv1]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 nonce-ttl [60]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 auth-calls [true]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 inbound-reg-force-matching-usern
ame [true]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 auth-all-packets [false]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 rtp-timeout-sec [300]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 rtp-hold-timeout-sec [1800]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 force-register-domain [0.0.0.0]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 force-subscription-domain [0.0.0
.0]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 force-register-db-domain [0.0.0.
0]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 challenge-realm [auto_from]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 send-message-query-on-register [
false]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:3087 all-reg-options-ping [true]
2011-04-30 11:08:24.171875 [NOTICE] sofia.c:2265 Adding Alias [0.0.0.0] for prof
ile [internal]
2011-04-30 11:08:24.171875 [NOTICE] sofia.c:3994 Adding Alias [internal] for pro
file [internal]
2011-04-30 11:08:24.171875 [NOTICE] sofia.c:4009 Started Profile internal [sofia
_reg_internal]
2011-04-30 11:08:24.171875 [DEBUG] sofia.c:1476 Creating agent for internal
2011-04-30 11:08:24.187500 [ERR] sofia.c:1539 Error Creating SIP UA for profile:
 external
2011-04-30 11:08:24.203125 [ERR] sofia.c:1539 Error Creating SIP UA for profile:
 internal


                     Name          Type                                       Da
ta      State
================================================================================
=================
================================================================================
=================
0 profiles 0 aliases

2011-04-30 11:09:23.296875 [INFO] mod_sofia.c:4785 EVENT_TRAP: IP change detecte
d
2011-04-30 11:09:23.296875 [INFO] mod_sofia.c:4786 IP change detected [0.0.0.0]-
>[192.168.200.101] []->[]
2011-04-30 11:09:23.671875 [NOTICE] sofia_glue.c:5119 Reload XML [Success]
2011-04-30 11:09:23.671875 [INFO] mod_pocketsphinx.c:482 PocketSphinx Reloaded
2011-04-30 11:09:23.671875 [INFO] switch_time.c:999 Timezone reloaded 530 defini
tions


                     Name          Type                                       Da
ta      State
================================================================================
=================
================================================================================
=================
0 profiles 0 aliases



More information about the FreeSWITCH-users mailing list