[Freeswitch-users] faxrx error 13 Unexpected message received
In my attempts to receive a fax from a PSTN fax machine, the transaction fails with error code 13 "Unexpected message received". Verbose logging is on for mod_fax. Here is an exerpt: # 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: CFR with final frame tag 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: ff 13 84 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 In state 12 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Unexpected CFR received in state 12 .. == 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:180 Fax processing not successful - result (13) Unexpected message received. 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:185 Remote station id: ** 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:186 Local station id: SpanDSP Fax Ident 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:187 Pages transferred: 0 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:189 Total fax pages: 0 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:190 Image resolution: 8031x3850 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:191 Transfer Rate: 14400 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:193 ECM status on 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:194 remote country: 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:195 remote vendor: 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:196 remote model: 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:198 == # I have successfully received a fax from faxzero.com on this installation, as have I successfully sent a fax from freeswitch to the PSTN fax machine in question. I've been digging, but there doesn't seem to be a whole lot of information on faxing. I guess I could use a bit of direction. Any input is much appreciated. Thanks! -- Travis ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Re: [Freeswitch-users] faxrx error 13 Unexpected message received
On 09/17/2009 12:08 AM, Travis Stutsman wrote: > In my attempts to receive a fax from a PSTN fax machine, the transaction > fails with error code 13 "Unexpected message received". Verbose logging > is on for mod_fax. Here is an exerpt: > > # > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: CFR with > final frame tag > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: ff 13 84 > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 In state 12 > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Unexpected > CFR received in state 12 > .. > > == > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:180 Fax processing not > successful - result (13) Unexpected message received. > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:185 Remote station id: > ** > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:186 Local station id: > SpanDSP Fax Ident > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:187 Pages transferred: 0 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:189 Total fax pages: 0 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:190 Image resolution: > 8031x3850 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:191 Transfer Rate: > 14400 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:193 ECM status on > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:194 remote country: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:195 remote vendor: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:196 remote model: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:198 > > == > # > > I have successfully received a fax from faxzero.com on this > installation, as have I successfully sent a fax from freeswitch to the > PSTN fax machine in question. > > I've been digging, but there doesn't seem to be a whole lot of > information on faxing. I guess I could use a bit of direction. Any > input is much appreciated. > You seem to have chopped out all the interesting parts of that log. A full log might say something interesting. Steve ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Re: [Freeswitch-users] faxrx error 13 Unexpected message received
And make sure verbose is set to true in ./conf/autoload_configs/ fax.conf.xml. On Sep 16, 2009, at 11:50 AM, Steve Underwood wrote: > On 09/17/2009 12:08 AM, Travis Stutsman wrote: >> In my attempts to receive a fax from a PSTN fax machine, the >> transaction >> fails with error code 13 "Unexpected message received". Verbose >> logging >> is on for mod_fax. Here is an exerpt: >> >> # >> 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: CFR >> with >> final frame tag >> 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: ff >> 13 84 >> 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 In state >> 12 >> 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Unexpected >> CFR received in state 12 >> .. >> = >> = >> = >> = >> == >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:180 Fax processing not >> successful - result (13) Unexpected message received. >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:185 Remote station id: >> ** >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:186 Local station id: >> SpanDSP Fax Ident >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:187 Pages transferred: 0 >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:189 Total fax pages: 0 >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:190 Image resolution: >> 8031x3850 >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:191 Transfer Rate: >> 14400 >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:193 ECM status >> on >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:194 remote country: >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:195 remote vendor: >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:196 remote model: >> 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:198 >> = >> = >> = >> = >> == >> # >> >> I have successfully received a fax from faxzero.com on this >> installation, as have I successfully sent a fax from freeswitch to >> the >> PSTN fax machine in question. >> >> I've been digging, but there doesn't seem to be a whole lot of >> information on faxing. I guess I could use a bit of direction. Any >> input is much appreciated. >> > You seem to have chopped out all the interesting parts of that log. A > full log might say something interesting. > > Steve > > > ___ > FreeSWITCH-users mailing list > FreeSWITCH-users@lists.freeswitch.org > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users > http://www.freeswitch.org ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Re: [Freeswitch-users] faxrx error 13 Unexpected message received
1.402707 [DEBUG] mod_fax.c:137 FLOW FAX Set rx type 8 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:137 FLOW FAX FAX exchange complete 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:137 FLOW FAX Set tx type 8 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:137 FLOW FAX FAX exchange complete 2009-09-15 10:41:41.433958 [DEBUG] switch_core_codec.c:122 Restore original codec. # CFR in phase C? Hmm... Thanks again. -- Travis -Original Message- From: freeswitch-users-boun...@lists.freeswitch.org [mailto:freeswitch-users-boun...@lists.freeswitch.org] On Behalf Of Steve Underwood Sent: Wednesday, September 16, 2009 12:51 PM To: freeswitch-users@lists.freeswitch.org Subject: Re: [Freeswitch-users] faxrx error 13 Unexpected message received On 09/17/2009 12:08 AM, Travis Stutsman wrote: > In my attempts to receive a fax from a PSTN fax machine, the transaction > fails with error code 13 "Unexpected message received". Verbose logging > is on for mod_fax. Here is an exerpt: > > # > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: CFR with > final frame tag > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Rx: ff 13 84 > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 In state 12 > 2009-09-15 10:41:39.215123 [DEBUG] mod_fax.c:137 FLOW T.30 Unexpected > CFR received in state 12 > .. > > == > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:180 Fax processing not > successful - result (13) Unexpected message received. > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:185 Remote station id: > ** > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:186 Local station id: > SpanDSP Fax Ident > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:187 Pages transferred: 0 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:189 Total fax pages: 0 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:190 Image resolution: > 8031x3850 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:191 Transfer Rate: > 14400 > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:193 ECM status on > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:194 remote country: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:195 remote vendor: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:196 remote model: > 2009-09-15 10:41:41.402707 [DEBUG] mod_fax.c:198 > > == > # > > I have successfully received a fax from faxzero.com on this > installation, as have I successfully sent a fax from freeswitch to the > PSTN fax machine in question. > > I've been digging, but there doesn't seem to be a whole lot of > information on faxing. I guess I could use a bit of direction. Any > input is much appreciated. > You seem to have chopped out all the interesting parts of that log. A full log might say something interesting. Steve ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Re: [Freeswitch-users] faxrx error 13 Unexpected message received
Hi Travis, That's a pretty weird call. It looks like you have a long delayed echo. See below. On 09/17/2009 01:21 AM, Travis Stutsman wrote: > Alrighty. Here is mod_fax from beginning to end. > > > # > 2009-09-15 10:41:26.433382 [DEBUG] mod_fax.c:591 Raw read codec > activation Success L16 2 > 2009-09-15 10:41:26.433382 [DEBUG] mod_fax.c:607 Raw write codec > activation Success L16 > 2009-09-15 10:41:26.433382 [DEBUG] switch_channel.c:182 > sofia/external/***...@**.***.**.*** receive message [AUDIO_SYNC] > 2009-09-15 10:41:26.464633 [DEBUG] switch_core_io.c:232 > sofia/external/***...@**.***.**.*** receive message > [TRANSCODING_NECESSARY] > 2009-09-15 10:41:27.589676 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Carrier up (-2) in state 1 > 2009-09-15 10:41:27.761558 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Carrier down (-1) in state 1 > 2009-09-15 10:41:27.792809 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Carrier up (-2) in state 1 > 2009-09-15 10:41:27.870937 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:28.308454 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:28.355331 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:28.370956 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:28.824099 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:29.27231 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:29.261615 [DEBUG] mod_fax.c:137 FLOW T.30 HDLC signal > status is Abort (-8) in state 1 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Send complete > in phase T30_PHASE_A_CED, state 1 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Starting > answer mode > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Changing from > phase T30_PHASE_A_CED to T30_PHASE_B_TX > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW FAX Set rx type 0 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW FAX Set tx type 4 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Start T2 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Changing from > state 1 to 17 > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Sending ident > 'SpanDSP Fax Ident' > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Tx: CSI > without final frame tag > 2009-09-15 10:41:29.511625 [DEBUG] mod_fax.c:137 FLOW T.30 Tx: ff 03 40 > 74 6e 65 64 49 20 78 61 46 20 50 53 44 6e 61 70 53 20 20 20 > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 Send complete > in phase T30_PHASE_B_TX, state 17 > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 DIS: > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ...0= > Store and forward Internet fax (T.37): Not set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .0..= > Real-time Internet fax (T.38): Not set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 0...= > 3G mobile network: Not set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ..0. = > V.8 capabilities: Not set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .0.. = > Preferred octets: 256 octets > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ...0= > Ready to transmit a fax document (polling): Not set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ..1.= > Can receive fax: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ..10 11..= > Supported data signalling rates: V.27 ter, V.29, and V.17 > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .1.. = > R8x7.7lines/mm and/or 200x200pels/25.4mm: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 1... = > 2-D coding: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ..10= > Recording width: 215mm +- 1%, 255mm +- 1% and 303mm +- 1% > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 10..= > Recording length: Unlimited > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .111 = > Receiver's minimum scan line time: 0ms at 3.85 l/mm; T7.7 = T3.85 > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 1... = > Extension indicator: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ..0.= > Compressed/uncompressed mode: Compressed > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .1..= > Error correction mode (ECM): ECM > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 .1.. = > T.6 coding: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 1... = > Extension indicator: Set > 2009-09-15 10:41:31.89811 [DEBUG] mod_fax.c:137 FLOW T.30 ...0=
Re: [Freeswitch-users] faxrx error 13 Unexpected message received
Thanks Steve. More tests today. Consistent results. The Fax machine is in the same building as the FS server. It goes out over the PSTN to my carrier, then carrier to me over IP to the server. I need to try more fax machines and more locations. -- Travis ___ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
