[Asterisk-bugs] [Asterisk 0010091]: not register

noreply at bugs.diguim.com noreply at bugs.diguim.com
Fri Jun 29 15:17:59 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 15:17 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 15:17  
---------------------------------------------------------------------- 
this is my another provider



 == Using TOS bits 0
  == Using CoS mark 5
[Jun 29 15:46:08] DEBUG[26109]: chan_sip.c:2948 do_setnat: Setting NAT on
RTP to Off
[Jun 29 15:46:08] DEBUG[26109]: chan_sip.c:4750 sip_alloc: Allocating new
SIP dialog for MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU. - INVITE (With
RTP)
[Jun 29 15:46:08] DEBUG[26109]: chan_sip.c:2948 do_setnat: Setting NAT on
RTP to Off
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on 'MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.' of
Response 1: Match Found
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:2948 do_setnat: Setting NAT on
RTP to Off
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:5701 process_sdp: We're
settling with these formats: 0x4 (ulaw)
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:14299 handle_request_invite:
Checking SIP call limits for device 20088
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:8592 build_route: build_route:
Contact hop: <sip:20088 at 192.168.1.65:53099>
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:14373 handle_request_invite:
SIP/20088-099fe6a8: New call is still down.... Trying...
[Jun 29 15:46:09] DEBUG[26109]: pbx.c:1764 pbx_extension_helper: Launching
'Macro'
    -- Executing [24840367 at nacionales:1] Macro("SIP/20088-099fe6a8",
"outbound-nacionales|24840367") in new stack
[Jun 29 15:46:09] DEBUG[26109]: pbx.c:1764 pbx_extension_helper: Launching
'Dial'
    -- Executing [s at macro-outbound-nacionales:1]
Dial("SIP/20088-099fe6a8", "SIP/linea1/24840367||T") in new stack
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:16281 sip_request_call: Asked
to create a SIP channel with formats: 0x4 (ulaw)
  == Using TOS bits 0
  == Using CoS mark 5
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:4750 sip_alloc: Allocating new
SIP dialog for (No Call-ID) - INVITE (With RTP)
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:2948 do_setnat: Setting NAT on
RTP to Off
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable
STACK-macro-outbound-nacionales-s-1.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable MACRO_DEPTH.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable ARG1.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable MACRO_PRIORITY.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable MACRO_CONTEXT.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable MACRO_EXTEN.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable
STACK-nacionales-24840367-1.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPCALLID.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPDOMAIN.
[Jun 29 15:46:09] DEBUG[26109]: channel.c:3388
ast_channel_inherit_variables: Not copying variable SIPURI.
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:3223 sip_call: Outgoing Call
for 24840367
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:3242 sip_call: Our T38
capability (0), joint T38 capability (0)
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:6764 add_sdp: ** Our
capability: 0x4 (ulaw) Video flag: False Text flag: False
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:6765 add_sdp: ** Our prefcodec:
0x4 (ulaw)
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:1749 initialize_initreq:
Initializing initreq for method INVITE - callid
782059246e4cb3f66a77462a74288776 at 216.144.238.254
    -- Called linea1/24840367
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:2337 __sip_semi_ack:
(Provisional) Stopping retransmission (but retaining packet) on
'782059246e4cb3f66a77462a74288776 at 216.144.238.254' Request 102: Found
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:7037
transmit_response_with_sdp: Setting framing from config on incoming call
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:6764 add_sdp: ** Our
capability: 0x4 (ulaw) Video flag: True Text flag: True
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:6765 add_sdp: ** Our prefcodec:
0x0 (nothing)
[Jun 29 15:46:09] DEBUG[26109]: rtp.c:2924 ast_rtp_write: Ooh, format
changed from unknown to ulaw
[Jun 29 15:46:09] DEBUG[26109]: rtp.c:2940 ast_rtp_write: Created
smoother: format: 4 ms: 20 len: 160
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:2337 __sip_semi_ack:
(Provisional) Stopping retransmission (but retaining packet) on
'782059246e4cb3f66a77462a74288776 at 216.144.238.254' Request 102: Found
[Jun 29 15:46:09] DEBUG[26109]: chan_sip.c:5701 process_sdp: We're
settling with these formats: 0x4 (ulaw)
    -- SIP/linea1-09a02620 is making progress passing it to
