Hello,
I have an issue that I don't understand.
IP Office answers 400 on SIP invites.
I suspect malformed INVITE, but I don't find why.
Other calls are OK, just some callers, always the same, are refused.
I noticed errors with topology, but other calls are OK.
Any help is welcome.
Here are monitor traces...
I have an issue that I don't understand.
IP Office answers 400 on SIP invites.
I suspect malformed INVITE, but I don't find why.
Other calls are OK, just some callers, always the same, are refused.
I noticed errors with topology, but other calls are OK.
Any help is welcome.
Here are monitor traces...
Code:
2023-09-19T15:04:50 1177341605mS SIP Rx: UDP [PublicIP]:5060 -> [PrivateIP]:5060
INVITE sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
P-Asserted-Identity: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS
P-Early-Media: supported
Supported: histinfo,timer
Content-Type: application/sdp
Contact: <sip:[CallerNumber]@[PublicIP]:5060;x-fbi=stdn-10;tgrp=inbound;trunk_context=inbound;transport=udp>
Content-Length: 320
Session-Expires: 2160;refresher=uac
Min-SE: 90
v=0
o=- 3581248632 1248934670 IN IP4 [PublicIP]
s=-
c=IN IP4 [PublicIP]
t=0 0
a=sendrecv
m=audio 35592 RTP/AVP 8 18 98 0
c=IN IP4 [PublicIP]
a=rtpmap:8 PCMA/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:98 telephone-event/8000
a=fmtp:98 0-15
a=rtpmap:0 PCMU/8000
a=maxptime:40
a=ptime:20
2023-09-19T15:04:50 1177341610mS Sip: Association found trunk: SIP Line (17)
2023-09-19T15:04:50 1177341611mS SIP Call Rx: 17
INVITE sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
P-Asserted-Identity: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS
P-Early-Media: supported
Supported: histinfo,timer
Content-Type: application/sdp
Contact: <sip:[CallerNumber]@[PublicIP]:5060;x-fbi=stdn-10;tgrp=inbound;trunk_context=inbound;transport=udp>
Content-Length: 320
Session-Expires: 2160;refresher=uac
Min-SE: 90
v=0
o=- 3581248632 1248934670 IN IP4 [PublicIP]
s=-
c=IN IP4 [PublicIP]
t=0 0
a=sendrecv
m=audio 35592 RTP/AVP 8 18 98 0
c=IN IP4 [PublicIP]
a=rtpmap:8 PCMA/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:98 telephone-event/8000
a=fmtp:98 0-15
a=rtpmap:0 PCMU/8000
a=maxptime:40
a=ptime:20
2023-09-19T15:04:50 1177341614mS CMCallEvt: 0000000000000000 0.66621.0 -1 BaseEP: NEW CMEndpoint f3dbfd10 TOTAL NOW=654 CALL_LIST=6
2023-09-19T15:04:50 1177341614mS Sip: SIP Line (17): sip_trunk_config_items 50020001, sip_trunk_config_items_2 00000000, voip.flags 00000948
2023-09-19T15:04:50 1177341614mS Sip: SIPDialog f3dbd320 created, dialogs 647 txn_keys 1 video 0 presentation 0 camera 0 unsupp audio 0
2023-09-19T15:04:50 1177341615mS Sip: 0000000000000000 0.66621.0 -1 SIPTrunk Endpoint(f3dbd320) SetUnIntTransactionCondition to UnInt_None
2023-09-19T15:04:50 1177341615mS CMMap: PCP created pcp[750]b0r0
2023-09-19T15:04:50 1177341616mS CH : CHand::AllocateIPConnectionPoint cp[750]b0r0[TOTAL CP:748]
2023-09-19T15:04:50 1177341617mS VOIP: (Out) 0000000000000000 0.66621.0 -1 SIPTrunk Endpoint: SetOutboundSecInfo, size 2 GenerateLocal
2023-09-19T15:04:50 1177341617mS PRIM: (Out) 0000000000000000 0.66621.0 -1 SIPTrunk Endpoint: SetCapabilitySet Local 0 to f3e43740 (size 9) has g722 0
2023-09-19T15:04:50 1177341618mS Sip: SIP Line (17) GetNetworkTopologySource Use Network Topology badly configured
2023-09-19T15:04:50 1177341618mS Sip: SIP Line (17) GetNetworkTopologySource Use Network Topology badly configured
2023-09-19T15:04:50 1177341618mS Sip: SIP Line (17): License, Valid 1, Available 8, Consumed 3
2023-09-19T15:04:50 1177341619mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForRequest from [PublicIP]:5060 to [PublicIP]:5060
2023-09-19T15:04:50 1177341620mS Sip: 0a02f2010001043d 17.66621.1 -1 SIPTrunk Endpoint(f3dbd320) PreProcess Invite: error is 6
2023-09-19T15:04:50 1177341620mS Sip: SIPDialog::ExtractResponseParamsFromViaHeader remote sent_by: [PublicIP]:5060 trunk
2023-09-19T15:04:50 1177341620mS Sip: SIPDialog::ExtractResponseParamsFromViaHeader remote sent by transport: SIP/2.0/UDP trunk
2023-09-19T15:04:50 1177341621mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForResponse from [PublicIP]:5060 to [PublicIP]:5060
2023-09-19T15:04:50 1177341622mS Sip: 0a02f2010001043d 17.66621.1 -1 SIPTrunk Endpoint(f3dbd320) SendSIPResponse: INVITE code 400 SENT TO [PublicIP] 5060
2023-09-19T15:04:50 1177341622mS SIP Call Tx: 17
SIP/2.0 400 Bad Request
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer
Server: IP Office 11.1.1.1.0 build 18
Reason: Q.850;cause=41;text="Temporary failure"
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=aaf36dce8c2e7606
Content-Length: 0
2023-09-19T15:04:50 1177341624mS SIP Tx: UDP [PrivateIP]:5060 -> [PublicIP]:5060
SIP/2.0 400 Bad Request
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer
Server: IP Office 11.1.1.1.0 build 18
Reason: Q.850;cause=41;text="Temporary failure"
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=aaf36dce8c2e7606
Content-Length: 0
2023-09-19T15:04:50 1177341625mS Sip: 0a02f2010001043d 17.66621.1 -1 SIPTrunk Endpoint(f3dbd320) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::FINAL(28)
2023-09-19T15:04:50 1177341625mS Sip: Incoming Method, Parsing Failed 6
2023-09-19T15:04:50 1177341648mS SIP Rx: UDP [PublicIP]:5060 -> [PrivateIP]:5060
ACK sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
CSeq: 1 ACK
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=aaf36dce8c2e7606
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
Content-Length: 0
2023-09-19T15:04:50 1177341651mS Sip: From Tag does not match any mNearTag or mFarTag or it is non existent ...
2023-09-19T15:04:50 1177341651mS Sip: Association found trunk: SIP Line (17)
2023-09-19T15:04:50 1177341652mS SIP Call Rx: 17
ACK sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKbbh2220098n52lj2f320.1
CSeq: 1 ACK
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=aaf36dce8c2e7606
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
Content-Length: 0
2023-09-19T15:04:50 1177341671mS SIP Rx: UDP [PublicIP]:5060 -> [PrivateIP]:5060
INVITE sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
P-Asserted-Identity: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS
P-Early-Media: supported
Supported: histinfo,timer
Content-Type: application/sdp
Contact: <sip:[CallerNumber]@[PublicIP]:5060;x-fbi=stdn-10;tgrp=inbound;trunk_context=inbound;transport=udp>
Content-Length: 319
Session-Expires: 2160;refresher=uac
Min-SE: 90
v=0
o=- 900060258 1248934670 IN IP4 [PublicIP]
s=-
c=IN IP4 [PublicIP]
t=0 0
a=sendrecv
m=audio 10500 RTP/AVP 8 18 98 0
c=IN IP4 [PublicIP]
a=rtpmap:8 PCMA/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:98 telephone-event/8000
a=fmtp:98 0-15
a=rtpmap:0 PCMU/8000
a=maxptime:40
a=ptime:20
2023-09-19T15:04:50 1177341675mS Sip: From Tag does not match any mNearTag or mFarTag or it is non existent ...
2023-09-19T15:04:50 1177341676mS Sip: Association found trunk: SIP Line (17)
2023-09-19T15:04:50 1177341677mS SIP Call Rx: 17
INVITE sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
P-Asserted-Identity: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS
P-Early-Media: supported
Supported: histinfo,timer
Content-Type: application/sdp
Contact: <sip:[CallerNumber]@[PublicIP]:5060;x-fbi=stdn-10;tgrp=inbound;trunk_context=inbound;transport=udp>
Content-Length: 319
Session-Expires: 2160;refresher=uac
Min-SE: 90
v=0
o=- 900060258 1248934670 IN IP4 [PublicIP]
s=-
c=IN IP4 [PublicIP]
t=0 0
a=sendrecv
m=audio 10500 RTP/AVP 8 18 98 0
c=IN IP4 [PublicIP]
a=rtpmap:8 PCMA/8000
a=fmtp:18 annexb=no
a=rtpmap:18 G729/8000
a=rtpmap:98 telephone-event/8000
a=fmtp:98 0-15
a=rtpmap:0 PCMU/8000
a=maxptime:40
a=ptime:20
2023-09-19T15:04:50 1177341679mS CMCallEvt: 0000000000000000 0.66622.0 -1 BaseEP: NEW CMEndpoint f3db1334 TOTAL NOW=655 CALL_LIST=6
2023-09-19T15:04:50 1177341680mS Sip: SIP Line (17): sip_trunk_config_items 50020001, sip_trunk_config_items_2 00000000, voip.flags 00000948
2023-09-19T15:04:50 1177341680mS Sip: SIPDialog f3daf6d4 created, dialogs 648 txn_keys 2 video 0 presentation 0 camera 0 unsupp audio 0
2023-09-19T15:04:50 1177341680mS Sip: 0000000000000000 0.66622.0 -1 SIPTrunk Endpoint(f3daf6d4) SetUnIntTransactionCondition to UnInt_None
2023-09-19T15:04:50 1177341681mS CMMap: PCP created pcp[751]b0r0
2023-09-19T15:04:50 1177341681mS CH : CHand::AllocateIPConnectionPoint cp[751]b0r0[TOTAL CP:749]
2023-09-19T15:04:50 1177341682mS VOIP: (Out) 0000000000000000 0.66622.0 -1 SIPTrunk Endpoint: SetOutboundSecInfo, size 2 GenerateLocal
2023-09-19T15:04:50 1177341682mS PRIM: (Out) 0000000000000000 0.66622.0 -1 SIPTrunk Endpoint: SetCapabilitySet Local 0 to f3e355b0 (size 9) has g722 0
2023-09-19T15:04:50 1177341683mS Sip: SIP Line (17) GetNetworkTopologySource Use Network Topology badly configured
2023-09-19T15:04:50 1177341683mS Sip: SIP Line (17) GetNetworkTopologySource Use Network Topology badly configured
2023-09-19T15:04:50 1177341684mS Sip: SIP Line (17): License, Valid 1, Available 8, Consumed 3
2023-09-19T15:04:50 1177341684mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForRequest from [PublicIP]:5060 to [PublicIP]:5060
2023-09-19T15:04:50 1177341685mS Sip: 0a02f2010001043e 17.66622.1 -1 SIPTrunk Endpoint(f3daf6d4) PreProcess Invite: error is 6
2023-09-19T15:04:50 1177341685mS Sip: SIPDialog::ExtractResponseParamsFromViaHeader remote sent_by: [PublicIP]:5060 trunk
2023-09-19T15:04:50 1177341686mS Sip: SIPDialog::ExtractResponseParamsFromViaHeader remote sent by transport: SIP/2.0/UDP trunk
2023-09-19T15:04:50 1177341686mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForResponse from [PublicIP]:5060 to [PublicIP]:5060
2023-09-19T15:04:50 1177341687mS Sip: 0a02f2010001043e 17.66622.1 -1 SIPTrunk Endpoint(f3daf6d4) SendSIPResponse: INVITE code 400 SENT TO [PublicIP] 5060
2023-09-19T15:04:50 1177341688mS SIP Call Tx: 17
SIP/2.0 400 Bad Request
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer
Server: IP Office 11.1.1.1.0 build 18
Reason: Q.850;cause=41;text="Temporary failure"
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=0363fd877eec724a
Content-Length: 0
2023-09-19T15:04:50 1177341689mS SIP Tx: UDP [PrivateIP]:5060 -> [PublicIP]:5060
SIP/2.0 400 Bad Request
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer
Server: IP Office 11.1.1.1.0 build 18
Reason: Q.850;cause=41;text="Temporary failure"
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=0363fd877eec724a
Content-Length: 0
2023-09-19T15:04:50 1177341690mS Sip: 0a02f2010001043e 17.66622.1 -1 SIPTrunk Endpoint(f3daf6d4) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::FINAL(28)
2023-09-19T15:04:50 1177341691mS Sip: Incoming Method, Parsing Failed 6
2023-09-19T15:04:50 1177341713mS SIP Rx: UDP [PublicIP]:5060 -> [PrivateIP]:5060
ACK sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
CSeq: 1 ACK
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=0363fd877eec724a
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
Content-Length: 0
2023-09-19T15:04:50 1177341716mS Sip: From Tag does not match any mNearTag or mFarTag or it is non existent ...
2023-09-19T15:04:50 1177341716mS Sip: From Tag does not match any mNearTag or mFarTag or it is non existent ...
2023-09-19T15:04:50 1177341716mS Sip: Association found trunk: SIP Line (17)
2023-09-19T15:04:50 1177341717mS SIP Call Rx: 17
ACK sip:[CalledNumber]@[PrivateIP]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP [PublicIP]:5060;branch=z9hG4bKtbl20g00a0mhni4va120.1
CSeq: 1 ACK
From: <sip:[CallerNumber]@bc83.xi85.eit-mss.fr>;tag=SDjak8a02-64d453e7-65099c7371a8cc6-0012-08-ic-ibo-cacid169512869111893241810-lucentIBCF-127730
To: <sip:[CalledNumber]@[ProviderIP]:5060>;tag=0363fd877eec724a
Max-Forwards: 61
Call-ID: SDjak8a02-48b3432729f5c75c07b2b754fa142dbb-v300g00070
Content-Length: 0