cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
10268
Views
5
Helpful
15
Replies

Outbound Fax Issues - SIP Fax Machine

Joseph E Spoon
Level 1
Level 1

We have just received a Xerox Workcentre 5330 with SIP capabilities.  We have SIP up and working and the printer is authenticated back to the CUCM.   We are also able to receive faxes just fine but we're  unable to send.  I see the call hitting the router and the remote fax machine actually rings, but after it rings and starts to process the call, the call just ends and the fax is aborted.  Any suggestions on what would be causing this?

Thanks           

15 Replies 15

I'm onsite and have tried toggling the following options:

MTP -> On Gateway and/or Device

Toggled options from dial-peer such as "no vad" "session transport udp" "fax rate 14400".

Toggled options under voice service voip such as "signaling forward unconditional" fax-relay ans-disable".

Changed fax rate on the Fax Machine, native is G3.

One thing I did notice on this fax machine when I got here is it's showing that it's sending to an IP fax machine...I don't see any options for a conventional fax machine or legacy.  I'm not sure if this is purely symantics or if it is legitimately trying to send it to another IP/SIP fax machine.  It's a Xerox WorkCentre 5330.  Also below is a copy of debugs I ran on an outbound call.  Running "debug voip dialpeer" "debug voip ccapi inout" "debug voip translations".

Let me know if you have any other suggestions.

Thanks

=========================

Jan 21 23:44:17.099: //58171/00E497EF1100/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x4889BDE8, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=6801,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=THE CALLED NUMBER---OMITTED

(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=9, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

Jan 21 23:44:17.099: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 21 23:44:17.099: :cc_get_feature_vsa malloc success

Jan 21 23:44:17.099: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 21 23:44:17.099:  cc_get_feature_vsa count is 2

Jan 21 23:44:17.099: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 21 23:44:17.099: :FEATURE_VSA attributes are: feature_name:0,feature_time:1266204872,feature_id:57561

Jan 21 23:44:17.099: //58172/00E497EF1100/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

Jan 21 23:44:17.099: //58172/00E497EF1100/CCAPI/ccCallSetContext:

   Context=0x4B27804C

Jan 21 23:44:17.099: //58171/00E497EF1100/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=9

Jan 21 23:44:17.171: //58172/00E497EF1100/CCAPI/cc_api_call_proceeding:

   Interface=0x4889BDE8, Progress Indication=NULL(0)

Jan 21 23:44:18.563: //58172/00E497EF1100/CCAPI/cc_api_call_cut_progress:

   Interface=0x4889BDE8, Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2),

   Cause Value=0

Jan 21 23:44:18.563: //58172/00E497EF1100/CCAPI/cc_api_call_cut_progress:

   Call Entry(Responsed=TRUE)

Jan 21 23:44:18.563: //58171/00E497EF1100/CCAPI/ccCallCutProgress:

   Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2), Cause Value=0

   Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE)

Jan 21 23:44:18.563: //58171/00E497EF1100/CCAPI/ccCallCutProgress:

   Call Entry(Responsed=TRUE)

Jan 21 23:44:18.563: //58172/00E497EF1100/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Jan 21 23:44:18.563: //58171/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

   (confID=0x46C6A638, callID1=0xE33B, callID2=0xE33C, tag=0x0)

Jan 21 23:44:18.563: //58171/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

   (confID=0x46C6A638, callID1=0xE33B, gcid=0-0-0-0, tag=0x0)

Jan 21 23:44:18.563: //58172/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

   (confID=0x46C6A638, callID2=0xE33C, gcid=0-0-0-0, tag=0x0)

Jan 21 23:44:18.563: //58171/00E497EF1100/CCAPI/ccConferenceCreate:

   Conference Id=0x46C6A638, Call Id1=58171, Call Id2=58172, Tag=0x0

Jan 21 23:44:18.563: //58171/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 21 23:44:18.563: cc_api_get_xcode_stream : 4534

Jan 21 23:44:18.563: //58171/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:

   Conference Id=0x207C, Source Interface=0x477F3EE4, Source Call Id=58171,

   Destination Call Id=58172, Disposition=0x0, Tag=0x0

Jan 21 23:44:18.563: //58172/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:

   Conference Id=0x207C, Source Interface=0x4889BDE8, Source Call Id=58172,

   Destination Call Id=58171, Disposition=0x0, Tag=0xFFFFFFFF

Jan 21 23:44:18.563: //58171/00E497EF1100/CCAPI/cc_generic_bridge_done:

   Conference Id=0x207C, Source Interface=0x4889BDE8, Source Call Id=58172,

   Destination Call Id=58171, Disposition=0x0, Tag=0xFFFFFFFF

Jan 21 23:44:18.567: //58171/00E497EF1100/CCAPI/ccConferenceCreate:

   Call Entry(Conference Id=0x207C, Destination Call Id=58172)

Jan 21 23:44:18.567: //58172/00E497EF1100/CCAPI/ccConferenceCreate:

   Call Entry(Conference Id=0x207C, Destination Call Id=58171)