SIP/20088-099fe6a8
[Jun 29 15:46:09] DEBUG[26109]: rtp.c:940 ast_rtcp_read: Got RTCP report
of 132 bytes
[Jun 29 15:46:09] DEBUG[26109]: rtp.c:2924 ast_rtp_write: Ooh, format
changed from unknown to ulaw
[Jun 29 15:46:09] DEBUG[26109]: rtp.c:2940 ast_rtp_write: Created
smoother: format: 4 ms: 20 len: 160
[Jun 29 15:46:10] DEBUG[26109]: rtp.c:940 ast_rtcp_read: Got RTCP report
of 160 bytes
[Jun 29 15:46:10] DEBUG[26109]: rtp.c:1632 ast_rtp_early_bridge: Channel
'<unspecified>' has no RTP, not doing anything
[Jun 29 15:46:10] DEBUG[26109]: channel.c:1666 ast_hangup: Hanging up
channel 'SIP/linea1-09a02620'
[Jun 29 15:46:10] DEBUG[26109]: chan_sip.c:3695 sip_hangup: Hangup call
SIP/linea1-09a02620, SIP callid
782059246e4cb3f66a77462a74288776 at 216.144.238.254)
[Jun 29 15:46:10] DEBUG[26109]: chan_sip.c:2280 __sip_ack: Acked pending
invite 102
[Jun 29 15:46:10] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on '782059246e4cb3f66a77462a74288776 at 216.144.238.254' of
Request 102: Match Found
[Jun 29 15:46:10] DEBUG[26109]: app_dial.c:1806 dial_exec_full: Exiting
with DIALSTATUS=CANCEL.
[Jun 29 15:46:10] DEBUG[26109]: app_macro.c:329 _macro_exec: Spawn
extension (macro-outbound-nacionales,s,1) exited non-zero on
'SIP/20088-099fe6a8' in macro 'outbound-nacionales'
  == Spawn extension (macro-outbound-nacionales, s, 1) exited non-zero on
'SIP/20088-099fe6a8' in macro 'outbound-nacionales'
[Jun 29 15:46:10] DEBUG[26109]: pbx.c:2395 __ast_pbx_run: Spawn extension
(macro-outbound-nacionales,s,1) exited non-zero on 'SIP/20088-099fe6a8'
  == Spawn extension (macro-outbound-nacionales, s, 1) exited non-zero on
