Can't hear anything when dialout

All installation and configuration problems and questions

Moderators: gerski, enjay, williamconley, Op3r, Staydog, gardo, mflorell, MJCoate, mcargile, Kumba, Michael_N

Can't hear anything when dialout

Postby gonzalomv » Tue Dec 11, 2007 5:36 pm

Hello, first thanks for all the hard work, the scratch install, wiki, etc. really.

I been dealing with vicidial / astguiclient for some days.

Well everything "appears" to be ok, i know that is a complex system, so it will be good if you tell me, what else do i need to post, to solve this problem.

Code: Select all
    -- Registered SIP '1002' at 190.2.28.1 port 52714 expires 3600
    -- Saved useragent "eyeBeam release 1004p stamp 31962" for peer 1002
    -- Unregistered SIP '1002'
    -- Registered SIP '1002' at 190.2.28.1 port 52714 expires 3600
    -- Saved useragent "eyeBeam release 1004p stamp 31962" for peer 1002
  == Parsing '/etc/asterisk/manager.conf': Found
  == Manager 'sendcron' logged on from 127.0.0.1
  == Parsing '/etc/asterisk/manager.conf': Found
  == Manager 'sendcron' logged on from 127.0.0.1
  == Manager 'sendcron' logged off from 127.0.0.1
  == Manager 'sendcron' logged off from 127.0.0.1
    -- Executing AGI("SIP/1002-081a5110", "AGI(agi://127.0.0.1:4577/call_log") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/AGI(agi://127.0.0.1:4577/call_log
Failed to execute '/var/lib/asterisk/agi-bin/AGI(agi://127.0.0.1:4577/call_log': No such file or directory
    -- AGI Script AGI(agi://127.0.0.1:4577/call_log completed, returning 0
    -- Executing Dial("SIP/1002-081a5110", "SIP/54111234567@SIPtrunk|55|o") in new stack
    -- Called 54111234567@SIPtrunk
    -- SIP/SIPtrunk-081a8810 is making progress passing it to SIP/1002-081a5110
    -- SIP/SIPtrunk-081a8810 answered SIP/1002-081a5110
    -- Attempting native bridge of SIP/1002-081a5110 and SIP/SIPtrunk-081a8810
 == Parsing '/etc/asterisk/manager.conf': Found
  == Manager 'sendcron' logged on from 127.0.0.1
  == Parsing '/etc/asterisk/manager.conf': Found
  == Manager 'sendcron' logged on from 127.0.0.1
  == Manager 'sendcron' logged off from 127.0.0.1
  == Manager 'sendcron' logged off from 127.0.0.1
Dec 11 19:15:02 WARNING[4414]: res_musiconhold.c:426 spawn_mp3: Found no files in '/var/lib/asterisk/mohmp3'
Dec 11 19:15:02 WARNING[4414]: res_musiconhold.c:508 monmp3thread: Unable to spawn mp3player
  == Spawn extension (default, 9054111234567, 2) exited non-zero on 'SIP/1002-081a5110'
    -- Executing DeadAGI("SIP/1002-081a5110", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----43-----32)") in new stack                                                                                                                                       
    -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----43-----32) completed, returning 0
  == Parsing '/etc/asterisk/manager.conf': Found



The call_log.agi file doesn't exist on that dir (afaik thats correct)
the mp3 problem, doesn't seems to be a BIG issue

I know that it will be good if i add more info, *.conf, plase tell me what else should i post.

Thanks!
gonzalomv
 
Posts: 5
Joined: Tue Dec 11, 2007 5:06 pm

Postby mflorell » Tue Dec 11, 2007 11:13 pm

Asterisk version?

astGUIclient version?
mflorell
Site Admin
 
Posts: 18387
Joined: Wed Jun 07, 2006 2:45 pm
Location: Florida

Postby gonzalomv » Wed Dec 12, 2007 8:18 am

Sorry for that.

1) Version of VICIDIAL
vicidial v2.0.4
Asterisk v1.2.24 (libpri v1.2.5 zaptel v1.2.21)
other apps version are specified by the scratch install



