thr3ads.net - asterisk users - [Asterisk-Users] Registering with second SIP service causes error every 2 seconds

If this information is useful, please help other people find it:
Share via:
Michael Stahl
2005-May-20 07:42 UTC
[Asterisk-Users] Registering with second SIP service causes error every 2 seconds - what is going on?

I had my asterisk server working fine with FWD as a SIP provider, so I
now added a second SIP provider (voctel).  The addition to my sip.conf
file is almost identical to FWD, however, asterisk now generates lots of
debug messages for some strange reason!  In particular, the line "#####
Testing 127.0.0.1 with 172.31.0.0" shows up every two seconds!  (See my
log below).
 
If I comment out the register and [section] for the new SIP service, the
error goes away.  While leaving the line in, the VocTel service appears
properly when I "SHOW SIP PEERS", "SHOW SIP USERS", and
"SHOW SIP
REGISTRY".
 
Can anyone explain what is happening?  Why are these testing lines
appearing every 2 seconds, and how do I stop them?
 
General info===================My asterisk server's internal address =
172.31.254.2
My asterisk server's internal netmask = 255.255.0.0
FWD server = 209.91.145.154 
VocTel server = 69.90.155.70 (new service)
 
sip.conf sections===============register => xxx:yyy@fwd.pulver.com/8000
register => xxx:yyy@switch-1.voctel.net/9000

[fwd]
context=menuexternal   ; Give them external caller context
type=friend
secret=yyy
username=xxx
fromuser=xxx
fromdomain=fwd.pulver.com
host=fwd.pulver.com
dtmfmode=inband
nat=yes     
canreinvite=no
;regexten=8000                   ; Show FWD as extension 7000
insecure=very     ; required for incoming FWD calls 
 
