[ Marcony @ 13.05.2010. 20:00 ] @
Imam Cisco 1841 ruter i na njemu advanced enterprise image koji podrzava CME 3.1.
Kada ga konfigurisem (npr. putem telephony-service setup-a), telefoni se registruju, ali ne mogu da se zovu medjusobno.

Telefon prijavljuje da je broj nepostojeci.

Ista konfiguracija, ali u GNS3 (sa ruterom serije 3700) radi bez problema.

Zna li neko u cemu je problem?
[ Ve$eli @ 14.05.2010. 12:09 ] @
Da to nije 1861 mozda, 1841 ne podrzava voip... Ako mozes okaci konfiguraciju pa cemo videti.
[ Marcony @ 15.05.2010. 13:49 ] @
U pitanju je bas 1841. Sam image podrzava CME, a i komande za konfigurisanje su dostupne.
[ Marcony @ 15.05.2010. 18:36 ] @
Konfiguracija... poenta ove konfiguracije je da CIPC telefon ima dve linije i da moze da zove sam sebe.
Cisto testa radi.

Code:
telephony-service
 max-ephones 3
 max-dn 3
 ip source-address 192.168.10.1 port 2000
 auto assign 1 to 3
 create cnf-files version-stamp Jan 01 2002 00:00:00
 max-conferences 4 gain -6
 transfer-system full-consult
!
!
ephone-dn  1  dual-line
 number 1001
!
!
ephone-dn  2  dual-line
 number 1002
!
!
ephone-dn  3  dual-line
 number 1003
!
!
ephone  1
 mac-address 4061.860C.B3EB
 type CIPC
 button  1:1 2:2
!
!
!         
ephone  2
!
!
!
ephone  3
[ Ve$eli @ 16.05.2010. 13:25 ] @
Konfiguracija je u principu OK, nekad samo hoce da zeza ukoliko je vreme na sistemu lose pa nece da napravi konfiguracione fajlove. Sto se tice same podrske za voice za 1841, veruj mi da bi zeznuo Cisco ako bi uspeo tako nesto da proradi... Jel nije problem da stavis output "sh ver", situacija je zanimljiva :)
Mozda bi bilo zgodno da upalis "debug ephone reg" pre nego startujes CIPC, pa da vidimo i taj output.
[ Marcony @ 16.05.2010. 22:18 ] @
sh ver...

Code:

Cisco IOS Software, 1841 Software (C1841-ADVENTERPRISEK9-M), Version 12.3(14)YT1, RELEASE SOFTWARE (fc1)
Synched to version 12.4(1.7)

ROM: System Bootstrap, Version 12.4(13r)T, RELEASE SOFTWARE (fc1)
ROM: Cisco IOS Software, 1841 Software (C1841-ADVENTERPRISEK9-M), Version 12.3(14)YT1, RELEASE SOFTWARE (fc1)

Router uptime is 11 minutes
System returned to ROM by power-on
System restarted at 23:05:51 UTC Sun May 16 2010
System image file is "flash:c1841-adventerprisek9-mz.123_14.YT1.bin"

Cisco 1841 (revision 7.0) with 238592K/23552K bytes of memory.
Processor board ID FCZ122691ZY
2 FastEthernet interfaces
1 Virtual Private Network (VPN) Module
DRAM configuration is 64 bits wide with parity disabled.
191K bytes of NVRAM.
62720K bytes of ATA CompactFlash (Read/Write)

Router#
[ Marcony @ 16.05.2010. 22:19 ] @
debug ephone reg... (Cisco 7911 telefon)

Code:

