[asterisk-dev] Channel problems

[Anthony LaMantia]

you may want to post this to mantis at bugs.digium.com so if it is a bug 
it can be documented , tagged, and looked into

voip at gmx-topmail.de wrote:
> Hi,
>
> again have strange channel problems with sip:
>
> ------
>
> Jul 15 16:52:51 VERBOSE[18440] logger.c:     -- Executing
> DeadAGI("SIP/mysipid-3d7b", "newalepo.php") in new stack
> Jul 15 16:52:51 VERBOSE[18440] logger.c:     -- Launched AGI Script
> /var/lib/asterisk/agi-bin/newalepo.php
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_request' =>
> 'newalepo.php'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_channel' =>
> 'SIP/mysipid-3d7b'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_language' => 'en'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_type' => 'SIP'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_uniqueid' =>
> '1152982371.5285'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_callerid' =>
> 'mysipid'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_calleridname' =>
> 'mysipid'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_callingpres' =>
> '0'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_callingani2' =>
> '0'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_callington' => '0'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_callingtns' => '0'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_dnid' =>
> '92215616237'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_rdnis' =>
> 'unknown'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_context' =>
> 'from-gigasip-user'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_extension' =>
> '92215616237'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_priority' => '1'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_enhanced' => '0.0'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 'agi_accountcode' =>
> 'mysipid'
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: 
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: string(96) "mysipid
> ; SIP/mysipid-3d7b ; 1152982371.5285 ; mysipid ; 0092215616237 ;
> 92215616237"n
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: >> SET AUTOHANGUP 3600
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: >> SET CALLERID 
> Jul 15 16:52:51 VERBOSE[18440] logger.c:   newalepo.php: >> EXEC DIAL
> sip/70092215616237 at 217.111.25.154
> Jul 15 16:52:51 VERBOSE[18440] logger.c:     -- AGI Script Executing
> Application: (DIAL) Options: (sip/70092215616237 at 217.111.25.154)
> Jul 15 16:52:51 DEBUG[18440] res_config_mysql.c: MySQL RealTime: Retrieve SQL:
> SELECT * FROM sipfriends WHERE name = '217.111.25.154'
> Jul 15 16:52:51 DEBUG[18440] res_config_mysql.c: MySQL RealTime: Everything is
> fine.
> Jul 15 16:52:51 DEBUG[18440] chan_sip.c: Outgoing Call for 70092215616237
> Jul 15 16:52:51 VERBOSE[18440] logger.c:     -- Called
> 70092215616237 at 217.111.25.154
> Jul 15 16:53:06 VERBOSE[18440] logger.c:     -- SIP/217.111.25.154-bb31 is
> making progress passing it to SIP/mysipid-3d7b
> Jul 15 16:53:07 DEBUG[18440] chan_sip.c: Oooh, format changed to 2
> Jul 15 16:53:09 NOTICE[18440] rtp.c: Comfort noise support incomplete in
> Asterisk (RFC 3389). Please turn off on client if possible. Client IP:
> 217.111.25.154
> Jul 15 16:53:17 VERBOSE[18440] logger.c:     -- SIP/217.111.25.154-bb31 is
> making progress passing it to SIP/mysipid-3d7b
> Jul 15 16:54:02 VERBOSE[18440] logger.c:     -- SIP/217.111.25.154-bb31 answered
> SIP/mysipid-3d7b
> Jul 15 16:54:02 VERBOSE[18440] logger.c:     -- Attempting native bridge of
> SIP/mysipid-3d7b and SIP/217.111.25.154-bb31
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> .
> .
> .
> repeated 2 million times
> ...
> ...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 17:52:51 DEBUG[18440] channel.c: Nobody there, continuing...
> Jul 15 18:05:45 DEBUG[18440] channel.c: Didn't get a frame from channel:
> SIP/217.111.25.154-bb31
> Jul 15 18:05:45 DEBUG[18440] channel.c: Bridge stops bridging channels
> SIP/mysipid-3d7b and SIP/217.111.25.154-bb31
> Jul 15 18:05:45 DEBUG[18440] chan_sip.c: update_call_counter(70092215616237) -
> decrement call limit counter
> Jul 15 18:05:45 DEBUG[18440] app_dial.c: Exiting with DIALSTATUS=ANSWER.
> Jul 15 18:05:45 VERBOSE[18440] logger.c:   newalepo.php: >> GET VARIABLE
> ANSWEREDTIME
> Jul 15 18:05:45 VERBOSE[18440] logger.c:   newalepo.php: >> GET VARIABLE
> DIALSTATUS
> Jul 15 18:05:45 VERBOSE[18440] logger.c:   newalepo.php: string(6) "ANSWER"n
> Jul 15 18:05:45 VERBOSE[18440] logger.c:     -- AGI Script newalepo.php
> completed, returning 0
> Jul 15 18:05:45 DEBUG[18440] pbx.c: Extension 92215616237, priority 1 returned
> normally even though call was hung up
> Jul 15 18:05:45 DEBUG[18440] cdr_addon_mysql.c: cdr_mysql: inserting a CDR
> record.
> Jul 15 18:05:45 DEBUG[18440] cdr_addon_mysql.c: cdr_mysql: SQL command as
> follows: INSERT INTO cdr
> (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode)
> VALUES ('2006-07-15 16:52:51','\"mysipid\"
> <mysipid>','mysipid','92215616237','contextsip',
> 'SIP/mysipid-3d7b','SIP/217.111.25.154-bb31','Dial','sip/70092215616237 at 217.111.25.154',4374,4303,'ANSWERED',3,'mysipid')
>
> Jul 15 18:05:45 DEBUG[18440] chan_sip.c: update_call_counter(mysipid) -
> decrement call limit counter
>
> -----
>
> So why is asterisk keeping channels up when "...Nobody there, continuing...". And what happened there? Won't Asterisk hangup when the user pulls the line out of the wall? Or when the user looses signal from his Accesspoint using a WLAN phone?
>
>
> Thanks
>