Befehl ausgeführt, und über date werden mir aktuelle Daten angezeigtAuf einer Linux 3CX shellapt -y install ntp.
10.02.2025 16:41:31 026xxxxxxx Fax (88) Answered 00:00:00 00:00:34 0,00 Terminated by Fax (88)
Zuletzt bearbeitet:
Befehl ausgeführt, und über date werden mir aktuelle Daten angezeigtAuf einer Linux 3CX shellapt -y install ntp.
Kläre, wieso der Anruf per DID nicht da ankommt. Das sollte funktionieren.wenn ich die 88 anwähle kommt das Fax Signal, bei der DID aber nicht
ich hab auf Ausführlich stehen. Nach was genau sollte ich hier den suchen?Die Option Aktivieren des G.711 zu T.38 Fallback im Faxserver ist aktiviert, richtig?
Kläre, wieso der Anruf per DID nicht da ankommt. Das sollte funktionieren.
Es kann ja auch sein, dass die definierten DID nicht treffen. Das 3CX Aktivitätsprotokoll zeigt schon recht gut welche DID für so einen Anruf verwendet wird, muss man die Protokollierungsstufe auf mind. Medium stellen.
Auf der Console timedatectlUnter den Parametern steht bei NTP Server der pool.ntp.org drin. Uhrzeit finde ich wo?
Das ist aber schon das BYE. Was passiert davor?Hier mal ein Auszug vom Protokoll
...
10.02.2025 16:57:32.944 L:639.3[Fax:88{4878663e88cb}]: on terminated: 'Cause: BYE from PBX
10.02.2025 16:57:32.944 L:639.3[Fax:88{4878663e88cb}] onReadyToSend: Send Send 200/BYE from 0.0.0.0:0
10.02.2025 16:57:08.421 L:639.3[Fax:88{4878663e88cb}]: SDP events handler sehReneg reset by sehRenegDas ist aber schon das BYE. Was passiert davor?
Ist das überhaupt ein Anruf von außerhalb an die Fax DID der 3CX? Sieht irgendwie ganz und gar nicht so aus. Der Teil davor (vor 16:56:58) fehlt auch.
10.02.2025 19:46:22.452 L:1.3[Fax:88{7896f862ffa9}] detached from call; ads{633}
10.02.2025 19:46:22.452 L:1.3[Fax:88{7896f862ffa9}]: CONNECTION ID updated: 3 => 0
10.02.2025 19:46:22.451 Removing connected for L:1.3[Fax:88{7896f862ffa9}], terminate connected
10.02.2025 19:46:22.451 L:1.3[Fax:88{7896f862ffa9}] is terminated
10.02.2025 19:46:22.451 L:1.3[Fax:88{7896f862ffa9}] Connected handler: Terminated event: OK
10.02.2025 19:46:22.451 Call(C:1): request to stop call recording @ L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:46:22.451 L:1.3[Fax:88{7896f862ffa9}]: on terminated: 'Cause: BYE from PBX
10.02.2025 19:46:22.451 Removing connected for L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:46:22.451 Call(C:1): request to stop call recording @ L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:46:22.451 L:1.3[Fax:88{7896f862ffa9}] being terminated (UserTerminated)
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] has no segment with L:1.1[Line:10001<<0xxxx{67c5e6777d6a}]
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] segment terminated (UserTerminated) to L:1.1[Line:10001<<02622873079{67c5e6777d6a}]
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] has no segment with L:1.1[Line:10001<<02622873079{67c5e6777d6a}]
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] segment terminated (Ok) to L:1.1[Line:10001<<02622873079{67c5e6777d6a}]
10.02.2025 19:46:22.450 Removing connected for L:1.3[Fax:88{7896f862ffa9}], terminate connected
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] is terminated
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}] Connected handler: Terminated event: OK
10.02.2025 19:46:22.450 DefSEHL:1.3[Fax:88{7896f862ffa9}] leg terminated
10.02.2025 19:46:22.450 L:1.1[Line:10001<<0xxxxxxx{67c5e6777d6a}] segment terminated (UserTerminated) to L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}]: destroying MSEP([email protected]:5482@?)
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}]: disjoined MSEP([email protected]:5482@?) from MSC([email protected]:5482)
10.02.2025 19:46:22.450 Call(C:1): request to stop call recording @ L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:46:22.450 L:1.3[Fax:88{7896f862ffa9}]: on terminated: 'Cause: BYE from PBX
10.02.2025 19:46:22.449 L:1.3[Fax:88{7896f862ffa9}] onReadyToSend: Send Send 200/BYE from 0.0.0.0:0 tid=f128323734e1c17d Call-ID=M_Sdh3nkWG33r4HKxWl7Jg..:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:5483;branch=z9hG4bK-524287-1---f128323734e1c17d;rport=5483
Contact: <sip:[email protected]:5062>
To: "0xxxx"<sip:[email protected]:5062;nf=e>;tag=81abf04b
From: <sip:[email protected]:5062>;tag=3fdbbd27
Call-ID: M_Sdh3nkWG33r4HKxWl7Jg..
CSeq: 3 BYE
Content-Length: 0
10.02.2025 19:45:57.904 L:1.3[Fax:88{7896f862ffa9}]: SDP events handler sehReneg reset by sehReneg
10.02.2025 19:45:57.904 L:1.3[Fax:88{7896f862ffa9}]: state changed GotAnswer_to => SentAnswer_from
10.02.2025 19:45:57.904 L:1.3[Fax:88{7896f862ffa9}] onReadyToSend: Send Send 200/INVITE from 0.0.0.0:0 tid=c99fea023fd5152a Call-ID=M_Sdh3nkWG33r4HKxWl7Jg..:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 127.0.0.1:5483;branch=z9hG4bK-524287-1---c99fea023fd5152a;rport=5483
Contact: <sip:[email protected]:5062>
To: "0xxxxx"<sip:[email protected]:5062;nf=e>;tag=81abf04b
From: <sip:[email protected]:5062>;tag=3fdbbd27
Call-ID: M_Sdh3nkWG33r4HKxWl7Jg..
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE, UPDATE
Content-Type: application/sdp
Supported: replaces, timer
Content-Length: 276
v=0
o=3cxPS 16255908975738880 2162470433062914 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 127.0.0.1
t=0 0
m=image 7002 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:1400
a=T38FaxUdpEC:t38UDPRedundancy
10.02.2025 19:45:57.904 L:1.3[Fax:88{7896f862ffa9}]: state changed TookAnswer => Ready
10.02.2025 19:45:57.903 L:1.3[Fax:88{7896f862ffa9}] took local SDP for answer: v=0
o=3cxPS 16255908975738880 2162470433062914 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 127.0.0.1
t=0 0
m=image 7002 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxDatagram:1400
a=T38FaxUdpEC:t38UDPRedundancy
10.02.2025 19:45:57.902 L:1.3[Fax:88{7896f862ffa9}]: state changed SetOffer => TookAnswer
10.02.2025 19:45:57.791 L:1.3[Fax:88{7896f862ffa9}]: state changed Initial => GotOffer_from
10.02.2025 19:45:57.789 L:1.3[Fax:88{7896f862ffa9}]: SDP events handler change from sehDefault to sehReneg
10.02.2025 19:45:57.789 L:1.1[Line:10001<<02622873079{67c5e6777d6a}] doesn't support re-INVITE, but re-INVITE is from Fax(L:1.3[Fax:88{7896f862ffa9}]); forcing re-INVITE
10.02.2025 19:45:57.789 C:1 SDP renegotiation request from L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:57.789 DefSEHL:1.3[Fax:88{7896f862ffa9}] onOffer, state = connected
10.02.2025 19:45:57.789 L:1.3[Fax:88{7896f862ffa9}] set remote offer SDP: v=0
o=3cxVCE 18446744072935286943 733624840 IN IP4 127.0.0.1
s=3cxVCE Audio Call
c=IN IP4 127.0.0.1
t=0 0
m=image 12002 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxUdpEC:t38UDPRedundancy
10.02.2025 19:45:57.789 L:1.3[Fax:88{7896f862ffa9}]MSEP([email protected]:5482@[email protected]:5482) set offer; joined
10.02.2025 19:45:47.575 C:1 % RouteConnected Fax:88{7896f862ffa9}
10.02.2025 19:45:47.575 L:1.3[Fax:88{7896f862ffa9}] changes event handler from SingleDest to Connected
10.02.2025 19:45:47.575 C:1 media is on MS; checking media reneg conditions for L:1.1[Line:10001<<0xxxxx{67c5e6777d6a}] and L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.574 Connected: L:1.3[Fax:88{7896f862ffa9}] => L:1.1[Line:10001<<0xxxxx{67c5e6777d6a}]
10.02.2025 19:45:47.574 Segm(2): L:1.1[Line:10001<<02622873079{67c5e6777d6a}] segment answered at L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.574 Set connected: L:1.1[Line:10001<<02622873079{67c5e6777d6a}] <=> L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.574 L:1.3[Fax:88{7896f862ffa9}]: accepted; MSEP([email protected]:5482@[email protected]:5482)
10.02.2025 19:45:47.574 Call(C:1): == Connected L:1.1[Line:10001<<02622873079{67c5e6777d6a}] and L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.574 L:1.3[Fax:88{7896f862ffa9}]: accepted; MSEP([email protected]:5482@[email protected]:5482)
10.02.2025 19:45:47.574 [IncRR](C:1): Confirming L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.573 [IncRR](C:1): Connected destination L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.573 SingleDest(1646998458)@C:1OnConnected from L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}]: joined to MSCall(MSC([email protected]:5482))
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}]: connected
10.02.2025 19:45:47.573 DefSEHL:1.3[Fax:88{7896f862ffa9}] answer provided
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}]: disjoined MSEP([email protected]:5482@?) from MSC([email protected]:5482)
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}] set remote answer SDP: v=0
o=3cxVCE 18446744072935286943 733624839 IN IP4 127.0.0.1
s=3cxVCE Audio Call
c=IN IP4 127.0.0.1
t=0 0
m=audio 12004 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}]: joined to MSCall(MSC([email protected]:5482))
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}]MSEP([email protected]:5482@?) set answer; disjoined
10.02.2025 19:45:47.573 L:1.3[Fax:88{7896f862ffa9}] onReadyToSend: Send Send Req ACK from 0.0.0.0:0 tid=18cc726bd5b8ee4d Call-ID=M_Sdh3nkWG33r4HKxWl7Jg..:
ACK sip:[email protected]:5483;rinstance=d68080f50fd928b7 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-524287-1---18cc726bd5b8ee4d;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5062>
To: <sip:[email protected]:5062>;tag=3fdbbd27
From: "0xxxxx"<sip:[email protected]:5062;nf=e>;tag=81abf04b
Call-ID: M_Sdh3nkWG33r4HKxWl7Jg..
CSeq: 1 ACK
Content-Length: 0
10.02.2025 19:45:47.571 L:1.3[Fax:88{7896f862ffa9}] Outgoing handler: Ringing event
10.02.2025 19:45:47.571 SingleDest(1646998458)@C:1OnRinging from L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.570 L:1.3[Fax:88{7896f862ffa9}]: ringing
10.02.2025 19:45:47.570 L:1.3[Fax:88{7896f862ffa9}]: has answered outgoing INVITE
10.02.2025 19:45:47.544 [IncRR](C:1): : Party changed: L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.544 BaseDest(1646998458)@C:1: Active connection update on L:1.3[Fax:88{7896f862ffa9}] (locked 0)
10.02.2025 19:45:47.544 L:1.3[Fax:88{7896f862ffa9}]: CONNECTION ID updated: 0 => 3
10.02.2025 19:45:47.544 L:1.3[Fax:88{7896f862ffa9}] initiating call with InvOUT Send Req INVITE from 0.0.0.0:0 tid=589a4f297fd1832b Call-ID=M_Sdh3nkWG33r4HKxWl7Jg..:
INVITE sip:[email protected]:5483;rinstance=d68080f50fd928b7 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-524287-1---589a4f297fd1832b;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5062>
To: <sip:[email protected]:5062>
From: "0xxxxx"<sip:[email protected]:5062;nf=e>;tag=81abf04b
Call-ID: M_Sdh3nkWG33r4HKxWl7Jg..
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE, UPDATE
Content-Type: application/sdp
Supported: replaces, timer
Content-Length: 437
v=0
o=3cxPS 16255908975738880 2162470433062913 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 127.0.0.1
t=0 0
m=audio 7000 RTP/AVP 0 8 9 18 112 102 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:112 opus/48000/2
a=fmtp:112 maxplaybackrate=16000;sprop-maxcapturerate=16000
a=rtpmap:102 telephone-event/48000
a=rtpmap:101 telephone-event/8000
a=sendrecv
10.02.2025 19:45:47.544 L:1.3[Fax:88{7896f862ffa9}]: disjoined MSEP([email protected]:5482@?) from MSC([email protected]:5482)
10.02.2025 19:45:47.544 L:1.3[Fax:88{7896f862ffa9}] took local SDP for offer: v=0
o=3cxPS 16255908975738880 2162470433062913 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 127.0.0.1
t=0 0
m=audio 7000 RTP/AVP 0 8 9 18 112 102 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:112 opus/48000/2
a=fmtp:112 maxplaybackrate=16000;sprop-maxcapturerate=16000
a=rtpmap:102 telephone-event/48000
a=rtpmap:101 telephone-event/8000
a=sendrecv
10.02.2025 19:45:47.543 L:1.3[Fax:88{7896f862ffa9}]: state changed Init => TookOffer
10.02.2025 19:45:47.543 L:1.3[Fax:88{7896f862ffa9}]: created MSEP([email protected]:5482@[email protected]:5482) (bound); joined, SRTP disabled
10.02.2025 19:45:47.543 L:1.3[Fax:88{7896f862ffa9}]: joined to MSCall(MSC([email protected]:5482))
10.02.2025 19:45:47.543 L:1.3[Fax:88{7896f862ffa9}] diversion path: [[External.10001.],[Fax.17.]]
10.02.2025 19:45:47.543 SingleDest(1646998458)@C:1 start, outbound leg L:1.3[Fax:88{7896f862ffa9}]
10.02.2025 19:45:47.543 Created UAC leg L:1.3[Fax:88{7896f862ffa9}] for Destination Fax:88{7896f862ffa9}; ads{633}
10.02.2025 19:45:47.543 C:1: creating destination for Fax:88{7896f862ffa9}; target uid 7896.a3a8
10.02.2025 19:45:47.543 [IncRR](C:1): Divert request on L:1.2[Route:ROUTER@{}10001{e56dc372f9d6}] to Fax:88{7896f862ffa9}
10.02.2025 19:45:47.543 SingleDest(605196072)@C:1 Divert request L:1.2[Route:ROUTER@{}10001{e56dc372f9d6}] divert to Fax:88{7896f862ffa9}
10.02.2025 19:33:34.385 [CM504008]: Fax Service: Fax.88 registered as sip:[email protected]:5062 with contact sip:[email protected]:5483;rinstance=d68080f50fd928b7
Ja ein Anruf auf die DID gibt kein Signal, beim internen Anruf auf die 88 gibt es aber einsNoch einmal einige Posts zurück. Du schreibst, dass du kein Fax Signal hörst wenn du von extern die Fax DID anrufst. Ist dem noch so?
Jetzt schreibst du, dass du versuchst ein Fax zu schicken. Auch das geht schief da immer noch PCMU als Codec verhandelt wird und danach T38.
Der Anfang vom Anruf fehlt immer noch: New Call, Checking Inbound Rule, Rule matched ... usw.. Das war doch urspr. wohl dein Problem.
Ändere das bitte.
Dort und im SIP Trunk und in den Endgeräten und vmtl. eben auch im ATA.Wo ändere ich den Codec? Erweitert --> Codecs?
Du meinst im 3CX Aktivitätsprotokoll? Da hast du gefiltert? Dann kann das halt schon so kurz aussehen. Das wichtige - die DID Suche - fehlt.Das was ich eben als Code geschickt habe, war alles das was nach dem Neustart unter den Protokollen beim Benutzer Fax geloggt wurde
10.02.2025 20:03:22.602 L:317.1[Line:10006<<017xxxxxxxx{99d6c53f7696}] got endpoint Line:10006<<017xxxxxxxx{99d6c53f7696} from "MisterX" <sip:[email protected]:5062> to <sip:[email protected]:5062>
10.02.2025 20:03:22.602 [CM503012]: Inbound office hours rule (unnamed) for 10006 forwards to Fax:888
10.02.2025 20:03:22.602 Rule matched
10.02.2025 20:03:22.602 Checking inbound rule '': hour type = 2; cond = 6; mask = '*xxxxxxx'
10.02.2025 20:03:22.602 Checking inbound rule '': hour type = 2; cond = 6; mask = '*xxxxxxx'
10.02.2025 20:03:22.602 Checking inbound rule '111': hour type = 2; cond = 6; mask = '*xxxxxxx'
10.02.2025 20:03:22.601 Checking inbound rule '222': hour type = 2; cond = 6; mask = '*xxxxxxx'
10.02.2025 20:03:22.601 [Flow] No office hours set, office hours assumed
10.02.2025 20:03:22.601 Current local time is: 20:3:22
10.02.2025 20:03:22.601 [Flow] Looking for inbound target: called=035xxxxxxxxx; caller="MisterX" <sip:017xxxxxxxx@:0>
10.02.2025 20:03:22.601 CallerNameAddr: "MisterX"<sip:017xxxxxxxx;nf=e>
10.02.2025 20:03:22.601 PBSubst: 017xxxxxxxx => MisterX(2 matches found)
10.02.2025 20:03:22.601 No inbound caller ID reformat rule for DN:10006 is defined, or it is disabled (<Rules />)
10.02.2025 20:03:22.601 Created device copy Dev(1793448091):[sip:[email protected]:5060 / 035xxxxxxxxxx]: AOR = <sip:[email protected]:5062/UDP>
10.02.2025 20:03:22.601 Line Lc:10006(@xxxxxxxxxxx[<sip:[email protected]:5060/UDP>]) found for rinstance '96563b8868ff2f11'
10.02.2025 20:03:22.601 Lsip{347755/317.1/UAS[GotInvite&Neutral]} incoming call:
InvIN Recv Req INVITE from xx.xx.xxx.xx:5060 tid=07d5.8a14f78642fe08bd563f1bdac16baf42.0 [email protected]:
2005 gegründet, als VoIP noch eine aufstrebende Technologie war, hat sich 3CX seither zu einem globalen Marktführer im Bereich der Geschäftskommunikation entwickelt.