May 16 23:16:04.559: New Skinny socket accepted [1] (0 active)
May 16 23:16:04.559: sin_family 2, sin_port 51522, in_addr 192.168.10.2
May 16 23:16:04.559: skinny_add_socket 1 192.168.10.2 51522
May 16 23:16:05.559: 
Skinny StationAlarmMessage on socket [1] 192.168.10.2 
May 16 23:16:05.559: ** severityWarning p1=0 [0x0] p2=0 [0x0]
May 16 23:16:05.559: 6: Name=SEP001A6DCF91F8 Load= term11.default File Not Found
May 16 23:16:05.559: %IPPHONE-6-REG_ALARM: 25: Name=SEP001A6DCF91F8 Load= term11.default Last=Initialized
May 16 23:16:05.559: 
Skinny StationAlarmMessage on socket [1] 192.168.10.2 
May 16 23:16:05.559: severityInformational p1=0 [0x0] p2=0 [0x0]
May 16 23:16:05.559: 25: Name=SEP001A6DCF91F8 Load= term11.default Last=Initialized
May 16 23:16:05.559: ephone-(-1)[1] StationRegisterMessage (0/0/5) from 192.168.10.2
May 16 23:16:05.559: ephone-(-1)[1] Register StationIdentifier DeviceName SEP001A6DCF91F8
May 16 23:16:05.559: ephone-(-1)[1] StationIdentifier Instance 0    deviceType 307
May 16 23:16:05.559: ephone-(-1) Allow any Skinny Server IP address 192.168.10.1
May 16 23:16:05.559: ephone-1[1]:new phone associate OK on socket [1]
May 16 23:16:05.563: %IPPHONE-6-REGISTER_NEW: ephone-1:SEP001A6DCF91F8 IP:192.168.10.2 Socket:1 DeviceType:Phone has registered.
May 16 23:16:05.563: Phone 0 socket 1
May 16 23:16:05.563: Skinny Local IP address = 192.168.10.1 on port 2000

May 16 23:16:05.563: Skinny Phone IP address = 192.168.10.2 51522
May 16 23:16:05.563: ephone-1[1]:Signal protocol ver 5 to phone with ver 12
May 16 23:16:05.563: ephone-1[1]:Date Format M/D/Y
May 16 23:16:05.563: ephone-1[1]:RegisterAck sent to ephone 1: keepalive period 30 use sccp-version 5
May 16 23:16:05.563: ephone-1[1]:CapabilitiesReq sent
May 16 23:16:05.815: ephone-1[1]:Skinny IP port 3500 set for socket [1]
May 16 23:16:05.815: ephone-1[1]:ButtonTemplateReqMessage
May 16 23:16:05.815: ephone-1[1]:ButtonTemplateReqMessage waiting for Caps
May 16 23:16:05.815: ephone-1[1]:StationSoftKeyTemplateReqMessage
May 16 23:16:05.815: ephone-1[1]:***Forcing Telecaster Mode
May 16 23:16:05.815: ephone-1[1]:StationSoftKeyTemplateResMessage
May 16 23:16:05.815: ephone-1[1]:StationSoftKeySetReqMessage
May 16 23:16:05.815: ephone-1[1]:Removed SkPark key
May 16 23:16:05.815: ephone-1[1]:StationSoftKeySetResMessageSleep 250 msec for ephone-(1) on socket [1]
May 16 23:16:06.067: ephone-1[1]:StationConfigStatReqMessage
May 16 23:16:06.067: ephone-1[1]:StationConfigStatMessage sent for device SEP001A6DCF91F8
May 16 23:16:06.067: ephone-1[1]:CapabilitiesRes received
May 16 23:16:06.067: ephone-1[1]:Caps list 9
WideBand_256K  40 ms
G711Ulaw64k  40 ms
G711Alaw64k  40 ms
Unrecognized Media Type 86  60 ms
G729AnnexB  60 ms
G729AnnexAwAnnexB  60 ms
G729  60 ms
G729AnnexA  60 ms
Unrecognized Media Type 257  1 ms