[voctel]
context=menuexternal   ; Give them external caller context
type=friend
secret=yyy
username=xxx
fromuser=xxx
fromdomain=switch-1.voctel.net
host=switch-1.voctel.net
;defaultip=172.31.254.2   
dtmfmode=inband
nat=yes    
canreinvite=no
;regexten=9000                   
insecure=very     ; required for incoming calls 
 
 
my message log==================== 
May 20 10:01:33 DEBUG[5520]: ##### Testing 209.91.145.154 with
172.31.0.0
May 20 10:01:33 DEBUG[5520]: Target address 209.91.145.154 is not local,
substituting externip
May 20 10:01:33 DEBUG[5520]: Scheduled a registration timeout # 15
May 20 10:01:33 DEBUG[5520]: ##### Testing 69.90.155.70 with 172.31.0.0
May 20 10:01:33 DEBUG[5520]: Target address 69.90.155.70 is not local,
substituting externip
May 20 10:01:33 DEBUG[5520]: Scheduled a registration timeout # 17
May 20 10:01:33 VERBOSE[5520]:  [chan_agent]May 20 10:01:33
VERBOSE[5520]:  [chan_agent] => (Agent Proxy Channel)
May 20 10:01:33 VERBOSE[5520]:   == Registered channel type 'Agent'
(Call Agent Proxy Channel)
May 20 10:01:33 VERBOSE[5520]:   == Registered application 'AgentLogin'
May 20 10:01:33 VERBOSE[5520]:   == Registered application
'AgentCallbackLogin'
May 20 10:01:33 VERBOSE[5520]:   == Registered application
'AgentMonitorOutgoing'
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/agents.conf':
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/agents.conf':
Found
May 20 10:01:33 VERBOSE[5520]:  [skipping chan_mgcp]
May 20 10:01:33 VERBOSE[5520]:  [skipping chan_iax2]
May 20 10:01:33 VERBOSE[5520]:  [skipping chan_iax]
May 20 10:01:33 VERBOSE[5520]:  [chan_local]May 20 10:01:33
VERBOSE[5520]:  [chan_local] => (Local Proxy Channel)
May 20 10:01:33 VERBOSE[5520]:   == Registered channel type 'Local'
(Local Proxy Channel Driver)
May 20 10:01:33 VERBOSE[5520]:  [skipping chan_skinny]
May 20 10:01:33 VERBOSE[5520]:  [chan_oss]May 20 10:01:33 VERBOSE[5520]:
[chan_oss] => (OSS Console Channel Driver)
May 20 10:01:33 VERBOSE[5520]:   == Console is full duplex
May 20 10:01:33 VERBOSE[5520]:   == Registered channel type 'Console'
(OSS Console Channel Driver)
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/oss.conf':
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/oss.conf':
Found
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/enum.conf':
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/enum.conf':
Found
May 20 10:01:33 VERBOSE[5520]:   == Parsing
'/asterisk/etc/extconfig.conf': May 20 10:01:33 VERBOSE[5520]:  
=Parsing '/asterisk/etc/extconfig.conf': Found
May 20 10:01:33 VERBOSE[5520]: Asterisk Event Logger restarted
May 20 10:01:33 VERBOSE[5520]:   == Parsing
'/asterisk/etc/manager.conf': May 20 10:01:33 VERBOSE[5520]:   =Parsing
'/asterisk/etc/manager.conf': Found
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/enum.conf':
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/enum.conf':
Found
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/rtp.conf':
May 20 10:01:33 VERBOSE[5520]:   == Parsing '/asterisk/etc/rtp.conf':
Found
May 20 10:01:33 VERBOSE[5520]:   == Parsing
'/cygdrive/e/pbx/config/rtp.conf': May 20 10:01:33 VERBOSE[5520]:  
=Parsing '/cygdrive/e/pbx/config/rtp.conf': Found
May 20 10:01:33 VERBOSE[5520]:   == RTP Allocating from port range 10000
-> 13000
May 20 10:01:33 VERBOSE[5520]: Asterisk Ready.
May 20 10:01:33 DEBUG[5520]: (Provisional) Stopping retransmission (but
retaining packet) on '2657c93c79b12ba855365135794f06e5@172.31.254.2'
Request 102: Found
May 20 10:01:33 DEBUG[5520]: Setting NAT on RTP to 0
May 20 10:01:33 DEBUG[5520]: Setting NAT on VRTP to 0
May 20 10:01:33 DEBUG[5520]: ##### Testing 172.31.250.5 with 172.31.0.0
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'2657c93c79b12ba855365135794f06e5@172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Setting NAT on RTP to 0
May 20 10:01:33 DEBUG[5520]: Setting NAT on VRTP to 0
May 20 10:01:33 DEBUG[5520]: ##### Testing 172.31.250.9 with 172.31.0.0
May 20 10:01:33 DEBUG[5520]: Setting NAT on RTP to 0
May 20 10:01:33 DEBUG[5520]: Setting NAT on VRTP to 0
May 20 10:01:33 DEBUG[5520]: ##### Testing 172.31.250.4 with 172.31.0.0
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'40c9fe6a49067a72561f3b294fd30023@172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'3477d43f70a3a52b28e4baf17d8341fc@172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: (Provisional) Stopping retransmission (but
retaining packet) on '2657c93c79b12ba855365135794f06e5@172.31.254.2'
Request 103: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'398150e9375216574d9a2fdb76c3625e@172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'088232df6db505597d157d8d71dfed43@172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'40c9fe6a49067a72561f3b294fd30023@172.31.254.2' of Request 103: Found
May 20 10:01:33 DEBUG[5520]: Registration successful
May 20 10:01:33 DEBUG[5520]: Cancelling timeout 17
May 20 10:01:38 DEBUG[5520]: ##### Testing 127.0.0.1 with 172.31.0.0
May 20 10:01:38 DEBUG[5520]: Target address 127.0.0.1 is not local,
substituting externip
May 20 10:01:39 DEBUG[5520]: ##### Testing 127.0.0.1 with 172.31.0.0
May 20 10:01:39 DEBUG[5520]: Target address 127.0.0.1 is not local,
substituting externip
May 20 10:01:40 DEBUG[5520]: ##### Testing 127.0.0.1 with 172.31.0.0
May 20 10:01:40 DEBUG[5520]: Target address 127.0.0.1 is not local,
substituting externip
May 20 10:01:42 DEBUG[5520]: ##### Testing 127.0.0.1 with 172.31.0.0
May 20 10:01:42 DEBUG[5520]: Target address 127.0.0.1 is not local,
substituting externip

-------------- next part --------------
An HTML attachment was scrubbed...
URL:
http://lists.digium.com/pipermail/asterisk-users/attachments/20050520/746948e9/attachment.htm
Possibly Parallel Threads

Search for more seemingly similar threads
asterisk users - May 2005 - Registering with second SIP service causes error every 2 seconds - what is going on?

[Asterisk-Users] Registering with second SIP service causes error every 2 seconds - what is going on?

Possibly Parallel Threads

Wisdom of the Ancients
