[Asterisk-Users] Registering with second SIP service causes error
every 2 seconds - what is going on?
Michael Stahl
mstahl at ocg.ca
Fri May 20 07:42:14 MST 2005
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 at fwd.pulver.com/8000
register => xxx:yyy at 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 at 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 at 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 at 172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'3477d43f70a3a52b28e4baf17d8341fc at 172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: (Provisional) Stopping retransmission (but
retaining packet) on '2657c93c79b12ba855365135794f06e5 at 172.31.254.2'
Request 103: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'398150e9375216574d9a2fdb76c3625e at 172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'088232df6db505597d157d8d71dfed43 at 172.31.254.2' of Request 102: Found
May 20 10:01:33 DEBUG[5520]: Stopping retransmission on
'40c9fe6a49067a72561f3b294fd30023 at 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
More information about the asterisk-users
mailing list