2) loadavg
load average: 0.17, 0.06, 0.02



3) Server Specs
Quad Xeon, 2gb ram, Digium TE410P...
Btw the TE410P is not connected (to PSTN), i install zaptel and wct4xxp modules, just as a timing device.



4) Codecs used
allowed: ulaw alaw gsm
i allowed only ulaw, then alaw, and then gsm. Without luck.
If i set it to alaw then i got:
NOTICE[4481]: chan_sip.c:3775 process_sdp: No compatible codecs!
If i use ulaw then i can establish a call but i cant hear anything

*CLI> show translation
Code: Select all
         Translation times between formats (in milliseconds)
          Source Format (Rows) Destination Format(Columns)

         g723   gsm  ulaw  alaw  g726 adpcm  slin lpc10  g729 speex  ilbc
   g723     -     -     -     -     -     -     -     -     -     -     -
    gsm     -     -     2     2     2     2     1     3     -     -    14
   ulaw     -     2     -     1     2     2     1     3     -     -    14
   alaw     -     2     1     -     2     2     1     3     -     -    14
   g726     -     2     2     2     -     2     1     3     -     -    14
  adpcm     -     2     2     2     2     -     1     3     -     -    14
   slin     -     1     1     1     1     1     -     2     -     -    13
  lpc10     -     3     3     3     3     3     2     -     -     -    15
   g729     -     -     -     -     -     -     -     -     -     -     -
  speex     -     -     -     -     -     -     -     -     -     -     -
   ilbc     -     3     3     3     3     3     2     4     -     -     -


*CLI> sip show channels
Code: Select all
Peer             User/ANR    Call ID      Seq (Tx/Rx)  Form  Hold     Last Message
194.221.62.198   5411478439  5bcd5f4025a  00103/00000  ulaw  No       Tx: INVITE
192.168.1.107    1002        NmE0Zjg2ZmE  00101/00002  ulaw  No       Rx: INVITE
2 active SIP channels

*CLI> sip show channels
Code: Select all
Peer             User/ANR    Call ID      Seq (Tx/Rx)  Form  Hold     Last Message
194.221.62.198   5411478439  5bcd5f4025a  00105/00000  ulaw  No       Tx: ACK
200.126.201.230  1002        NmE0Zjg2ZmE  00102/00002  ulaw  No       Tx: ACK




5) VOIP or PSTN
VOIP



6) OS
Ubuntu server. Please, i follow the scratch install (also the debian scratch install). So i don´t think that the os is the problem.

Thanks for your reply. really
gonzalomv
 
Posts: 5
Joined: Tue Dec 11, 2007 5:06 pm

Postby ramindia » Wed Dec 12, 2007 8:24 am

Hi

what happend when you dial from Softphone directly registering with Asterisk ?

is that call go through ? if so send us the call log.


* not from Vicidial*

ram
Kindly post your feedback, if this solution works.
so its very usefull for others who join later as a NEWBIE.
ramindia
 
Posts: 688
Joined: Wed Oct 11, 2006 4:06 am
Location: India

Postby nobesnickr » Wed Dec 12, 2007 11:34 am

gonzalomv wrote:6) OS
Ubuntu server. Please, i follow the scratch install (also the debian scratch install). So i don´t think that the os is the problem.
[/b]


I use Ubuntu also with no noticeable problems so i doubt that is it.

Like ram says, what happens when you dial out not using vici?
nobesnickr
 
Posts: 56
Joined: Thu Nov 01, 2007 6:44 pm

Postby Michael_N » Wed Dec 12, 2007 4:27 pm

Have you checked with your VOIP provider, wich codec they accept
And is you provider geografic near you? like in same country or neighbor country?

You could also connect you softphone directly to your provider, to see if that works better.
If it does the the problem is the config on your side...

You are running ubuntu server without Graphic user interface ?
Michael_N
 