Jan 21 23:44:18.567: //58172/00E497EF1100/CCAPI/cc_api_caps_ind:

   Destination Interface=0x477F3EE4, Destination Call Id=58171, Source Call Id=58172,

   Caps(Codec=0x1, Fax Rate=0x1, Vad=0x1,

   Modem=0x2, Codec Bytes=20, Signal Type=3)

Jan 21 23:44:18.567: //58172/00E497EF1100/CCAPI/cc_api_caps_ind:

   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),

   Playout Max=1000(ms), Fax Nom=300(ms))

Jan 21 23:44:18.567: //58171/00E497EF1100/CCAPI/cc_process_notify_bridge_done:

   Conference Id=0x207C, Call Id1=58171, Call Id2=58172

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=6801, Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=6801

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeers:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=6801

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=THE CALLED NUMBER---OMITTED

, Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=THE CALLED NUMBER---OMITTED

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

Jan 21 23:44:18.571: //-1/xxxxxxxxxxxx/DPM/dpMatchPeers:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=9

Jan 21 23:44:18.571: //58171/00E497EF1100/CCAPI/ccCallNotify:

   Data Bitmask=0x7, Call Id=58171

Jan 21 23:44:18.571: //58172/00E497EF1100/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Jan 21 23:44:18.595: //58171/00E497EF1100/CCAPI/cc_api_caps_ind:

   Destination Interface=0x4889BDE8, Destination Call Id=58172, Source Call Id=58171,

   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,

   Modem=0x0, Codec Bytes=160, Signal Type=2)

Jan 21 23:44:18.595: //58171/00E497EF1100/CCAPI/cc_api_caps_ind:

   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),

   Playout Max=1000(ms), Fax Nom=300(ms))

Jan 21 23:44:18.595: //58171/00E497EF1100/CCAPI/cc_api_caps_ack:

   Destination Interface=0x4889BDE8, Destination Call Id=58172, Source Call Id=58171,

   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),

   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=9297)

Jan 21 23:44:18.599: //58172/00E497EF1100/CCAPI/cc_api_caps_ack:

   Destination Interface=0x477F3EE4, Destination Call Id=58171, Source Call Id=58172,

   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),

   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=9297)

Jan 21 23:44:18.599: //58172/00E497EF1100/CCAPI/cc_api_voice_mode_event:

   Call Id=58172

Jan 21 23:44:18.599: //58172/00E497EF1100/CCAPI/cc_api_voice_mode_event:

   Call Entry(Context=0x4B27804C)

Jan 21 23:44:20.819: %ISDN-6-CONNECT: Interface Serial0/0/0:22 is now connected toTHE CALLED NUMBER---OMITTED

N/A

Jan 21 23:44:20.823: //58172/00E497EF1100/CCAPI/cc_api_call_connected:

   Interface=0x4889BDE8, Data Bitmask=0x1, Progress Indication=DESTINATION IS NON ISDN(2),

   Connection Handle=0

Jan 21 23:44:20.823: //58172/00E497EF1100/CCAPI/cc_api_call_connected:

   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)

Jan 21 23:44:20.823: //58171/00E497EF1100/CCAPI/ccCallConnect:

   Progress Indication=DESTINATION IS NON ISDN(2), Data Bitmask=0x1

Jan 21 23:44:20.823: //58172/00E497EF1100/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Jan 21 23:44:20.823: //58171/00E497EF1100/CCAPI/ccCallConnect:

   Call Entry(Connected=TRUE, Responsed=TRUE)

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=6801, Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=6801

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeers:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=6801

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=THE CALLED NUMBER---OMITTED

, Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=THE CALLED NUMBER---OMITTED

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

Jan 21 23:44:20.823: //-1/xxxxxxxxxxxx/DPM/dpMatchPeers:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=9

Jan 21 23:44:20.823: //58171/00E497EF1100/CCAPI/ccCallNotify:

   Data Bitmask=0x7, Call Id=58171

Jan 21 23:44:20.827: //58172/00E497EF1100/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Jan 21 23:44:29.871: //58172/00E497EF1100/CCAPI/cc_api_call_feature:

   Feature Type=1, Interface=0x4889BDE8, Call Id=58172

Jan 21 23:44:29.871: //58172/00E497EF1100/CCAPI/cc_api_t38_fax_start:

   Destination Interface=0x477F3EE4, Destination Call Id=58171, Source Call Id=58172,

   Caps(Codec=T38Fax(0x10000), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),

   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2)

Jan 21 23:44:29.871: //58172/00E497EF1100/CCAPI/cc_api_call_feature:

   Feature Type=1, Interface=0x4889BDE8, Call Id=58172

Jan 21 23:44:29.871: //58171/00E497EF1100/CCAPI/ccCallFeature:

   Feature Type=1, Call Id=58171

Jan 21 23:44:29.871: //58171/00E497EF1100/CCAPI/ccCallFeature:

   Feature Type=1, Call Id=58171