May 16 23:16:06.067: ephone-1[1]:Process pending button template
May 16 23:16:06.071: ephone-1[1]:ButtonTemplateReqMessage
May 16 23:16:06.071: ephone-1[1]:CheckAutoReg
May 16 23:16:06.071: ephone-1[1]:AutoReg is disabled
May 16 23:16:06.071: ephone-1[1][SEP001A6DCF91F8]:Setting 1 lines 4 speed-dials on phone (max_line 2)
May 16 23:16:06.071: ephone-1[1]:First Speed Dial Button location is 2 (0)
May 16 23:16:06.071: ephone-1[1]:Configured 4 speed dial buttons
May 16 23:16:06.071: ephone-1[1]:ButtonTemplate lines=1 speed=4 buttons=6 offset=0
May 16 23:16:06.323: ephone-1[1]:StationLineStatReqMessage from ephone line 1
May 16 23:16:06.323: ephone-1[1]:CheckAutoReg
May 16 23:16:06.323: ephone-1[1]:AutoReg is disabled
May 16 23:16:06.323: ephone-1[1][SEP001A6DCF91F8]:StationLineStatReqMessage from ephone line 1 Invalid DN -1
May 16 23:16:06.323: ephone-1[1][SEP001A6DCF91F8]:StationLineStatResMessage sent to ephone (1 of 2)
May 16 23:16:06.335: ephone-1[1]:StationForwardStatReqMessage line 1 from ephone
May 16 23:16:06.335: Skinny StationForwardStatMessage line 1 sent on ephone socket [1] for ephone-1
May 16 23:16:06.335: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0
May 16 23:16:06.335: ephone-1[1]:StationSpeedDialStatReqMessage speed 1
May 16 23:16:06.335: ephone-1[1]:No speed-dial set 1
May 16 23:16:06.335: ephone-1[1]:StationSpeedDialStatMessage sent
May 16 23:16:06.335: ephone-1[1]:StationSpeedDialStatReqMessage speed 2
May 16 23:16:06.335: ephone-1[1]:No speed-dial set 2
May 16 23:16:06.335: ephone-1[1]:StationSpeedDialStatMessage sent
May 16 23:16:06.339: ephone-1[1]:StationSpeedDialStatReqMessage speed 3
May 16 23:16:06.339: ephone-1[1]:No speed-dial set 3
May 16 23:16:06.339: ephone-1[1]:StationSpeedDialStatMessage sent
May 16 23:16:06.339: ephone-1[1]:StationSpeedDialStatReqMessage speed 4
May 16 23:16:06.339: ephone-1[1]:No speed-dial set 4
May 16 23:16:06.339: ephone-1[1]:StationSpeedDialStatMessage sent
May 16 23:16:06.339: ephone-1[1]:Skinny Available Lines 1 set for socket [1]
May 16 23:16:06.339: ephone-1[1]:SkinnyCompleteRegistrationForAvailLines
May 16 23:16:06.339: ephone-1[1]:1 lines Completed Registration out of 0 lines
May 16 23:16:06.559: New Skinny socket accepted [1] (1 active)
May 16 23:16:06.559: sin_family 2, sin_port 50464, in_addr 192.168.10.2
May 16 23:16:06.559: skinny_add_socket 1 192.168.10.2 50464
May 16 23:16:07.615: KEYSWITCH Clean up DN 1 chan 2 (1001)

May 16 23:16:10.387: KEYSWITCH Clean up DN 2 chan 2 (1002)

May 16 23:16:13.411: KEYSWITCH Clean up DN 3 chan 2 (1003)

May 16 23:16:15.427: ephone-1[1]:SkinnyCompleteRegistration
May 16 23:16:16.435: KEYSWITCH Clean up DN 4 chan 2 (1004)

May 16 23:16:19.459: KEYSWITCH Clean up DN 5 chan 2 (1005)
[ Marcony @ 16.05.2010. 22:25 ] @
Svi se oni fino registruju, samo sto ne radi pozivanje izmedju telefona.
Kojom debug komandom bih mogao da vidim sta se desava sa pozivom?
[ Ve$eli @ 16.05.2010. 23:44 ] @
Uh izgleda da nisam bas pazljivo citao :) Za debug samih poziva dva SCCP telefona najbolja je komanda "debug ephone detail". Jeste da je output malo veci, ali je takva priroda skinny-a.
[ Marcony @ 17.05.2010. 07:59 ] @
Uh... mnogo razmenjenih poruka... na sta konkretno da obratim paznju prilikom uspostavljanja poziva?
[ Ve$eli @ 17.05.2010. 08:41 ] @
Mozes pasteovati output pa cemo videti - ima dosta sitnih pojedinacnih poruko kojima CME govori telefonu sta da uradi sa lampom, softkey-evima, ringerom, spikerfonom, pregovori oko kodeka, isto tako i telefon salje svaki event ka CME ruteru, a svaki event je jedna poruka - to je priroda skinny-a.