Posts: 687
Joined: Wed Jul 05, 2006 3:13 pm
Location: sweden

Postby gonzalomv » Mon Dec 17, 2007 4:55 pm

This post is becouse the prevention system, sorry.
The following is the one.
gonzalomv
 
Posts: 5
Joined: Tue Dec 11, 2007 5:06 pm

Postby gonzalomv » Mon Dec 17, 2007 4:55 pm

Sorry for the delay in the reply, but i did a lot of tests. The sound issue, apparently was a problem in my sip.conf with my provider. Now i configured it properly.

Code: Select all
register => username:pass@sip.voicetrading.com

[SIPtrunk]
;[voicetrading]
type=peer
fromuser=username
username=username
canreinvite=no
secret=pass
insecure=very
host=sip.voicetrading.com
disallow=all
allow=ulaw
allow=alaw
allow=gsm
qualify=yes
nat=no



Now it works ok. Even if i pass trough call_log.agi
In my opinion the problem now is in agi-VDADtransfer.agi app
if i register my soft phone on asterisk, i can talk with a phone number or other interns, soft phones, etc. Also i can make manual dials with agc.

I made a new campaign, new list, etc Following (carefully) the documentation. Don't know where is the problem...

I put some logs here

I attached to ASTVDauto

Code: Select all
loop counter: |5556453|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:49|LIVE AGENTS LOGGED IN: 0   ACTIVE CALLS: 0|
2007-12-17 17:29:49|OLD TRUNK SHORTS CLEARED: 1 |''||
2007-12-17 17:29:49| : agents:      dial_level: 0|
2007-12-17 17:29:49| : Calls to place: 0 (0 - 0) 0 |
2007-12-17 17:29:49|CAMPAIGN DIFFERENTIAL: 0   0   (0 - 0)|
2007-12-17 17:29:49|LOCAL TRUNK SHORTAGE: 0|0  (0 - 96)|
2007-12-17 17:29:49| : CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:49||     lagged call vla agent PAUSED 0E0|20071217172919|20071217172939|20071217172949||
2007-12-17 17:29:49||     lagged call vac agent DELETED 0E0|2007-12-17 17:27:49||

loop counter: |5556452|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:52|LIVE AGENTS LOGGED IN: 0   ACTIVE CALLS: 0|
2007-12-17 17:29:52|OLD TRUNK SHORTS CLEARED: 1 |''||
2007-12-17 17:29:52| : agents:      dial_level: 0|
2007-12-17 17:29:52| : Calls to place: 0 (0 - 0) 0 |
2007-12-17 17:29:52|CAMPAIGN DIFFERENTIAL: 0   0   (0 - 0)|
2007-12-17 17:29:52|LOCAL TRUNK SHORTAGE: 0|0  (0 - 96)|
2007-12-17 17:29:52| : CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:52||     lagged call vla agent PAUSED 0E0|20071217172922|20071217172942|20071217172952||
2007-12-17 17:29:52||     lagged call vac agent DELETED 0E0|2007-12-17 17:27:52||

loop counter: |5556451|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:54|LIVE AGENTS LOGGED IN: 0   ACTIVE CALLS: 0|
2007-12-17 17:29:54|OLD TRUNK SHORTS CLEARED: 1 |''||
2007-12-17 17:29:54| : agents:      dial_level: 0|
2007-12-17 17:29:54| : Calls to place: 0 (0 - 0) 0 |
2007-12-17 17:29:54|CAMPAIGN DIFFERENTIAL: 0   0   (0 - 0)|
2007-12-17 17:29:54|LOCAL TRUNK SHORTAGE: 0|0  (0 - 96)|
2007-12-17 17:29:54| : CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:54||     lagged call vla agent PAUSED 0E0|20071217172924|20071217172944|20071217172954||
2007-12-17 17:29:54||     lagged call vac agent DELETED 0E0|2007-12-17 17:27:54||