Jan 21 23:44:29.903: //58171/00E497EF1100/CCAPI/cc_api_t38_fax_start:

   Destination Interface=0x4889BDE8, Destination Call Id=58172, Source Call Id=58171,

   Caps(Codec=T38Fax(0x10000), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),

   Modem=OFF(0x0), Codec Bytes=40, Signal Type=2)

Jan 21 23:44:29.907: //58172/xxxxxxxxxxxx/CCAPI/cc_api_local_codec_dnld_done:

   (dstVdbPtr=0x477F3EE4, dstCallId=0xE33B, srcCallId=0xE33C)

Jan 21 23:44:29.907: //58171/00E497EF1100/CCAPI/cc_api_local_codec_dnld_done:

   Destination Interface=0x477F3EE4, Destination Call Id=58171, Source Call Id=58172

Jan 21 23:44:29.907: //58171/00E497EF1100/CCAPI/cc_api_set_fax_mode:

   Destination Interface=0x477F3EE4, Destination Call Id=58171, Source Call Id=58172

Jan 21 23:44:29.907: //58171/00E497EF1100/CCAPI/cc_api_t38_fax_start:

   Destination Interface=0x4889BDE8, Destination Call Id=58172, Source Call Id=58171,

   Caps(Codec=T38Fax(0x10000), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),

   Modem=OFF(0x0), Codec Bytes=40, Signal Type=2)

Jan 21 23:44:29.935: //58172/00E497EF1100/CCAPI/cc_api_remote_codec_dnld_done:

   Destination Interface=0x4889BDE8, Destination Call Id=58172, Source Call Id=58171, Xmit Function=0x43279754

Jan 21 23:44:30.515: //58171/00E497EF1100/CCAPI/cc_api_call_disconnected:

   Cause Value=16, Interface=0x477F3EE4, Call Id=58171

Jan 21 23:44:30.515: //58171/00E497EF1100/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

Jan 21 23:44:30.519: //58171/00E497EF1100/CCAPI/ccConferenceDestroy:

   Conference Id=0x207C, Tag=0x0

Jan 21 23:44:30.519: //58171/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x207C, Source Interface=0x477F3EE4, Source Call Id=58171,

   Destination Call Id=58172, Disposition=0x0, Tag=0x0

Jan 21 23:44:30.519: //58172/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x207C, Source Interface=0x4889BDE8, Source Call Id=58172,

   Destination Call Id=58171, Disposition=0x0, Tag=0x0

Jan 21 23:44:30.519: //58171/00E497EF1100/CCAPI/cc_generic_bridge_done:

   Conference Id=0x207C, Source Interface=0x4889BDE8, Source Call Id=58172,

   Destination Call Id=58171, Disposition=0x0, Tag=0x0

Jan 21 23:44:30.519: //58171/00E497EF1100/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

Jan 21 23:44:30.519: //58171/00E497EF1100/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Jan 21 23:44:30.519: //58171/00E497EF1100/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Jan 21 23:44:30.519: //58172/00E497EF1100/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Jan 21 23:44:30.519: //58172/00E497EF1100/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Jan 21 23:44:30.519: //58172/00E497EF1100/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Jan 21 23:44:30.531: %ISDN-6-DISCONNECT: Interface Serial0/0/0:22  disconnected fromTHE CALLED NUMBER---OMITTED

, call lasted 9 seconds

Jan 21 23:44:30.571: //58172/00E497EF1100/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x4889BDE8, Tag=0x0, Call Id=58172,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Jan 21 23:44:30.571: //-1/00E497EF1100/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x0

Jan 21 23:44:30.575: //58172/00E497EF1100/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 21 23:44:30.575: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 21 23:44:30.575: :cc_free_feature_vsa freeing 4B78C0C0

Jan 21 23:44:30.575: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 21 23:44:30.575:  vsacount in free is 1

Jan 21 23:44:30.575: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=9T, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:30.575: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

Jan 21 23:44:33.523: //58171/00E497EF1100/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Jan 21 23:44:33.523: //58171/00E497EF1100/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x477F3EE4, Tag=0x0, Call Id=58171,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Jan 21 23:44:33.523: //-1/00E497EF1100/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x4A05C2AC; count=2

Jan 21 23:44:33.523: //-1/00E497EF1100/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x4A101CFC

Jan 21 23:44:33.523: //58171/00E497EF1100/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 21 23:44:33.523: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 21 23:44:33.523: :cc_free_feature_vsa freeing 4B78C1A0

Jan 21 23:44:33.523: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 21 23:44:33.523:  vsacount in free is 0

Jan 21 23:44:33.523: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6750, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

Jan 21 23:44:33.523: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=6750

Jan 21 23:44:43.655: %ENVMON-4-FAN_LOW_RPM: Fan 1 service recommended

Jan 21 23:44:43.655: %ENVMON-4-FAN_LOW_RPM: Fan 2 service recommended