Iskreno, nisam cuo da je iko podigao CME da radi na 1841. Kontam da je mozda Cisco pravio IOS za 1861 pa ga je modifikovao za 1841, posto po Cisco dokumentaciji, najmanja platforma ISR rutera koja podrzava voice je 1861.
[ Ve$eli @ 17.05.2010. 17:39 ] @
U svakom slucaju bi bilo zanimljivo ako bi mogao da pasteujes output da vidimo sta se desava - do kog dela poziv pravilno ide.

Pozdrav,
Veselin
[ Marcony @ 17.05.2010. 20:05 ] @
Cisco 7911 telefon sa ekstenzijom 1003 poziva CIPC sa ekstenzijom 1001:

Code:

CCME#debug ephone detail 
This may severely impact system performance. Continue? [confirm]
EPHONE detail debugging is enabled
CCME#
*May 17 19:05:14.551: ephone-2[1][SEP001A6DCF91F8]:SoftKeyEventMessage event 2 line 0 callref 0
*May 17 19:05:14.551: ephone-2[1]:SK NEWCALL line 0 ref 0
*May 17 19:05:14.551: ephone-2[1]:SkinnyRestartTransferCollect for line 0 chan 1
*May 17 19:05:14.551: ephone-2[1]:SkinnyRestartTransferCollect ignored
*May 17 19:05:14.551: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:14.551: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:14.551: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:14.551: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:14.551: ephone-2[1]:OFFHOOK
*May 17 19:05:14.551: ephone-2[1]:---SkinnySyncPhoneDnOverlays is onhook
*May 17 19:05:14.551: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:14.551: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:14.551: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:14.551: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:14.551: ephone-2[1]:SIEZE on activeLine 0 activeChan 1
*May 17 19:05:14.551: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:14.551: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:14.551: ephone-2[1]:Sieze auto select line 1 chan 1
*May 17 19:05:14.551: ephone-2[1]:UpdateCallState DN 3 chan 1 state 2 calleddn -1 chan 1
*May 17 19:05:14.551: ephone-2[1]:Binding ephone-2 to DN 3 chan 1 s2s:0
*May 17 19:05:14.555: Assign Call Ref 14 to DN 3 chan 1
*May 17 19:05:14.555: Skinny Call State change for DN 3 chan 1 SIEZE from IDLE
*May 17 19:05:14.555: ephone-(2) DN 3 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 0.0.0.0 port=0
*May 17 19:05:14.555: SkinnyUpdateCstate DN 3 chan 1 cstate 1
*May 17 19:05:14.555: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.555: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.555: ephone-2[1][SEP001A6DCF91F8]:SkinnyUpdateCstate first phone for DN 3 chan 1 ref 14
*May 17 19:05:14.555: ephone-2[1]:SkinnyUpdateCState line 1 chan 1 DN 3 ref 14
*May 17 19:05:14.555: ephone-2[1]:SetCallState line 1 DN 3(-1) chan 1 ref 14 TsOffHook
*May 17 19:05:14.555: ephone-2[1]:ClearCallPrompt line 1 ref 14
*May 17 19:05:14.555: ephone-2[1]:SelectPhoneSoftKeys set 4 mask FFFF for line 1 ref 14
*May 17 19:05:14.559: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.559: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.559: ephone-2[1]:SetLineLamp 1 to ON
*May 17 19:05:14.559: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.559: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.559: ephone-2[1]:Check Plar Number 
*May 17 19:05:14.559: ephone-2[1]:SpeakerPhoneOffHook mute 0
*May 17 19:05:14.567: SetDnCodec DN 3 chan 1 codec 4:G711Ulaw64k  vad 0 size 160
*May 17 19:05:14.567: DN 3 chan 1 Voice_Mode
*May 17 19:05:14.567: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.567: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.567: dn_tone_control DN=3 chan 1 tonetype=33:DtInsideDialTone onoff=1 pid=70
*May 17 19:05:14.567: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.567: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.567: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:14.567: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:14.571: ephone-2[1]:CallPrompt line 1 ref 14:tag 132 (Enter Number)
*May 17 19:05:14.571: ephone-2[1]:is_auto_local 0 for DN 3
*May 17 19:05:14.571: Skinny StartTone 33 sent on  ephone socket [1] DtInsideDialTone
*May 17 19:05:15.327: ephone-2[1]:KeypadButtonMessage 1
*May 17 19:05:15.327: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.327: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.327: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.327: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.327: ephone-2[1]:Store ReDial digit: 1
*May 17 19:05:15.327: ephone-2[1]:SkinnyTryCall to 1 instance 1 start at 0 secondary 0 

