From Shashi Kumar, 4 Years ago, written in FreeSWITCH.
- go back
Embed
Viewing differences between and Custom ringback error
  1. recv 1791 bytes from udp/[139.59.34.94]:5060 at 20:26:36.573215:
  2. ------------------------------------------------------------------------
  3. INVITE sip:1001@139.59.81.245:34807;transport=udp;gw=signalwire_prod SIP/2.0
  4. Record-Route: <sip:139.59.34.94:5060;r2=on;lr;nat=yes>
  5. Record-Route: <sip:139.59.34.94:5061;transport=tls;r2=on;lr;nat=yes>
  6. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bK5fde.c1f2cb88d60d5b878a0fd3b9dfd4a691.0;i=804
  7. Via: SIP/2.0/TLS 138.68.46.209:35181;received=138.68.46.209;rport=43634;branch=z9hG4bK105m2Nj6ym9yj
  8. Max-Forwards: 63
  9. From: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>;tag=grmN85UvDXrgH
  10. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>
  11. Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  12. CSeq: 14305105 INVITE
  13. Contact: <sip:mod_sofia@138.68.46.209:35181;transport=tls;alias=138.68.46.209~43634~3>
  14. User-Agent: SignalWire STACK
  15. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  16. Supported: timer, path, replaces
  17. Allow-Events: talk, hold, conference, refer
  18. Session-Expires: 600;refresher=uac
  19. Min-SE: 90
  20. Privacy: none
  21. Content-Type: application/sdp
  22. Content-Disposition: session
  23. Content-Length: 497
  24. P-SRC-IP: 147.75.65.195
  25. X-Relay-Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  26. X-CID: 1646798335_57904152@23.29.23.120
  27. X-FS-Support: update_display,send_info
  28. P-Asserted-Identity: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>
  29.  
  30. v=0
  31. o=SignalWire-STACK 1577699049 1577699050 IN IP4 138.68.46.209
  32. s=SignalWire-STACK
  33. c=IN IP4 138.68.46.209
  34. t=0 0
  35. m=audio 18746 RTP/SAVP 0 101 13
  36. a=rtpmap:0 PCMU/8000
  37. a=rtpmap:101 telephone-event/8000
  38. a=fmtp:101 0-16
  39. a=rtpmap:13 CN/8000
  40. a=crypto:1 AEAD_AES_256_GCM_8 inline:lHMErHQ2AMk0ub2CXc2CFzv0az4EKTYVRZmimQWEj8V4rRMhomIM79yguzg=
  41. a=ptime:20
  42. m=audio 18746 RTP/AVP 0 101 13
  43. a=rtpmap:0 PCMU/8000
  44. a=rtpmap:101 telephone-event/8000
  45. a=fmtp:101 0-16
  46. a=rtpmap:13 CN/8000
  47. a=ptime:20
  48. 2019-12-30 20:26:36.565496 [NOTICE] switch_channel.c:1118 New Channel sofia/external/+16503820000@sip.signalwire.com [85420fdb-4ed0-48e6-8220-999062f2f580]
  49. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_NEW (Cur 1 Tot 61)
  50. 2019-12-30 20:26:36.565496 [DEBUG] sofia.c:10243 sofia/external/+16503820000@sip.signalwire.com receiving invite from 139.59.34.94:5060 version: 20.19.6 -release-14-2b31de9 64bit
  51. 2019-12-30 20:26:36.565496 [DEBUG] sofia.c:7290 Channel sofia/external/+16503820000@sip.signalwire.com entering state [received][100]
  52. 2019-12-30 20:26:36.565496 [DEBUG] sofia.c:7300 Remote SDP:
  53. v=0
  54. o=SignalWire-STACK 1577699049 1577699050 IN IP4 138.68.46.209
  55. s=SignalWire-STACK
  56. c=IN IP4 138.68.46.209
  57. t=0 0
  58. m=audio 18746 RTP/SAVP 0 101 13
  59. a=rtpmap:0 PCMU/8000
  60. a=rtpmap:101 telephone-event/8000
  61. a=fmtp:101 0-16
  62. a=rtpmap:13 CN/8000
  63. a=crypto:1 AEAD_AES_256_GCM_8 inline:lHMErHQ2AMk0ub2CXc2CFzv0az4EKTYVRZmimQWEj8V4rRMhomIM79yguzg=
  64. a=ptime:20
  65. m=audio 18746 RTP/AVP 0 101 13
  66. a=rtpmap:0 PCMU/8000
  67. a=rtpmap:101 telephone-event/8000
  68. a=fmtp:101 0-16
  69. a=rtpmap:13 CN/8000
  70. a=ptime:20
  71.  
  72. 2019-12-30 20:26:36.565496 [DEBUG] sofia.c:7703 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_NEW -> CS_INIT
  73. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:604 (sofia/external/+16503820000@sip.signalwire.com) State NEW
  74. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_INIT (Cur 1 Tot 61)
  75. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+16503820000@sip.signalwire.com) State INIT
  76. 2019-12-30 20:26:36.565496 [DEBUG] mod_sofia.c:93 sofia/external/+16503820000@sip.signalwire.com SOFIA INIT
  77. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:40 sofia/external/+16503820000@sip.signalwire.com Standard INIT
  78. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:48 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_INIT -> CS_ROUTING
  79. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+16503820000@sip.signalwire.com) State INIT going to sleep
  80. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_ROUTING (Cur 1 Tot 61)
  81. 2019-12-30 20:26:36.565496 [DEBUG] switch_channel.c:2332 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change DOWN -> RINGING
  82. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+16503820000@sip.signalwire.com) State ROUTING
  83. send 410 bytes to udp/[139.59.34.94]:5060 at 20:26:36.575736:
  84. ------------------------------------------------------------------------
  85. SIP/2.0 100 Trying
  86. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bK5fde.c1f2cb88d60d5b878a0fd3b9dfd4a691.0;i=804
  87. From: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>;tag=grmN85UvDXrgH
  88. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>
  89. Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  90. CSeq: 14305105 INVITE
  91. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  92. Content-Length: 0
  93.  
  94. 2019-12-30 20:26:36.565496 [DEBUG] mod_sofia.c:154 sofia/external/+16503820000@sip.signalwire.com SOFIA ROUTING
  95. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:236 sofia/external/+16503820000@sip.signalwire.com Standard ROUTING
  96. 2019-12-30 20:26:36.565496 [INFO] mod_dialplan_xml.c:637 Processing CALIFORNIA  <+16503820000>->1001 in context public
  97. Dialplan: sofia/external/+16503820000@sip.signalwire.com parsing [public->lua-env-hangup-hook-test] continue=false
  98. Dialplan: sofia/external/+16503820000@sip.signalwire.com Regex (PASS) [lua-env-hangup-hook-test] destination_number(1001) =~ /^(.*)$/ break=on-false
  99. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action pre_answer()
  100. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action playback(/usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3)
  101. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action hangup()
  102. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:287 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_ROUTING -> CS_EXECUTE
  103. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+16503820000@sip.signalwire.com) State ROUTING going to sleep
  104. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_EXECUTE (Cur 1 Tot 61)
  105. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+16503820000@sip.signalwire.com) State EXECUTE
  106. 2019-12-30 20:26:36.565496 [DEBUG] mod_sofia.c:209 sofia/external/+16503820000@sip.signalwire.com SOFIA EXECUTE
  107. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_state_machine.c:329 sofia/external/+16503820000@sip.signalwire.com Standard EXECUTE
  108. EXECUTE [depth=0] sofia/external/+16503820000@sip.signalwire.com pre_answer()
  109. 2019-12-30 20:26:36.565496 [INFO] mod_dptools.c:1477 Sending early media
  110. 2019-12-30 20:26:36.565496 [WARNING] switch_core_media.c:5475 Received invite with SAVP but secure media is administratively disabled
  111. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  112. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  113. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  114. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5648 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  115. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  116. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  117. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5509 Set telephone-event payload to 101@8000
  118. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:3837 Set Codec sofia/external/+16503820000@sip.signalwire.com PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  119. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_codec.c:111 sofia/external/+16503820000@sip.signalwire.com Original read codec set to PCMU:0
  120. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5852 Set telephone-event payload to 101@8000
  121. 2019-12-30 20:26:36.565496 [DEBUG] switch_core_media.c:5910 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf send payload to 101 recv payload to 101
  122. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:8109 STUN Success [139.59.81.245]:[22522]
  123. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:8113 STUN Not Required ip and port match. [139.59.81.245]:[22522]
  124. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:8682 AUDIO RTP [sofia/external/+16503820000@sip.signalwire.com] 139.59.81.245 port 22522 -> 138.68.46.209 port 18746 codec: 0 ms: 20
  125. 2019-12-30 20:26:36.805503 [DEBUG] switch_rtp.c:4496 Starting timer [soft] 160 bytes per 20ms
  126. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:8996 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf send payload to 101
  127. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:9003 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf receive payload to 101
  128. 2019-12-30 20:26:36.805503 [DEBUG] switch_core_media.c:9026 sofia/external/+16503820000@sip.signalwire.com Set rtp dtmf delay to 40
  129. 2019-12-30 20:26:36.805503 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/+16503820000@sip.signalwire.com!
  130. 2019-12-30 20:26:36.825476 [DEBUG] switch_channel.c:3565 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change RINGING -> EARLY
  131. 2019-12-30 20:26:36.825476 [DEBUG] switch_core_media.c:8664 Audio params are unchanged for sofia/external/+16503820000@sip.signalwire.com.
  132. 2019-12-30 20:26:36.825476 [DEBUG] mod_sofia.c:2600 Ring SDP:
  133. v=0
  134. o=FreeSWITCH 1577695274 1577695275 IN IP4 139.59.81.245
  135. s=FreeSWITCH
  136. c=IN IP4 139.59.81.245
  137. t=0 0
  138. m=audio 22522 RTP/AVP 0 101
  139. a=rtpmap:0 PCMU/8000
  140. a=rtpmap:101 telephone-event/8000
  141. a=fmtp:101 0-16
  142. a=ptime:20
  143. a=sendrecv
  144.  
  145. send 1436 bytes to udp/[139.59.34.94]:5060 at 20:26:36.826645:
  146. ------------------------------------------------------------------------
  147. SIP/2.0 183 Session Progress
  148. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bK5fde.c1f2cb88d60d5b878a0fd3b9dfd4a691.0;i=804
  149. Via: SIP/2.0/TLS 138.68.46.209:35181;received=138.68.46.209;rport=43634;branch=z9hG4bK105m2Nj6ym9yj
  150. Record-Route: <sip:139.59.34.94:5060;r2=on;lr;nat=yes>
  151. Record-Route: <sip:139.59.34.94:5061;transport=tls;r2=on;lr;nat=yes>
  152. From: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>;tag=grmN85UvDXrgH
  153. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=c03a1gS30FmcH
  154. Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  155. CSeq: 14305105 INVITE
  156. Contact: <sip:+18448375267@139.59.81.245:34807;transport=udp>
  157. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  158. Accept: application/sdp
  159. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  160. Supported: timer, path, replaces
  161. Allow-Events: talk, hold, conference, refer
  162. Content-Type: application/sdp
  163. Content-Disposition: session
  164. Content-Length: 245
  165. X-FS-Display-Name: 1001
  166. X-FS-Display-Number: sip:1001@shashi-fs-12345.sip.signalwire.com
  167. X-FS-Support: update_display,send_info
  168. P-Asserted-Identity: "1001" <sip:1001@shashi-fs-12345.sip.signalwire.com>
  169.  
  170. v=0
  171. o=FreeSWITCH 1577695274 1577695275 IN IP4 139.59.81.245
  172. s=FreeSWITCH
  173. c=IN IP4 139.59.81.245
  174. t=0 0
  175. m=audio 0 RTP/SAVP 19
  176. m=audio 22522 RTP/AVP 0 101
  177. a=rtpmap:0 PCMU/8000
  178. a=rtpmap:101 telephone-event/8000
  179. a=fmtp:101 0-16
  180. a=ptime:20
  181. 2019-12-30 20:26:36.825476 [DEBUG] sofia.c:7290 Channel sofia/external/+16503820000@sip.signalwire.com entering state [early][183]
  182. EXECUTE [depth=0] sofia/external/+16503820000@sip.signalwire.com playback(/usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3)
  183. 2019-12-30 20:26:36.825476 [DEBUG] switch_ivr_play_say.c:1492 Codec Activated L16@8000hz 1 channels 20ms
  184. send 868 bytes to udp/[190.102.98.218]:5060 at 20:26:49.789521:
  185. ------------------------------------------------------------------------
  186. REGISTER sip:dev-phones.sip.swire.io;transport=udp SIP/2.0
  187. Via: SIP/2.0/UDP 139.59.81.245:34807;rport;branch=z9hG4bK313NH3rXtBg3c
  188. Max-Forwards: 70
  189. From: <sip:1001@dev-phones.sip.swire.io>;tag=eHD3B5ZSQ4QUN
  190. To: <sip:1001@dev-phones.sip.swire.io>
  191. Call-ID: 085024fb-a208-4f31-a77c-e10fc8bffd38
  192. CSeq: 14180125 REGISTER
  193. Contact: <sip:gw+signalwire_stageing@139.59.81.245:34807;transport=udp;gw=signalwire_stageing>
  194. Expires: 3600
  195. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  196. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  197. Supported: timer, path, replaces
  198. Authorization: Digest username="1001", realm="dev-phones.sip.swire.io", nonce="XgoP6l4KDr6xrgdYbJtU2pEFLHrYoDKq", algorithm=MD5, uri="sip:dev-phones.sip.swire.io;transport=udp", response="8cddcd08bfcaa6a7ffce89f39a857d6d"
  199. Content-Length: 0
  200.  
  201. recv 488 bytes from udp/[190.102.98.218]:5060 at 20:26:50.365628:
  202. ------------------------------------------------------------------------
  203. SIP/2.0 401 Unauthorized
  204. Via: SIP/2.0/UDP 139.59.81.245:34807;rport=34807;branch=z9hG4bK313NH3rXtBg3c;received=139.59.81.245
  205. From: <sip:1001@dev-phones.sip.swire.io>;tag=eHD3B5ZSQ4QUN
  206. To: <sip:1001@dev-phones.sip.swire.io>;tag=2557f8e108d5866fc8727054f77f98a6.d3ff
  207. Call-ID: 085024fb-a208-4f31-a77c-e10fc8bffd38
  208. CSeq: 14180125 REGISTER
  209. WWW-Authenticate: Digest realm="dev-phones.sip.swire.io", nonce="XgoRXl4KEDJuk03oJMEgnRsyN10hG3B/"
  210. Server: SignalWire Proxy
  211. Content-Length: 0
  212.  
  213. send 868 bytes to udp/[190.102.98.218]:5060 at 20:26:50.365858:
  214. ------------------------------------------------------------------------
  215. REGISTER sip:dev-phones.sip.swire.io;transport=udp SIP/2.0
  216. Via: SIP/2.0/UDP 139.59.81.245:34807;rport;branch=z9hG4bK4aXeKy90Qm6Nr
  217. Max-Forwards: 70
  218. From: <sip:1001@dev-phones.sip.swire.io>;tag=eHD3B5ZSQ4QUN
  219. To: <sip:1001@dev-phones.sip.swire.io>
  220. Call-ID: 085024fb-a208-4f31-a77c-e10fc8bffd38
  221. CSeq: 14180126 REGISTER
  222. Contact: <sip:gw+signalwire_stageing@139.59.81.245:34807;transport=udp;gw=signalwire_stageing>
  223. Expires: 3600
  224. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  225. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  226. Supported: timer, path, replaces
  227. Authorization: Digest username="1001", realm="dev-phones.sip.swire.io", nonce="XgoRXl4KEDJuk03oJMEgnRsyN10hG3B/", algorithm=MD5, uri="sip:dev-phones.sip.swire.io;transport=udp", response="e4b3214f20ae27ff94b4739f032a7452"
  228. Content-Length: 0
  229.  
  230. recv 486 bytes from udp/[190.102.98.218]:5060 at 20:26:50.683812:
  231. ------------------------------------------------------------------------
  232. SIP/2.0 200 OK
  233. Via: SIP/2.0/UDP 139.59.81.245:34807;rport=34807;branch=z9hG4bK4aXeKy90Qm6Nr;received=139.59.81.245
  234. From: <sip:1001@dev-phones.sip.swire.io>;tag=eHD3B5ZSQ4QUN
  235. To: <sip:1001@dev-phones.sip.swire.io>;tag=2557f8e108d5866fc8727054f77f98a6.9081
  236. Call-ID: 085024fb-a208-4f31-a77c-e10fc8bffd38
  237. CSeq: 14180126 REGISTER
  238. Contact: <sip:gw+signalwire_stageing@139.59.81.245:34807;transport=udp;gw=signalwire_stageing>;expires=600
  239. Server: SignalWire Proxy
  240. Content-Length: 0
  241.  
  242. 2019-12-30 20:26:50.665511 [DEBUG] sofia_reg.c:2457 Changing expire time to 600 by request of proxy sip:dev-phones.sip.swire.io
  243. 2019-12-30 20:26:58.185492 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3
  244. EXECUTE [depth=0] sofia/external/+16503820000@sip.signalwire.com hangup()
  245. 2019-12-30 20:26:58.185492 [NOTICE] mod_dptools.c:1380 Hangup sofia/external/+16503820000@sip.signalwire.com [CS_EXECUTE] [NORMAL_CLEARING]
  246. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_session.c:2905 sofia/external/+16503820000@sip.signalwire.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  247. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+16503820000@sip.signalwire.com) State EXECUTE going to sleep
  248. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_HANGUP (Cur 1 Tot 61)
  249. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:848 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change EARLY -> HANGUP
  250. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+16503820000@sip.signalwire.com) State HANGUP
  251. 2019-12-30 20:26:58.185492 [DEBUG] mod_sofia.c:460 Channel sofia/external/+16503820000@sip.signalwire.com hanging up, cause: NORMAL_CLEARING
  252. 2019-12-30 20:26:58.185492 [DEBUG] mod_sofia.c:605 Responding to INVITE with: 480
  253. send 946 bytes to udp/[139.59.34.94]:5060 at 20:26:58.204805:
  254. ------------------------------------------------------------------------
  255. SIP/2.0 480 Temporarily Unavailable
  256. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bK5fde.c1f2cb88d60d5b878a0fd3b9dfd4a691.0;i=804
  257. Via: SIP/2.0/TLS 138.68.46.209:35181;received=138.68.46.209;rport=43634;branch=z9hG4bK105m2Nj6ym9yj
  258. Max-Forwards: 63
  259. From: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>;tag=grmN85UvDXrgH
  260. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=c03a1gS30FmcH
  261. Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  262. CSeq: 14305105 INVITE
  263. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  264. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  265. Supported: timer, path, replaces
  266. Allow-Events: talk, hold, conference, refer
  267. Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  268. Content-Length: 0
  269. X-FS-Display-Name: 1001
  270. X-FS-Display-Number: sip:1001@shashi-fs-12345.sip.signalwire.com
  271. P-Asserted-Identity: "1001" <sip:1001@shashi-fs-12345.sip.signalwire.com>
  272.  
  273. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:60 sofia/external/+16503820000@sip.signalwire.com Standard HANGUP, cause: NORMAL_CLEARING
  274. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+16503820000@sip.signalwire.com) State HANGUP going to sleep
  275. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:620 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_HANGUP -> CS_REPORTING
  276. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_REPORTING (Cur 1 Tot 61)
  277. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+16503820000@sip.signalwire.com) State REPORTING
  278. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:174 sofia/external/+16503820000@sip.signalwire.com Standard REPORTING, cause: NORMAL_CLEARING
  279. 2019-12-30 20:26:58.185492 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+16503820000@sip.signalwire.com) State REPORTING going to sleep
  280. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_state_machine.c:611 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_REPORTING -> CS_DESTROY
  281. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_session.c:1726 Session 61 (sofia/external/+16503820000@sip.signalwire.com) Locked, Waiting on external entities
  282. 2019-12-30 20:26:58.205480 [NOTICE] switch_core_session.c:1744 Session 61 (sofia/external/+16503820000@sip.signalwire.com) Ended
  283. 2019-12-30 20:26:58.205480 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/+16503820000@sip.signalwire.com [CS_DESTROY]
  284. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_state_machine.c:739 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_DESTROY (Cur 0 Tot 61)
  285. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+16503820000@sip.signalwire.com) State DESTROY
  286. 2019-12-30 20:26:58.205480 [DEBUG] mod_sofia.c:365 sofia/external/+16503820000@sip.signalwire.com SOFIA DESTROY
  287. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_state_machine.c:181 sofia/external/+16503820000@sip.signalwire.com Standard DESTROY
  288. 2019-12-30 20:26:58.205480 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+16503820000@sip.signalwire.com) State DESTROY going to sleep
  289. recv 431 bytes from udp/[139.59.34.94]:5060 at 20:26:58.206341:
  290. ------------------------------------------------------------------------
  291. ACK sip:1001@139.59.81.245:34807;transport=udp;gw=signalwire_prod SIP/2.0
  292. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bK5fde.c1f2cb88d60d5b878a0fd3b9dfd4a691.0;i=804
  293. Max-Forwards: 63
  294. From: "CALIFORNIA " <sip:+16503820000@sip.signalwire.com>;tag=grmN85UvDXrgH
  295. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=c03a1gS30FmcH
  296. Call-ID: ff90d235-c41e-4281-8433-94c793ec1147
  297. CSeq: 14305105 ACK
  298. Content-Length: 0
  299.  
  300. recv 1796 bytes from udp/[139.59.34.94]:5060 at 20:27:01.753021:
  301. ------------------------------------------------------------------------
  302. INVITE sip:1001@139.59.81.245:34807;transport=udp;gw=signalwire_prod SIP/2.0
  303. Record-Route: <sip:139.59.34.94:5060;r2=on;lr;nat=yes>
  304. Record-Route: <sip:139.59.34.94:5061;transport=tls;r2=on;lr;nat=yes>
  305. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  306. Via: SIP/2.0/TLS 138.197.101.1:35181;received=138.197.101.1;rport=54404;branch=z9hG4bKtt6HyF6BXDgXa
  307. Max-Forwards: 63
  308. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  309. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>
  310. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  311. CSeq: 14305118 INVITE
  312. Contact: <sip:mod_sofia@138.197.101.1:35181;transport=tls;alias=138.197.101.1~54404~3>
  313. User-Agent: SignalWire STACK
  314. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  315. Supported: timer, path, replaces
  316. Allow-Events: talk, hold, conference, refer
  317. Session-Expires: 600;refresher=uac
  318. Min-SE: 90
  319. Privacy: none
  320. Content-Type: application/sdp
  321. Content-Disposition: session
  322. Content-Length: 497
  323. P-SRC-IP: 147.75.65.192
  324. X-Relay-Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  325. X-CID: 1900329890_117407016@23.29.21.120
  326. X-FS-Support: update_display,send_info
  327. P-Asserted-Identity: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>
  328.  
  329. v=0
  330. o=SignalWire-STACK 1577700661 1577700662 IN IP4 138.197.101.1
  331. s=SignalWire-STACK
  332. c=IN IP4 138.197.101.1
  333. t=0 0
  334. m=audio 17160 RTP/SAVP 0 101 13
  335. a=rtpmap:0 PCMU/8000
  336. a=rtpmap:101 telephone-event/8000
  337. a=fmtp:101 0-16
  338. a=rtpmap:13 CN/8000
  339. a=crypto:1 AEAD_AES_256_GCM_8 inline:acuqqtV88Pbn3PRnLXLyWXi89MALBoqIM6APKwvN29eVoPoas3rsA/CKwpM=
  340. a=ptime:20
  341. m=audio 17160 RTP/AVP 0 101 13
  342. a=rtpmap:0 PCMU/8000
  343. a=rtpmap:101 telephone-event/8000
  344. a=fmtp:101 0-16
  345. a=rtpmap:13 CN/8000
  346. a=ptime:20
  347. 2019-12-30 20:27:01.745508 [NOTICE] switch_channel.c:1118 New Channel sofia/external/+16503820000@sip.signalwire.com [13521b49-a0cb-43e8-a832-2fa8f3d4515c]
  348. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_NEW (Cur 1 Tot 62)
  349. 2019-12-30 20:27:01.745508 [DEBUG] sofia.c:10243 sofia/external/+16503820000@sip.signalwire.com receiving invite from 139.59.34.94:5060 version: 20.19.6 -release-14-2b31de9 64bit
  350. 2019-12-30 20:27:01.745508 [DEBUG] sofia.c:7290 Channel sofia/external/+16503820000@sip.signalwire.com entering state [received][100]
  351. 2019-12-30 20:27:01.745508 [DEBUG] sofia.c:7300 Remote SDP:
  352. v=0
  353. o=SignalWire-STACK 1577700661 1577700662 IN IP4 138.197.101.1
  354. s=SignalWire-STACK
  355. c=IN IP4 138.197.101.1
  356. t=0 0
  357. m=audio 17160 RTP/SAVP 0 101 13
  358. a=rtpmap:0 PCMU/8000
  359. a=rtpmap:101 telephone-event/8000
  360. a=fmtp:101 0-16
  361. a=rtpmap:13 CN/8000
  362. a=crypto:1 AEAD_AES_256_GCM_8 inline:acuqqtV88Pbn3PRnLXLyWXi89MALBoqIM6APKwvN29eVoPoas3rsA/CKwpM=
  363. a=ptime:20
  364. m=audio 17160 RTP/AVP 0 101 13
  365. a=rtpmap:0 PCMU/8000
  366. a=rtpmap:101 telephone-event/8000
  367. a=fmtp:101 0-16
  368. a=rtpmap:13 CN/8000
  369. a=ptime:20
  370.  
  371. 2019-12-30 20:27:01.745508 [DEBUG] sofia.c:7703 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_NEW -> CS_INIT
  372. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:604 (sofia/external/+16503820000@sip.signalwire.com) State NEW
  373. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_INIT (Cur 1 Tot 62)
  374. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+16503820000@sip.signalwire.com) State INIT
  375. 2019-12-30 20:27:01.745508 [DEBUG] mod_sofia.c:93 sofia/external/+16503820000@sip.signalwire.com SOFIA INIT
  376. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:40 sofia/external/+16503820000@sip.signalwire.com Standard INIT
  377. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:48 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_INIT -> CS_ROUTING
  378. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+16503820000@sip.signalwire.com) State INIT going to sleep
  379. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_ROUTING (Cur 1 Tot 62)
  380. 2019-12-30 20:27:01.745508 [DEBUG] switch_channel.c:2332 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change DOWN -> RINGING
  381. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+16503820000@sip.signalwire.com) State ROUTING
  382. send 412 bytes to udp/[139.59.34.94]:5060 at 20:27:01.755403:
  383. ------------------------------------------------------------------------
  384. SIP/2.0 100 Trying
  385. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  386. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  387. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>
  388. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  389. CSeq: 14305118 INVITE
  390. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  391. Content-Length: 0
  392.  
  393. 2019-12-30 20:27:01.745508 [DEBUG] mod_sofia.c:154 sofia/external/+16503820000@sip.signalwire.com SOFIA ROUTING
  394. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:236 sofia/external/+16503820000@sip.signalwire.com Standard ROUTING
  395. 2019-12-30 20:27:01.745508 [INFO] mod_dialplan_xml.c:637 Processing Shashi Kumar  <+16503820000>->1001 in context public
  396. Dialplan: sofia/external/+16503820000@sip.signalwire.com parsing [public->lua-env-hangup-hook-test] continue=false
  397. Dialplan: sofia/external/+16503820000@sip.signalwire.com Regex (PASS) [lua-env-hangup-hook-test] destination_number(1001) =~ /^(.*)$/ break=on-false
  398. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action pre_answer()
  399. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action playback(/usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3)
  400. Dialplan: sofia/external/+16503820000@sip.signalwire.com Action hangup()
  401. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:287 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_ROUTING -> CS_EXECUTE
  402. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+16503820000@sip.signalwire.com) State ROUTING going to sleep
  403. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_EXECUTE (Cur 1 Tot 62)
  404. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+16503820000@sip.signalwire.com) State EXECUTE
  405. 2019-12-30 20:27:01.745508 [DEBUG] mod_sofia.c:209 sofia/external/+16503820000@sip.signalwire.com SOFIA EXECUTE
  406. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_state_machine.c:329 sofia/external/+16503820000@sip.signalwire.com Standard EXECUTE
  407. EXECUTE [depth=0] sofia/external/+16503820000@sip.signalwire.com pre_answer()
  408. 2019-12-30 20:27:01.745508 [INFO] mod_dptools.c:1477 Sending early media
  409. 2019-12-30 20:27:01.745508 [WARNING] switch_core_media.c:5475 Received invite with SAVP but secure media is administratively disabled
  410. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  411. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  412. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  413. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5648 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  414. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  415. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5593 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  416. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5509 Set telephone-event payload to 101@8000
  417. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:3837 Set Codec sofia/external/+16503820000@sip.signalwire.com PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  418. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_codec.c:111 sofia/external/+16503820000@sip.signalwire.com Original read codec set to PCMU:0
  419. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5852 Set telephone-event payload to 101@8000
  420. 2019-12-30 20:27:01.745508 [DEBUG] switch_core_media.c:5910 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf send payload to 101 recv payload to 101
  421. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:8109 STUN Success [139.59.81.245]:[21506]
  422. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:8113 STUN Not Required ip and port match. [139.59.81.245]:[21506]
  423. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:8682 AUDIO RTP [sofia/external/+16503820000@sip.signalwire.com] 139.59.81.245 port 21506 -> 138.197.101.1 port 17160 codec: 0 ms: 20
  424. 2019-12-30 20:27:01.985500 [DEBUG] switch_rtp.c:4496 Starting timer [soft] 160 bytes per 20ms
  425. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:8996 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf send payload to 101
  426. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:9003 sofia/external/+16503820000@sip.signalwire.com Set 2833 dtmf receive payload to 101
  427. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:9026 sofia/external/+16503820000@sip.signalwire.com Set rtp dtmf delay to 40
  428. 2019-12-30 20:27:01.985500 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/+16503820000@sip.signalwire.com!
  429. 2019-12-30 20:27:01.985500 [DEBUG] switch_channel.c:3565 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change RINGING -> EARLY
  430. 2019-12-30 20:27:01.985500 [DEBUG] switch_core_media.c:8664 Audio params are unchanged for sofia/external/+16503820000@sip.signalwire.com.
  431. 2019-12-30 20:27:01.985500 [DEBUG] mod_sofia.c:2600 Ring SDP:
  432. v=0
  433. o=FreeSWITCH 1577696315 1577696316 IN IP4 139.59.81.245
  434. s=FreeSWITCH
  435. c=IN IP4 139.59.81.245
  436. t=0 0
  437. m=audio 21506 RTP/AVP 0 101
  438. a=rtpmap:0 PCMU/8000
  439. a=rtpmap:101 telephone-event/8000
  440. a=fmtp:101 0-16
  441. a=ptime:20
  442. a=sendrecv
  443.  
  444. send 1438 bytes to udp/[139.59.34.94]:5060 at 20:27:02.004887:
  445. ------------------------------------------------------------------------
  446. SIP/2.0 183 Session Progress
  447. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  448. Via: SIP/2.0/TLS 138.197.101.1:35181;received=138.197.101.1;rport=54404;branch=z9hG4bKtt6HyF6BXDgXa
  449. Record-Route: <sip:139.59.34.94:5060;r2=on;lr;nat=yes>
  450. Record-Route: <sip:139.59.34.94:5061;transport=tls;r2=on;lr;nat=yes>
  451. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  452. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=D9v32Ba7XraZc
  453. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  454. CSeq: 14305118 INVITE
  455. Contact: <sip:+18448375267@139.59.81.245:34807;transport=udp>
  456. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  457. Accept: application/sdp
  458. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  459. Supported: timer, path, replaces
  460. Allow-Events: talk, hold, conference, refer
  461. Content-Type: application/sdp
  462. Content-Disposition: session
  463. Content-Length: 245
  464. X-FS-Display-Name: 1001
  465. X-FS-Display-Number: sip:1001@shashi-fs-12345.sip.signalwire.com
  466. X-FS-Support: update_display,send_info
  467. P-Asserted-Identity: "1001" <sip:1001@shashi-fs-12345.sip.signalwire.com>
  468.  
  469. v=0
  470. o=FreeSWITCH 1577696315 1577696316 IN IP4 139.59.81.245
  471. s=FreeSWITCH
  472. c=IN IP4 139.59.81.245
  473. t=0 0
  474. m=audio 0 RTP/SAVP 19
  475. m=audio 21506 RTP/AVP 0 101
  476. a=rtpmap:0 PCMU/8000
  477. a=rtpmap:101 telephone-event/8000
  478. a=fmtp:101 0-16
  479. a=ptime:20
  480. 2019-12-30 20:27:01.985500 [DEBUG] sofia.c:7290 Channel sofia/external/+16503820000@sip.signalwire.com entering state [early][183]
  481. EXECUTE [depth=0] sofia/external/+16503820000@sip.signalwire.com playback(/usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3)
  482. 2019-12-30 20:27:02.005478 [DEBUG] switch_ivr_play_say.c:1492 Codec Activated L16@8000hz 1 channels 20ms
  483. recv 469 bytes from udp/[139.59.34.94]:5060 at 20:27:02.976556:
  484. ------------------------------------------------------------------------
  485. CANCEL sip:1001@139.59.81.245:34807;transport=udp;gw=signalwire_prod SIP/2.0
  486. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  487. Max-Forwards: 63
  488. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  489. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>
  490. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  491. CSeq: 14305118 CANCEL
  492. Content-Length: 0
  493. Reason: SIP;cause=487;text="ORIGINATOR_CANCEL"
  494.  
  495. send 359 bytes to udp/[139.59.34.94]:5060 at 20:27:02.976703:
  496. ------------------------------------------------------------------------
  497. SIP/2.0 200 OK
  498. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  499. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  500. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=D9v32Ba7XraZc
  501. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  502. CSeq: 14305118 CANCEL
  503. Content-Length: 0
  504.  
  505. send 712 bytes to udp/[139.59.34.94]:5060 at 20:27:02.976825:
  506. ------------------------------------------------------------------------
  507. SIP/2.0 487 Request Terminated
  508. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  509. Via: SIP/2.0/TLS 138.197.101.1:35181;received=138.197.101.1;rport=54404;branch=z9hG4bKtt6HyF6BXDgXa
  510. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  511. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=D9v32Ba7XraZc
  512. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  513. CSeq: 14305118 INVITE
  514. User-Agent: FreeSWITCH-mod_sofia/20.19.6-release-14-2b31de9~64bit
  515. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  516. Supported: timer, path, replaces
  517. Allow-Events: talk, hold, conference, refer
  518. Content-Length: 0
  519.  
  520. recv 433 bytes from udp/[139.59.34.94]:5060 at 20:27:02.977502:
  521. ------------------------------------------------------------------------
  522. ACK sip:1001@139.59.81.245:34807;transport=udp;gw=signalwire_prod SIP/2.0
  523. Via: SIP/2.0/UDP 139.59.34.94:5060;branch=z9hG4bKb996.0826543676554cc829e0af113fa8a7b6.0;i=904
  524. Max-Forwards: 63
  525. From: "Shashi Kumar " <sip:+16503820000@sip.signalwire.com>;tag=BH0rXK5gg6BZc
  526. To: <sip:+18448375267@shashi-fs-12345.sip.signalwire.com>;tag=D9v32Ba7XraZc
  527. Call-ID: ab67b548-c6cc-46ee-bb57-9bd9eb1c9226
  528. CSeq: 14305118 ACK
  529. Content-Length: 0
  530.  
  531. 2019-12-30 20:27:02.965492 [DEBUG] sofia.c:7290 Channel sofia/external/+16503820000@sip.signalwire.com entering state [terminated][487]
  532. 2019-12-30 20:27:02.965492 [NOTICE] sofia.c:8523 Hangup sofia/external/+16503820000@sip.signalwire.com [CS_EXECUTE] [ORIGINATOR_CANCEL]
  533. 2019-12-30 20:27:02.965492 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/src/backup/freeswitch-advantage/clients/flex/Sound_of_phone_ringing2.mp3
  534. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_session.c:2905 sofia/external/+16503820000@sip.signalwire.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  535. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+16503820000@sip.signalwire.com) State EXECUTE going to sleep
  536. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_HANGUP (Cur 1 Tot 62)
  537. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:848 (sofia/external/+16503820000@sip.signalwire.com) Callstate Change EARLY -> HANGUP
  538. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+16503820000@sip.signalwire.com) State HANGUP
  539. 2019-12-30 20:27:02.965492 [DEBUG] mod_sofia.c:460 Channel sofia/external/+16503820000@sip.signalwire.com hanging up, cause: ORIGINATOR_CANCEL
  540. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:60 sofia/external/+16503820000@sip.signalwire.com Standard HANGUP, cause: ORIGINATOR_CANCEL
  541. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+16503820000@sip.signalwire.com) State HANGUP going to sleep
  542. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:620 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_HANGUP -> CS_REPORTING
  543. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_REPORTING (Cur 1 Tot 62)
  544. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+16503820000@sip.signalwire.com) State REPORTING
  545. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:174 sofia/external/+16503820000@sip.signalwire.com Standard REPORTING, cause: ORIGINATOR_CANCEL
  546. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+16503820000@sip.signalwire.com) State REPORTING going to sleep
  547. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:611 (sofia/external/+16503820000@sip.signalwire.com) State Change CS_REPORTING -> CS_DESTROY
  548. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_session.c:1726 Session 62 (sofia/external/+16503820000@sip.signalwire.com) Locked, Waiting on external entities
  549. 2019-12-30 20:27:02.965492 [NOTICE] switch_core_session.c:1744 Session 62 (sofia/external/+16503820000@sip.signalwire.com) Ended
  550. 2019-12-30 20:27:02.965492 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/+16503820000@sip.signalwire.com [CS_DESTROY]
  551. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:739 (sofia/external/+16503820000@sip.signalwire.com) Running State Change CS_DESTROY (Cur 0 Tot 62)
  552. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+16503820000@sip.signalwire.com) State DESTROY
  553. 2019-12-30 20:27:02.965492 [DEBUG] mod_sofia.c:365 sofia/external/+16503820000@sip.signalwire.com SOFIA DESTROY
  554. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:181 sofia/external/+16503820000@sip.signalwire.com Standard DESTROY
  555. 2019-12-30 20:27:02.965492 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+16503820000@sip.signalwire.com) State DESTROY going to sleep
  556.