Ich habe folgendes Problem beim Faxversandproblem (Faxserver steht in Österreich) an einige Nummern im Ausland (Deutschland, Italien, Belgien, ...). Es kann an diese Nummern nicht gefaxt werden. Error Code 540 kommt retour. Großteil über 90% der Faxsendungen in diese Länder funktionieren aber. Trotzdem bleiben zahlreiche Nummern über wo kein Fax von Ferrarifax weg hin gesendet werden können. Über ein analoges Fax kann problemlos an diese Nummern gefaxt werden.
Der Fehler ist: Error code 540
Ländereinstellung und Rufnummernkorrektur sind korrekt.
Die Nummer die gewählt wird stimmen. Keine Ahnung warum der Fehler kommt.
LOG:
(4148) 12/08/29 13:24:26 - INFO: DChannel::StartSend(): processing outgoing job 11005171 on Box 10.10.10.178 - D03.
(4148) 12/08/29 13:24:26 - INFO: [phnumcor] MakePhoneNumExt(): raw address '0049XXXXXXXX' after automatic correction: '0049XXXXXXXX'.
(4148) 12/08/29 13:24:26 - INFO: --> :send --bchan_exec=fax.prc --called_party_number="00049XXXXXX" --calling_party_number="XXXXXXXXX" --client_id=11005171 --bchan_param=" --type=send --tx-file='[10.100.20.230:1154]/OMCUMS-EXPORT-50946B2A/work/omcums0/send/00a7ecf9.bff' --bps=14400 --ecm=0 --resolution=200 --compression=MMR --header=1 --logo=0 --info-text='' --csid='0043XXXXXXXXX' --to-whom='0049XXXXXXXX' --from-whom='XXXXXXX' --pages=1 --debug-snfs=0 --debug-fc=0 --debug-t30=1 --debug-t4=0 --debug-lapi=0 --debug-modem=0 --stat-fd=1"
(4148) 12/08/29 13:24:26 - INFO: <-- JC :input=':send --bchan_exec=fax.prc --called_party_number="00049XXXXXXXX" --calling_party_number="XXXXXXXX" --client_id=11005171 --bchan_param=" --type=send --tx-file='[10.100.20.230:1154]/OMCUMS-EXPORT-50946B2A/work/omcums0/send/00a7ecf9.bff' --bps=14400 --ecm=0 --resolution=200 --compression=MMR --header=1 --logo=0 --info-text='' --csid='0043XXXXXXXX' --to-whom='0049XXXXXXXXX' --from-whom='XXXXXXXXX' --pages=1 --debug-snfs=0 --debug-fc=0 --debug-t30=1 --debug-t4=0 --debug-lapi=0 --debug-modem=0 --stat-fd=1"'
(4148) 12/08/29 13:24:26 - INFO: state=ON_HOOK event=TE_OFFHOOK
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=OFF_HOOK
(4148) 12/08/29 13:24:26 - INFO: state=OFF_HOOK event=TE_SETUP
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=PREPARE_DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- :dchannel --message="offhook" --channel_id=8164 --client_id="11005171"
(4148) 12/08/29 13:24:26 - INFO: state=DSS1_U0, event=L4L3_SETUP_REQ
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: progress indicator set to enabled='FALSE' value=0
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,812 CallingNameSize == 0, qsig='false'
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,813 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U1
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,815 T:00 01 ac dc 08 01 72 05 04 03 90 90 a3 18 01 83 6c 0b 01 80 30 37 32 32 39 36 38 35 35 70 11 81 30 30 30 34 39 38 32 31 37 39 34 30 32 33 35 39
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,851 R:00 01 01 ae
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,949 R:02 01 dc ae 08 01 f2 0d 18 01 89
(4148) 12/08/29 13:24:26 - INFO: state=DSS1_U1, event=DSS1_SETUP_ACK
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,951 cpn=00049XXXXXXXXXX instance=1 callref=114 <-- state=DSS1_U2
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,952 T:02 01 01 de
(4148) 12/08/29 13:24:26 - INFO: state=PREPARE_DIALING event=CCA_DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- :alive
(4148) 12/08/29 13:24:26 - INFO: /dev/watchdog'
(4148) 12/08/29 13:24:26 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:27 - INFO: JobQueue::AddChannel(): adding channel 00889194 to list at 008890C8.
(4120) 12/08/29 13:24:27 - INFO: <-- :alive
(4120) 12/08/29 13:24:27 - INFO: /dev/watchdog'
(4120) 12/08/29 13:24:27 - INFO: <-- :sh --status=0
(4124) 12/08/29 13:24:29 - INFO: <-- :alive
(4124) 12/08/29 13:24:29 - INFO: /dev/watchdog'
(4124) 12/08/29 13:24:30 - INFO: <-- :sh --status=0
(4120) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.56,598 R:02 01 01 03
(4120) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.56,599 T:02 01 01 4b
(4132) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.57,514 R:02 01 01 95
(4132) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.57,516 T:02 01 01 97
(4132) 12/08/29 13:24:30 - INFO: <-- :alive
(4132) 12/08/29 13:24:30 - INFO: /dev/watchdog'
(4132) 12/08/29 13:24:31 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:32 - INFO: <-- :alive
(4148) 12/08/29 13:24:32 - INFO: /dev/watchdog'
(4148) 12/08/29 13:24:32 - INFO: <-- :sh --status=0
(4120) 12/08/29 13:24:33 - INFO: <-- :alive
(4120) 12/08/29 13:24:33 - INFO: /dev/watchdog'
(4120) 12/08/29 13:24:33 - INFO: <-- :sh --status=0
(4124) 12/08/29 13:24:34 - INFO: <-- L2X : 2012-08-29 13:24.00,698 R:02 01 01 2d
(4124) 12/08/29 13:24:34 - INFO: <-- L2X : 2012-08-29 13:24.00,699 T:02 01 01 f1
(4124) 12/08/29 13:24:35 - INFO: <-- :alive
(4124) 12/08/29 13:24:35 - INFO: /dev/watchdog'
(4124) 12/08/29 13:24:35 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,962 R:02 01 de ae 08 01 f2 45 08 02 80 9c
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U2, event=DSS1_DISCONNECT
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:02,964 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U12
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,966 T:02 01 01 e0
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U12, event=L4L3_RELEASE_REQ
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:02,967 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U19
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,971 T:00 01 ae e0 08 01 72 4d
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,988 R:00 01 01 b0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.03,098 R:02 01 e0 b0 08 01 f2 5a 08 02 80 90
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U19, event=DSS1_RELEASE_COMPLETE
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:03,099 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.03,101 T:02 01 01 e2
(4148) 12/08/29 13:24:36 - INFO: state=DIALING event=CCA_CALL_REJ
(4148) 12/08/29 13:24:36 - INFO: <-- :dchannel --message="onhook" --dchannel=8164-00049XXXXXXXXX-Wed_Aug_29_13:23:52_2012 --client_id="11005171" --charges=0 --cause=1C
(4148) 12/08/29 13:24:36 - INFO: Submitting message of type 'Send' to '0049XXXXXXXX' with status 2 and error code 540.
Mitschnitt auf IDSN Ebene zeigt es kommt kein Connect zustande.
Normal cleaning, keine ISDN Fehler, keine Ursache am ISDN zu sehen.
Hat jemand noch eine Idee woran das liegt?
Der Fehler ist: Error code 540
Ländereinstellung und Rufnummernkorrektur sind korrekt.
Die Nummer die gewählt wird stimmen. Keine Ahnung warum der Fehler kommt.
LOG:
(4148) 12/08/29 13:24:26 - INFO: DChannel::StartSend(): processing outgoing job 11005171 on Box 10.10.10.178 - D03.
(4148) 12/08/29 13:24:26 - INFO: [phnumcor] MakePhoneNumExt(): raw address '0049XXXXXXXX' after automatic correction: '0049XXXXXXXX'.
(4148) 12/08/29 13:24:26 - INFO: --> :send --bchan_exec=fax.prc --called_party_number="00049XXXXXX" --calling_party_number="XXXXXXXXX" --client_id=11005171 --bchan_param=" --type=send --tx-file='[10.100.20.230:1154]/OMCUMS-EXPORT-50946B2A/work/omcums0/send/00a7ecf9.bff' --bps=14400 --ecm=0 --resolution=200 --compression=MMR --header=1 --logo=0 --info-text='' --csid='0043XXXXXXXXX' --to-whom='0049XXXXXXXX' --from-whom='XXXXXXX' --pages=1 --debug-snfs=0 --debug-fc=0 --debug-t30=1 --debug-t4=0 --debug-lapi=0 --debug-modem=0 --stat-fd=1"
(4148) 12/08/29 13:24:26 - INFO: <-- JC :input=':send --bchan_exec=fax.prc --called_party_number="00049XXXXXXXX" --calling_party_number="XXXXXXXX" --client_id=11005171 --bchan_param=" --type=send --tx-file='[10.100.20.230:1154]/OMCUMS-EXPORT-50946B2A/work/omcums0/send/00a7ecf9.bff' --bps=14400 --ecm=0 --resolution=200 --compression=MMR --header=1 --logo=0 --info-text='' --csid='0043XXXXXXXX' --to-whom='0049XXXXXXXXX' --from-whom='XXXXXXXXX' --pages=1 --debug-snfs=0 --debug-fc=0 --debug-t30=1 --debug-t4=0 --debug-lapi=0 --debug-modem=0 --stat-fd=1"'
(4148) 12/08/29 13:24:26 - INFO: state=ON_HOOK event=TE_OFFHOOK
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=OFF_HOOK
(4148) 12/08/29 13:24:26 - INFO: state=OFF_HOOK event=TE_SETUP
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=PREPARE_DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- :dchannel --message="offhook" --channel_id=8164 --client_id="11005171"
(4148) 12/08/29 13:24:26 - INFO: state=DSS1_U0, event=L4L3_SETUP_REQ
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: progress indicator set to enabled='FALSE' value=0
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,812 CallingNameSize == 0, qsig='false'
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,813 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U1
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,815 T:00 01 ac dc 08 01 72 05 04 03 90 90 a3 18 01 83 6c 0b 01 80 30 37 32 32 39 36 38 35 35 70 11 81 30 30 30 34 39 38 32 31 37 39 34 30 32 33 35 39
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,851 R:00 01 01 ae
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,949 R:02 01 dc ae 08 01 f2 0d 18 01 89
(4148) 12/08/29 13:24:26 - INFO: state=DSS1_U1, event=DSS1_SETUP_ACK
(4148) 12/08/29 13:24:26 - INFO: <-- DSS1: 13:23:52,951 cpn=00049XXXXXXXXXX instance=1 callref=114 <-- state=DSS1_U2
(4148) 12/08/29 13:24:26 - INFO: <-- L2X : 2012-08-29 13:23.52,952 T:02 01 01 de
(4148) 12/08/29 13:24:26 - INFO: state=PREPARE_DIALING event=CCA_DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- JC :CH_ID=8164: <-- next_state=DIALING
(4148) 12/08/29 13:24:26 - INFO: <-- :alive
(4148) 12/08/29 13:24:26 - INFO: /dev/watchdog'
(4148) 12/08/29 13:24:26 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:27 - INFO: JobQueue::AddChannel(): adding channel 00889194 to list at 008890C8.
(4120) 12/08/29 13:24:27 - INFO: <-- :alive
(4120) 12/08/29 13:24:27 - INFO: /dev/watchdog'
(4120) 12/08/29 13:24:27 - INFO: <-- :sh --status=0
(4124) 12/08/29 13:24:29 - INFO: <-- :alive
(4124) 12/08/29 13:24:29 - INFO: /dev/watchdog'
(4124) 12/08/29 13:24:30 - INFO: <-- :sh --status=0
(4120) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.56,598 R:02 01 01 03
(4120) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.56,599 T:02 01 01 4b
(4132) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.57,514 R:02 01 01 95
(4132) 12/08/29 13:24:30 - INFO: <-- L2X : 2012-08-29 13:23.57,516 T:02 01 01 97
(4132) 12/08/29 13:24:30 - INFO: <-- :alive
(4132) 12/08/29 13:24:30 - INFO: /dev/watchdog'
(4132) 12/08/29 13:24:31 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:32 - INFO: <-- :alive
(4148) 12/08/29 13:24:32 - INFO: /dev/watchdog'
(4148) 12/08/29 13:24:32 - INFO: <-- :sh --status=0
(4120) 12/08/29 13:24:33 - INFO: <-- :alive
(4120) 12/08/29 13:24:33 - INFO: /dev/watchdog'
(4120) 12/08/29 13:24:33 - INFO: <-- :sh --status=0
(4124) 12/08/29 13:24:34 - INFO: <-- L2X : 2012-08-29 13:24.00,698 R:02 01 01 2d
(4124) 12/08/29 13:24:34 - INFO: <-- L2X : 2012-08-29 13:24.00,699 T:02 01 01 f1
(4124) 12/08/29 13:24:35 - INFO: <-- :alive
(4124) 12/08/29 13:24:35 - INFO: /dev/watchdog'
(4124) 12/08/29 13:24:35 - INFO: <-- :sh --status=0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,962 R:02 01 de ae 08 01 f2 45 08 02 80 9c
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U2, event=DSS1_DISCONNECT
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:02,964 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U12
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,966 T:02 01 01 e0
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U12, event=L4L3_RELEASE_REQ
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:02,967 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U19
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,971 T:00 01 ae e0 08 01 72 4d
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.02,988 R:00 01 01 b0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.03,098 R:02 01 e0 b0 08 01 f2 5a 08 02 80 90
(4148) 12/08/29 13:24:36 - INFO: state=DSS1_U19, event=DSS1_RELEASE_COMPLETE
(4148) 12/08/29 13:24:36 - INFO: <-- DSS1: 13:24:03,099 cpn=00049XXXXXXXXX instance=1 callref=114 <-- state=DSS1_U0
(4148) 12/08/29 13:24:36 - INFO: <-- L2X : 2012-08-29 13:24.03,101 T:02 01 01 e2
(4148) 12/08/29 13:24:36 - INFO: state=DIALING event=CCA_CALL_REJ
(4148) 12/08/29 13:24:36 - INFO: <-- :dchannel --message="onhook" --dchannel=8164-00049XXXXXXXXX-Wed_Aug_29_13:23:52_2012 --client_id="11005171" --charges=0 --cause=1C
(4148) 12/08/29 13:24:36 - INFO: Submitting message of type 'Send' to '0049XXXXXXXX' with status 2 and error code 540.
Mitschnitt auf IDSN Ebene zeigt es kommt kein Connect zustande.
Normal cleaning, keine ISDN Fehler, keine Ursache am ISDN zu sehen.
Hat jemand noch eine Idee woran das liegt?
Kommentar