[AsteriskBrasil] Erro no Asterisk... Ajuda!

Sexta Novembro 3 12:34:04 BRT 2006

Pessoal, 

Estou de volta com o sistema que estava com erros estes dias! Mas novamente estou com erros, de travamento do asterisk...  Por mais buscas que o faço para tentar encontrar as causas ainda não encontrei... Hoje o asterisk já caiu duas vezes... nestas duas vezes eu gravei o log para tentar identificar os motivos da queda! Que vou passar as ultimas linhas para ver se alguem conseguiria me ajudar neste probleminha!

O sistema conta com um servidor novo HP Pentium IV 3.2, 512 Mb, 80Gb de HD, placa Digium TE110P sistema instalado apartir do Trixbox 1.2. Hoje ele esta com:
Asterisk 1.2.7.1   Zaptel  1.2.5 
e R2 em produçao com: libunicall-0.0.3 libmfcr2-0.0.3 spandsp-0.0.2 libsupertone-0.0.2 

Agora os logs temos:

PRIMEIRO LOG ---------
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 259067db-5922f4ea em 10.0.0.205 Their Tag 116bfdf8dc7c8daeo0 Our tag: as518a2fad
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: b9ccd56d-99a619fd em 10.0.0.201 Their Tag 2d7b8edd1ac8c7do1 Our tag: as7e1032f4
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 1705de88-a131a604 em 10.0.0.200 Their Tag c87fd0f846c2d654o1 Our tag: as4d90b996
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 50fe30a8-5bb87a64 em 10.0.0.200 Their Tag 88ba41871e41db4o0 Our tag: as3fc6299e
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: a864f8d0-1d10162c em 10.0.0.202 Their Tag 4fd5a6c082edc0fco1 Our tag: as725f292b
Nov  3 09:10:26 DEBUG[4327] acl.c: ##### Testing 10.0.0.205 with 10.0.0.0
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: Allocating new SIP dialog for 012976833cbcc4a445e0cc5b73e8e4bf em 10.0.0.8 - SIP/2.0 (No RTP)
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: That's odd...  Got a response on a call we dont know about. Cseq 102 Cmd SIP/2.0
Nov  3 09:10:26 DEBUG[4316] chan_sip.c: Checking device state for peer 1900
Nov  3 09:10:26 DEBUG[4316] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Nov  3 09:10:26 VERBOSE[4316] logger.c:     -- SIP Seeding peer from astdb: '1900' at 1900 em 10.0.0.205:5060 for 200
Nov  3 09:10:26 DEBUG[4316] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
Nov  3 09:10:26 DEBUG[4316] acl.c: ##### Testing 10.0.0.205 with 10.0.0.0
Nov  3 09:10:26 DEBUG[4316] devicestate.c: Changing state for SIP/1900 - state 1 (Not in use)
Nov  3 09:10:26 DEBUG[20361] app_queue.c: Device 'SIP/1900' changed to state '1' (Not in use)
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 259067db-5922f4ea em 10.0.0.205 Their Tag 116bfdf8dc7c8daeo0 Our tag: as518a2fad
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: b9ccd56d-99a619fd em 10.0.0.201 Their Tag 2d7b8edd1ac8c7do1 Our tag: as7e1032f4
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 1705de88-a131a604 em 10.0.0.200 Their Tag c87fd0f846c2d654o1 Our tag: as4d90b996
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: 50fe30a8-5bb87a64 em 10.0.0.200 Their Tag 88ba41871e41db4o0 Our tag: as3fc6299e
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: = No match Their Call ID: a864f8d0-1d10162c em 10.0.0.202 Their Tag 4fd5a6c082edc0fco1 Our tag: as725f292b
Nov  3 09:10:26 DEBUG[4327] acl.c: ##### Testing 10.0.0.205 with 10.0.0.0
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: Allocating new SIP dialog for 6c439c3d38d3607470594cf2279fd246 em 10.0.0.8 - SIP/2.0 (No RTP)
Nov  3 09:10:26 DEBUG[4327] chan_sip.c: That's odd...  Got a response on a call we dont know about. Cseq 102 Cmd SIP/2.0
Nov  3 09:10:26 DEBUG[20132] app_queue.c: It's not our turn (UniCall/8-1).
Nov  3 09:10:27 DEBUG[20132] app_queue.c: It's not our turn (UniCall/8-1).
Nov  3 09:10:28 DEBUG[4327] chan_sip.c: Auto destroying call 'a864f8d0-1d10162c em 10.0.0.202'
Nov  3 09:10:28 DEBUG[4327] chan_sip.c: Auto destroying call '50fe30a8-5bb87a64 em 10.0.0.200'
Nov  3 09:10:28 DEBUG[4327] chan_sip.c: Auto destroying call '1705de88-a131a604 em 10.0.0.200'
Nov  3 09:10:28 DEBUG[20356] chan_unicall.c: DTMF digit: 2 on UniCall/9-1
Nov  3 09:10:28 WARNING[20356] chan_unicall.c: MFC/R2 UniCall/9 Channel switching
Nov  3 09:10:28 DEBUG[20356] channel.c: Scheduling timer at 0 sample intervals
Nov  3 09:10:28 DEBUG[20356] channel.c: Set channel UniCall/9-1 to write format alaw
Nov  3 09:10:28 DEBUG[20356] pbx.c: Oooh, got something to jump out with ('2')!
Nov  3 09:10:29 DEBUG[20132] app_queue.c: It's not our turn (UniCall/8-1).

SEGUNDO LOG -------

Nov  3 11:09:06 DEBUG[20397] chan_sip.c: **** Received NOTIFY (4) - Command in SIP NOTIFY
Nov  3 11:09:06 DEBUG[20397] chan_sip.c: = Found Their Call ID: 76d9ff70362a91c50f11714b0b812942 em 10.0.0.8 Their Tag e3938aa0a05fdef3i0 Our tag: as377f93c1
Nov  3 11:09:06 DEBUG[20397] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Nov  3 11:09:06 DEBUG[20397] chan_agent.c: Asked for bridged channel on 'SIP/1550-d31e'/'Agent/1558', returning 'UniCall/2-1'
Nov  3 11:09:06 DEBUG[20397] channel.c: Set channel UniCall/2-1 to write format slin
Nov  3 11:09:06 VERBOSE[20397] logger.c:     -- Started music on hold, class 'default', on UniCall/2-1
Nov  3 11:09:06 DEBUG[20397] channel.c: Scheduling timer at 160 sample intervals
Nov  3 11:09:06 DEBUG[20397] chan_sip.c: = Found Their Call ID: 76d9ff70362a91c50f11714b0b812942 em 10.0.0.8 Their Tag e3938aa0a05fdef3i0 Our tag: as377f93c1
Nov  3 11:09:06 DEBUG[20397] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Nov  3 11:09:06 DEBUG[20397] chan_sip.c: Stopping retransmission on '76d9ff70362a91c50f11714b0b812942 em 10.0.0.8' of Response 103: Match Found
Nov  3 11:09:06 DEBUG[27651] channel.c: Generator got voice, switching to phase locked mode
Nov  3 11:09:06 DEBUG[27651] channel.c: Scheduling timer at 0 sample intervals
Nov  3 11:09:06 DEBUG[27651] channel.c: Set channel UniCall/2-1 to write format slin
Nov  3 11:09:06 DEBUG[27651] channel.c: Set channel UniCall/2-1 to write format slin
Nov  3 11:09:06 DEBUG[27651] res_musiconhold.c: UniCall/2-1 Opened file 3 '/var/lib/asterisk/mohmp3/02'
Nov  3 11:09:06 DEBUG[27692] pbx.c: Launching 'SetAccount'
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Executing SetAccount("UniCall/4-1", "XXXX*E") in new stack
Nov  3 11:09:06 DEBUG[27692] pbx.c: Launching 'SetCDRUserField'
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Executing SetCDRUserField("UniCall/4-1", "ENTRADA_NORMAL") in new stack
Nov  3 11:09:06 DEBUG[27692] pbx.c: Launching 'ResponseTimeout'
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Executing ResponseTimeout("UniCall/4-1", "4") in new stack
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Set Response Timeout to 4
Nov  3 11:09:06 DEBUG[27692] pbx.c: Launching 'NoOp'
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Executing NoOp("UniCall/4-1", "Chamada de: 6133621400") in new stack
Nov  3 11:09:06 DEBUG[27692] pbx.c: Launching 'BackGround'
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Executing BackGround("UniCall/4-1", "ura") in new stack
Nov  3 11:09:06 DEBUG[27692] channel.c: Set channel UniCall/4-1 to write format slin
Nov  3 11:09:06 WARNING[27692] interface.c: Junk at the beginning of frame 49443303
Nov  3 11:09:06 DEBUG[27692] channel.c: Scheduling timer at 160 sample intervals
Nov  3 11:09:06 VERBOSE[27692] logger.c:     -- Playing 'ura-siagri' (language 'pt_BR')
Nov  3 11:09:07 DEBUG[27671] app_queue.c: It's our turn (UniCall/3-1).
Nov  3 11:09:07 DEBUG[27671] app_queue.c: UniCall/3-1 is trying to call a queue member.
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Simple queue (no URL)
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Simple queue (no URL)
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Trying 'Agent/1558' with metric 1000001
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Trying 'Agent/1550' with metric 1001000
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Nobody left to try ringing in queue
Nov  3 11:09:07 DEBUG[27671] app_queue.c: Everyone is busy at this time
Nov  3 11:09:07 DEBUG[27671] app_queue.c: UniCall/3-1: Nobody answered.

------

Eu não conseguir ver nenhum erro...  mas única aparente coincidencia e que sempre que deu erro, estava numa fila de atendimento...   com isto olhem como esta configurado a minha fila:

queues.conf
[general]
persistentmembers = yes
musiconhold = default

[suporte]
musiconhold = default
music = default
strategy = roundrobin
timeout = 20
retry = 5
member => Agent/1550
member => Agent/1558

e extensions.conf

[suporte]

exten => s,1,Answer()
exten => s,2,NoOP(Chamada de: ${CALLERIDNUM})
exten => s,3,SetAccount(${CALLERIDNUM}*E)
exten => s,4,SetCDRUserfield(LIG-EXTERNA)
exten => s,5,SetMusicOnHold(default)
exten => s,6,SetVar(QUEUE_PRIO=10)
exten => s,7,Playback(${AGUARDE-TRANSFERINDO})
exten => s,8,Queue(suporte,twhoH)
exten => s,9,Hangup

Agora... eu conto com a ajuda de alguem... pois vê estes erros faz a pessoa entrar em desespero... rsrs

De ante mão obrigado a todos que puderem ler este email!

Huander Leão

-------------- Próxima Parte ----------
Um anexo em HTML foi limpo...
URL: http://listas.asteriskbrasil.org/pipermail/asteriskbrasil/attachments/20061103/34b8a3b7/attachment.html