Hairpinning an outbound hylafax+iaxmodem call to an inbound hylafax+iaxmodem call

jlixfeld
Posts: 21
Member Since:
2007-01-08

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?



jlixfeld
Posts: 21
Member Since:
2007-01-08
*bump*

*bump*



JasonR
Posts: 345
Member Since:
2006-05-31
The outbound Hylafax log is

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

--

Jason Reiser
http://www.centpbx.com/



jlixfeld
Posts: 21
Member Since:
2007-01-08
Right, I'm faxing myself. I

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'


jlixfeld
Posts: 21
Member Since:
2007-01-08
So I just tried to dial my

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'


hendrikdw
Posts: 35
Member Since:
2006-06-22
Try to dail out

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



Comment viewing options

Select your preferred way to display the comments and click "Save settings" to activate your changes.