*May 17 19:05:15.327: dn_tone_control DN=3 chan 1 tonetype=0:DtSilence onoff=0 pid=70
*May 17 19:05:15.327: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.327: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.327: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.327: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.327: ephone-2[1]:is_auto_local 0 for DN 3
*May 17 19:05:15.327: ephone-2[1]:StopTone sent to ephone
*May 17 19:05:15.835: ephone-2[1]:KeypadButtonMessage 0
*May 17 19:05:15.835: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.835: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.835: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:15.835: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:15.835: ephone-2[1]:Store ReDial digit: 10
*May 17 19:05:15.835: ephone-2[1]:SkinnyTryCall to 10 instance 1 start at 0 secondary 0 

*May 17 19:05:16.339: ephone-2[1]:KeypadButtonMessage 0
*May 17 19:05:16.339: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:16.339: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.339: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:16.339: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.339: ephone-2[1]:Store ReDial digit: 100
*May 17 19:05:16.339: ephone-2[1]:SkinnyTryCall to 100 instance 1 start at 0 secondary 0 

*May 17 19:05:16.843: ephone-2[1]:KeypadButtonMessage 1
*May 17 19:05:16.843: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:16.843: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.843: SkinnyGetCallState for DN 3 chan 1 SIEZE
*May 17 19:05:16.843: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.843: ephone-2[1]:Store ReDial digit: 1001
*May 17 19:05:16.843: ephone-2[1]:SkinnyTryCall to 1001 instance 1 start at 0 secondary 0 
SkinnyTryCall to 1001 instance 1 match DN 1
*May 17 19:05:16.843: SkinnyGetCallState for DN 1 chan 1 IDLE
*May 17 19:05:16.843: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:16.843: ephone-2[1]:Skinny-to-Skinny call DN 3 chan 1 to DN 1 chan 1 instance 1
*May 17 19:05:16.843: ephone-2[1]:UpdateCallState DN 3 chan 1 state 1 calleddn 1 chan 1
*May 17 19:05:16.843: ephone-2[1]:Binding ephone-2 to DN 3 chan 1 s2s:0
*May 17 19:05:16.843: Binding calledDn 1 chan 1 to DN 3 chan 1
*May 17 19:05:16.843: Skinny Call State change for DN 3 chan 1 ALERTING from SIEZE
*May 17 19:05:16.843: ephone-(2) DN 3 chan 1 calledDn 1 chan 1 callingDn -1 chan 1 0.0.0.0 port=0
*May 17 19:05:16.843: SkinnyUpdateCstate DN 3 chan 1 cstate 3
*May 17 19:05:16.843: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:16.843: called DN 1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.843: ephone-2[1][SEP001A6DCF91F8]:SkinnyUpdateCstate first phone for DN 3 chan 1 ref 14
*May 17 19:05:16.843: ephone-2[1]:SkinnyUpdateCState line 1 chan 1 DN 3 ref 14
*May 17 19:05:16.843: ephone-2[1][SEP001A6DCF91F8]:Send TsProceed for TsRingOut DN 3 line 1 chan 1
*May 17 19:05:16.843: ephone-2[1]:DialedNumber: 1001 DN 3 line 1 ref 14
*May 17 19:05:16.843: ephone-2[1]:SetCallState line 1 DN 3(-1) chan 1 ref 14 TsProceed
*May 17 19:05:16.847: ephone-2[1]:SetCallState line 1 DN 3(-1) chan 1 ref 14 TsRingOut
*May 17 19:05:16.847: ephone-2[1]:CallPrompt line 1 ref 14:tag 122 (Ring Out)
*May 17 19:05:16.847: ephone-2[1]:SelectPhoneSoftKeys set 8 mask FFFF for line 1 ref 14
*May 17 19:05:16.847: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:16.847: called DN 1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.847: ephone-2[1]:SetLineLamp 1 to ON
*May 17 19:05:16.847: SetCallInfo calling dn 3 chan 1 dn 3 chan 1
calling [1003] called [1001] called name 
*May 17 19:05:16.847: SetCallInfo DN 3 chan 1 is not skinny-to-skinny
*May 17 19:05:16.847: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:16.847: called DN 1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:16.847: ephone-2[1]:DisplayCallInfo outgoing call line 1 ref 14
*May 17 19:05:16.847: ephone-2[1]:DisplayCallInfo callingNumber=1003

