flexfax: SNPP / PageSend Problem

[Mike Jackson <mhjack@tscnet.com>]

Help!

	I'm having a problem with hylafax-4.1beta1 running on a Linux
system.  I am launching hfaxd from inetd and only using the SNPP
capabilities of hylafax on this machine.  The faxq daemon is running 
in the background.

	The page is sent, queued, transmitted, and received on my pager;
however, faxq/pagesend thinks that there was some form of error.  The only
thing that seems to be wrong is that the hylafax system doesn't know that
the page was accepted and gives a "Job has no PIN to send to" error
message.

	I think that this might be a bug in the 4.1beta1 code in
pageSendApp.c++; but my C++ isn't as good as my C :)
 
	Here are the transcripts/logs (Actual numbers removed).

-----------------------------------------------------------------------

Session with SNPP:

220 kes.tscnet.com SNPP server (HylaFAX (tm) Version 4.1beta1) ready. 
LOGIN user
230 User user logged in. 
SITE JQUEUE yes
PAGER att555555555
MESS test message
250 Message text OK.
SEND
250 Message succesfully queued. 
QUIT
221 Goodbye.

----------------------------------------------------------------------
My etc/pagermap file has an entry for the TAP provider like this:

^att(.*)        18008888888/\1

-----------------------------------------------------------------------

Syslog: [Dates/Times removed for readability]

hfaxd[5389]: connect from httpd@207.227.236.33
FaxQueuer[30253]: SUBMIT JOB 22
PageSend[5392]: MODEM  /
PageSend[5392]: SEND PAGE: JOB 22 DEST 18008418837 COMMID 00000011
PageSend[5560]: MODEM  /
PageSend[5560]: PAGE FAILED: Job has no PIN to send to
FaxQueuer[30253]: NOTIFY: bin/notify "doneq/q22" "failed" "0:05"

-----------------------------------------------------------------------

Session Transcript Message (with SessionTracing 0x100f turned on)

Subject: pager job 22 to 3609085553 failed

Your pager job to 3609085553 failed because:
    Job has no PIN to send to

    ---- Transcript of session follows ----

Aug 06 14:59:50.33: [ 5392]: SESSION BEGIN 00000011 18008418837
Aug 06 14:59:50.34: [ 5392]: SEND PAGE: JOB 22 DEST 18008418837 COMMID
00000011
Aug 06 14:59:50.34: [ 5392]: MODEM set DTR OFF
Aug 06 14:59:50.34: [ 5392]: DELAY 2600 ms
Aug 06 14:59:52.94: [ 5392]: MODEM set DTR ON
Aug 06 14:59:52.94: [ 5392]: MODEM set baud rate: 38400 baud, input flow
RTS/CTS
, output flow RTS/CTS
Aug 06 14:59:52.94: [ 5392]: MODEM flush i/o
Aug 06 14:59:52.94: [ 5392]: <-- [15:ATE0V1Q0S0=0H0\r]
Aug 06 14:59:53.73: [ 5392]: --> [2:OK]
Aug 06 14:59:53.73: [ 5392]: <-- [21:ATS8=2S7=60&K3&D3&C1\r]
Aug 06 14:59:53.90: [ 5392]: --> [2:OK]
Aug 06 14:59:53.90: [ 5392]: <-- [5:ATM0\r]
Aug 06 14:59:54.05: [ 5392]: --> [2:OK]
Aug 06 14:59:54.05: [ 5392]: MODEM set parity: 7 bits, even parity
Aug 06 14:59:54.05: [ 5392]: MODEM input buffering enabled
Aug 06 14:59:54.05: [ 5392]: <-- [12:AT+FCLASS=0\r]
Aug 06 14:59:54.31: [ 5392]: --> [2:OK]
Aug 06 14:59:54.31: [ 5392]: DIAL 18008888888
Aug 06 14:59:54.31: [ 5392]: <-- [16:ATDT18008888888\r]
Aug 06 15:00:13.75: [ 5392]: --> [13:CONNECT 14400]
Aug 06 15:00:13.75: [ 5392]: EXPECT ID (paging central identification)
Aug 06 15:00:13.75: [ 5392]: <-- <1:\015>
Aug 06 15:00:15.75: [ 5392]: MODEM TIMEOUT: reading line from modem
Aug 06 15:00:15.75: [ 5392]: --> <3:ID=>
Aug 06 15:00:15.75: [ 5392]: RECV ID ("ID=")
Aug 06 15:00:15.75: [ 5392]: SEND device identification/login request
Aug 06 15:00:15.75: [ 5392]: <-- <5:\033PG1\015>
Aug 06 15:00:16.71: [ 5392]: --> <3:110>
Aug 06 15:00:16.71: [ 5392]: RECV: 110
Aug 06 15:00:16.71: [ 5392]: --> <1:\006>
Aug 06 15:00:16.71: [ 5392]: RECV ACK (login successful)
Aug 06 15:00:16.71: [ 5392]: --> <3:\033[p>
Aug 06 15:00:16.71: [ 5392]: RECV go-ahead (prologue done)
Aug 06 15:00:16.71: [ 5392]: SEND message block
Aug 06 15:00:16.71: [ 5392]: <-- <38:\0025555555555\015test message\015\
0039>;\015>
Aug 06 15:00:17.63: [ 5392]: --> <1:\006>
Aug 06 15:00:17.63: [ 5392]: RECV ACK (message block accepted)
Aug 06 15:00:17.63: [ 5392]: <-- <2:\004\015>
Aug 06 15:00:19.48: [ 5392]: --> <10:NO CARRIER>
Aug 06 15:00:19.48: [ 5392]: RECV: NO CARRIER
Aug 06 15:00:49.48: [ 5392]: MODEM TIMEOUT: reading line from modem
Aug 06 15:00:49.48: [ 5392]: <-- [5:ATH0\r]
Aug 06 15:00:50.36: [ 5392]: --> [2:OK]
Aug 06 15:00:50.36: [ 5392]: MODEM input buffering enabled
Aug 06 15:00:50.36: [ 5392]: MODEM set DTR OFF
Aug 06 15:00:50.36: [ 5392]: SESSION END

    ---- Unsent job status ----

   Destination: 5555555555
         JobID: 22
       GroupID: 22
        Sender: user
      Mailaddr: user@host.domain.com
        CommID: 00000011
Submitted From: host.domain.com
        Status: Job has no PIN to send to
       Dialogs: 1 (exchanges with remote device)
         Dials: 0 (consecutive failed calls to destination)
         Calls: 1 (total phone calls placed)

    ---- Message text ----

test message

------------------------------------------------------------------------

Any help with this would be appreciated.

					Mike Jackson
					TSCNet