[Asterisk-bugs] [Asterisk 0010091]: not register
noreply at bugs.diguim.com
noreply at bugs.diguim.com
Fri Jun 29 14:25:16 CDT 2007
email_notification_title_for_action_bugnote_submitted
======================================================================
http://bugs.digium.com/view.php?id=10091
======================================================================
Reported By: jeanneth
Assigned To:
======================================================================
Project: Asterisk
Issue ID: 10091
Category: Channels/chan_sip/Registration
Reproducibility: always
Severity: crash
Priority: normal
Status: feedback
Asterisk Version: 1.4.5
SVN Branch (only for SVN checkouts, not tarball releases): trunk
SVN Revision (number only!): 72662
Disclaimer on File?: No
Request Review:
======================================================================
Date Submitted: 06-29-2007 13:16 CDT
Last Modified: 06-29-2007 14:25 CDT
======================================================================
Summary: not register
Description:
*CLI> [Jun 29 13:11:35] NOTICE[25987]: chan_sip.c:13058
handle_response_peerpoke: Peer 'linea1' is now Reachable. (95ms / 1000ms)
[Jun 29 13:11:35] NOTICE[25987]: chan_sip.c:11596 sip_dump_history: You
must have debugging enabled (SIP or Asterisk) in order to dump SIP
history.
[Jun 29 13:11:35] NOTICE[25987]: chan_sip.c:13058
handle_response_peerpoke: Peer 'prueba1' is now Reachable. (1ms / 3000ms)
[Jun 29 13:11:36] NOTICE[25987]: chan_sip.c:13058
handle_response_peerpoke: Peer 'prueba2' is now Reachable. (241ms /
2000ms)
[Jun 29 13:11:39] NOTICE[25987]: chan_sip.c:16084 sip_poke_noanswer: Peer
'20088' is now UNREACHABLE! Last qualify: 0
======================================================================
----------------------------------------------------------------------
jeanneth - 06-29-07 14:25
----------------------------------------------------------------------
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4750 sip_alloc: Allocating new
SIP dialog for (No Call-ID) - INVITE (With RTP)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2948 do_setnat: Setting NAT on
RTP to Off
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4215 sip_new: *** Our native
formats are 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4216 sip_new: *** Joint
capabilities are 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4217 sip_new: *** Our
capabilities are 0x105 (g723|ulaw|g729)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4218 sip_new: ***
AST_CODEC_CHOOSE formats are 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4220 sip_new: *** Our preferred
formats from the incoming channel are 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4246 sip_new: This channel will
not be able to handle video.
[Jun 29 14:50:25] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable
STACK-gt-locales-24840367-1.
[Jun 29 14:50:25] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPCALLID.
[Jun 29 14:50:25] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPDOMAIN.
[Jun 29 14:50:25] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPURI.
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:3223 sip_call: Outgoing Call
for 50224840367
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:3404 update_call_counter:
Updating call counter for outgoing call
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:3242 sip_call: Our T38
capability (0), joint T38 capability (0)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6764 add_sdp: ** Our
capability: 0x4 (ulaw) Video flag: False Text flag: False
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6765 add_sdp: ** Our prefcodec:
0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6922 add_sdp: -- Done with
adding codecs to SDP
[Jun 29 14:50:25] DEBUG[26109]: channel.c:2448
ast_internal_timing_enabled: Internal timing is disabled
(option_internal_timing=0 chan->timingfd=-1)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6980 add_sdp: Done building
SDP. Settling with this capability: 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:1749 initialize_initreq:
Initializing initreq for method INVITE - callid
5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254
-- Called gt-isis/50224840367
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4812 find_call: = Found Their
Call ID: 5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254 Their Tag Our
tag: as7442af66
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2280 __sip_ack: Acked pending
invite 102
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on '5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254' of
Request 102: Match Found
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:12542 handle_response_invite:
SIP response 407 to standard invite
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11947 do_proxy_auth: Auth
attempt 1 on INVITE
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6764 add_sdp: ** Our
capability: 0x4 (ulaw) Video flag: False Text flag: False
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6765 add_sdp: ** Our prefcodec:
0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6922 add_sdp: -- Done with
adding codecs to SDP
[Jun 29 14:50:25] DEBUG[26109]: channel.c:2448
ast_internal_timing_enabled: Internal timing is disabled
(option_internal_timing=0 chan->timingfd=-1)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:6980 add_sdp: Done building
SDP. Settling with this capability: 0x4 (ulaw)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4812 find_call: = Found Their
Call ID: 5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254 Their Tag Our
tag: as7442af66
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2280 __sip_ack: Acked pending
invite 103
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on '5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254' of
Request 103: Match Found
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:12542 handle_response_invite:
SIP response 403 to standard invite
[Jun 29 14:50:25] WARNING[26109]: chan_sip.c:12739 handle_response_invite:
Received response: "Forbidden" from '"jeanneth"
<sip:20088 at 216.144.238.254>;tag=as7442af66'
[Jun 29 14:50:25] WARNING[26109]: chan_sip.c:12739 handle_response_invite:
Received response: "Forbidden" from '"jeanneth"
<sip:20088 at 216.144.238.254>;tag=as7442af66'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:1760 sip_alreadygone: Setting
SIP_ALREADYGONE on dialog 5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254
-- SIP/gt-isis-099fabe8 is circuit-busy
[Jun 29 14:50:25] DEBUG[26109]: channel.c:1666 ast_hangup: Hanging up
channel 'SIP/gt-isis-099fabe8'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:3695 sip_hangup: Hangup call
SIP/gt-isis-099fabe8, SIP callid
5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254)
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:400
__ast_device_state_changed_literal: Notification of state change to be
queued on device/channel SIP/gt-isis-099fabe8
== Everyone is busy/congested at this time (1:0/1/0)
[Jun 29 14:50:25] DEBUG[26109]: rtp.c:1632 ast_rtp_early_bridge: Channel
'<unspecified>' has no RTP, not doing anything
[Jun 29 14:50:25] DEBUG[26109]: app_dial.c:1806 dial_exec_full: Exiting
with DIALSTATUS=CONGESTION.
== Auto fallthrough, channel 'SIP/20088-099efce8' status is
'CONGESTION'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:1760 sip_alreadygone: Setting
SIP_ALREADYGONE on dialog MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.
[Jun 29 14:50:25] DEBUG[26109]: channel.c:1457 ast_softhangup_nolock:
Soft-Hanging up channel 'SIP/20088-099efce8'
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:400
__ast_device_state_changed_literal: Notification of state change to be
queued on device/channel SIP/20088-099efce8
[Jun 29 14:50:25] DEBUG[26109]: channel.c:1666 ast_hangup: Hanging up
channel 'SIP/20088-099efce8'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:3695 sip_hangup: Hangup call
SIP/20088-099efce8, SIP callid
MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.)
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:400
__ast_device_state_changed_literal: Notification of state change to be
queued on device/channel SIP/20088-099efce8
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:291 ast_device_state: No
provider found, checking channel drivers for SIP - gt-isis
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:16213 sip_devicestate: Checking
device state for peer gt-isis
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:380 do_state_change:
Changing state for SIP/gt-isis - state 1 (Not in use)
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:291 ast_device_state: No
provider found, checking channel drivers for SIP - 20088
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:16213 sip_devicestate: Checking
device state for peer 20088
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:380 do_state_change:
Changing state for SIP/20088 - state 1 (Not in use)
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:291 ast_device_state: No
provider found, checking channel drivers for SIP - 20088
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:16213 sip_devicestate: Checking
device state for peer 20088
[Jun 29 14:50:25] DEBUG[26109]: devicestate.c:380 do_state_change:
Changing state for SIP/20088 - state 1 (Not in use)
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4812 find_call: = No match
Their Call ID: 5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254 Their Tag
as7217464c Our tag: as7442af66
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:4812 find_call: = Found Their
Call ID: MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk. Their Tag cf535028
Our tag: as7e98df88
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:15613 handle_request: ****
Received ACK (6) - Command in SIP ACK
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on 'MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.' of
Response 2: Match Not Found
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11602 sip_dump_history:
---------- SIP HISTORY for
'5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11606 sip_dump_history: * SIP
Call
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 001.
NewChan Channel SIP/gt-isis-099fabe8 - from
5591bc6760a5d21a083cd6086a7
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 002.
TxReqRel INVITE / 102 INVITE - -UNKNOWN-
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 003.
Rx SIP/2.0 / 102 INVITE / 407 Proxy Authentication Required
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 004.
TxReq ACK / 102 ACK - -UNKNOWN-
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 005.
AuthResp Auth response sent for isis-gttrunk in realm asterisk - nc
1
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 006.
TxReqRel INVITE / 103 INVITE - -UNKNOWN-
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 007.
Rx SIP/2.0 / 103 INVITE / 403 Forbidden
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 008.
TxReq ACK / 103 ACK - -UNKNOWN-
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11612 sip_dump_history:
---------- END SIP HISTORY for
'5591bc6760a5d21a083cd6086a71d1f1 at 216.144.238.254'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11602 sip_dump_history:
---------- SIP HISTORY for 'MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.'
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11606 sip_dump_history: * SIP
Call
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 001.
Rx INVITE / 1 INVITE / sip:24840367 at 216.144.238.254
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 002.
AuthChal Auth challenge sent for - nc 0
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 003.
TxRespRel SIP/2.0 / 1 INVITE - 401 Unauthorized
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 004.
SchedDestroy 32000 ms
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 005.
Rx ACK / 1 ACK / sip:24840367 at 216.144.238.254
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 006.
Rx INVITE / 2 INVITE / sip:24840367 at 216.144.238.254
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 007.
CancelDestroy
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 008.
Invite New call: MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 009.
AuthOK Auth challenge succesful for 20088
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 010.
NewChan Channel SIP/20088-099efce8 - from
MWZlMjUzNDllNDliMjQwZmMyZGEyN
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 011.
TxResp SIP/2.0 / 2 INVITE - 100 Trying
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 012.
TxResp SIP/2.0 / 2 INVITE - 503 Service Unavailable
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11609 sip_dump_history: 013.
Rx ACK / 2 ACK / sip:24840367 at 216.144.238.254
[Jun 29 14:50:25] DEBUG[26109]: chan_sip.c:11612 sip_dump_history:
---------- END SIP HISTORY for
'MWZlMjUzNDllNDliMjQwZmMyZGEyNGY0MDdkZTBlMzk.'
[Jun 29 14:50:27] DEBUG[26109]: chan_sip.c:4812 find_call: = No match
Their Call ID: YzAwMGFjMmUwY2M0MzU5MDcyNjQ2YWMxNDNmM2Y1N2Q. Their Tag
c87fcd65 Our tag: as5ac649df
[Jun 29 14:50:27] DEBUG[26109]: chan_sip.c:4812 find_call: = No match
Their Call ID: ODk2MzczOGU2YzA5YjYyNDQ1YTlmNTZjNzIwNGFjYzg. Their Tag
902a9f72 Our tag: as5e824e7d
[Jun 29 14:50:27] DEBUG[26109]: chan_sip.c:4750 sip_alloc: Allocating new
SIP dialog for 48d8e40e4b64be1b1521973c2b7ea7ea at 202.60.73.170 - OPTIONS (No
RTP)
[Jun 29 14:50:27] DEBUG[26109]: chan_sip.c:15613 handle_request: ****
Received OPTIONS (3) - Command in SIP OPTIONS
isis*CLI>
Issue History
Date Modified Username Field Change
======================================================================
06-29-07 14:25 jeanneth Note Added: 0065939
======================================================================
More information about the Asterisk-bugs
mailing list