*May 17 19:05:16.847: ephone-2[1]::callingNumber 1003

*May 17 19:05:16.847: ephone-2[1]::callingParty 1003

*May 17 19:05:16.847: ephone-2[1]:Call Info DN 3 line 1 ref 14 call state 1 called 1001 calling 1003 origcalled 
*May 17 19:05:16.847: ephone-2[1]:SkinnyTryCall to 1001 instance 1 start at 0 secondary 0 
SkinnyTryCall to 1001 instance 1 match DN 1
*May 17 19:05:16.847: ephone-2[1]:SkinnyTryCall to 1001 instance 1 start at 0 secondary 0 
SkinnyTryCall to 1001 instance 1 match DN 1
*May 17 19:05:16.847: ephone-2[1]:Call Info DN 3 line 1 ref 14 called 1001 calling 1003 origcalled 1001 calltype 2
*May 17 19:05:16.851: ephone-2[1]:Call Info for chan 1
*May 17 19:05:16.851: ephone-2[1]: No-Name calling 
*May 17 19:05:16.851: ephone-2[1]: No-Name
*May 17 19:05:16.851: dn_support_srtp phone 2 DN 3 chan 1 not support type 2
*May 17 19:05:26.851: dn_tone_control DN=3 chan 1 tonetype=37:DtReorderTone onoff=1 pid=70
*May 17 19:05:26.851: ephone-2[1]:DN 3 disc reason 16 normal state ALERTING
*May 17 19:05:26.851: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:26.851: called DN 1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:26.851: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:26.851: called DN 1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:26.851: ephone-2[1]:is_auto_local 1 for DN 3
*May 17 19:05:26.851: Skinny StartTone 37 sent on  ephone socket [1] DtReorderTone
*May 17 19:05:26.851: ephone-2[1]:CallPrompt line 1 ref 14:tag 122 (Ring Out)
*May 17 19:05:26.851: ephone-2[1]:SelectPhoneSoftKeys set 8 mask FFFE for line 1 ref 14
*May 17 19:05:26.855: ephone-2[1]:CallPrompt line 1 ref 14:tag 156 (Unknow number)
*May 17 19:05:30.459: ephone-2[1][SEP001A6DCF91F8]:SoftKeyEventMessage event 9 line 1 callref 14
*May 17 19:05:30.459: ephone-2[1]:SK ENDCALL line 1 ref 14
*May 17 19:05:30.459: ephone-2[1]:ONHOOK (internal)
*May 17 19:05:30.459: ephone-2[1]:ClearCallPrompt line 1 ref 14
*May 17 19:05:30.459: ephone-2[1][SEP001A6DCF91F8]:CallPrompt line 1 ref 14:     
*May 17 19:05:30.459: ephone-2[1]:Line 1 chan 1 refresh (DN 3 state=1)
*May 17 19:05:30.459: ephone-2[1]:Check for transfer commit line 1 chan 1
*May 17 19:05:30.459: ephone-2[1]:Clean-up transferor_dn -1 consult_dn -1
*May 17 19:05:30.459: SkinnyGetCallState for DN 3 chan 1 ALERTING
*May 17 19:05:30.459: called DN -1 chan 1, calling DN -1 chan 1 phone 2 s2s:0
*May 17 19:05:30.459: ephone-2[1][SEP001A6DCF91F8]:Onhook clean up for DN 3 chan 1 in state 1
*May 17 19:05:30.459: ephone-2[1]:call clean up this DN 3 chan 1 was calling other DN -1 chan 1
*May 17 19:05:30.459: this ephone-2 other ephone-(-1) other DN state UNKNOWN
*May 17 19:05:30.459: ephone-2[1][SEP001A6DCF91F8]:Media already stopped line 1 DN 3 chan 1
*May 17 19:05:30.459: UpdateCallState DN 3 chan 1 state 0 phone-ref -1 calleddn -1 calleddn_chan 1
*May 17 19:05:30.459: DN 3 chan 1 End Voice_Mode
*May 17 19:05:30.459: SkinnySetDnInvokeId DN 3 chan 1 id 0 set=0
*May 17 19:05:30.459: SetCallInfo calling dn -1 chan 1 dn 3 chan 1
calling [] called []
*May 17 19:05:30.459: SetCallInfo DN 3 chan 1 is not skinny-to-skinny
*May 17 19:05:30.459: Skinny Call State change for DN 3 chan 1 IDLE from ALERTING
*May 17 19:05:30.459: ephone-(-1) DN 3 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 0.0.0.0 port=0
*May 17 19:05:30.459: SkinnyUpdateCstate DN 3 chan 1 cstate 2
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: ephone-2[1][SEP001A6DCF91F8]:SkinnyUpdateCstate first phone for DN 3 chan 1 ref 14
*May 17 19:05:30.463: ephone-2[1][SEP001A6DCF91F8]:SkinnyUpdateCState process cstate 2 for inactive DN 3 chan 1
*May 17 19:05:30.463: ephone-2[1]:SkinnyUpdateCstate inactive (overlay) line 1 for DN 3 ref 14 combo=0
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: DN 3 chan 1 ephone-2 state set to 2
*May 17 19:05:30.463: ephone-2[1]:SetCallState line 1 DN 3(3) chan 1 ref 14 TsOnHook
*May 17 19:05:30.463: ephone-2[1]:ClearCallPrompt line 1 ref 14
*May 17 19:05:30.463: ephone-2[1]:SelectPhoneSoftKeys set 0 mask FFBF for line 1 ref 14
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.463: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:30.463: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.467: ephone-2[1]:Clean Up Speakerphone state
*May 17 19:05:30.467: ephone-2[1]:SpeakerPhoneOnHook
*May 17 19:05:30.467: ephone-2[1]:StopTone sent to ephone
*May 17 19:05:30.467: Skinny StopTone sent on ephone socket [1] 
*May 17 19:05:30.467: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.467: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.467: ephone-2[1]:SetLineLamp 1 to OFF
*May 17 19:05:30.467: UnBinding ephone-2 from DN 3 chan 1
*May 17 19:05:30.467: ephone-2[1]:SkinnyArmPhoneCallbacks scan 2 lines
*May 17 19:05:30.467: ephone-2[1]:SkinnyArmPhoneCallbacks for 2 targets
*May 17 19:05:30.467: ephone-2[1][SEP001A6DCF91F8]:CallPrompt line 0 ref 0:  Cisco CME
*May 17 19:05:30.467: ephone-2[1]:SkinnyCheckPendingCallBackPhone scan 2 lines
*May 17 19:05:30.471: ephone-2[1]:---SkinnySyncPhoneDnOverlays is onhook
*May 17 19:05:30.471: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.471: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.471: SkinnyGetCallState for DN 3 chan 2 IDLE
*May 17 19:05:30.471: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.471: ephone-2[1]:SpeakerPhoneOnHook
*May 17 19:05:30.471: ephone-2[1]:ClearCallPrompt line 0 ref 0
*May 17 19:05:30.471: ephone-2[1]:SelectPhoneSoftKeys set 0 mask FFBF for line 0 ref 0
*May 17 19:05:30.475: ephone-2[1][SEP001A6DCF91F8]:CallPrompt line 0 ref 0:  Cisco CME
*May 17 19:05:30.475: ephone-2[1]:SkinnyCheckPendingCallBackPhone scan 2 lines
*May 17 19:05:30.483: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.483: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.483: dn_tone_control DN=3 chan 1 tonetype=0:DtSilence onoff=0 pid=70
*May 17 19:05:30.483: SkinnyGetCallState for DN 3 chan 1 IDLE
*May 17 19:05:30.483: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0
*May 17 19:05:30.483: ephone-2[1]:Check toneOn state for last_phone
*May 17 19:05:30.727: 
Skinny StationAlarmMessage on socket [1] 192.168.10.2 SEP001A6DCF91F8
*May 17 19:05:30.727: **** severityCritical p1=0 [0x0] p2=0 [0x0]
*May 17 19:05:30.727: 32: Name=SEP001A6DCF91F8 Load= term11.default : Invalid SCCP message! : ID :9a:u all
Port Statistics for unclassified packets is not turned on.

