Topic: 2.2.1-565 - Inbound routes not working properly.

[llandry]

Hi all,

Quick history:   Original 2.1.15 switch was upgraded to 2.2.1-545 then to 2.2.1-565..

I originally ( 2.1.15 ) had all incoming calls going to the default Greeting.. Ever since I've upgraded to 2.2.1, all my calls get routed to my Operator extention no matter the setting in Open/Closed inbound route in the Trunk definition...

Is there a new setting or some other change in 2.2.1 to get this to work properly... Is this maybe an upgrade issue?

Everything else is working perfectly so far.

Thanks in advance.

L2

[SARK devs]

HI Llandry

We have seen a few routing problems after upgrade but we've never been able to recreate them in the lab. 

I'll need to see a trace...

at the linux prompt...

Code: [Select]

asterisk -r
stop now
asterisk -vvvvc
agi debug

Run an inbound call and post the output here.

stop asterisk with

Code: [Select]

agi no debug
stop now

now close it gracefully and restart it with

Code: [Select]

/etc/init.d/sark stop
/etc/init.d/sark start
thx

S

[llandry]

This call should have been routed to the default Greeting..

Code: [Select]

*CLI>     -- Accepting UNAUTHENTICATED call from 206.191.37.138:
       > requested format = ulaw,
       > requested prefs = (ulaw|gsm),
       > actual format = gsm,
       > host prefs = (g729|gsm|ulaw|alaw),
       > priority = mine
    -- Executing [6477236652@mainmenu:1] AGI("IAX2/6477236652-9", "selintra|Inbound|6477236652") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: IAX2/6477236652-9
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1196624730.0
AGI Tx >> agi_callerid: 5192160299
AGI Tx >> agi_calleridname: unknown
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: mainmenu
AGI Tx >> agi_extension: 6477236652
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << SET VARIABLE MOH ""
AGI Tx >> 200 result=1
AGI Rx << SET CALLERID 5192160299
AGI Tx >> 200 result=1
AGI Rx << EXEC Ringing
    -- AGI Script Executing Application: (Ringing) Options: ((null))
AGI Tx >> 200 result=0
AGI Rx << EXEC Wait 3
    -- AGI Script Executing Application: (Wait) Options: (3)
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << SET VARIABLE REMOTENUM "6477236652"
AGI Tx >> 200 result=1
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << SET VARIABLE OPEN "YES"
AGI Tx >> 200 result=1
AGI Rx << DATABASE GET "STAT" "IVRSTAT"
AGI Tx >> 200 result=0
AGI Rx << EXEC Background silence/1
    -- AGI Script Executing Application: (Background) Options: (silence/1)
    -- <IAX2/6477236652-9> Playing 'silence/1' (language 'en')
AGI Tx >> 200 result=0
AGI Rx << SET PRIORITY 1
AGI Tx >> 200 result=0
AGI Rx << SET EXTENSION s
AGI Tx >> 200 result=0
AGI Rx << SET CONTEXT defaultOpenGreet
AGI Tx >> 200 result=0
    -- AGI Script selintra completed, returning 0
    -- Executing [s@defaultOpenGreet:1] BackGround("IAX2/6477236652-9", "if-u-know-ext-dial") in new stack
[Dec  2 14:45:34] WARNING[22219]: file.c:563 ast_openstream_full: File if-u-know-ext-dial does not exist in any format
[Dec  2 14:45:34] WARNING[22219]: file.c:866 ast_streamfile: Unable to open if-u-know-ext-dial (format 0x2 (gsm)): No such file or directory
[Dec  2 14:45:34] WARNING[22219]: pbx.c:5678 pbx_builtin_background: ast_streamfile failed on IAX2/6477236652-9 for if-u-know-ext-dial
    -- Executing [s@defaultOpenGreet:2] BackGround("IAX2/6477236652-9", "otherwise") in new stack
[Dec  2 14:45:34] WARNING[22219]: file.c:563 ast_openstream_full: File otherwise does not exist in any format
[Dec  2 14:45:34] WARNING[22219]: file.c:866 ast_streamfile: Unable to open otherwise (format 0x2 (gsm)): No such file or directory
[Dec  2 14:45:34] WARNING[22219]: pbx.c:5678 pbx_builtin_background: ast_streamfile failed on IAX2/6477236652-9 for otherwise
    -- Executing [s@defaultOpenGreet:3] BackGround("IAX2/6477236652-9", "pls-hold-while-try") in new stack
