For completeness here is the logs from a working, Server-Only 7.1 system. This system has an X100p clone installed but It's not connected:[root@gromit ~]# asterisk -vvvvvvvvvvvvvvvvvvr
== Parsing '/etc/asterisk/asterisk.conf': Found
== Parsing '/etc/asterisk/extconfig.conf': Found
Asterisk 1.2.20, Copyright (C) 1999 - 2007 Digium, Inc. and others.
Created by Mark Spencer <markster@digium.com>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'show license' for details.
=========================================================================
Connected to Asterisk 1.2.20 currently running on gromit (pid = 3940)
Verbosity is at least 18
-- Remote UNIX connection
-- Executing AGI("SIP/5000-08f8f208", "selintra|OutCluster|861120") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script selintra completed, returning 0
-- Executing AGI("SIP/5000-08f8f208", "selintra|OutRoute|VOIPTALK") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (SetCallerID) Options: (08458674281)
-- AGI Script Executing Application: (Dial) Options: (IAX2/84458485@Voiptalk/441620861120)
-- Called 84458485@Voiptalk/441620861120
-- Call accepted by 217.14.138.49 (format alaw)
-- Format for call is alaw
-- IAX2/Voiptalk-3 is making progress passing it to SIP/5000-08f8f208
-- IAX2/Voiptalk-3 answered SIP/5000-08f8f208
-- Hungup 'IAX2/Voiptalk-3'
== Spawn extension (default, 861120, 1) exited non-zero on 'SIP/5000-08f8f208'
-- Executing Hangup("SIP/5000-08f8f208", "") in new stack
== Spawn extension (default, h, 1) exited non-zero on 'SIP/5000-08f8f208'
=======================================
Incoming:
gromit*CLI>
-- Accepting UNAUTHENTICATED call from 217.14.132.185:
> requested format = alaw,
> requested prefs = (ilbc|gsm|ulaw|alaw|g729),
> actual format = ulaw,
> host prefs = (ulaw|alaw),
> priority = mine
-- Executing AGI("IAX2/217.14.132.185:4569-1", "selintra|Inbound|08458674281") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (DBget) Options: (dbVal=STAT/OCSTAT)
-- DBget: varname=dbVal, family=STAT, key=OCSTAT
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=STAT/IVRSTAT)
-- DBget: varname=dbVal, family=STAT, key=IVRSTAT
-- DBget: Value not found in database.
-- AGI Script selintra completed, returning 0
-- Executing AGI("IAX2/217.14.132.185:4569-1", "selintra|InCall|") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (DBget) Options: (dbVal=STAT/OCSTAT)
-- DBget: varname=dbVal, family=STAT, key=OCSTAT
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=cfimopen/5000)
-- DBget: varname=dbVal, family=cfimopen, key=5000
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=cfim/5000)
-- DBget: varname=dbVal, family=cfim, key=5000
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=STAT/OCSTAT)
-- DBget: varname=dbVal, family=STAT, key=OCSTAT
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=cfimopen/5000)
-- DBget: varname=dbVal, family=cfimopen, key=5000
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=STAT/OCSTAT)
-- DBget: varname=dbVal, family=STAT, key=OCSTAT
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=cfim/5000)
-- DBget: varname=dbVal, family=cfim, key=5000
-- DBget: Value not found in database.
-- AGI Script Executing Application: (DBget) Options: (dbVal=ringdelay/5000)
-- DBget: varname=dbVal, family=ringdelay, key=5000
-- DBget: Value not found in database.
-- AGI Script Executing Application: (Dial) Options: (SIP/5000|15|tT)
-- Called 5000
-- SIP/5000-08f98bd0 is ringing
-- SIP/5000-08f98bd0 answered IAX2/217.14.132.185:4569-1
== Spawn extension (extensions, 5000, 1) exited non-zero on 'IAX2/217.14.132.185:4569-1'
-- Executing Hangup("IAX2/217.14.132.185:4569-1", "") in new stack
== Spawn extension (extensions, h, 1) exited non-zero on 'IAX2/217.14.132.185:4569-1'
-- Hungup 'IAX2/217.14.132.185:4569-1'
========================================
gromit*CLI> sip show registry
Host Username Refresh State
gromit*CLI> sip show peers
Name/username Host Dyn Nat ACL Port Status
5000/Norrie-Desk 10.0.0.100 D N 5060 OK (5 ms)
1 sip peers [1 online , 0 offline]
gromit*CLI>
Here's the logs from a 7.1->7.1.3 system which then had SAIL installed. This system is a VMware machine with no PCI card but the symptoms have been identical for both physical and virtual machines:
Outgoing calls are OK:-- Executing AGI("SIP/5000-08ba3dc0", "selintra|OutCluster|861128") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script selintra completed, returning 0
-- Executing AGI("SIP/5000-08ba3dc0", "selintra|OutRoute|VOIPTALK") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (SetCallerID) Options: (08458674281)
-- AGI Script Executing Application: (Dial) Options: (IAX2/84458485@Voiptalk/441620861128)
-- Called 84458485@Voiptalk/441620861128
-- Call accepted by 217.14.138.49 (format alaw)
-- Format for call is alaw
-- IAX2/Voiptalk-1 is making progress passing it to SIP/5000-08ba3dc0
-- Hungup 'IAX2/Voiptalk-1'
== Spawn extension (default, 861128, 1) exited non-zero on 'SIP/5000-08ba3dc0'
-- Executing Hangup("SIP/5000-08ba3dc0", "") in new stack
== Spawn extension (default, h, 1) exited non-zero on 'SIP/5000-08ba3dc0'
sail1*CLI>
There's no logs at all for incoming calls:
Firewall configuration is the same ina all cases except port forwarding to the different servers. The incoming packets are hitting the servers. Here is the firewall when the call comes in:tcpdump -i ppp0 port 4569
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on ppp0, link-type LINUX_SLL (Linux cooked), capture size 68 bytes
17:40:56.906940 IP 217.14.132.185.iax > 78-32-4-241.adsl24.co.uk.iax: UDP, length 111
17:40:58.896940 IP 217.14.132.185.iax > 78-32-4-241.adsl24.co.uk.iax: UDP, length 111
17:41:00.916940 IP 217.14.132.185.iax > 78-32-4-241.adsl24.co.uk.iax: UDP, length 15
17:41:02.896940 IP 217.14.132.185.iax > 78-32-4-241.adsl24.co.uk.iax: UDP, length 15
SAIL box:tcpdump -i eth0 port 1812
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on eth0, link-type EN10MB (Ethernet), capture size 96 bytes
0 packets captured
0 packets received by filter
0 packets dropped by kernel
[root@sail1 ~]#
tcpdump -i eth0 port 4569
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on eth0, link-type EN10MB (Ethernet), capture size 96 bytes
17:37:03.905716 IP 217.14.132.185.4569 > sail1.mycompany.local.4569: UDP, length 111
17:37:05.940563 IP 217.14.132.185.4569 > sail1.mycompany.local.4569: UDP, length 111
17:37:07.923134 IP 217.14.132.185.4569 > sail1.mycompany.local.4569: UDP, length 15
17:37:09.904602 IP 217.14.132.185.4569 > sail1.mycompany.local.4569: UDP, length 15
Hope this helps,
N