All possible debugging has been turned off
CCME#
[ Ve$eli @ 18.05.2010. 12:05 ] @
Sve to ide dobro do neke tacke kada treba da se poziv rutira ka drugoj strani - dobro radi komunikacija izmedju ephone-3 tj 7911 i CME, ali kada poziv treba da se rutira ka CIPC-u, onda CME to ili ne zna ili mu je zabranjeno :) - tako da postoje samo SCCP poruke izmedju 7911 i CME, nema poruka izmedju CIPC-a i CME-a.
U logu bi video da ephone-1 salje neke poruke a toga ovde nema.

E sada, mozemo jos videti ako te ne mrzi virtuelne voice portove i virtuelne dial-peerove (koriste se za rutiranje poziva) - kada se kreira neki DN, onda se stvara virtuelni dial-peer i virtuelni voice port i oni se ne vide u konfiguraciji. Mozemo videti da li su kreirani sa komandama:
Code:
show voice port summary

i
Code:
show dial-peer voice summary
[ Marcony @ 18.05.2010. 21:49 ] @
Ja bih rekao da mu je zabranjeno :)

Code:

CCME#show voice port summary      
                                     IN       OUT
PORT      CH   SIG-TYPE   ADMIN OPER STATUS   STATUS   EC
========= == ============ ===== ==== ======== ======== ==
50/0/1    1      efxs     up    dorm on-hook  idle     y 
50/0/1    2      efxs     up    dorm on-hook  idle     y 
50/0/2    1      efxs     up    dorm on-hook  idle     y 
50/0/2    2      efxs     up    dorm on-hook  idle     y 
50/0/3    1      efxs     up    dorm on-hook  idle     y 
50/0/3    2      efxs     up    dorm on-hook  idle     y 

