Hello. I have been tring to set up the fax server for faxtomail and mailtofax. But have been unsuccesful in setting up the initial part itself. The procedure I followed is
Apps->Fax Server->provide a name test1 and virtual extention 9001-> Save. Similarly Apps->Fax Server->provide a name test2 and virtual extention 9007-> Save.
Created 2 inbound destinations for these two servers with
public DID's I have with Actions and Fax Detection respectively. I just wanted to see if these two can communicate by sending message between them but have been unsuccessful. Are the steps I have followed even correct? Is there any default setting, modules or variables I have to enable before this? I know am doing something completely wrong but I have not much idea about fax .So can someone please let me know the step by step procedure to set up the fax server to work. Would be of great help. Thank you.
The log I am getting now-
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] TRYING [3] of [4] to: 040******* with: t38 ON ECM OFF, SLOW
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Retry Command: originate {fax_retry_attempts=4,for_fax=1,accountcode='max.nl',domain_uuid=84c9f58a-ae19-4d1b-81c5-1924599f0aa1,domain_name=max.nl,mailto_address='',mailfrom_address='',origination_caller_id_name='000000000000000',origination_caller_id_number=000000000000000,fax_uri=sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040*******,fax_retry_limit=20,fax_retry_sleep=30,fax_verbose=true,fax_file='/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif',fax_ident='000000000000000',fax_header='000000000000000',fax_use_ecm=false,fax_enable_t38=true,fax_enable_t38_request=true,fax_disable_v17=true,fax_busy_attempts='0',api_hangup_hook='lua fax_retry.lua'}sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040******* &txfax('/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif')
2018-06-28 09:58:37.396752 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
2018-06-28 09:58:37.396752 [NOTICE] switch_channel.c:1104 New Channel sofia/external/040******* [a7af10be-8615-4699-8ad5-b11f9046fbd9]
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:5026 (sofia/external/040*******) State Change CS_NEW -> CS_INIT
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_INIT (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:627 (sofia/external/040*******) State INIT
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:93 sofia/external/040******* SOFIA INIT
2018-06-28 09:58:37.396752 [DEBUG] sofia_glue.c:1299 sofia/external/040******* sending invite version: 1.6.20 64bit
Local SDP:
v=0
o=FreeSWITCH 1530150101 1530150102 IN IP4 185.79.115.15
s=FreeSWITCH
c=IN IP4 185.79.115.15
t=0 0
m=audio 22616 RTP/AVP 0 8 101 13
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
a=sendrecv
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:40 sofia/external/040******* Standard INIT
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:48 (sofia/external/040*******) State Change CS_INIT -> CS_ROUTING
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:627 (sofia/external/040*******) State INIT going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_ROUTING (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:643 (sofia/external/040*******) State ROUTING
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:154 sofia/external/040******* SOFIA ROUTING
2018-06-28 09:58:37.396752 [DEBUG] switch_ivr_originate.c:67 (sofia/external/040*******) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:643 (sofia/external/040*******) State ROUTING going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] sofia.c:7283 Channel sofia/external/040******* entering state [calling][0]
2018-06-28 09:58:37.396752 [DEBUG] sofia.c:7283 Channel sofia/external/040******* entering state [terminated][503]
2018-06-28 09:58:37.396752 [NOTICE] sofia.c:8474 Hangup sofia/external/040******* [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:662 (sofia/external/040*******) State CONSUME_MEDIA
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:662 (sofia/external/040*******) State CONSUME_MEDIA going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_HANGUP (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:850 (sofia/external/040*******) Callstate Change DOWN -> HANGUP
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:852 (sofia/external/040*******) State HANGUP
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:449 Channel sofia/external/040******* hanging up, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:60 sofia/external/040******* Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:852 (sofia/external/040*******) State HANGUP going to sleep
2018-06-28 09:58:37.396752 [DEBUG] freeswitch_lua.cpp:372 DBH handle 0x7f8a70067440 Connected.
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Success: '0'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_result_text: 'FS_NOT_SET'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_file: '/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] uuid: 'a7af10be-8615-4699-8ad5-b11f9046fbd9'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_attempts: 4
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_limit: 20
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_sleep: 30
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_uri: 'sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040*******'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] accountcode: 'max.nl'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] origination_caller_id_name: 000000000000000
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] origination_caller_id_number: 000000000000000
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_result_code: 2
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] mailfrom_address:
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] mailto_address:
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] hangup_cause_q850: '41'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Last Fax Failed, try a different way. Wait first.
2018-06-28 09:58:37.416707 [DEBUG] switch_ivr_originate.c:3865 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]
2018-06-28 09:58:37.416707 [DEBUG] freeswitch_lua.cpp:401 DBH handle 0x7f8a5c057590 released.
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(fax_retry.lua):
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:619 (sofia/external/040*******) State Change CS_HANGUP -> CS_REPORTING
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_REPORTING (Cur 2 Tot 368)
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:938 (sofia/external/040*******) State REPORTING
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:174 sofia/external/040******* Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:938 (sofia/external/040*******) State REPORTING going to sleep
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:610 (sofia/external/040*******) State Change CS_REPORTING -> CS_DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_session.c:1713 Session 367 (sofia/external/040*******) Locked, Waiting on external entities
2018-06-28 09:58:37.436704 [NOTICE] switch_core_session.c:1731 Session 367 (sofia/external/040*******) Ended
2018-06-28 09:58:37.436704 [NOTICE] switch_core_session.c:1735 Close Channel sofia/external/040******* [CS_DESTROY]
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:741 (sofia/external/040*******) Running State Change CS_DESTROY (Cur 1 Tot 368)
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:751 (sofia/external/040*******) State DESTROY
2018-06-28 09:58:37.436704 [DEBUG] mod_sofia.c:354 sofia/external/040******* SOFIA DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:181 sofia/external/040******* Standard DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:751 (sofia/external/040*******) State DESTROY going to sleep
Apps->Fax Server->provide a name test1 and virtual extention 9001-> Save. Similarly Apps->Fax Server->provide a name test2 and virtual extention 9007-> Save.
Created 2 inbound destinations for these two servers with
public DID's I have with Actions and Fax Detection respectively. I just wanted to see if these two can communicate by sending message between them but have been unsuccessful. Are the steps I have followed even correct? Is there any default setting, modules or variables I have to enable before this? I know am doing something completely wrong but I have not much idea about fax .So can someone please let me know the step by step procedure to set up the fax server to work. Would be of great help. Thank you.The log I am getting now-
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] TRYING [3] of [4] to: 040******* with: t38 ON ECM OFF, SLOW
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Retry Command: originate {fax_retry_attempts=4,for_fax=1,accountcode='max.nl',domain_uuid=84c9f58a-ae19-4d1b-81c5-1924599f0aa1,domain_name=max.nl,mailto_address='',mailfrom_address='',origination_caller_id_name='000000000000000',origination_caller_id_number=000000000000000,fax_uri=sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040*******,fax_retry_limit=20,fax_retry_sleep=30,fax_verbose=true,fax_file='/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif',fax_ident='000000000000000',fax_header='000000000000000',fax_use_ecm=false,fax_enable_t38=true,fax_enable_t38_request=true,fax_disable_v17=true,fax_busy_attempts='0',api_hangup_hook='lua fax_retry.lua'}sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040******* &txfax('/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif')
2018-06-28 09:58:37.396752 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
2018-06-28 09:58:37.396752 [NOTICE] switch_channel.c:1104 New Channel sofia/external/040******* [a7af10be-8615-4699-8ad5-b11f9046fbd9]
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:5026 (sofia/external/040*******) State Change CS_NEW -> CS_INIT
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_INIT (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:627 (sofia/external/040*******) State INIT
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:93 sofia/external/040******* SOFIA INIT
2018-06-28 09:58:37.396752 [DEBUG] sofia_glue.c:1299 sofia/external/040******* sending invite version: 1.6.20 64bit
Local SDP:
v=0
o=FreeSWITCH 1530150101 1530150102 IN IP4 185.79.115.15
s=FreeSWITCH
c=IN IP4 185.79.115.15
t=0 0
m=audio 22616 RTP/AVP 0 8 101 13
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
a=sendrecv
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:40 sofia/external/040******* Standard INIT
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:48 (sofia/external/040*******) State Change CS_INIT -> CS_ROUTING
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:627 (sofia/external/040*******) State INIT going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_ROUTING (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:643 (sofia/external/040*******) State ROUTING
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:154 sofia/external/040******* SOFIA ROUTING
2018-06-28 09:58:37.396752 [DEBUG] switch_ivr_originate.c:67 (sofia/external/040*******) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:643 (sofia/external/040*******) State ROUTING going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] sofia.c:7283 Channel sofia/external/040******* entering state [calling][0]
2018-06-28 09:58:37.396752 [DEBUG] sofia.c:7283 Channel sofia/external/040******* entering state [terminated][503]
2018-06-28 09:58:37.396752 [NOTICE] sofia.c:8474 Hangup sofia/external/040******* [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:662 (sofia/external/040*******) State CONSUME_MEDIA
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:662 (sofia/external/040*******) State CONSUME_MEDIA going to sleep
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_HANGUP (Cur 2 Tot 368)
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:850 (sofia/external/040*******) Callstate Change DOWN -> HANGUP
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:852 (sofia/external/040*******) State HANGUP
2018-06-28 09:58:37.396752 [DEBUG] mod_sofia.c:449 Channel sofia/external/040******* hanging up, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:60 sofia/external/040******* Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.396752 [DEBUG] switch_core_state_machine.c:852 (sofia/external/040*******) State HANGUP going to sleep
2018-06-28 09:58:37.396752 [DEBUG] freeswitch_lua.cpp:372 DBH handle 0x7f8a70067440 Connected.
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Success: '0'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_result_text: 'FS_NOT_SET'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_file: '/var/lib/freeswitch/storage/fax/max.nl/9001/temp/a3afec4a-dc24-4841-ba24-c2c2eebd308b.tif'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] uuid: 'a7af10be-8615-4699-8ad5-b11f9046fbd9'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_attempts: 4
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_limit: 20
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_retry_sleep: 30
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_uri: 'sofia/gateway/502eb910-f3f5-4dfc-a5d9-9d10904c33cb/040*******'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] accountcode: 'max.nl'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] origination_caller_id_name: 000000000000000
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] origination_caller_id_number: 000000000000000
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] fax_result_code: 2
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] mailfrom_address:
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] mailto_address:
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] hangup_cause_q850: '41'
2018-06-28 09:58:37.396752 [INFO] switch_cpp.cpp:1376 [FAX] Last Fax Failed, try a different way. Wait first.
2018-06-28 09:58:37.416707 [DEBUG] switch_ivr_originate.c:3865 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]
2018-06-28 09:58:37.416707 [DEBUG] freeswitch_lua.cpp:401 DBH handle 0x7f8a5c057590 released.
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(fax_retry.lua):
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:619 (sofia/external/040*******) State Change CS_HANGUP -> CS_REPORTING
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:584 (sofia/external/040*******) Running State Change CS_REPORTING (Cur 2 Tot 368)
2018-06-28 09:58:37.416707 [DEBUG] switch_core_state_machine.c:938 (sofia/external/040*******) State REPORTING
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:174 sofia/external/040******* Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:938 (sofia/external/040*******) State REPORTING going to sleep
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:610 (sofia/external/040*******) State Change CS_REPORTING -> CS_DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_session.c:1713 Session 367 (sofia/external/040*******) Locked, Waiting on external entities
2018-06-28 09:58:37.436704 [NOTICE] switch_core_session.c:1731 Session 367 (sofia/external/040*******) Ended
2018-06-28 09:58:37.436704 [NOTICE] switch_core_session.c:1735 Close Channel sofia/external/040******* [CS_DESTROY]
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:741 (sofia/external/040*******) Running State Change CS_DESTROY (Cur 1 Tot 368)
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:751 (sofia/external/040*******) State DESTROY
2018-06-28 09:58:37.436704 [DEBUG] mod_sofia.c:354 sofia/external/040******* SOFIA DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:181 sofia/external/040******* Standard DESTROY
2018-06-28 09:58:37.436704 [DEBUG] switch_core_state_machine.c:751 (sofia/external/040*******) State DESTROY going to sleep
Last edited: