Lancom 1723 Sip-Proxy und Voice Call Manager an AGFEO AS45

[phoenixz]

Hallo zusammen,

nachdem ich recht viel positives über die Kopplung von Agfeo-Tk-Anlagen mit Lancom-Routern gelesen habe, habe ich versucht, beide Geräte über SIP-Proxy miteinander zu koppeln.

Obwohl der LANMonitor eine Kopplung mit der SIP-PBX anzeigt und der SIP-User angeblich an der Agfeo auch angemeldet ist ("Übergeordnete Registrierung: registriert), lassen sich trotzdem keine Gespräche führen.

Im VoIP-Modul der Agfeo lässt sich ja bekanntermaßen nicht viel außer der IP-Adresse (inkl. Ports) und der SIP-Einwahlkonten einstellen. Also muss mein Problem am Lancom liegen.

Wählt ein analoges Telefon am Lancom die Rufnummer eines Agfeo-Teilnehmers, ertönt im Telefon keine Leitung (also weder Besetzt-, noch Freizeichen). Interessanterweise resetet der Lancom dann auch nach ca. 6 Sekunden den gesamten Router, als käme es zu einem Spannungsausfall.

Was ich bislang am Lancom eingestellt habe:
TCP/IP: IP der Agfeo in die DMZ gesetzt
Firewall aus Testzwecken deaktiviert
VCM/Leitungen: SIP-PBX Domäne und IP eingetragen
VCM/Benutzer: Analog-Benutzer eingetragen / interner Wählton eingestellt

Irgendwas ist doch vermutlich an der Konfiguration (evtl. Call-Routen???) falsch eingestellt.

Hat da jemand evtl. eine Idee?

Vielen Dank im Voraus und herzliche Grüße aus Köln
Pino

[TraceStarted] 2008/12/22 14:15:58,000
Used config:
# Trace config 
trace + Callmanager 
trace + MEDIA 
trace + SLIC 
 
# Show commands 
show bootlog  
 
[ShowCmd] 2008/12/22 14:15:59,000
Result of command: "show bootlog "
Boot log (5169 Bytes):

****

01/01/1900 00:00:01  System boot after LCOS-Watchdog

DEVICE:           LANCOM 1723 VoIP (Annex B)
HW-RELEASE:       B
VERSION:          7.58.0045 / 14.11.2008 / 6.26b/E74.02.54

[Sysinfo] 2008/12/22 14:15:59,000
Result of command: "sysinfo"

DEVICE:           LANCOM 1723 VoIP (Annex B)
HW-RELEASE:       B
SERIAL-NUMBER:    060521800303
MAC-ADDRESS:      00a05712354d
IP-ADDRESS:       192.168.2.2
IP-NETMASK:       255.255.255.0
INTRANET-ADDRESS: 0.0.0.0
INTRANETMASK:     0.0.0.0
VERSION:          7.58.0045 / 14.11.2008 / 6.26b/E74.02.54
NAME:             AP_Lancom1723
CONFIG-STATUS:    1056;0
FIRMWARE-STATUS:  0;0.2;0.2;7.58.14112008.2;7.26.21112007.1
LANCAPI-PORT:     75
HW-MASK:          00000000000000000000000001100011
FEATUREWORD:      01000000001000000000000100011101
REGISTERED-WORD:  01000000001000000000000100011101
FEATURE-LIST:     00/F/00000000
FEATURE-LIST:     02/F/00000000
FEATURE-LIST:     03/F/00000000
FEATURE-LIST:     04/F/00000000
FEATURE-LIST:     08/F/00000000
FEATURE-LIST:     15/F/00000000
FEATURE-LIST:     1e/F/00000000
TIME:             00000000000000
HTTP-PORT:        80
HTTPS-PORT:       443
Compatible-IDs:   14:30:31
[SLIC] 1900/01/01 00:05:18,920 [SLIC] : -----[ SLIC EVENT, channel-id=0
[SLIC] 1900/01/01 00:05:18,920 [SLIC] : - info       : channel off-hook
[SLIC] 1900/01/01 00:05:18,920 [D3-SLIC] : -----[ INCOMING CALL, channel-id=0
[SLIC] 1900/01/01 00:05:18,920 [D3-SLIC] : - info       : call=0X33 in state 'NullState'
[SLIC] 1900/01/01 00:05:18,920 [D3-SLIC] : - info       : b-channel=0X100
[SLIC] 1900/01/01 00:05:18,920 [D3-SLIC] : - info       : switch from state 'NullState' to 'CallPresent'
[Callmanager] 1900/01/01 00:05:18,920 [ANALOG-USER] : -----[ CONNECT, call-id=16
[Callmanager] 1900/01/01 00:05:18,920 [ANALOG-USER] : -----[ CONNECT, call-id=16
[Callmanager] 1900/01/01 00:05:18,920 [VCM] : -----[ CALL INDICATION, call-id=16
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : Src CallId=2393508527@00a05712354d
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : To  : @AGFEO
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : - info       : number is not unique
[Callmanager] 1900/01/01 00:05:18,930 [VCM] : - info       : abort, destination ist not unique
[SLIC] 1900/01/01 00:05:18,940 [D3-SLIC] : -----[ SETUP ACKNOWLEDGE RECEIVED, channel-id=0
[SLIC] 1900/01/01 00:05:18,940 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:18,940 [D3-SLIC] : - info       : enable pcm bus
[SLIC] 1900/01/01 00:05:19,680 [SLIC] : -----[ SLIC EVENT, channel-id=0
[SLIC] 1900/01/01 00:05:19,680 [SLIC] : - info       : digit '3' detected  
[SLIC] 1900/01/01 00:05:19,680 [D3-SLIC] : -----[ INFO EVENT, channel-id=0
[SLIC] 1900/01/01 00:05:19,680 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:19,680 [D3-SLIC] : - info       : dialing digit 3
[Callmanager] 1900/01/01 00:05:19,680 [ANALOG-USER] : -----[ CONNECT on existing call, call-id=16
[Callmanager] 1900/01/01 00:05:19,680 [ANALOG-USER] : -----[ CONNECT, call-id=16
[Callmanager] 1900/01/01 00:05:19,680 [VCM] : -----[ CALL INDICATION, call-id=16
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : Src CallId=2393508527@00a05712354d
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : To  : 3@AGFEO
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : - info       : number is not unique
[Callmanager] 1900/01/01 00:05:19,690 [VCM] : - info       : abort, destination ist not unique
[SLIC] 1900/01/01 00:05:19,690 [D3-SLIC] : -----[ SETUP ACKNOWLEDGE RECEIVED, channel-id=0
[SLIC] 1900/01/01 00:05:19,690 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:19,690 [D3-SLIC] : - info       : enable pcm bus
[SLIC] 1900/01/01 00:05:20,390 [SLIC] : -----[ SLIC EVENT, channel-id=0
[SLIC] 1900/01/01 00:05:20,390 [SLIC] : - info       : digit '0' detected  
[SLIC] 1900/01/01 00:05:20,390 [D3-SLIC] : -----[ INFO EVENT, channel-id=0
[SLIC] 1900/01/01 00:05:20,390 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:20,390 [D3-SLIC] : - info       : dialing digit 0
[Callmanager] 1900/01/01 00:05:20,390 [ANALOG-USER] : -----[ CONNECT on existing call, call-id=16
[Callmanager] 1900/01/01 00:05:20,390 [ANALOG-USER] : -----[ CONNECT, call-id=16
[Callmanager] 1900/01/01 00:05:20,390 [VCM] : -----[ CALL INDICATION, call-id=16
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : Src CallId=2393508527@00a05712354d
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : using routing entry in row # 1
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : first/single way destination 30@AGFEO via AGFEO
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : proceeding call
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : -----[ INITIATE CALLS, call-id=16
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : initiate call to 30@AGFEO
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : outgoing line is AGFEO
[Callmanager] 1900/01/01 00:05:20,400 [VCM] : - info       : called number is incomplete
[Callmanager] 1900/01/01 00:05:20,410 [VCM] : -----[ INITIATE CALL, call-id=16
[Callmanager] 1900/01/01 00:05:20,410 [VCM] : -----[ CALL PROCEEDING INDICATION, call-id=16
[Callmanager] 1900/01/01 00:05:20,410 [VCM] : - info       : Src CallId=2393508527@00a05712354d
[Callmanager] 1900/01/01 00:05:20,410 [ANALOG-USER] : -----[ CALL PROCEEDING, call-id=16
[Callmanager] 1900/01/01 00:05:20,410 [ANALOG-USER] : - info       : plci=0X36
[Callmanager] 1900/01/01 00:05:20,410 [SIP-PBx] : -----[ INITIATE CALL, call-id=16
[Callmanager] 1900/01/01 00:05:20,410 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:20,410 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:20,420 [SIP-PBx] : - info       : number not complete, start overlap timeout
[MEDIA] 1900/01/01 00:05:20,420 [PCM-ENDPOINT] : -----[ CONSTRUCT, this: 011946e0
[MEDIA] 1900/01/01 00:05:20,420 [PCM-ENDPOINT] : -----[ UPDATE REMOTE, this: 011946e0
[SLIC] 1900/01/01 00:05:20,420 [D3-SLIC] : -----[ SETUP ACKNOWLEDGE RECEIVED, channel-id=0
[SLIC] 1900/01/01 00:05:20,420 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:20,420 [D3-SLIC] : - info       : enable pcm bus
[Callmanager] 1900/01/01 00:05:22,420 [SIP-CALL] : Overlap timeout, call-id=16
[Callmanager] 1900/01/01 00:05:22,420 [SIP-CALL] : - info       : called-id is '30'
[Callmanager] 1900/01/01 00:05:22,420 [SIP-PBx] : -----[ INFO, call-id=16
[Callmanager] 1900/01/01 00:05:22,420 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,420 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,420 [VCM] : -----[ INFO IS COMPLETE, call-id=16
[Callmanager] 1900/01/01 00:05:22,420 [ANALOG-USER] : -----[ INFO COMPLETE, call-id=16
[Callmanager] 1900/01/01 00:05:22,420 [ANALOG-USER] : - info       : plci=0X36
[Callmanager] 1900/01/01 00:05:22,420 [VCM] : - info       : called address is complete
[Callmanager] 1900/01/01 00:05:22,420 [VCM] : - info       : Line: 'AGFEO'
[Callmanager] 1900/01/01 00:05:22,420 [VCM] : - info       : From: '11@AGFEO'
[Callmanager] 1900/01/01 00:05:22,420 [VCM] : - info       : To  : '30@AGFEO'
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : -----[ CREATE (id=0118fca0)
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : -----[ UPDATE LOCAL (id=0118fca0)
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=0118fca0)
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : succeeded
[SLIC] 1900/01/01 00:05:22,420 [D3-SLIC] : -----[ CALL PROCEEDING RECEIVED, channel-id=0
[SLIC] 1900/01/01 00:05:22,420 [D3-SLIC] : - info       : call=0X33 in state 'CallPresent'
[SLIC] 1900/01/01 00:05:22,420 [D3-SLIC] : - info       : switch from state 'CallPresent' to 'IncomingCallProceeding'
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=0118fca0)
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,420 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,420 [SIP-PBx] : -----[ GENERATE INVITE, call-id=16
[Callmanager] 1900/01/01 00:05:22,430 [Sip-UA] : -----[ INVITE INDICATION, call-id=2867693175@00a05712354d
[Callmanager] 1900/01/01 00:05:22,430 [Sip-UA] : - info       : generate new call, call-id=17
[Callmanager] 1900/01/01 00:05:22,440 [Sip-UA] : - info       : early media detected
[Callmanager] 1900/01/01 00:05:22,440 [Sip-UA] : - info       : ResponseInfo: 'Trying'
[Callmanager] 1900/01/01 00:05:22,440 [SIP-CALL] : -----[ open Media Proxy On Invite , call-id=17
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : -----[ CREATE (id=011a7160)
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : -----[ UPDATE REMOTE (id=011a7160)
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : destination address changed, 192.168.2.2 -> 192.168.2.2
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : port changed, 57006 -> 31190
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011a7160)
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011a7160)
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,440 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,440 [VCM] : -----[ CALL INDICATION, call-id=17
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : Src CallId=2867693175@00a05712354d
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : number is complete
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : using routing entry in row # 1
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : first/single way destination 30@AGFEO via AGFEO
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : proceeding call
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : -----[ INITIATE CALLS, call-id=17
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : initiate call to 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : outgoing line is AGFEO
[Callmanager] 1900/01/01 00:05:22,450 [VCM] : - info       : called number is complete
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : -----[ INITIATE CALL, call-id=17
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : -----[ CALL PROCEEDING INDICATION, call-id=17
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : - info       : Src CallId=2867693175@00a05712354d
[Callmanager] 1900/01/01 00:05:22,470 [SIP-PBx] : -----[ INITIATE CALL, call-id=17
[Callmanager] 1900/01/01 00:05:22,470 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,470 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : -----[ INFO IS COMPLETE, call-id=17
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : - info       : called address is complete
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : - info       : Line: 'AGFEO'
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : - info       : From: '11@AGFEO'
[Callmanager] 1900/01/01 00:05:22,470 [VCM] : - info       : To  : '30@AGFEO'
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : -----[ CREATE (id=011af4a0)
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : -----[ UPDATE LOCAL (id=011af4a0)
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011af4a0)
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011af4a0)
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,470 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,470 [SIP-PBx] : -----[ GENERATE INVITE, call-id=17
[Callmanager] 1900/01/01 00:05:22,480 [Sip-UA] : - info       : reply code: 1
[Callmanager] 1900/01/01 00:05:22,480 [Sip-UA] : - info       : sip user is busy
[Callmanager] 1900/01/01 00:05:22,480 [Sip-UA] : -----[ INVITE INDICATION, call-id=3042398902@00a05712354d
[Callmanager] 1900/01/01 00:05:22,480 [Sip-UA] : - info       : generate new call, call-id=18
[Callmanager] 1900/01/01 00:05:22,490 [Sip-UA] : - info       : early media detected
[Callmanager] 1900/01/01 00:05:22,490 [Sip-UA] : - info       : ResponseInfo: 'Trying'
[Callmanager] 1900/01/01 00:05:22,490 [SIP-CALL] : -----[ open Media Proxy On Invite , call-id=18
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : -----[ CREATE (id=011b4660)
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : -----[ UPDATE REMOTE (id=011b4660)
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : destination address changed, 192.168.2.2 -> 192.168.2.2
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : port changed, 57006 -> 21118
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011b4660)
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011b4660)
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,490 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,490 [VCM] : -----[ CALL INDICATION, call-id=18
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : Src CallId=3042398902@00a05712354d
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : number is complete
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : using routing entry in row # 1
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : first/single way destination 30@AGFEO via AGFEO
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : proceeding call
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : -----[ INITIATE CALLS, call-id=18
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : initiate call to 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : outgoing line is AGFEO
[Callmanager] 1900/01/01 00:05:22,500 [VCM] : - info       : called number is complete
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : -----[ INITIATE CALL, call-id=18
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : -----[ CALL PROCEEDING INDICATION, call-id=18
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : - info       : Src CallId=3042398902@00a05712354d
[Callmanager] 1900/01/01 00:05:22,520 [SIP-PBx] : -----[ INITIATE CALL, call-id=18
[Callmanager] 1900/01/01 00:05:22,520 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,520 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : -----[ INFO IS COMPLETE, call-id=18
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : - info       : called address is complete
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : - info       : Line: 'AGFEO'
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : - info       : From: '11@AGFEO'
[Callmanager] 1900/01/01 00:05:22,520 [VCM] : - info       : To  : '30@AGFEO'
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : -----[ CREATE (id=011bbc20)
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : -----[ UPDATE LOCAL (id=011bbc20)
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011bbc20)
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011bbc20)
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,520 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,530 [SIP-PBx] : -----[ GENERATE INVITE, call-id=18
[Callmanager] 1900/01/01 00:05:22,530 [Sip-UA] : - info       : reply code: 1
[Callmanager] 1900/01/01 00:05:22,530 [Sip-UA] : - info       : sip user is busy
[Callmanager] 1900/01/01 00:05:22,530 [Sip-UA] : -----[ INVITE INDICATION, call-id=2379098342@00a05712354d
[Callmanager] 1900/01/01 00:05:22,540 [Sip-UA] : - info       : generate new call, call-id=19
[Callmanager] 1900/01/01 00:05:22,540 [Sip-UA] : - info       : early media detected
[Callmanager] 1900/01/01 00:05:22,540 [Sip-UA] : - info       : ResponseInfo: 'Trying'
[Callmanager] 1900/01/01 00:05:22,540 [SIP-CALL] : -----[ open Media Proxy On Invite , call-id=19
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : -----[ CREATE (id=011c0e00)
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : -----[ UPDATE REMOTE (id=011c0e00)
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : destination address changed, 192.168.2.2 -> 192.168.2.2
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : port changed, 57006 -> 44700
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011c0e00)
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011c0e00)
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,540 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,540 [VCM] : -----[ CALL INDICATION, call-id=19
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : Src CallId=2379098342@00a05712354d
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : number is complete
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : using routing entry in row # 1
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : first/single way destination 30@AGFEO via AGFEO
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : proceeding call
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : -----[ INITIATE CALLS, call-id=19
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : initiate call to 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : outgoing line is AGFEO
[Callmanager] 1900/01/01 00:05:22,560 [VCM] : - info       : called number is complete
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : -----[ INITIATE CALL, call-id=19
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : -----[ CALL PROCEEDING INDICATION, call-id=19
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : - info       : Src CallId=2379098342@00a05712354d
[Callmanager] 1900/01/01 00:05:22,570 [SIP-PBx] : -----[ INITIATE CALL, call-id=19
[Callmanager] 1900/01/01 00:05:22,570 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,570 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : -----[ INFO IS COMPLETE, call-id=19
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : - info       : called address is complete
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : - info       : Line: 'AGFEO'
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : - info       : From: '11@AGFEO'
[Callmanager] 1900/01/01 00:05:22,570 [VCM] : - info       : To  : '30@AGFEO'
[MEDIA] 1900/01/01 00:05:22,570 [RT-ENDPOINT] : -----[ CREATE (id=011c8580)
[MEDIA] 1900/01/01 00:05:22,570 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,570 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,570 [RT-ENDPOINT] : -----[ UPDATE LOCAL (id=011c8580)
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011c8580)
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011c8580)
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,580 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,580 [SIP-PBx] : -----[ GENERATE INVITE, call-id=19
[Callmanager] 1900/01/01 00:05:22,580 [Sip-UA] : - info       : reply code: 1
[Callmanager] 1900/01/01 00:05:22,590 [Sip-UA] : - info       : sip user is busy
[Callmanager] 1900/01/01 00:05:22,590 [Sip-UA] : -----[ INVITE INDICATION, call-id=2329741228@00a05712354d
[Callmanager] 1900/01/01 00:05:22,590 [Sip-UA] : - info       : generate new call, call-id=20
[Callmanager] 1900/01/01 00:05:22,590 [Sip-UA] : - info       : early media detected
[Callmanager] 1900/01/01 00:05:22,590 [Sip-UA] : - info       : ResponseInfo: 'Trying'
[Callmanager] 1900/01/01 00:05:22,590 [SIP-CALL] : -----[ open Media Proxy On Invite , call-id=20
[MEDIA] 1900/01/01 00:05:22,590 [RT-ENDPOINT] : -----[ CREATE (id=011cd240)
[MEDIA] 1900/01/01 00:05:22,590 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,590 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : -----[ UPDATE REMOTE (id=011cd240)
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : destination address changed, 192.168.2.2 -> 192.168.2.2
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : port changed, 57006 -> 32170
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011cd240)
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011cd240)
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,600 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,600 [VCM] : -----[ CALL INDICATION, call-id=20
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : Src CallId=2329741228@00a05712354d
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : number is complete
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : parse call routing table for active entries
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : using routing entry in row # 1
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : first/single way destination 30@AGFEO via AGFEO
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : proceeding call
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : -----[ INITIATE CALLS, call-id=20
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : initiate call to 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : outgoing line is AGFEO
[Callmanager] 1900/01/01 00:05:22,610 [VCM] : - info       : called number is complete
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : -----[ INITIATE CALL, call-id=20
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : -----[ CALL PROCEEDING INDICATION, call-id=20
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : - info       : Src CallId=2329741228@00a05712354d
[Callmanager] 1900/01/01 00:05:22,620 [SIP-PBx] : -----[ INITIATE CALL, call-id=20
[Callmanager] 1900/01/01 00:05:22,620 [SIP-PBx] : From: 11@AGFEO
[Callmanager] 1900/01/01 00:05:22,620 [SIP-PBx] : To  : 30@AGFEO
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : -----[ INFO IS COMPLETE, call-id=20
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : - info       : called address is complete
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : - info       : Line: 'AGFEO'
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : - info       : From: '11@AGFEO'
[Callmanager] 1900/01/01 00:05:22,620 [VCM] : - info       : To  : '30@AGFEO'
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : -----[ CREATE (id=011d4e40)
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : content is audio
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : -----[ UPDATE LOCAL (id=011d4e40)
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : -----[ FREE RESOURCES (id=011d4e40)
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : succeeded
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : -----[ OPEN RESOURCES (id=011d4e40)
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : outgoing stream is opened now
[MEDIA] 1900/01/01 00:05:22,630 [RT-ENDPOINT] : - info       : succeeded
[Callmanager] 1900/01/01 00:05:22,630 [SIP-PBx] : -----[ GENERATE INVITE, call-id=20
[Callmanager] 1900/01/01 00:05:22,640 [Sip-UA] : - info       : reply code: 1
[Callmanager] 1900/01/01 00:05:22,640 [Sip-UA] : - info       : sip user is busy
[Callmanager] 1900/01/01 00:05:22,640 [Sip-UA] : -----[ INVITE INDICATION, call-id=4242744277@00a05712354d
[Callmanager] 1900/01/01 00:05:22,640 [Sip-UA] : - info       : generate new call, call-id=21
[Callmanager] 1900/01/01 00:05:22,650 [Sip-UA] : - info       : early media detected
[Callmanager] 1900/01/01 00:05:22,650 [Sip-UA] : - info       : ResponseInfo: 'Trying'
[Callmanager] 1900/01/01 00:05:22,650 [SIP-CALL] : -----[ open Media Proxy On Invite , call-id=21