loop counter: |5556450|
2007-12-17 17:29:54||     lagged call vac agent DELETED 0E0|2007-12-17 17:19:54|LIVE||
2007-12-17 17:29:54||     updating server parameters 96|8365|-3.00|default||
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
checking to see if listener is dead |1|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:57|LIVE AGENTS LOGGED IN: 1   ACTIVE CALLS: 0|
2007-12-17 17:29:57|TEST01 123.123.123.123: agents: 1     dial_level: 1|
2007-12-17 17:29:57|TEST01 123.123.123.123: Calls to place: 1 (1 - 0) 1 |
2007-12-17 17:29:57|CAMPAIGN DIFFERENTIAL: 0.05   0.05   (0.05 - 0)|
2007-12-17 17:29:57|LOCAL TRUNK SHORTAGE: 0|0  (1 - 96)|
2007-12-17 17:29:57|TEST01 123.123.123.123: CALLING|
|UPDATE vicidial_hopper set status='QUEUE', user='VDAD_123.123.123.123' where campaign_id='TEST01' and status='READY' order by priority desc,hopper_id LIMIT 1|
hopper rows updated to QUEUE: |1|
|SELECT lead_id,alt_dial FROM vicidial_hopper where campaign_id='TEST01' and status='QUEUE' and user='VDAD_123.123.123.123' order by priority desc,hopper_id LIMIT 1|
|UPDATE vicidial_hopper set status='INCALL' where lead_id='4'|
hopper row updated to INCALL: |1|4|
2007-12-17 17:29:57||     number call dialed|TEST01|V1217172957000000004|INSERT INTO vicidial_manager values('','','2007-12-17 17:29:57','NEW','N','123.123.123.123','','Originate','V1217172957000000004','Exten: 8365','Context: default','Channel: Local/900541147771234@default','Priority: 1','Callerid: "V1217172957000000004" <0000000000>','Timeout: 60000','','','','')|0.00|NONE||
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:29
2007-12-17 17:29:57||     lagged call vla agent PAUSED 0E0|20071217172927|20071217172947|20071217172957||
2007-12-17 17:29:57||     lagged call vac agent DELETED 0E0|2007-12-17 17:27:57||
2007-12-17 17:29:57||     lastcalldate UPDATED 1|'101'||
2007-12-17 17:29:57||     logindate UPDATED 1|'TEST01'||

loop counter: |5556449|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:00|LIVE AGENTS LOGGED IN: 1   ACTIVE CALLS: 1|
2007-12-17 17:30:00|TEST01 123.123.123.123: agents: 1     dial_level: 1|
2007-12-17 17:30:00|TEST01 123.123.123.123: Calls to place: 0 (1 - 1) 1 |
2007-12-17 17:30:00|CAMPAIGN DIFFERENTIAL: 0.1   0.1   (0.1 - 0)|
2007-12-17 17:30:00|LOCAL TRUNK SHORTAGE: 0|0  (1 - 96)|
2007-12-17 17:30:00|TEST01 123.123.123.123: CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:00||     lagged call vla agent PAUSED 0E0|20071217172930|20071217172950|20071217173000||
2007-12-17 17:30:00||     lagged call vac agent DELETED 0E0|2007-12-17 17:28:00||
2007-12-17 17:30:00||     logindate UPDATED 1|'TEST01'||

loop counter: |5556447|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:05|LIVE AGENTS LOGGED IN: 1   ACTIVE CALLS: 1|
2007-12-17 17:30:05|TEST01 123.123.123.123: agents: 1     dial_level: 1|
2007-12-17 17:30:05|TEST01 123.123.123.123: Calls to place: 0 (1 - 1) 1 |
2007-12-17 17:30:05|CAMPAIGN DIFFERENTIAL: 0.2   0.2   (0.2 - 0)|
2007-12-17 17:30:05|LOCAL TRUNK SHORTAGE: 0|0  (1 - 96)|
2007-12-17 17:30:05|TEST01 123.123.123.123: CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:05||     lagged call vla agent PAUSED 0E0|20071217172935|20071217172955|20071217173005||
2007-12-17 17:30:05||     lagged call vac agent DELETED 0E0|2007-12-17 17:28:05||
2007-12-17 17:30:05||     logindate UPDATED 1|'TEST01'||

