Hairpinning an outbound hylafax+iaxmodem call to an inbound hylafax+iaxmodem call
I just got Hylafax with Trixbox 2.2 setup for inbound faxing using this and this and setup hy-email2fax using this for outbound faxing.
I have a trustfax account to test both incoming and outgoing faxes, but I can't seem to fax myself.
I keep getting emails back from HylaFAX Agent saying:
No answer from remote; too many attempts to dial
---- Transcript of session follows ----
May 18 21:52:25.13: [ 8037]: SESSION BEGIN 000000061 14165551212
May 18 21:52:25.13: [ 8037]: HylaFAX (tm) Version 4.3.3
May 18 21:52:25.13: [ 8037]: SEND FAX: JOB 6 DEST 14165551212 COMMID 000000061 DEVICE '/dev/ttyIAX' FROM 'Jason Lixfeld <jason-fax-at-lixfeld.ca>' USER exim
May 18 21:52:25.13: [ 8037]: STATE CHANGE: RUNNING -> SENDING
May 18 21:52:25.13: [ 8037]: <-- [12:AT+FCLASS=1\r]
May 18 21:52:25.13: [ 8037]: --> [2:OK]
May 18 21:52:25.14: [ 8037]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled
May 18 21:52:25.14: [ 8037]: DIAL 14165551212
May 18 21:52:25.14: [ 8037]: <-- [16:ATDT14165551212\r]
May 18 21:53:11.00: [ 8037]: --> [9:NO ANSWER]
May 18 21:53:11.00: [ 8037]: SEND FAILED: JOB 6 DEST 14165551212 ERR No answer from remote
May 18 21:53:11.00: [ 8037]: SEND FAILED: JOB 6 DEST 14165551212 ERR No answer from remote; too many attempts to dial
May 18 21:53:11.00: [ 8037]: <-- [5:ATH0\r]
May 18 21:53:11.01: [ 8037]: --> [2:OK]
May 18 21:53:11.01: [ 8037]: MODEM set DTR OFF
May 18 21:53:11.01: [ 8037]: MODEM set baud rate: 0 baud (flow control unchanged)
May 18 21:53:11.01: [ 8037]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
May 18 21:53:11.01: [ 8037]: SESSION END
------- Unsent job status -------
Destination: 14165551212
JobID: 6
GroupID: 6
Sender: Jason Lixfeld
Mailaddr: jason-fax-at-lixfeld.ca
CommID: 000000061
Modem: any
Submitted From: localhost
Page Width: 209 (mm)
Page Length: 296 (mm)
Resolution: 196 (lpi)
Status: No answer from remote; too many attempts to dial
Dialogs: 0
Dials: 11
Calls: 12
Pages: 0
TotPages: 8
Attempts: 0
Dirnum:
It seems to me like I can't hairpin a fax for some reason, but I can dial myself using my SIP phone no problem.
Anyone know where I might look for info on, or how I might go about troubleshooting this?
The outbound Hylafax log is telling you that there was no answer. You're dialing the same number - ie: faxing to yourself, right? Do you have more than one 'modem' configured and listening? What's the result of 'faxstat' at the terminal? It should be something like:
Modem ttyIAX0 (+1.416.555.1212): Running and idle
Modem ttyIAX1 (+1.416.555.1212): Running and idle
Assuming you're using IAXModem, you'll want to configure at least two so you can send yourself a test. I generally configure about 4 and put them in ring group for inbound faxes.
- Jason
Right, I'm faxing myself. I did not have more than one modem configured and listening. I created 3 more IAXmodems, and faxstat is now showing:
Modem ttyIAX1 (+1.416.555.1212): Running and idle Modem ttyIAX0 (+1.416.555.1212): Running and idle Modem ttyIAX2 (+1.416.555.1212): Running and idle Modem ttyIAX3 (+1.416.555.1212): Running and idle
I added 3 more IAX extensions, for a total of 4. Each one is named IAXModem, and each one has a different extension numbers, starting at 1100 (for ttyIAX0), 1101 (for ttyIAX1), etc.
I configured a ring group as you suggested and applied it to the inbound route for the fax DID. I added extensions 1100 thru 1103 to the ring group. I configured the ring group as ringall-prim. In the ring group destination, I configured set it to the ring group itself.
I still get the same problem:
May 21 13:34:54 julian FaxGetty[30905]: LOCKWAIT May 21 13:34:54 julian FaxGetty[30905]: STATE CHANGE: RUNNING -> LOCKWAIT (timeout 30) May 21 13:34:55 julian FaxSend[3571]: MODEM set DTR OFF May 21 13:34:55 julian FaxSend[3571]: MODEM set baud rate: 0 baud (flow control unchanged) May 21 13:34:55 julian FaxSend[3571]: DELAY 75 ms May 21 13:34:55 julian FaxSend[3571]: MODEM set DTR ON May 21 13:34:55 julian FaxSend[3571]: DELAY 2600 ms May 21 13:34:58 julian FaxSend[3571]: MODEM set baud rate: 19200 baud, input flow XON/XOFF, output flow XON/XOFF May 21 13:34:58 julian FaxSend[3571]: DELAY 10 ms May 21 13:34:58 julian FaxSend[3571]: MODEM flush i/o May 21 13:34:58 julian FaxSend[3571]: <-- [4:ATZ\r] May 21 13:34:58 julian FaxSend[3571]: --> [2:OK] May 21 13:34:58 julian FaxSend[3571]: DELAY 3000 ms May 21 13:35:01 julian FaxSend[3571]: MODEM flush i/o May 21 13:35:01 julian FaxSend[3571]: <-- [10:AT+VCID=1\r] May 21 13:35:01 julian FaxSend[3571]: --> [9:AT+VCID=1] May 21 13:35:01 julian FaxSend[3571]: --> [2:OK] May 21 13:35:01 julian FaxSend[3571]: <-- [7:ATS0=0\r] May 21 13:35:02 julian FaxSend[3571]: --> [6:ATS0=0] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [5:ATE0\r] May 21 13:35:02 julian FaxSend[3571]: --> [4:ATE0] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [5:ATV1\r] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [5:ATQ0\r] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [7:ATS8=2\r] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [8:ATS7=60\r] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [12:AT+FCLASS=?\r] May 21 13:35:02 julian FaxSend[3571]: --> [7:0,1,1.0] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: MODEM Supports "Data" May 21 13:35:02 julian FaxSend[3571]: MODEM Supports "Class 1" May 21 13:35:02 julian FaxSend[3571]: MODEM Supports "Class 1.0" May 21 13:35:02 julian FaxSend[3571]: <-- [12:AT+FCLASS=1\r] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: <-- [5:ATI3\r] May 21 13:35:02 julian FaxSend[3571]: --> [19:www.soft-switch.org] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: MODEM: Mfr <a href="http://www.soft-switch.org" title="www.soft-switch.org">www.soft-switch.org</a> May 21 13:35:02 julian FaxSend[3571]: <-- [5:ATI0\r] May 21 13:35:02 julian FaxSend[3571]: --> [7:spandsp] May 21 13:35:02 julian FaxSend[3571]: --> [2:OK] May 21 13:35:02 julian FaxSend[3571]: MODEM: Model spandsp May 21 13:35:02 julian FaxSend[3571]: <-- [9:AT+FTM=?\r] May 21 13:35:03 julian FaxSend[3571]: --> [39:24,48,72,73,74,96,97,98,121,122,145,146] May 21 13:35:03 julian FaxSend[3571]: --> [2:OK] May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 3.85 line/mm May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 7.7 line/mm May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 15.4 line/mm May 21 13:35:03 julian FaxSend[3571]: MODEM Supports R16 x 15.4 line/mm May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 200 x 100 dpi May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 200 x 200 dpi May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 200 x 400 dpi May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 300 x 300 dpi May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 2400 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 4800 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 7200 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 9600 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 12000 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 14400 bit/s May 21 13:35:03 julian FaxSend[3571]: MODEM Supports A4 page width (215 mm) May 21 13:35:03 julian FaxSend[3571]: MODEM Supports B4 page width (255 mm) May 21 13:35:03 julian FaxSend[3571]: MODEM Supports A3 page width (303 mm) May 21 13:35:03 julian FaxSend[3571]: MODEM Supports A4 page length (297 mm) May 21 13:35:03 julian FaxSend[3571]: MODEM Supports B4 page length (364 mm) May 21 13:35:03 julian FaxSend[3571]: MODEM Supports unlimited page length May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 1-D MH May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 2-D MR May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 2-D MMR May 21 13:35:03 julian FaxSend[3571]: MODEM Supports no ECM May 21 13:35:03 julian FaxSend[3571]: MODEM Supports T.30 Annex A, 64-byte ECM May 21 13:35:03 julian FaxSend[3571]: MODEM Supports T.30 Annex A, 256-byte ECM May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 0 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 5 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 10 ms, 5 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 10 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 20 ms, 10 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 20 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 40 ms, 20 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM Supports 40 ms/scanline May 21 13:35:03 julian FaxSend[3571]: MODEM <a href="http://WWW.SOFT-SWITCH.ORG" title="WWW.SOFT-SWITCH.ORG">WWW.SOFT-SWITCH.ORG</a> spandsp/ May 21 13:35:03 julian FaxSend[3571]: <-- [5:ATM0\r] May 21 13:35:03 julian FaxSend[3571]: --> [2:OK] May 21 13:35:03 julian FaxSend[3571]: STATE CHANGE: BASE -> RUNNING (timeout 30) May 21 13:35:03 julian FaxSend[3571]: MODEM input buffering disabled May 21 13:35:03 julian FaxSend[3571]: SEND FAX: JOB 7 DEST 14165551212 COMMID 000000072 DEVICE '/dev/ttyIAX3' FROM 'Jason Lixfeld <jlixfeld-fax-at-arionetworks.ca>' USER exim May 21 13:35:49 julian FaxSend[3571]: SEND FAILED: JOB 7 DEST 14165551212 ERR No answer from remote May 21 13:35:55 julian FaxGetty[30905]: MODEM set DTR OFF May 21 13:35:55 julian FaxGetty[30905]: MODEM set baud rate: 0 baud (flow control unchanged) May 21 13:35:55 julian FaxGetty[30905]: DELAY 75 ms May 21 13:35:55 julian FaxGetty[30905]: MODEM set DTR ON May 21 13:35:55 julian FaxGetty[30905]: DELAY 2600 ms
Asterisk log:
May 21 13:28:44 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1103' to 60 seconds (requested 300)
May 21 13:28:48 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1101' to 60 seconds (requested 300)
May 21 13:28:51 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1102' to 60 seconds (requested 300)
May 21 13:28:55 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1100' to 60 seconds (requested 300)
May 21 13:29:07 VERBOSE[2724] logger.c: -- Accepting AUTHENTICATED call from 127.0.0.1:
> requested format = slin,
> requested prefs = (),
> actual format = ulaw,
> host prefs = (ulaw|alaw|gsm),
> priority = mine
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Macro("IAX2/1101-9", "dialout-trunk|2|14165551212||") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "DIAL_TRUNK=2") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "_NODEST=") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "DIAL_NUMBER=14165551212") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "ROUTE_PASSWD=") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "DIAL_TRUNK_OPTIONS=tr") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?noauth") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-dialout-trunk,s,8)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "GROUP()=OUT_2") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Macro("IAX2/1101-9", "user-callerid|SKIPTTL") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "user-callerid: device 1101") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?report") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?start") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-user-callerid,s,5)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "REALCALLERIDNUM is 1101") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "AMPUSER=1101") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "AMPUSERCIDNAME=IAXModem") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?report") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "CALLERID(all)=IAXModem <1101>") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "REALCALLERIDNUM=1101") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "TTL: ARG1: SKIPTTL") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?continue") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-user-callerid,s,21)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "Using CallerID "IAXModem" <1101>") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Macro("IAX2/1101-9", "record-enable|1101|OUT") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?2:4") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-record-enable,s,4)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing DeadAGI("IAX2/1101-9", "recordingcheck|20070521-132907|1179768547.18") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 21 13:29:07 VERBOSE[3207] logger.c: recordingcheck|20070521-132907|1179768547.18: Outbound recording not enabled
May 21 13:29:07 VERBOSE[3207] logger.c: -- AGI Script recordingcheck completed, returning 0
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "No recording needed") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?skipoutcid") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "DIAL_TRUNK_OPTIONS=r") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Macro("IAX2/1101-9", "outbound-callerid|2") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?start") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-outbound-callerid,s,3)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "REALCALLERIDNUM is 1101") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?normcid") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-outbound-callerid,s,9)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "USEROUTCID=") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "EMERGENCYCID=") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "TRUNKOUTCID="Ario" <4165550000>") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?trunkcid") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-outbound-callerid,s,16)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?usercid") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "CALLERID(all)="Ario" <4165550000>") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?report") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-outbound-callerid,s,22)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing NoOp("IAX2/1101-9", "CallerID set to "Ario" <4165550000>") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?nomax") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Goto (macro-dialout-trunk,s,16)
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing DeadAGI("IAX2/1101-9", "fixlocalprefix") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 21 13:29:07 VERBOSE[3207] logger.c: -- AGI Script fixlocalprefix completed, returning 0
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "OUTNUM=14165551212") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Set("IAX2/1101-9", "custom=IAX2/172.16.16.1") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "0?customtrunk") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Executing Dial("IAX2/1101-9", "IAX2/172.16.16.1/14165551212|300|r") in new stack
May 21 13:29:07 VERBOSE[3207] logger.c: -- Called 172.16.16.1/14165551212
May 21 13:29:07 VERBOSE[2724] logger.c: -- Call accepted by 172.16.16.1 (format ulaw)
May 21 13:29:07 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:29:07 VERBOSE[3207] logger.c: -- IAX2/172.16.16.1-10 is proceeding passing it to IAX2/1101-9
May 21 13:29:07 VERBOSE[3207] logger.c: -- IAX2/172.16.16.1-10 is making progress passing it to IAX2/1101-9
May 21 13:29:37 VERBOSE[3207] logger.c: -- IAX2/172.16.16.1-10 is making progress passing it to IAX2/1101-9
May 21 13:29:39 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1103' to 60 seconds (requested 300)
May 21 13:29:46 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1102' to 60 seconds (requested 300)
May 21 13:29:47 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1101' to 60 seconds (requested 300)
May 21 13:29:50 NOTICE[2724] chan_iax2.c: Restricting registration for peer '1100' to 60 seconds (requested 300)
May 21 13:29:53 VERBOSE[3207] logger.c: -- Hungup 'IAX2/172.16.16.1-10'
May 21 13:29:53 VERBOSE[3207] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'IAX2/1101-9' in macro 'dialout-trunk'
May 21 13:29:53 VERBOSE[3207] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'IAX2/1101-9'
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing Macro("IAX2/1101-9", "hangupcall") in new stack
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing ResetCDR("IAX2/1101-9", "w") in new stack
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing NoCDR("IAX2/1101-9", "") in new stack
May 21 13:29:53 NOTICE[3207] cdr.c: CDR on channel 'IAX2/1101-9' not posted
May 21 13:29:53 NOTICE[3207] cdr.c: CDR on channel 'IAX2/1101-9' lacks end
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?skiprg") in new stack
May 21 13:29:53 VERBOSE[3207] logger.c: -- Goto (macro-hangupcall,s,6)
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing GotoIf("IAX2/1101-9", "1?theend") in new stack
May 21 13:29:53 VERBOSE[3207] logger.c: -- Goto (macro-hangupcall,s,9)
May 21 13:29:53 VERBOSE[3207] logger.c: -- Executing Wait("IAX2/1101-9", "5") in new stack
May 21 13:29:53 VERBOSE[3207] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/1101-9' in macro 'hangupcall'
May 21 13:29:53 VERBOSE[3207] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/1101-9'
May 21 13:29:53 VERBOSE[3207] logger.c: -- Hungup 'IAX2/1101-9'
So I just tried to dial my fax DID from my SIP phone which is configured on the same * machine. When I dialed out, I got the fax tone from the proper extension, but I noticed specifically that the Ring Group picked up the call this time around, where as when I tried to fax myself before (via hylafax queue timer cycling every 5 minutes so I did changes between those windows), the Ring Group was never called:
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Macro("SIP/2000-096e9718", "dialout-trunk|2|4165551212||") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "DIAL_TRUNK=2") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "_NODEST=") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "DIAL_NUMBER=4165551212") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "ROUTE_PASSWD=") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "DIAL_TRUNK_OPTIONS=tr") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?noauth") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-dialout-trunk,s,8)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "GROUP()=OUT_2") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Macro("SIP/2000-096e9718", "user-callerid|SKIPTTL") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "user-callerid: device 2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?report") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?start") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "REALCALLERIDNUM=2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "REALCALLERIDNUM is 2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "AMPUSER=2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "AMPUSERCIDNAME=Jason Lixfeld") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?report") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "CALLERID(all)=Jason Lixfeld <2000>") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "REALCALLERIDNUM=2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "TTL: ARG1: SKIPTTL") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?continue") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-user-callerid,s,21)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "Using CallerID "Jason Lixfeld" <2000>") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Macro("SIP/2000-096e9718", "record-enable|2000|OUT") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?2:4") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-record-enable,s,4)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing DeadAGI("SIP/2000-096e9718", "recordingcheck|20070521-134552|1179769552.53") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 21 13:45:52 VERBOSE[4858] logger.c: recordingcheck|20070521-134552|1179769552.53: Outbound recording not enabled
May 21 13:45:52 VERBOSE[4858] logger.c: -- AGI Script recordingcheck completed, returning 0
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "No recording needed") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?skipoutcid") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "DIAL_TRUNK_OPTIONS=r") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Macro("SIP/2000-096e9718", "outbound-callerid|2") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?start") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-outbound-callerid,s,3)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "REALCALLERIDNUM is 2000") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?normcid") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-outbound-callerid,s,9)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "USEROUTCID=") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "EMERGENCYCID=") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "TRUNKOUTCID="Ario" <4165550000>") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?trunkcid") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-outbound-callerid,s,16)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?usercid") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "CALLERID(all)="Ario" <4165550000>") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?report") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-outbound-callerid,s,22)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing NoOp("SIP/2000-096e9718", "CallerID set to "Ario" <4165550000>") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?nomax") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Goto (macro-dialout-trunk,s,16)
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing DeadAGI("SIP/2000-096e9718", "fixlocalprefix") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 21 13:45:52 VERBOSE[4858] logger.c: -- AGI Script fixlocalprefix completed, returning 0
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "OUTNUM=4165551212") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Set("SIP/2000-096e9718", "custom=IAX2/172.16.16.1") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "0?customtrunk") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Executing Dial("SIP/2000-096e9718", "IAX2/172.16.16.1/4165551212|300|r") in new stack
May 21 13:45:52 VERBOSE[4858] logger.c: -- Called 172.16.16.1/4165551212
May 21 13:45:52 VERBOSE[2724] logger.c: -- Call accepted by 172.16.16.1 (format ulaw)
May 21 13:45:52 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:45:52 VERBOSE[4858] logger.c: -- IAX2/172.16.16.1-7 is proceeding passing it to SIP/2000-096e9718
May 21 13:45:53 VERBOSE[2724] logger.c: -- Accepting AUTHENTICATED call from 172.16.16.1:
> requested format = slin,
> requested prefs = (),
> actual format = ulaw,
> host prefs = (ulaw|alaw|gsm),
> priority = mine
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "FROM_DID=4165551212") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing Gosub("IAX2/172.16.16.1-8", "app-blacklist-check|s|1") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing LookupBlacklist("IAX2/172.16.16.1-8", "") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?blacklisted") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing Return("IAX2/172.16.16.1-8", "") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing Answer("IAX2/172.16.16.1-8", "") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing PlayTones("IAX2/172.16.16.1-8", "ring") in new stack
May 21 13:45:53 VERBOSE[4863] logger.c: -- Executing NVFaxDetect("IAX2/172.16.16.1-8", "0") in new stack
May 21 13:45:53 VERBOSE[4858] logger.c: -- IAX2/172.16.16.1-7 answered SIP/2000-096e9718
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Goto("IAX2/172.16.16.1-8", "ext-group|600|1") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (ext-group,600,1)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Macro("IAX2/172.16.16.1-8", "user-callerid|") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "user-callerid: 4165550000") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?report") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?start") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "REALCALLERIDNUM=4165550000") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "REALCALLERIDNUM is 4165550000") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "AMPUSER=") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "AMPUSERCIDNAME=") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "1?report") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (macro-user-callerid,s,11)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "TTL: ARG1: ") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?continue") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "_TTL=64") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "1?continue") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (macro-user-callerid,s,21)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "Using CallerID "" <4165550000>") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "1?skipdb") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (ext-group,600,4)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "__NODEST=") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "__BLKVM_OVERRIDE=BLKVM/600/IAX2/172.16.16.1-8") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "__BLKVM_BASE=600") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "DB(BLKVM/600/IAX2/172.16.16.1-8)=TRUE") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "RRNODEST=") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "__NODEST=600") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "1?REPCID") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (ext-group,600,14)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "CALLERID(name) is ") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "RecordMethod=Group") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Macro("IAX2/172.16.16.1-8", "record-enable|1100-1101-1102-1103|Group") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?2:4") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Goto (macro-record-enable,s,4)
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing DeadAGI("IAX2/172.16.16.1-8", "recordingcheck|20070521-134558|1179769553.55") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 21 13:45:58 VERBOSE[4863] logger.c: -- AGI Script recordingcheck completed, returning 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "No recording needed") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/172.16.16.1-8", "RingGroupMethod=ringall-prim") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Macro("IAX2/172.16.16.1-8", "dial|20|tr|1100-1101-1102-1103") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing DeadAGI("IAX2/172.16.16.1-8", "dialparties.agi") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Starting New Dialparties.agi
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: priority is 1
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Caller ID name is 'unknown' number is '4165550000'
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Methodology of ring is 'ringall-prim'
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: USE_CONFIRMATION: 'FALSE'
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: RINGGROUP_INDEX: ''
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Added extension 1100 to extension map
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Added extension 1101 to extension map
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Added extension 1102 to extension map
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Added extension 1103 to extension map
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1100 cf is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1101 cf is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1102 cf is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1103 cf is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1100 do not disturb is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1101 do not disturb is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1102 do not disturb is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Extension 1103 do not disturb is disabled
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extnum: 1100
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascw: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfb: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfb:
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfu: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfu:
May 21 13:45:58 VERBOSE[4870] logger.c: == Parsing '/etc/asterisk/manager.conf': May 21 13:45:58 VERBOSE[4870] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
May 21 13:45:58 VERBOSE[4870] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': May 21 13:45:58 VERBOSE[4870] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
May 21 13:45:58 WARNING[4870] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of /etc/asterisk/manager_custom.conf
May 21 13:45:58 VERBOSE[4870] logger.c: == Manager 'admin' logged on from 127.0.0.1
May 21 13:45:58 VERBOSE[4870] logger.c: == Manager 'admin' logged off from 127.0.0.1
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Extension 1100 has ExtensionState: 0
May 21 13:45:58 VERBOSE[4871] logger.c: == Parsing '/etc/asterisk/manager.conf': May 21 13:45:58 VERBOSE[4871] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
May 21 13:45:58 VERBOSE[4871] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': May 21 13:45:58 VERBOSE[4871] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
May 21 13:45:58 WARNING[4871] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of /etc/asterisk/manager_custom.conf
May 21 13:45:58 VERBOSE[4871] logger.c: == Manager 'admin' logged on from 127.0.0.1
May 21 13:45:58 VERBOSE[4871] logger.c: == Manager 'admin' logged off from 127.0.0.1
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Extension 1100 has ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1100
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: dbset CALLTRACE/1100 to 4165550000
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extnum: 1101
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascw: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfb: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfb:
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfu: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfu:
May 21 13:45:58 VERBOSE[4872] logger.c: == Parsing '/etc/asterisk/manager.conf': May 21 13:45:58 VERBOSE[4872] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
May 21 13:45:58 VERBOSE[4872] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': May 21 13:45:58 VERBOSE[4872] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
May 21 13:45:58 WARNING[4872] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of /etc/asterisk/manager_custom.conf
May 21 13:45:58 VERBOSE[4872] logger.c: == Manager 'admin' logged on from 127.0.0.1
May 21 13:45:58 VERBOSE[4872] logger.c: == Manager 'admin' logged off from 127.0.0.1
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Extension 1101 has ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1101
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: dbset CALLTRACE/1101 to 4165550000
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extnum: 1102
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascw: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfb: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfb:
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfu: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfu:
May 21 13:45:58 VERBOSE[4873] logger.c: == Parsing '/etc/asterisk/manager.conf': May 21 13:45:58 VERBOSE[4873] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
May 21 13:45:58 VERBOSE[4873] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': May 21 13:45:58 VERBOSE[4873] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
May 21 13:45:58 WARNING[4873] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of /etc/asterisk/manager_custom.conf
May 21 13:45:58 VERBOSE[4873] logger.c: == Manager 'admin' logged on from 127.0.0.1
May 21 13:45:58 VERBOSE[4873] logger.c: == Manager 'admin' logged off from 127.0.0.1
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Extension 1102 has ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1102
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: dbset CALLTRACE/1102 to 4165550000
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extnum: 1103
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascw: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfb: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfb:
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: exthascfu: 0
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: extcfu:
May 21 13:45:58 VERBOSE[4874] logger.c: == Parsing '/etc/asterisk/manager.conf': May 21 13:45:58 VERBOSE[4874] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
May 21 13:45:58 VERBOSE[4874] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': May 21 13:45:58 VERBOSE[4874] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
May 21 13:45:58 WARNING[4874] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of /etc/asterisk/manager_custom.conf
May 21 13:45:58 VERBOSE[4874] logger.c: == Manager 'admin' logged on from 127.0.0.1
May 21 13:45:58 VERBOSE[4874] logger.c: == Manager 'admin' logged off from 127.0.0.1
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: dialparties.agi: Extension 1103 has ExtensionState: 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1103
May 21 13:45:58 VERBOSE[4863] logger.c: -- dialparties.agi: dbset CALLTRACE/1103 to 4165550000
May 21 13:45:58 VERBOSE[4863] logger.c: > dialparties.agi: NODEST: 600 adding M(auto-blkvm) to dialopts: trM(auto-blkvm)
May 21 13:45:58 VERBOSE[4863] logger.c: -- AGI Script dialparties.agi completed, returning 0
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Dial("IAX2/172.16.16.1-8", "IAX2/1100&IAX2/1101&IAX2/1102&IAX2/1103|20|trM(auto-blkvm)") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Called 1100
May 21 13:45:58 VERBOSE[4863] logger.c: -- Called 1101
May 21 13:45:58 VERBOSE[4863] logger.c: -- Called 1102
May 21 13:45:58 VERBOSE[4863] logger.c: -- Called 1103
May 21 13:45:58 VERBOSE[2724] logger.c: -- Call accepted by 127.0.0.1 (format ulaw)
May 21 13:45:58 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:45:58 VERBOSE[2724] logger.c: -- Call accepted by 127.0.0.1 (format ulaw)
May 21 13:45:58 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:45:58 VERBOSE[2724] logger.c: -- Call accepted by 127.0.0.1 (format ulaw)
May 21 13:45:58 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:45:58 VERBOSE[2724] logger.c: -- Call accepted by 127.0.0.1 (format ulaw)
May 21 13:45:58 VERBOSE[2724] logger.c: -- Format for call is ulaw
May 21 13:45:58 VERBOSE[4863] logger.c: -- IAX2/1100-6 is ringing
May 21 13:45:58 VERBOSE[4863] logger.c: -- IAX2/1101-9 is ringing
May 21 13:45:58 VERBOSE[4863] logger.c: -- IAX2/1102-10 is ringing
May 21 13:45:58 VERBOSE[4863] logger.c: -- IAX2/1103-16 is ringing
May 21 13:45:58 VERBOSE[4863] logger.c: -- IAX2/1100-6 answered IAX2/172.16.16.1-8
May 21 13:45:58 VERBOSE[4863] logger.c: -- Hungup 'IAX2/1103-16'
May 21 13:45:58 VERBOSE[4863] logger.c: -- Hungup 'IAX2/1102-10'
May 21 13:45:58 VERBOSE[4863] logger.c: -- Hungup 'IAX2/1101-9'
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing Set("IAX2/1100-6", "__MACRO_RESULT=") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- Executing DBdel("IAX2/1100-6", "BLKVM/600/IAX2/172.16.16.1-8") in new stack
May 21 13:45:58 VERBOSE[4863] logger.c: -- DBdel: family=BLKVM, key=600/IAX2/172.16.16.1-8
May 21 13:46:05 VERBOSE[4858] logger.c: -- Hungup 'IAX2/172.16.16.1-7'
May 21 13:46:05 VERBOSE[4858] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/2000-096e9718' in macro 'dialout-trunk'
May 21 13:46:05 VERBOSE[4858] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/2000-096e9718'
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing Macro("SIP/2000-096e9718", "hangupcall") in new stack
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing ResetCDR("SIP/2000-096e9718", "w") in new stack
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing NoCDR("SIP/2000-096e9718", "") in new stack
May 21 13:46:05 NOTICE[4858] cdr.c: CDR on channel 'SIP/2000-096e9718' not posted
May 21 13:46:05 NOTICE[4858] cdr.c: CDR on channel 'SIP/2000-096e9718' lacks end
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?skiprg") in new stack
May 21 13:46:05 VERBOSE[4858] logger.c: -- Goto (macro-hangupcall,s,6)
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing GotoIf("SIP/2000-096e9718", "1?theend") in new stack
May 21 13:46:05 VERBOSE[4858] logger.c: -- Goto (macro-hangupcall,s,9)
May 21 13:46:05 VERBOSE[4858] logger.c: -- Executing Wait("SIP/2000-096e9718", "5") in new stack
May 21 13:46:05 VERBOSE[4858] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/2000-096e9718' in macro 'hangupcall'
May 21 13:46:05 VERBOSE[4858] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/2000-096e9718'
May 21 13:46:06 VERBOSE[4863] logger.c: -- Hungup 'IAX2/1100-6'
May 21 13:46:06 VERBOSE[4863] logger.c: == Spawn extension (macro-dial, s, 10) exited non-zero on 'IAX2/172.16.16.1-8' in macro 'dial'
May 21 13:46:06 VERBOSE[4863] logger.c: == Spawn extension (macro-dial, s, 10) exited non-zero on 'IAX2/172.16.16.1-8'
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing Macro("IAX2/172.16.16.1-8", "hangupcall") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing ResetCDR("IAX2/172.16.16.1-8", "w") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing NoCDR("IAX2/172.16.16.1-8", "") in new stack
May 21 13:46:06 NOTICE[4863] cdr.c: CDR on channel 'IAX2/172.16.16.1-8' not posted
May 21 13:46:06 NOTICE[4863] cdr.c: CDR on channel 'IAX2/172.16.16.1-8' lacks end
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "1?skiprg") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- Goto (macro-hangupcall,s,6)
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing GotoIf("IAX2/172.16.16.1-8", "0?theend") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing NoOp("IAX2/172.16.16.1-8", "Cleaning Up Block VM Flag: BLKVM/600/IAX2/172.16.16.1-8") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing DBdel("IAX2/172.16.16.1-8", "BLKVM/600/IAX2/172.16.16.1-8") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: -- DBdel: family=BLKVM, key=600/IAX2/172.16.16.1-8
May 21 13:46:06 VERBOSE[4863] logger.c: -- DBdel: Error deleting key from database.
May 21 13:46:06 VERBOSE[4863] logger.c: -- Executing Wait("IAX2/172.16.16.1-8", "5") in new stack
May 21 13:46:06 VERBOSE[4863] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/172.16.16.1-8' in macro 'hangupcall'
May 21 13:46:06 VERBOSE[4863] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/172.16.16.1-8'
May 21 13:46:06 VERBOSE[4863] logger.c: -- Hungup 'IAX2/172.16.16.1-8'
Hi All
I have Hylafax installed on my TB, with 6 IaxModems.
I can recieved fax with no problem.
But when I try to send a fax, it don't send it or dail out on the PRI line.
Here are my log file:
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [0835575961@from-zaptel:1] Set("IAX2/1101-13", "DID=0835575961") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [0835575961@from-zaptel:2] Goto("IAX2/1101-13", "s|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (from-zaptel,s,1)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:1] NoOp("IAX2/1101-13", "Entering from-zaptel with DID == 0835575961") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:2] Ringing("IAX2/1101-13", "") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:3] Set("IAX2/1101-13", "DID=0835575961") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:4] NoOp("IAX2/1101-13", "DID is now 0835575961") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:5] GotoIf("IAX2/1101-13", "0?zapok:notzap") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (from-zaptel,s,6)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@from-zaptel:6] Goto("IAX2/1101-13", "from-pstn|0835575961|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (from-pstn,0835575961,1)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [0835575961@from-pstn:1] NoOp("IAX2/1101-13", "Catch-All DID Match - Found 0835575961 - You probably want a DID for this.") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [0835575961@from-pstn:2] Goto("IAX2/1101-13", "ext-did|s|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (ext-did,s,1)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:1] Set("IAX2/1101-13", "__FROM_DID=s") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:2] Gosub("IAX2/1101-13", "app-blacklist-check|s|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@app-blacklist-check:1] LookupBlacklist("IAX2/1101-13", "") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@app-blacklist-check:2] GotoIf("IAX2/1101-13", "0?blacklisted") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@app-blacklist-check:3] Return("IAX2/1101-13", "") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:3] GotoIf("IAX2/1101-13", "1 ?cidok") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (ext-did,s,5)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:5] NoOp("IAX2/1101-13", "CallerID is "device" <1101>") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:6] SetMusicOnHold("IAX2/1101-13", "EnyaNew") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:7] Set("IAX2/1101-13", "__MOHCLASS=EnyaNew") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:8] Set("IAX2/1101-13", "FAX_RX=disabled") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:9] Set("IAX2/1101-13", "__CALLINGPRES_SV=allowed_passed_screen") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:10] SetCallerPres("IAX2/1101-13", "allowed_not_screened") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ext-did:11] Goto("IAX2/1101-13", "timeconditions|3|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (timeconditions,3,1)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [3@timeconditions:1] GotoIfTime("IAX2/1101-13", "07:00-17:00|mon-sat|*|*?ivr-22|s|1") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Goto (ivr-22,s,1)
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:1] Set("IAX2/1101-13", "LOOPCOUNT=0") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:2] Set("IAX2/1101-13", "__DIR-CONTEXT=default") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:3] Set("IAX2/1101-13", "_IVR_CONTEXT_ivr-22=") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:4] Set("IAX2/1101-13", "_IVR_CONTEXT=ivr-22") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:5] GotoIf("IAX2/1101-13", "0?begin") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:6] Answer("IAX2/1101-13", "") in new stack
[Jun 25 13:00:04] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:7] Wait("IAX2/1101-13", "1") in new stack
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:8] Set("IAX2/1101-13", "TIMEOUT(digit)=3") in new stack
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Digit timeout set to 3
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:9] Set("IAX2/1101-13", "TIMEOUT(response)=2") in new stack
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Response timeout set to 2
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Executing [s@ivr-22:10] BackGround("IAX2/1101-13", "custom/8_SureMainWelcomeMsg") in new stack
[Jun 25 13:00:05] VERBOSE[13525] logger.c: -- Playing 'custom/8_SureMainWelcomeMsg' (language 'en')
[Jun 25 13:00:06] VERBOSE[13529] logger.c: == Connect attempt from '127.0.0.1' unable to authenticate
[Jun 25 13:00:11] VERBOSE[13543] logger.c: == Connect attempt from '127.0.0.1' unable to authenticate
[Jun 25 13:00:16] VERBOSE[13544] logger.c: == Connect attempt from '127.0.0.1' unable to authenticate
[Jun 25 13:00:17] VERBOSE[13094] logger.c: -- Accepting AUTHENTICATED call from 10.10.100.170:
> requested format = ulaw,
> requested prefs = (),
> actual format = alaw,
> host prefs = (alaw|gsm|ulaw),
> priority = mine
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [0128101381@from-zaptel:1] Set("IAX2/1100-14", "DID=0128101381") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [0128101381@from-zaptel:2] Goto("IAX2/1100-14", "s|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (from-zaptel,s,1)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:1] NoOp("IAX2/1100-14", "Entering from-zaptel with DID == 0128101381") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:2] Ringing("IAX2/1100-14", "") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:3] Set("IAX2/1100-14", "DID=0128101381") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:4] NoOp("IAX2/1100-14", "DID is now 0128101381") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:5] GotoIf("IAX2/1100-14", "0?zapok:notzap") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (from-zaptel,s,6)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@from-zaptel:6] Goto("IAX2/1100-14", "from-pstn|0128101381|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (from-pstn,0128101381,1)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [0128101381@from-pstn:1] NoOp("IAX2/1100-14", "Catch-All DID Match - Found 0128101381 - You probably want a DID for this.") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [0128101381@from-pstn:2] Goto("IAX2/1100-14", "ext-did|s|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (ext-did,s,1)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:1] Set("IAX2/1100-14", "__FROM_DID=s") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:2] Gosub("IAX2/1100-14", "app-blacklist-check|s|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@app-blacklist-check:1] LookupBlacklist("IAX2/1100-14", "") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@app-blacklist-check:2] GotoIf("IAX2/1100-14", "0?blacklisted") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@app-blacklist-check:3] Return("IAX2/1100-14", "") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:3] GotoIf("IAX2/1100-14", "1 ?cidok") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (ext-did,s,5)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:5] NoOp("IAX2/1100-14", "CallerID is "device" <1100>") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:6] SetMusicOnHold("IAX2/1100-14", "EnyaNew") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:7] Set("IAX2/1100-14", "__MOHCLASS=EnyaNew") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:8] Set("IAX2/1100-14", "FAX_RX=disabled") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:9] Set("IAX2/1100-14", "__CALLINGPRES_SV=allowed_passed_screen") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:10] SetCallerPres("IAX2/1100-14", "allowed_not_screened") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ext-did:11] Goto("IAX2/1100-14", "timeconditions|3|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (timeconditions,3,1)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [3@timeconditions:1] GotoIfTime("IAX2/1100-14", "07:00-17:00|mon-sat|*|*?ivr-22|s|1") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Goto (ivr-22,s,1)
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:1] Set("IAX2/1100-14", "LOOPCOUNT=0") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:2] Set("IAX2/1100-14", "__DIR-CONTEXT=default") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:3] Set("IAX2/1100-14", "_IVR_CONTEXT_ivr-22=") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:4] Set("IAX2/1100-14", "_IVR_CONTEXT=ivr-22") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:5] GotoIf("IAX2/1100-14", "0?begin") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:6] Answer("IAX2/1100-14", "") in new stack
[Jun 25 13:00:17] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:7] Wait("IAX2/1100-14", "1") in new stack
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:8] Set("IAX2/1100-14", "TIMEOUT(digit)=3") in new stack
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Digit timeout set to 3
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:9] Set("IAX2/1100-14", "TIMEOUT(response)=2") in new stack
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Response timeout set to 2
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Executing [s@ivr-22:10] BackGround("IAX2/1100-14", "custom/8_SureMainWelcomeMsg") in new stack
[Jun 25 13:00:18] VERBOSE[13546] logger.c: -- Playing 'custom/8_SureMainWelcomeMsg' (language 'en')
[Jun 25 13:00:20] VERBOSE[13547] logger.c: == Parsing '/etc/asterisk/manager.conf': [Jun 25 13:00:20] VERBOSE[13547] logger.c: Found
[Jun 25 13:00:20] VERBOSE[13547] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [Jun 25 13:00:20] VERBOSE[13547] logger.c: Found
[Jun 25 13:00:20] VERBOSE[13547] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Jun 25 13:00:20] VERBOSE[13547] logger.c: Found
[Jun 25 13:00:20] VERBOSE[13547] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Jun 25 13:00:20] VERBOSE[13547] logger.c: == Manager 'admin' logged on from 127.0.0.1
Can someone please help me with this problem...
Hendrik

Member Since:
2007-01-08