Resolving remote host '10.222.16.30'... Done.
------------------------------ Scenario Screen -------- [1-9]: Change Screen --
Call rate (length) Port Total-time Total-calls Remote-host
15.0(0 ms)/1.000s 5062 89.33 s 80 10.222.16.30:5060(UDP)
Call limit 80 hit, 0.0 s period 0 ms scheduler resolution
0 calls (limit 80) Peak was 80 calls, after 5 s
0 Running, 2 Paused, 0 Woken up
44 dead call msg (discarded) 0 out-of-call msg (discarded)
0 open sockets 0/0/0 UDP errors (send/recv/cong)
Messages Retrans Timeout Unexpected-Msg
INVITE ----------> 80 46 0
407 <---------- 80 0 0 0
ACK ----------> 80 0
INVITE ----------> 80 0
100 <---------- 50 0 0 0
180 <---------- 0 0 0 0
183 <---------- 0 0 0 0
200 <---------- E-RTD1 80 283 0 0
ACK ----------> 80 283
Pause [ 30.0s] 80 26
BYE ----------> 80 119 8
200 <---------- 72 0 0 134
------------------------------ Test Terminated --------------------------------
----------------------------- Statistics Screen ------- [1-9]: Change Screen --
Start Time | 2019-11-13 16:51:54.924085 1573642314.924085
Last Reset Time | 2019-11-13 16:53:24.258217 1573642404.258217
Current Time | 2019-11-13 16:53:24.258852 1573642404.258852
-------------------------+---------------------------+--------------------------
Counter Name | Periodic value | Cumulative value
-------------------------+---------------------------+--------------------------
Elapsed Time | 00:00:00:000000 | 00:00:00:000000
Call Rate | 0.000 cps | 0.896 cps
-------------------------+---------------------------+--------------------------
Incoming calls created | 0 | 0
Outgoing calls created | 0 | 80
Total Calls created | | 80
Current Calls | 0 |
-------------------------+---------------------------+--------------------------
Successful call | 0 | 72
Failed call | 0 | 8
-------------------------+---------------------------+--------------------------
Response Time 1 | 00:00:00:000000 | 00:00:00:000000
Call Length | 00:00:00:000000 | 00:00:00:000000
------------------------------ Test Terminated --------------------------------
2019-11-13 16:53:20.271302 1573642400.271302: Continuing call on unexpected message for Call-Id '60-16071@10.150.70.66': while expecting '200' (index 11), received 'SIP/2.0 481 Call Does Not Exist
Via: SIP/2.0/UDP 10.150.70.66:5062
From: <sip:1016@compA.com>;tag=60
To: "9664" <sip:9664@compA.com>;tag=BeB0eN91p0Q1a
Call-ID:
60-16071@10.150.70.66CSeq: 2 BYE
User-Agent: FreeSWITCH-mod_sofia/1.10.1-release-12-f9990221e6~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
=====================================================================================
tcpdump на стороне машины с SIPp показывает что этот ответ отдает FS на BYE
IP 10.150.70.66.5062 > 10.222.16.30.5060: UDP, length 312
E..T.]@.@..h
.FB
........@m%BYE sip:9664@10.222.16.30:5060 SIP/2.0
Via: SIP/2.0/UDP 10.150.70.66:5062
From: <sip:1016@compA.com>;tag=76
To: "9664" <sip:9664@compA.com>;tag=1K8H5HpvejaHH
Call-ID:
76-15980@10.150.70.66CSeq: 2 BYE
Contact: <sip:1016@10.150.70.66:5062>
Max-Forwards: 70
Subject: Performance Test
Content-Length: 0
IP 10.222.16.30.5060 > 10.150.70.66.5062: UDP, length 434
E...T...>...
...
.FB......N.SIP/2.0 481 Call Does Not Exist
Via: SIP/2.0/UDP 10.150.70.66:5062
From: <sip:1016@compA.com>;tag=76
To: "9664" <sip:9664@compA.com>;tag=1K8H5HpvejaHH
Call-ID:
76-15980@10.150.70.66CSeq: 2 BYE
User-Agent: FreeSWITCH-mod_sofia/1.10.1-release-12-f9990221e6~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
=============================================================================
Дебаг на FS дает WRONG_CALL_STATE
2019-11-13 17:02:15.169108 [NOTICE] switch_channel.c:1118 New Channel
sofia/internal/1016@compA.com [c6528bda-d119-445c-9572-cd91e57ea87b]
2019-11-13 17:02:15.169108 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1016@compA.com) Running State Change CS_NEW (Cur 344 Tot 16785)
2019-11-13 17:02:15.169108 [DEBUG] sofia.c:10243
sofia/internal/1016@compA.com receiving invite from 10.150.70.66:5062 version: 1.10.1 -release-12-f9990221e6 64bit
2019-11-13 17:02:15.169108 [DEBUG] sofia.c:10337 verifying acl "domains" for ip/port 10.150.70.66:0.
2019-11-13 17:02:15.169108 [DEBUG] switch_core_state_machine.c:604 (sofia/internal/1016@compA.com) State NEW
2019-11-13 17:02:15.169108 [DEBUG] sofia.c:2426 detaching session c6528bda-d119-445c-9572-cd91e57ea87b
2019-11-13 17:02:15.189083 [WARNING] switch_core_state_machine.c:688 d9c72d08-b207-46d6-8ede-e5441e1734bf
sofia/internal/1016@compA.com Abandoned
2019-11-13 17:02:15.189083 [NOTICE] switch_core_state_machine.c:691 Hangup
sofia/internal/1016@compA.com [CS_NEW] [WRONG_CALL_STATE]