loop counter: |5556446|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:07|LIVE AGENTS LOGGED IN: 0   ACTIVE CALLS: 1|
2007-12-17 17:30:07|OLD TRUNK SHORTS CLEARED: 1 |''||
2007-12-17 17:30:07| : agents:      dial_level: 0|
2007-12-17 17:30:07| : Calls to place: 0 (0 - 0) 1 |
2007-12-17 17:30:07|CAMPAIGN DIFFERENTIAL: 0.2   0.2   (0.2 - 0)|
2007-12-17 17:30:07|LOCAL TRUNK SHORTAGE: 0|0  (1 - 96)|
2007-12-17 17:30:07| : CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:07||     lagged call vla agent PAUSED 0E0|20071217172937|20071217172957|20071217173007||
2007-12-17 17:30:07||     lagged call vac agent DELETED 0E0|2007-12-17 17:28:07||

loop counter: |5556445|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:10|LIVE AGENTS LOGGED IN: 0   ACTIVE CALLS: 1|
2007-12-17 17:30:10|OLD TRUNK SHORTS CLEARED: 1 |''||
2007-12-17 17:30:10| : agents:      dial_level: 0|
2007-12-17 17:30:10| : Calls to place: 0 (0 - 0) 1 |
2007-12-17 17:30:10|CAMPAIGN DIFFERENTIAL: 0.2   0.2   (0.2 - 0)|
2007-12-17 17:30:10|LOCAL TRUNK SHORTAGE: 0|0  (1 - 96)|
2007-12-17 17:30:10| : CALLING|
TIME DEBUG: -3.00|-3.00|0|   GMT: 20:30
2007-12-17 17:30:10||     lagged call vla agent PAUSED 0E0|20071217172940|20071217173000|20071217173010||
2007-12-17 17:30:10||     lagged call vac agent DELETED 0E0|2007-12-17 17:28:10||


This is from the asterisk CLI
Code: Select all
 == Manager 'sendcron' logged on from 127.0.0.1
    -- Executing Dial("Local/900541147771234@default-e93b,2", "SIP/00541147771234@SIPtrunk|55|o") in new stack
    -- Called 00541147771234@SIPtrunk
    -- SIP/SIPtrunk-081a9180 is making progress passing it to Local/900541147771234@default-e93b,2
    -- SIP/SIPtrunk-081a9180 answered Local/900541147771234@default-e93b,2
       > Channel Local/900541147771234@default-e93b,1 was answered.
  == Manager 'sendcron' logged off from 127.0.0.1
    -- Executing AGI("Local/900541147771234@default-e93b,1", "agi://127.0.0.1:4577/call_log") in new stack
    -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
    -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
    -- AGI Script agi-VDADtransfer.agi completed, returning 0
    -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
    -- AGI Script agi-VDADtransfer.agi completed, returning 0
    -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
    -- AGI Script agi-VDADtransfer.agi completed, returning 0
    -- Executing Hangup("Local/900541147771234@default-e93b,1", "") in new stack
  == Spawn extension (default, 8365, 5) exited non-zero on 'Local/900541147771234@default-e93b,1'
    -- Executing DeadAGI("Local/900541147771234@default-e93b,1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------)") in new stack
    -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------) completed, returning 0
  == Spawn extension (default, 900541147771234, 1) exited non-zero on 'Local/900541147771234@default-e93b,2'
    -- Executing DeadAGI("Local/900541147771234@default-e93b,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----9-----2)") in new stack
    -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----9-----2) completed, returning 0
  == Parsing '/etc/asterisk/manager.conf': Found
  == Manager 'sendcron' logged on from 127.0.0.1
  == Parsing '/etc/asterisk/manager.conf': Found