'SIP/20088-099fe6a8'
[Jun 29 15:46:10] DEBUG[26109]: channel.c:1666 ast_hangup: Hanging up
channel 'SIP/20088-099fe6a8'
[Jun 29 15:46:10] DEBUG[26109]: chan_sip.c:3695 sip_hangup: Hangup call
SIP/20088-099fe6a8, SIP callid
MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.)
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on '782059246e4cb3f66a77462a74288776 at 216.144.238.254' of
Request 102: Match Found
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on '782059246e4cb3f66a77462a74288776 at 216.144.238.254' of
Request 102: Match Not Found
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11602 sip_dump_history:
---------- SIP HISTORY for
'782059246e4cb3f66a77462a74288776 at 216.144.238.254'
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11606 sip_dump_history:   * SIP
Call
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   001.
NewChan         Channel SIP/linea1-09a02620 - from
782059246e4cb3f66a77462a7428
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   002.
TxReqRel        INVITE / 102 INVITE - -UNKNOWN-
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   003.
Rx              SIP/2.0 / 102 INVITE / 100 trying -- your call is important
to
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   004.
Rx              SIP/2.0 / 102 INVITE / 183 Session Progress
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   005.
SchedDestroy    6400 ms
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   006.
TxReqRel        CANCEL / 102 CANCEL - -UNKNOWN-
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   007.
SchedDestroy    6400 ms
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   008.
Rx              SIP/2.0 / 102 CANCEL / 200 canceling
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   009.
Rx              SIP/2.0 / 102 INVITE / 487 Request Terminated
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   010.
TxReq           ACK / 102 ACK - -UNKNOWN-
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   011.
Hangup          Got 487 on CANCEL request from us on call without owner.
Killin
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11612 sip_dump_history:
---------- END SIP HISTORY for
'782059246e4cb3f66a77462a74288776 at 216.144.238.254'
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:2296 __sip_ack: Stopping
retransmission on 'MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.' of
Response 2: Match Found
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11602 sip_dump_history:
---------- SIP HISTORY for 'MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.'
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11606 sip_dump_history:   * SIP
Call
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   001.
Rx              INVITE / 1 INVITE / sip:24840367 at 216.144.238.254
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   002.
AuthChal        Auth challenge sent for  - nc 0
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   003.
TxRespRel       SIP/2.0 / 1 INVITE - 401 Unauthorized
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   004.
SchedDestroy    32000 ms
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   005.
Rx              ACK / 1 ACK / sip:24840367 at 216.144.238.254
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   006.
Rx              INVITE / 2 INVITE / sip:24840367 at 216.144.238.254
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   007.
CancelDestroy
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   008.
Invite          New call: MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   009.
AuthOK          Auth challenge succesful for 20088
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   010.
NewChan         Channel SIP/20088-099fe6a8 - from
MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5Z
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   011.
TxResp          SIP/2.0 / 2 INVITE - 100 Trying
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   012.
TxResp          SIP/2.0 / 2 INVITE - 183 Session Progress
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   013.
Rx              CANCEL / 2 CANCEL / sip:24840367 at 216.144.238.254
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   014.
TxRespRel       SIP/2.0 / 2 INVITE - 487 Request Terminated
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   015.
TxResp          SIP/2.0 / 2 CANCEL - 200 OK
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   016.
Rx              ACK / 2 ACK / sip:24840367 at 216.144.238.254
[Jun 29 15:46:11] DEBUG[26109]: chan_sip.c:11612 sip_dump_history:
---------- END SIP HISTORY for
'MGE0MjlhZmMyZjQ2Y2QxNWQ2NDk5ZjBiYmZjZDY4NWU.'
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11602 sip_dump_history:
---------- SIP HISTORY for
'1c63b85a697e832546077ee472f844af at 202.60.73.170'
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11606 sip_dump_history:   * SIP
Call
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   001.
Rx              OPTIONS / 102 OPTIONS / sip:216.144.238.254
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   002.
TxResp          SIP/2.0 / 102 OPTIONS - 200 OK
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   003.
SchedDestroy    32000 ms
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11609 sip_dump_history:   004.
AutoDestroy     1c63b85a697e832546077ee472f844af at 202.60.73.170
[Jun 29 15:46:12] DEBUG[26109]: chan_sip.c:11612 sip_dump_history:
---------- END SIP HISTORY for
'1c63b85a697e832546077ee472f844af at 202.60.73.170'
[Jun 29 15:46:14] DEBUG[26109]: chan_sip.c:4750 sip_alloc: Allocating new
SIP dialog for (No Call-ID) - OPTIONS (No RTP)
[Jun 29 15:46:14] DEBUG[26109]: chan_sip.c:1749 initialize_initreq:
Initializing initreq for method OPTIONS - callid
7ecbe751213582441a5d61a253c7648e at 216.144.238.254 

Issue History 
Date Modified   Username       Field                    Change               
====================================================================== 
06-29-07 13:16  jeanneth       New Issue                                    
06-29-07 13:16  jeanneth       Asterisk Version          => 1.4.5           
06-29-07 13:16  jeanneth       SVN Branch (only for SVN checkou =>  trunk       
  
06-29-07 13:16  jeanneth       SVN Revision (number only!) => 72662           
06-29-07 13:17  jeanneth       Disclaimer on File?       => No              
06-29-07 13:19  russell        Note Added: 0065933                          
06-29-07 13:19  russell        Status                   new => feedback     
======================================================================




More information about the Asterisk-bugs mailing list