[asterisk-dev] ADSI: "unable to send CAS" in __adsi_transmit_messages()

[Michael Grigoni]

Greetings:

We've been running Asterisk CVS-HEAD-03/14/05-09:27:05e on Linux 2.4.27
(headless, diskless) for more than a year with Quicknet FXS and generic
(winmodem) FXO hardware; we just connected a Nortel/Aastra 390 ADSI
phone on Phone/phone0 (Quicknet) and configured ADSI as follows:

1. added 'adsi=yes' to zapata.conf (for what its worth since the
    phone isn't on a zap channel)

2. added an ADSI programming extension to 'extensions.conf':
    exten => 9298,1,ADSIProg(tryit.adsi)
    exten => 9298,n,Hangup()

Caller ID is working on the Aastra 390 on Phone/phone0; ADSI programming
fails as follows:

(Asterisk started as: 'asterisk -vvvv -dddd -c')

Console log messages

      -- Executing ADSIProg("Phone/phone0", "tryit.adsi") in new stack
Urgent handler
     -- ADSI Available on CPE.  Attempting Upload.
Urgent handler
Apr  6 17:46:17 WARNING[8879]: res_adsi.c:205 __adsi_transmit_messages: 
Unable to send CAS
     -- Hungup 'Phone/phone0'
Urgent handler


/var/log/asterisk/full:

Apr  6 19:02:45 DEBUG[9067]: Device 'Phone/phone0' changed to state '2'
Apr  6 19:02:45 DEBUG[9068]: Launching 'ADSIProg'
Apr  6 19:02:45 VERBOSE[9068]: Asterisk Ready.
     -- Executing ADSIProg("Phone/phone0", "tryit.adsi") in new stack
Apr  6 19:02:45 VERBOSE[9068]:     -- ADSI Available on CPE.  Attempting 
Upload.
Apr  6 19:02:45 DEBUG[9068]: Set channel Phone/phone0 to write format ulaw
Apr  6 19:02:45 DEBUG[9068]: Set channel Phone/phone0 to read format ulaw
Apr  6 19:02:46 WARNING[9068]: Unable to send CAS
Apr  6 19:02:47 DEBUG[9068]: No ADSI CPE detected (0)
Apr  6 19:02:47 DEBUG[9068]: Spawn extension (local,9298,1) exited 
non-zero on 'Phone/phone0'
Apr  6 19:02:47 DEBUG[9068]: Hanging up channel 'Phone/phone0'
Apr  6 19:02:47 DEBUG[9068]: phone_hangup(Phone/phone0)
Apr  6 19:02:47 DEBUG[9068]: Got hunghup, giving busy signal
Apr  6 19:02:47 VERBOSE[9068]:     -- Hungup 'Phone/phone0'
Apr  6 19:02:47 DEBUG[9070]: Device 'Phone/phone0' changed to state '0'
Apr  6 19:02:47 DEBUG[9070]: Device 'Phone/phone0' changed to state '0'


The log message "Unable to send CAS" appears to be a result of a
failure in 'adsi_careful_send()' which is silent on this failure:

/* If we don't get anything at all back in a second, forget
                    about it */
                 if (ast_waitfor(chan, 1000) < 1)
                         return -1;

Before I start peppering the code with printfs I'd appreciate some
input.  The phone _DOES_ download ADSI programming from Sayson over
the PSTN.

There is one old reference in the original [Asterisk] list that
ADSI on Quicknet FXS isn't working.  All help much appreciated.

Regards,

Michael Grigoni
Cybertheque Museum