[Dec  2 14:45:34] WARNING[22219]: file.c:563 ast_openstream_full: File pls-hold-while-try does not exist in any format
[Dec  2 14:45:34] WARNING[22219]: file.c:866 ast_streamfile: Unable to open pls-hold-while-try (format 0x2 (gsm)): No such file or directory
[Dec  2 14:45:34] WARNING[22219]: pbx.c:5678 pbx_builtin_background: ast_streamfile failed on IAX2/6477236652-9 for pls-hold-while-try
    -- Executing [s@defaultOpenGreet:4] BackGround("IAX2/6477236652-9", "silence/3") in new stack
    -- <IAX2/6477236652-9> Playing 'silence/3' (language 'en')
    -- Executing [s@defaultOpenGreet:5] Goto("IAX2/6477236652-9", "defaultOpenGreet|t|1") in new stack
    -- Goto (defaultOpenGreet,t,1)
    -- Executing [t@defaultOpenGreet:1] Goto("IAX2/6477236652-9", "extensions|5001|1") in new stack
    -- Goto (extensions,5001,1)
    -- Executing [5001@extensions:1] AGI("IAX2/6477236652-9", "selintra|InCall|") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: IAX2/6477236652-9
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1196624730.0
AGI Tx >> agi_callerid: 5192160299
AGI Tx >> agi_calleridname: unknown
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: extensions
AGI Tx >> agi_extension: 5001
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfimopen" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "cfim" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfimopen" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfim" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "ringdelay" "5001"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE MOH
AGI Tx >> 200 result=1 ()
AGI Rx << EXEC Dial SIP/5001|15|tTwW
    -- AGI Script Executing Application: (Dial) Options: (SIP/5001|15|tTwW)
    -- Called 5001
    -- SIP/5001-08b28c50 is ringing
[Dec  2 14:45:40] NOTICE[22219]: cdr.c:434 ast_cdr_free: CDR on channel 'SIP/5001-08b28c50' not posted
AGI Tx >> 200 result=-1
  == Spawn extension (extensions, 5001, 1) exited non-zero on 'IAX2/6477236652-9'
    -- Executing [h@extensions:1] Hangup("IAX2/6477236652-9", "") in new stack
  == Spawn extension (extensions, h, 1) exited non-zero on 'IAX2/6477236652-9'
    -- Hungup 'IAX2/6477236652-9'
    -- Saved useragent "Cisco-CP7940G/8.0" for peer 5001
    -- Saved useragent "Cisco-CP7940G/8.0" for peer 5000


It apears to be looking for voice files but none can be found.... I've search for  "if-u-know*" and it's nowhere to be found..

update:
After downloading and installing a new voice pack, I'm now geting the Default greeting...
I'm still not going to a conference though.



The following should have routed  directly to a conf.. ( 700 )

Code: [Select]

     -- Accepting UNAUTHENTICATED call from 206.191.37.138:
       > requested format = ulaw,
       > requested prefs = (ulaw|gsm),
       > actual format = gsm,
       > host prefs = (g729|gsm|ulaw|alaw),
       > priority = mine
    -- Executing [6477236652@mainmenu:1] AGI("IAX2/6477236652-9", "selintra|Inbound|6477236652") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: IAX2/6477236652-9
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1196625344.0
AGI Tx >> agi_callerid: 5192160299
AGI Tx >> agi_calleridname: unknown
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: mainmenu
AGI Tx >> agi_extension: 6477236652
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << SET VARIABLE MOH ""
AGI Tx >> 200 result=1
AGI Rx << SET CALLERID 5192160299
AGI Tx >> 200 result=1
AGI Rx << EXEC Ringing
    -- AGI Script Executing Application: (Ringing) Options: ((null))