CCME#show dial-peer voice summary 
dial-peer hunt 0
             AD                                    PRE PASS                OUT 
TAG    TYPE  MIN  OPER PREFIX    DEST-PATTERN      FER THRU SESS-TARGET    STAT PORT
20004  pots  up   up             1001$              0                           50/0/1
20005  pots  up   up             1002$              0                           50/0/2
20006  pots  up   up             1003$              0                           50/0/3
CCME#
[ Ve$eli @ 19.05.2010. 06:39 ] @
I ja :) Mada me iskreno i zacudilo da se telefoni registruju, ali Cisco moze zabraniti kako hoce da bi uzeo vise $ na visim platformama. Uglavnom, ne bih imao ideju sta dalje pokusavati da poziv krene dalje.

Pozdrav,
Veselin
[ Marcony @ 19.05.2010. 08:12 ] @
Slucajno sam postavio oba telefona na istu ekstenziju.
Kada na jednom podignem slusalicu, na drugom se jasno vidi da je lokal zauzet!

Sve radi, samo glavno ne radi :)))))
[ zeenmc @ 11.10.2012. 18:39 ] @
Stara tema, ali na novootvorenoj nisam dobio odgovor, treba mi CME zbog spremanja ccna voice, imam ruter 2801, kako mogu da ga instaliram ? treba mi za 2 telefona 7940 i 7912

Zahvaljujem na odgovoru :)