SIP : IP Office answers 400 bad request, on some calls
SIP : IP Office answers 400 bad request, on some calls
(OP)
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
RE: SIP : IP Office answers 400 bad request, on some calls
Under Users/SIP
SIP Name = full 10 digit phone number
SIP Disply = Name you want displayed.
Contact = Extension Number
SIP Calls will fail from users that do not have those fields properly configured.
RE: SIP : IP Office answers 400 bad request, on some calls
Thank you for your answer.
Sorry, I was not clear enough.
Issue is on incoming calls, essentially from some mobile phones.
In general calls are working.
Destination is an huntgroup.
RE: SIP : IP Office answers 400 bad request, on some calls
It's the tag of the INVITE who is too long for IPO.
You can use a SBC to make a SIP manipulation to shorten it.
RE: SIP : IP Office answers 400 bad request, on some calls
That was the issue.
IP Office only supports 80 characters long until 11.1.2.3 that increases the limit to 150 chars.
I upgraded system to 11.1.2.3, everything is OK since then.