AGI Tx >> 200 result=0
AGI Rx << EXEC Wait 3
    -- AGI Script Executing Application: (Wait) Options: (3)
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << SET VARIABLE REMOTENUM "6477236652"
AGI Tx >> 200 result=1
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << SET VARIABLE OPEN "YES"
AGI Tx >> 200 result=1
AGI Rx << DATABASE GET "STAT" "IVRSTAT"
AGI Tx >> 200 result=0
AGI Rx << SET PRIORITY 1
AGI Tx >> 200 result=0
AGI Rx << SET EXTENSION 5001
AGI Tx >> 200 result=0
AGI Rx << SET CONTEXT extensions
AGI Tx >> 200 result=0
    -- AGI Script selintra completed, returning 0
    -- Executing [5001@extensions:1] AGI("IAX2/6477236652-9", "selintra|InCall|") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: IAX2/6477236652-9
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1196625344.0
AGI Tx >> agi_callerid: 5192160299
AGI Tx >> agi_calleridname: unknown
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: extensions
AGI Tx >> agi_extension: 5001
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfimopen" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "cfim" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfimopen" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "STAT" "OCSTAT"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE IFTIME(18:00-07:00|mon|1|jan?CLOSED:OPEN)
AGI Tx >> 200 result=1 (OPEN)
AGI Rx << DATABASE GET "cfim" "5001"
AGI Tx >> 200 result=0
AGI Rx << DATABASE GET "ringdelay" "5001"
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE MOH
AGI Tx >> 200 result=1 ()
AGI Rx << EXEC Dial SIP/5001|15|tTwW
    -- AGI Script Executing Application: (Dial) Options: (SIP/5001|15|tTwW)
    -- Called 5001
    -- SIP/5001-08b862a0 is ringing
[Dec  2 14:55:54] NOTICE[22439]: cdr.c:434 ast_cdr_free: CDR on channel 'SIP/5001-08b862a0' not posted
AGI Tx >> 200 result=-1
  == Spawn extension (extensions, 5001, 1) exited non-zero on 'IAX2/6477236652-9'
    -- Executing [h@extensions:1] Hangup("IAX2/6477236652-9", "") in new stack
  == Spawn extension (extensions, h, 1) exited non-zero on 'IAX2/6477236652-9'
    -- Hungup 'IAX2/6477236652-9'




Thanks !

L2

[SARK devs]

Interesting....

What does this give....

Code: [Select]

db selintra show 6477236652
Kind Regards

S

[llandry]

S, 

sorry for the late reply.... got sidetracked..

Here's the output:

Code: [Select]

6477236652=lineIO
    active=YES
    callerid=647 7236652
    carrier=Unlimitel
    closecustom=
    closedisa=NO
    closeext=
    closegreet=1000
    closeivr=NO
    closequeue=None
    closeroute=700
    closesibling=None
    closespeed=
    cluster=default
    custom=
    desc=6477236652
    disa=NO
    disapass=
    ext=
    faxdetect=NO
    forceivr=NO
    host=xxxx.xxxxxxx.ca
    inprefix=
    lcl=NO
    macaddr=
    match=
    moh=YES
    monitor=YES
    opengreet=None
    openroute=700
    opensibling=None
    password=xxxxxxx
    pat=
    provision=
    queue=None
    register=6477236652:xxxxxxx@xxx.xxxxxxx.ca
    remotenum=6477236652
    sipiaxpeer=type=peer
host=iax02.unlimitel.ca
qualify=3000
canreinvite=no
username=6477236652
fromuser=6477236652
secret=2154068
disallow=all
allow=g729
allow=gsm
allow=ulaw
allow=alaw
    sipiaxuser=type=user
context=mainmenu
    speed=
    tag=
    transform=91800:1800 91888:1888 91877:1877 91866:1866 91: 9:
    username=6477236652
    zapcaruser=
    zzeor=EOR

couple new observations.... After you solved my issue with the default greeting, I upgraded the Office switch to 2.2.1-565... Same scenario as my home switch ( 2.1.15 to 2.2.1)

1) Again, the new asterisk distribution was missing some sounds files...
2) SIPDefault.cnf is being overwritten. (/tftpboot)
3) Parking a call causes the call to be dropped ( happened in 2.1.15 as well )

Again, thanks for all the assistance.

L2

[SARK devs]

Hi Llandry,

We've seen this once before (in Canada) where someone upgraded from 2.1.15.  2.1.15 was/is a pretty bleeding edge release.  Can you send us a copy of /home/e-smith/db/selintra so we can put a copy of your system up here?

send it to admin@selintra.com aand mark it for my attention

re sipDefault - look in ipdevices and replace our image with yours.

parking - try using the ordinary transfer button on the phone and then *5+send

Best

Jeff

[llandry]

Sure thing....

it's on it's way.

Thanks

L2