/var/log/asterisk/messages

Code: Select all
Dec 17 17:36:23 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:24 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:24 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:24 DEBUG[1752] manager.c: Manager received command 'Login'
Dec 17 17:36:24 VERBOSE[1752] logger.c:   == Parsing '/etc/asterisk/manager.conf': Dec 17 17:36:24 VERBOSE[1752] logger.c:   == Parsing '/etc/asterisk/manager.conf': Found
Dec 17 17:36:24 VERBOSE[1752] logger.c:   == Manager 'sendcron' logged on from 127.0.0.1
Dec 17 17:36:24 DEBUG[1752] manager.c: Manager received command 'Originate'
Dec 17 17:36:24 VERBOSE[1754] logger.c:     -- Executing Dial("Local/900541147771234@default-e93b,2", "SIP/00541147771234@SIPtrunk|55|o") in new stack
Dec 17 17:36:24 DEBUG[1754] chan_sip.c: Setting NAT on RTP to 0
Dec 17 17:36:24 DEBUG[1754] chan_sip.c: Outgoing Call for 00541147771234
Dec 17 17:36:24 VERBOSE[1754] logger.c:     -- Called 00541147771234@SIPtrunk
Dec 17 17:36:25 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:25 DEBUG[4481] chan_sip.c: Acked pending invite 102
Dec 17 17:36:25 DEBUG[4481] chan_sip.c: Stopping retransmission on '5ee08a5013442e91530ae76a40f71702@190.2.42.10' of Request 102: Match Found
Dec 17 17:36:25 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:25 DEBUG[4481] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '5ee08a5013442e91530ae76a40f71702@190.2.42.10' Request 103: Found
Dec 17 17:36:25 VERBOSE[1754] logger.c:     -- SIP/SIPtrunk-081a9180 is making progress passing it to Local/900541147771234@default-e93b,2
Dec 17 17:36:25 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:26 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:26 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:27 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:27 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:28 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:28 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:29 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:29 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:29 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:30 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:30 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:31 DEBUG[4481] chan_sip.c: Acked pending invite 103
Dec 17 17:36:31 DEBUG[4481] chan_sip.c: Stopping retransmission on '5ee08a5013442e91530ae76a40f71702@123.123.123.123' of Request 103: Match Found
Dec 17 17:36:31 DEBUG[4481] chan_sip.c: build_route: Contact hop: sip:00541147771234@194.221.62.198:5060
Dec 17 17:36:31 DEBUG[4470] channel.c: Avoiding initial deadlock for 'SIP/SIPtrunk-081a9180'
Dec 17 17:36:31 VERBOSE[1754] logger.c:     -- SIP/SIPtrunk-081a9180 answered Local/900541147771234@default-e93b,2
Dec 17 17:36:31 DEBUG[4470] channel.c: Avoiding initial deadlock for 'Local/900541147771234@default-e93b,2'
Dec 17 17:36:31 VERBOSE[1752] logger.c:        > Channel Local/900541147771234@default-e93b,1 was answered.
Dec 17 17:36:31 DEBUG[1752] manager.c: Manager received command 'Logoff'
Dec 17 17:36:31 VERBOSE[1752] logger.c:   == Manager 'sendcron' logged off from 127.0.0.1
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- Executing AGI("Local/900541147771234@default-e93b,1", "agi://127.0.0.1:4577/call_log") in new stack
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
Dec 17 17:36:31 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- AGI Script agi-VDADtransfer.agi completed, returning 0
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
Dec 17 17:36:31 VERBOSE[1766] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
Dec 17 17:36:31 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:32 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:32 VERBOSE[1766] logger.c:     -- AGI Script agi-VDADtransfer.agi completed, returning 0
Dec 17 17:36:32 VERBOSE[1766] logger.c:     -- Executing AGI("Local/900541147771234@default-e93b,1", "agi-VDADtransfer.agi|8365") in new stack
Dec 17 17:36:32 VERBOSE[1766] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADtransfer.agi
Dec 17 17:36:32 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:33 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:33 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:33 VERBOSE[1766] logger.c:     -- AGI Script agi-VDADtransfer.agi completed, returning 0
Dec 17 17:36:33 VERBOSE[1766] logger.c:     -- Executing Hangup("Local/900541147771234@default-e93b,1", "") in new stack
Dec 17 17:36:33 VERBOSE[1766] logger.c:   == Spawn extension (default, 8365, 5) exited non-zero on 'Local/900541147771234@default-e93b,1'
Dec 17 17:36:33 VERBOSE[1766] logger.c:     -- Executing DeadAGI("Local/900541147771234@default-e93b,1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------)") in new stack
Dec 17 17:36:33 VERBOSE[1766] logger.c:     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------) completed, returning 0
Dec 17 17:36:33 DEBUG[1754] channel.c: Didn't get a frame from channel: Local/900541147771234@default-e93b,2
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '"V1217173624000000001" <0000000000>'
Dec 17 17:36:33 DEBUG[1754] channel.c: Bridge stops bridging channels Local/900541147771234@default-e93b,2 and SIP/SIPtrunk-081a9180
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '0000000000'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '8365'
Dec 17 17:36:33 DEBUG[1754] chan_sip.c: update_call_counter(00541147771234) - decrement call limit counter
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'default'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'Local/900541147771234@default-e93b,1'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '(null)'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'DeadAGI'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------)'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '2007-12-17 17:36:31'
Dec 17 17:36:33 DEBUG[1754] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '(null)'
Dec 17 17:36:33 VERBOSE[1754] logger.c:   == Spawn extension (default, 900541147771234, 1) exited non-zero on 'Local/900541147771234@default-e93b,2'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '2007-12-17 17:36:33'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '2'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '0'
Dec 17 17:36:33 VERBOSE[1754] logger.c:     -- Executing DeadAGI("Local/900541147771234@default-e93b,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----9-----2)") in new stack
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'ANSWERED'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is 'DOCUMENTATION'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '(null)'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '1197923784.111'
Dec 17 17:36:33 DEBUG[1766] pbx.c: Function result is '(null)'
Dec 17 17:36:33 VERBOSE[1754] logger.c:     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----9-----2) completed, returning 0
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '"V1217173624000000001" <0000000000>'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '0000000000'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '900541147771234'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'default'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'Local/900541147771234@default-e93b,2'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'SIP/SIPtrunk-081a9180'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'Dial'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'SIP/00541147771234@SIPtrunk|55|o'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '2007-12-17 17:36:24'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '2007-12-17 17:36:31'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '2007-12-17 17:36:33'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '9'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '2'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'ANSWERED'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is 'DOCUMENTATION'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '(null)'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '1197923784.112'
Dec 17 17:36:33 DEBUG[1754] pbx.c: Function result is '(null)'
Dec 17 17:36:33 DEBUG[4481] chan_sip.c: Stopping retransmission on '5ee08a5013442e91530ae76a40f71702@123.123.123.123' of Request 104: Match Found
Dec 17 17:36:34 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:34 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:34 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:35 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:35 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:36 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:36 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:36 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:37 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:37 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:38 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:38 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:38 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:39 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:39 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:40 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:40 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:40 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:41 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:41 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:42 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:42 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:42 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:43 DEBUG[4481] chan_sip.c: Stopping retransmission on '393ef7e375b0d60149e14a7c5556f73c@123.123.123.123' of Request 102: Match Found
Dec 17 17:36:43 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:43 DEBUG[4546] manager.c: Manager received command 'Command'
Dec 17 17:36:44 DEBUG[4546] manager.c: Manager received command 'Command'
gonzalomv
 
Posts: 5
Joined: Tue Dec 11, 2007 5:06 pm


Return to Support

Who is online

Users browsing this forum: Google [Bot] and 137 guests