FreeSWITCH Pastebin

hold-unhold

From Funky Motmot, 4 Years ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/8591c911
Embed
Download Paste or View Raw
  1. recv 539 bytes from udp/[127.0.0.1]:5055 at 19:00:39.655556:
  2. ------------------------------------------------------------------------
  3. INVITE sip:999000@139.59.28.136:14080 SIP/2.0
  4. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-0
  5. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  6. To: sut <sip:999000@139.59.28.136:14080>
  7. Call-ID: 1-5033@127.0.0.1
  8. CSeq: 1 INVITE
  9. Contact: sip:sipp@127.0.0.1:5055
  10. Max-Forwards: 70
  11. Content-Type: application/sdp
  12. Content-Length:   198
  13.  
  14. v=0
  15. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  16. s=-
  17. c=IN IP4 127.0.0.1
  18. t=0 0
  19. m=audio 45000 RTP/AVP 8 101
  20. a=rtpmap:8 PCMA/8000
  21. a=rtpmap:101 telephone-event/8000
  22. a=fmtp:101 0-16
  23. a=ptime:20
  24. 2020-02-14 19:00:39.643403 [NOTICE] switch_channel.c:1118 New Channel sofia/external/sipp@127.0.0.1:5055 [400f4568-4398-497f-a95c-6749605d97a5]
  25. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_NEW (Cur 1 Tot 168)
  26. 2020-02-14 19:00:39.643403 [DEBUG] sofia.c:10259 sofia/external/sipp@127.0.0.1:5055 receiving invite from 127.0.0.1:5055 version: 20.19.10 -dev-792-e8a938982b 64bit
  27. 2020-02-14 19:00:39.643403 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [received][100]
  28. 2020-02-14 19:00:39.643403 [DEBUG] sofia.c:7311 Remote SDP:
  29. v=0
  30. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  31. s=-
  32. c=IN IP4 127.0.0.1
  33. t=0 0
  34. m=audio 45000 RTP/AVP 8 101
  35. a=rtpmap:8 PCMA/8000
  36. a=rtpmap:101 telephone-event/8000
  37. a=fmtp:101 0-16
  38. a=ptime:20
  39.  
  40. 2020-02-14 19:00:39.643403 [DEBUG] sofia.c:7714 (sofia/external/sipp@127.0.0.1:5055) State Change CS_NEW -> CS_INIT
  41. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:604 (sofia/external/sipp@127.0.0.1:5055) State NEW
  42. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_INIT (Cur 1 Tot 168)
  43. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:628 (sofia/external/sipp@127.0.0.1:5055) State INIT
  44. 2020-02-14 19:00:39.643403 [DEBUG] mod_sofia.c:93 sofia/external/sipp@127.0.0.1:5055 SOFIA INIT
  45. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:40 sofia/external/sipp@127.0.0.1:5055 Standard INIT
  46. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:48 (sofia/external/sipp@127.0.0.1:5055) State Change CS_INIT -> CS_ROUTING
  47. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:628 (sofia/external/sipp@127.0.0.1:5055) State INIT going to sleep
  48. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_ROUTING (Cur 1 Tot 168)
  49. 2020-02-14 19:00:39.643403 [DEBUG] switch_channel.c:2332 (sofia/external/sipp@127.0.0.1:5055) Callstate Change DOWN -> RINGING
  50. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:644 (sofia/external/sipp@127.0.0.1:5055) State ROUTING
  51. send 295 bytes to udp/[127.0.0.1]:5055 at 19:00:39.657333:
  52. ------------------------------------------------------------------------
  53. SIP/2.0 100 Trying
  54. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-0
  55. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  56. To: sut <sip:999000@139.59.28.136:14080>
  57. Call-ID: 1-5033@127.0.0.1
  58. CSeq: 1 INVITE
  59. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  60. Content-Length: 0
  61.  
  62. 2020-02-14 19:00:39.643403 [DEBUG] mod_sofia.c:154 sofia/external/sipp@127.0.0.1:5055 SOFIA ROUTING
  63. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:236 sofia/external/sipp@127.0.0.1:5055 Standard ROUTING
  64. 2020-02-14 19:00:39.643403 [INFO] mod_dialplan_xml.c:637 Processing sipp <sipp>->999000 in context public
  65. Dialplan: sofia/external/sipp@127.0.0.1:5055 parsing [public->sipp test] continue=false
  66. Dialplan: sofia/external/sipp@127.0.0.1:5055 Regex (PASS) [sipp test] destination_number(999000) =~ /^(.*)/ break=on-false
  67. Dialplan: sofia/external/sipp@127.0.0.1:5055 Action bridge(sofia/external/sip:service@139.59.28.136:5031;transport=udp)
  68. Dialplan: sofia/external/sipp@127.0.0.1:5055 Action hangup()
  69. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:287 (sofia/external/sipp@127.0.0.1:5055) State Change CS_ROUTING -> CS_EXECUTE
  70. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:644 (sofia/external/sipp@127.0.0.1:5055) State ROUTING going to sleep
  71. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_EXECUTE (Cur 1 Tot 168)
  72. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:651 (sofia/external/sipp@127.0.0.1:5055) State EXECUTE
  73. 2020-02-14 19:00:39.643403 [DEBUG] mod_sofia.c:209 sofia/external/sipp@127.0.0.1:5055 SOFIA EXECUTE
  74. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:329 sofia/external/sipp@127.0.0.1:5055 Standard EXECUTE
  75. EXECUTE [depth=0] sofia/external/sipp@127.0.0.1:5055 bridge(sofia/external/sip:service@139.59.28.136:5031;transport=udp)
  76. 2020-02-14 19:00:39.643403 [DEBUG] switch_ivr_originate.c:2269 Parsing global variables
  77. 2020-02-14 19:00:39.643403 [NOTICE] switch_channel.c:1118 New Channel sofia/external/service@139.59.28.136:5031 [2f707ddb-4b2b-4122-9daa-3a204a8d4dc8]
  78. 2020-02-14 19:00:39.643403 [DEBUG] mod_sofia.c:5092 (sofia/external/service@139.59.28.136:5031) State Change CS_NEW -> CS_INIT
  79. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_INIT (Cur 2 Tot 169)
  80. 2020-02-14 19:00:39.643403 [DEBUG] switch_core_state_machine.c:628 (sofia/external/service@139.59.28.136:5031) State INIT
  81. 2020-02-14 19:00:39.643403 [DEBUG] mod_sofia.c:93 sofia/external/service@139.59.28.136:5031 SOFIA INIT
  82. 2020-02-14 19:00:39.663382 [DEBUG] sofia_glue.c:1618 sofia/external/service@139.59.28.136:5031 sending invite version: 20.19.10 -dev-792-e8a938982b 64bit
  83. Local SDP:
  84. v=0
  85. o=FreeSWITCH 1581680985 1581680986 IN IP4 139.59.28.136
  86. s=FreeSWITCH
  87. c=IN IP4 139.59.28.136
  88. t=0 0
  89. m=audio 25854 RTP/AVP 8 101
  90. a=rtpmap:8 PCMA/8000
  91. a=rtpmap:101 telephone-event/8000
  92. a=fmtp:101 0-16
  93. a=ptime:20
  94. a=sendrecv
  95.  
  96. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:40 sofia/external/service@139.59.28.136:5031 Standard INIT
  97. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:48 (sofia/external/service@139.59.28.136:5031) State Change CS_INIT -> CS_ROUTING
  98. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:628 (sofia/external/service@139.59.28.136:5031) State INIT going to sleep
  99. send 1046 bytes to udp/[139.59.28.136]:5031 at 19:00:39.664787:
  100. ------------------------------------------------------------------------
  101. INVITE sip:service@139.59.28.136:5031;transport=udp SIP/2.0
  102. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKSrcaN9m0jF79j
  103. Max-Forwards: 69
  104. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  105. To: <sip:service@139.59.28.136:5031;transport=udp>
  106. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  107. CSeq: 16299627 INVITE
  108. Contact: <sip:mod_sofia@139.59.28.136:14080>
  109. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  110. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  111. Supported: timer, path, replaces
  112. Allow-Events: talk, hold, conference, refer
  113. Content-Type: application/sdp
  114. Content-Disposition: session
  115. Content-Length: 222
  116. X-FS-Support: update_display,send_info
  117. Remote-Party-ID: "sipp" <sip:sipp@139.59.28.136>;party=calling;screen=yes;privacy=off
  118.  
  119. v=0
  120. o=FreeSWITCH 1581680985 1581680986 IN IP4 139.59.28.136
  121. s=FreeSWITCH
  122. c=IN IP4 139.59.28.136
  123. t=0 0
  124. m=audio 25854 RTP/AVP 8 101
  125. a=rtpmap:8 PCMA/8000
  126. a=rtpmap:101 telephone-event/8000
  127. a=fmtp:101 0-16
  128. a=ptime:20
  129. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_ROUTING (Cur 2 Tot 169)
  130. 2020-02-14 19:00:39.663382 [DEBUG] sofia.c:7301 Channel sofia/external/service@139.59.28.136:5031 entering state [calling][0]
  131. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:644 (sofia/external/service@139.59.28.136:5031) State ROUTING
  132. 2020-02-14 19:00:39.663382 [DEBUG] mod_sofia.c:154 sofia/external/service@139.59.28.136:5031 SOFIA ROUTING
  133. 2020-02-14 19:00:39.663382 [DEBUG] switch_ivr_originate.c:67 (sofia/external/service@139.59.28.136:5031) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  134. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:644 (sofia/external/service@139.59.28.136:5031) State ROUTING going to sleep
  135. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 169)
  136. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:663 (sofia/external/service@139.59.28.136:5031) State CONSUME_MEDIA
  137. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_state_machine.c:663 (sofia/external/service@139.59.28.136:5031) State CONSUME_MEDIA going to sleep
  138. recv 584 bytes from udp/[139.59.28.136]:5031 at 19:00:39.665903:
  139. ------------------------------------------------------------------------
  140. SIP/2.0 200 OK
  141. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKSrcaN9m0jF79j
  142. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  143. To: <sip:service@139.59.28.136:5031;transport=udp>;tag=1
  144. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  145. CSeq: 16299627 INVITE
  146. Contact: <sip:139.59.28.136:5031;transport=UDP>
  147. Content-Type: application/sdp
  148. Content-Length:   206
  149.  
  150. v=0
  151. o=user1 53655765 2353687637 IN IP4 139.59.28.136
  152. s=-
  153. c=IN IP4 139.59.28.136
  154. t=0 0
  155. m=audio 30514 RTP/AVP 8 101
  156. a=rtpmap:8 PCMA/8000
  157. a=rtpmap:101 telephone-event/8000
  158. a=fmtp:101 0-16
  159. a=ptime:20
  160. 2020-02-14 19:00:39.663382 [DEBUG] sofia.c:7301 Channel sofia/external/service@139.59.28.136:5031 entering state [completing][200]
  161. 2020-02-14 19:00:39.663382 [DEBUG] sofia.c:7311 Remote SDP:
  162. v=0
  163. o=user1 53655765 2353687637 IN IP4 139.59.28.136
  164. s=-
  165. c=IN IP4 139.59.28.136
  166. t=0 0
  167. m=audio 30514 RTP/AVP 8 101
  168. a=rtpmap:8 PCMA/8000
  169. a=rtpmap:101 telephone-event/8000
  170. a=fmtp:101 0-16
  171. a=ptime:20
  172.  
  173. send 389 bytes to udp/[139.59.28.136]:5031 at 19:00:39.667171:
  174. ------------------------------------------------------------------------
  175. ACK sip:139.59.28.136:5031;transport=UDP SIP/2.0
  176. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKt152p453FrXve
  177. Max-Forwards: 70
  178. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  179. To: <sip:service@139.59.28.136:5031;transport=udp>;tag=1
  180. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  181. CSeq: 16299627 ACK
  182. Contact: <sip:mod_sofia@139.59.28.136:14080>
  183. Content-Length: 0
  184.  
  185. 2020-02-14 19:00:39.663382 [DEBUG] sofia.c:7301 Channel sofia/external/service@139.59.28.136:5031 entering state [ready][200]
  186. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  187. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:5651 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  188. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:5512 Set telephone-event payload to 101@8000
  189. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:3840 Set Codec sofia/external/service@139.59.28.136:5031 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  190. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_codec.c:111 sofia/external/service@139.59.28.136:5031 Original read codec set to PCMA:8
  191. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:5855 Set telephone-event payload to 101@8000
  192. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:5913 sofia/external/service@139.59.28.136:5031 Set 2833 dtmf send payload to 101 recv payload to 101
  193. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:8684 AUDIO RTP [sofia/external/service@139.59.28.136:5031] 139.59.28.136 port 25854 -> 139.59.28.136 port 30514 codec: 8 ms: 20
  194. 2020-02-14 19:00:39.663382 [DEBUG] switch_rtp.c:4496 Starting timer [soft] 160 bytes per 20ms
  195. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:8998 sofia/external/service@139.59.28.136:5031 Set 2833 dtmf send payload to 101
  196. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:9005 sofia/external/service@139.59.28.136:5031 Set 2833 dtmf receive payload to 101
  197. 2020-02-14 19:00:39.663382 [DEBUG] switch_core_media.c:9028 sofia/external/service@139.59.28.136:5031 Set rtp dtmf delay to 40
  198. 2020-02-14 19:00:39.663382 [NOTICE] sofia.c:8483 Channel [sofia/external/service@139.59.28.136:5031] has been answered
  199. 2020-02-14 19:00:39.663382 [DEBUG] switch_channel.c:3865 (sofia/external/service@139.59.28.136:5031) Callstate Change DOWN -> ACTIVE
  200. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  201. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  202. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  203. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  204. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5651 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  205. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5512 Set telephone-event payload to 101@8000
  206. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:3840 Set Codec sofia/external/sipp@127.0.0.1:5055 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  207. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_codec.c:111 sofia/external/sipp@127.0.0.1:5055 Original read codec set to PCMA:8
  208. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5855 Set telephone-event payload to 101@8000
  209. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:5913 sofia/external/sipp@127.0.0.1:5055 Set 2833 dtmf send payload to 101 recv payload to 101
  210. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:8684 AUDIO RTP [sofia/external/sipp@127.0.0.1:5055] 139.59.28.136 port 20338 -> 127.0.0.1 port 45000 codec: 8 ms: 20
  211. 2020-02-14 19:00:39.683396 [DEBUG] switch_rtp.c:4496 Starting timer [soft] 160 bytes per 20ms
  212. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:8998 sofia/external/sipp@127.0.0.1:5055 Set 2833 dtmf send payload to 101
  213. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:9005 sofia/external/sipp@127.0.0.1:5055 Set 2833 dtmf receive payload to 101
  214. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:9028 sofia/external/sipp@127.0.0.1:5055 Set rtp dtmf delay to 40
  215. 2020-02-14 19:00:39.683396 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/sipp@127.0.0.1:5055!
  216. 2020-02-14 19:00:39.683396 [DEBUG] switch_channel.c:3565 (sofia/external/sipp@127.0.0.1:5055) Callstate Change RINGING -> EARLY
  217. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_media.c:8666 Audio params are unchanged for sofia/external/sipp@127.0.0.1:5055.
  218. 2020-02-14 19:00:39.683396 [DEBUG] mod_sofia.c:898 Local SDP sofia/external/sipp@127.0.0.1:5055:
  219. v=0
  220. o=FreeSWITCH 1581686501 1581686502 IN IP4 139.59.28.136
  221. s=FreeSWITCH
  222. c=IN IP4 139.59.28.136
  223. t=0 0
  224. m=audio 20338 RTP/AVP 8 101
  225. a=rtpmap:8 PCMA/8000
  226. a=rtpmap:101 telephone-event/8000
  227. a=fmtp:101 0-16
  228. a=ptime:20
  229. a=sendrecv
  230.  
  231. send 943 bytes to udp/[127.0.0.1]:5055 at 19:00:39.689876:
  232. ------------------------------------------------------------------------
  233. SIP/2.0 200 OK
  234. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-0
  235. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  236. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  237. Call-ID: 1-5033@127.0.0.1
  238. CSeq: 1 INVITE
  239. Contact: <sip:999000@139.59.28.136:14080;transport=udp>
  240. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  241. Accept: application/sdp
  242. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  243. Supported: timer, path, replaces
  244. Allow-Events: talk, hold, conference, refer
  245. Content-Type: application/sdp
  246. Content-Disposition: session
  247. Content-Length: 222
  248. Remote-Party-ID: "Outbound Call" <sip:service@139.59.28.136>;party=calling;privacy=off;screen=no
  249.  
  250. v=0
  251. o=FreeSWITCH 1581686501 1581686502 IN IP4 139.59.28.136
  252. s=FreeSWITCH
  253. c=IN IP4 139.59.28.136
  254. t=0 0
  255. m=audio 20338 RTP/AVP 8 101
  256. a=rtpmap:8 PCMA/8000
  257. a=rtpmap:101 telephone-event/8000
  258. a=fmtp:101 0-16
  259. a=ptime:20
  260. 2020-02-14 19:00:39.683396 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [completed][200]
  261. 2020-02-14 19:00:39.683396 [NOTICE] switch_ivr_originate.c:3847 Channel [sofia/external/sipp@127.0.0.1:5055] has been answered
  262. 2020-02-14 19:00:39.683396 [DEBUG] switch_channel.c:3865 (sofia/external/sipp@127.0.0.1:5055) Callstate Change EARLY -> ACTIVE
  263. 2020-02-14 19:00:39.683396 [DEBUG] switch_ivr_originate.c:3905 Originate Resulted in Success: [sofia/external/service@139.59.28.136:5031]
  264. 2020-02-14 19:00:39.683396 [DEBUG] switch_ivr_bridge.c:1796 (sofia/external/service@139.59.28.136:5031) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  265. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 169)
  266. 2020-02-14 19:00:39.683396 [DEBUG] switch_core_state_machine.c:654 (sofia/external/service@139.59.28.136:5031) State EXCHANGE_MEDIA
  267. 2020-02-14 19:00:39.683396 [DEBUG] mod_sofia.c:656 SOFIA EXCHANGE_MEDIA
  268. recv 318 bytes from udp/[127.0.0.1]:5055 at 19:00:39.692485:
  269. ------------------------------------------------------------------------
  270. ACK sip:999000@139.59.28.136:14080 SIP/2.0
  271. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-5
  272. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  273. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  274. Call-ID: 1-5033@127.0.0.1
  275. CSeq: 1 ACK
  276. Contact: sip:sipp@127.0.0.1:5055
  277. Max-Forwards: 70
  278. Content-Length: 0
  279.  
  280. 2020-02-14 19:00:39.683396 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [ready][200]
  281. recv 545 bytes from udp/[127.0.0.1]:5055 at 19:00:47.695505:
  282. ------------------------------------------------------------------------
  283. INVITE sip:999000@139.59.28.136:14080 SIP/2.0
  284. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-7
  285. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  286. To: sut <sip:999000@139.59.28.136:14080>
  287. Call-ID: 1-5033@127.0.0.1
  288. CSeq: 10 INVITE
  289. Contact: <sip:127.0.0.1:5055;transport=UDP>
  290. Content-Type: application/sdp
  291. Content-Length:   210
  292.  
  293. v=0
  294. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  295. s=-
  296. c=IN IP4 127.0.0.1
  297. t=0 0
  298. m=audio 45000 RTP/AVP 8 101
  299. a=rtpmap:8 PCMA/8000
  300. a=rtpmap:101 telephone-event/8000
  301. a=fmtp:101 0-16
  302. a=ptime:20
  303. a=sendonly
  304. send 314 bytes to udp/[127.0.0.1]:5055 at 19:00:47.706710:
  305. ------------------------------------------------------------------------
  306. SIP/2.0 100 Trying
  307. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-7
  308. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  309. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  310. Call-ID: 1-5033@127.0.0.1
  311. CSeq: 10 INVITE
  312. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  313. Content-Length: 0
  314.  
  315. 2020-02-14 19:00:47.703400 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [received][100]
  316. 2020-02-14 19:00:47.703400 [DEBUG] sofia.c:7311 Remote SDP:
  317. v=0
  318. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  319. s=-
  320. c=IN IP4 127.0.0.1
  321. t=0 0
  322. m=audio 45000 RTP/AVP 8 101
  323. a=rtpmap:8 PCMA/8000
  324. a=rtpmap:101 telephone-event/8000
  325. a=fmtp:101 0-16
  326. a=sendonly
  327. a=ptime:20
  328.  
  329. 2020-02-14 19:00:47.703400 [DEBUG] switch_channel.c:1927 (sofia/external/sipp@127.0.0.1:5055) Callstate Change ACTIVE -> HELD
  330. 2020-02-14 19:00:47.883388 [DEBUG] switch_ivr.c:632 sofia/external/service@139.59.28.136:5031 Command Execute [depth=0] playback(local_stream://moh)
  331. EXECUTE [depth=0] sofia/external/service@139.59.28.136:5031 playback(local_stream://moh)
  332. 2020-02-14 19:00:47.883388 [DEBUG] mod_local_stream.c:909 Opening Stream [moh/8000] 8000hz
  333. 2020-02-14 19:00:47.883388 [DEBUG] switch_ivr_play_say.c:1492 Codec Activated L16@8000hz 1 channels 20ms
  334. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  335. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  336. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  337. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  338. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5651 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  339. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5512 Set telephone-event payload to 101@8000
  340. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5855 Set telephone-event payload to 101@8000
  341. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:5913 sofia/external/sipp@127.0.0.1:5055 Set 2833 dtmf send payload to 101 recv payload to 101
  342. 2020-02-14 19:00:47.943389 [DEBUG] switch_core_media.c:8666 Audio params are unchanged for sofia/external/sipp@127.0.0.1:5055.
  343. 2020-02-14 19:00:47.943389 [DEBUG] sofia.c:8254 Processing updated SDP
  344. send 813 bytes to udp/[127.0.0.1]:5055 at 19:00:47.958330:
  345. ------------------------------------------------------------------------
  346. SIP/2.0 200 OK
  347. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-7
  348. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  349. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  350. Call-ID: 1-5033@127.0.0.1
  351. CSeq: 10 INVITE
  352. Contact: <sip:999000@139.59.28.136:14080;transport=udp>
  353. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  354. Accept: application/sdp
  355. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  356. Supported: timer, path, replaces
  357. Content-Type: application/sdp
  358. Content-Disposition: session
  359. Content-Length: 234
  360.  
  361. v=0
  362. o=FreeSWITCH 1581686501 1581686503 IN IP4 139.59.28.136
  363. s=FreeSWITCH
  364. c=IN IP4 139.59.28.136
  365. t=0 0
  366. m=audio 20338 RTP/AVP 8 101
  367. a=rtpmap:8 PCMA/8000
  368. a=rtpmap:101 telephone-event/8000
  369. a=fmtp:101 0-16
  370. a=recvonly
  371. a=ptime:20
  372. 2020-02-14 19:00:47.943389 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [completed][200]
  373. recv 320 bytes from udp/[127.0.0.1]:5055 at 19:00:47.958929:
  374. ------------------------------------------------------------------------
  375. ACK sip:999000@139.59.28.136:14080 SIP/2.0
  376. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-10
  377. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  378. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  379. Call-ID: 1-5033@127.0.0.1
  380. CSeq: 10 ACK
  381. Contact: sip:sipp@127.0.0.1:5055
  382. Max-Forwards: 70
  383. Content-Length: 0
  384.  
  385. 2020-02-14 19:00:47.963419 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [ready][200]
  386. recv 546 bytes from udp/[127.0.0.1]:5055 at 19:00:55.963634:
  387. ------------------------------------------------------------------------
  388. INVITE sip:999000@139.59.28.136:14080 SIP/2.0
  389. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-12
  390. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  391. To: sut <sip:999000@139.59.28.136:14080>
  392. Call-ID: 1-5033@127.0.0.1
  393. CSeq: 15 INVITE
  394. Contact: <sip:127.0.0.1:5055;transport=UDP>
  395. Content-Type: application/sdp
  396. Content-Length:   210
  397.  
  398. v=0
  399. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  400. s=-
  401. c=IN IP4 127.0.0.1
  402. t=0 0
  403. m=audio 45000 RTP/AVP 8 101
  404. a=rtpmap:8 PCMA/8000
  405. a=rtpmap:101 telephone-event/8000
  406. a=fmtp:101 0-16
  407. a=ptime:20
  408. a=inactive
  409. send 315 bytes to udp/[127.0.0.1]:5055 at 19:00:55.972882:
  410. ------------------------------------------------------------------------
  411. SIP/2.0 100 Trying
  412. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-12
  413. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  414. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  415. Call-ID: 1-5033@127.0.0.1
  416. CSeq: 15 INVITE
  417. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  418. Content-Length: 0
  419.  
  420. 2020-02-14 19:00:55.963402 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [received][100]
  421. 2020-02-14 19:00:55.963402 [DEBUG] sofia.c:7311 Remote SDP:
  422. v=0
  423. o=user1 53655765 2353687637 IN IP4 127.0.0.1
  424. s=-
  425. c=IN IP4 127.0.0.1
  426. t=0 0
  427. m=audio 45000 RTP/AVP 8 101
  428. a=rtpmap:8 PCMA/8000
  429. a=rtpmap:101 telephone-event/8000
  430. a=fmtp:101 0-16
  431. a=inactive
  432. a=ptime:20
  433.  
  434. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  435. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  436. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  437. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5596 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  438. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5651 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  439. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5512 Set telephone-event payload to 101@8000
  440. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5855 Set telephone-event payload to 101@8000
  441. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:5913 sofia/external/sipp@127.0.0.1:5055 Set 2833 dtmf send payload to 101 recv payload to 101
  442. 2020-02-14 19:00:55.963402 [DEBUG] switch_core_media.c:8666 Audio params are unchanged for sofia/external/sipp@127.0.0.1:5055.
  443. 2020-02-14 19:00:55.963402 [DEBUG] sofia.c:8254 Processing updated SDP
  444. send 814 bytes to udp/[127.0.0.1]:5055 at 19:00:55.973899:
  445. ------------------------------------------------------------------------
  446. SIP/2.0 200 OK
  447. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-12
  448. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  449. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  450. Call-ID: 1-5033@127.0.0.1
  451. CSeq: 15 INVITE
  452. Contact: <sip:999000@139.59.28.136:14080;transport=udp>
  453. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  454. Accept: application/sdp
  455. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  456. Supported: timer, path, replaces
  457. Content-Type: application/sdp
  458. Content-Disposition: session
  459. Content-Length: 234
  460.  
  461. v=0
  462. o=FreeSWITCH 1581686501 1581686504 IN IP4 139.59.28.136
  463. s=FreeSWITCH
  464. c=IN IP4 139.59.28.136
  465. t=0 0
  466. m=audio 20338 RTP/AVP 8 101
  467. a=rtpmap:8 PCMA/8000
  468. a=rtpmap:101 telephone-event/8000
  469. a=fmtp:101 0-16
  470. a=inactive
  471. a=ptime:20
  472. 2020-02-14 19:00:55.963402 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [completed][200]
  473. recv 320 bytes from udp/[127.0.0.1]:5055 at 19:00:55.974428:
  474. ------------------------------------------------------------------------
  475. ACK sip:999000@139.59.28.136:14080 SIP/2.0
  476. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-15
  477. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  478. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  479. Call-ID: 1-5033@127.0.0.1
  480. CSeq: 15 ACK
  481. Contact: sip:sipp@127.0.0.1:5055
  482. Max-Forwards: 70
  483. Content-Length: 0
  484.  
  485. recv 320 bytes from udp/[127.0.0.1]:5055 at 19:00:55.975666:
  486. ------------------------------------------------------------------------
  487. BYE sip:999000@139.59.28.136:14080 SIP/2.0
  488. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-16
  489. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  490. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  491. Call-ID: 1-5033@127.0.0.1
  492. CSeq: 20 BYE
  493. Contact: sip:sipp@127.0.0.1:5055
  494. Max-Forwards: 70
  495. Content-Length: 0
  496.  
  497. 2020-02-14 19:00:55.983411 [DEBUG] sofia.c:7301 Channel sofia/external/sipp@127.0.0.1:5055 entering state [ready][200]
  498. 2020-02-14 19:00:55.983411 [DEBUG] switch_channel.c:2112 (sofia/external/sipp@127.0.0.1:5055) Callstate Change HELD -> UNHELD
  499. 2020-02-14 19:00:55.983411 [NOTICE] sofia.c:1089 Hangup sofia/external/sipp@127.0.0.1:5055 [CS_EXECUTE] [NORMAL_CLEARING]
  500. send 432 bytes to udp/[127.0.0.1]:5055 at 19:00:55.995711:
  501. ------------------------------------------------------------------------
  502. SIP/2.0 200 OK
  503. Via: SIP/2.0/UDP 127.0.0.1:5055;branch=z9hG4bK-5033-1-16
  504. From: sipp <sip:sipp@127.0.0.1:5055>;tag=1
  505. To: sut <sip:999000@139.59.28.136:14080>;tag=B7DrarvrFN9Fe
  506. Call-ID: 1-5033@127.0.0.1
  507. CSeq: 20 BYE
  508. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  509. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  510. Supported: timer, path, replaces
  511. Content-Length: 0
  512.  
  513. 2020-02-14 19:00:55.983411 [DEBUG] switch_ivr_bridge.c:915 BRIDGE THREAD DONE [sofia/external/sipp@127.0.0.1:5055]
  514. 2020-02-14 19:00:55.983411 [NOTICE] switch_ivr_bridge.c:930 Hangup sofia/external/service@139.59.28.136:5031 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  515. 2020-02-14 19:00:55.983411 [DEBUG] switch_ivr_bridge.c:1895 sofia/external/service@139.59.28.136:5031 skip receive message [UNBRIDGE] (channel is hungup already)
  516. 2020-02-14 19:00:55.983411 [DEBUG] switch_ivr_bridge.c:1898 sofia/external/sipp@127.0.0.1:5055 skip receive message [UNBRIDGE] (channel is hungup already)
  517. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_session.c:2905 sofia/external/sipp@127.0.0.1:5055 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  518. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:651 (sofia/external/sipp@127.0.0.1:5055) State EXECUTE going to sleep
  519. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_HANGUP (Cur 2 Tot 169)
  520. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:848 (sofia/external/sipp@127.0.0.1:5055) Callstate Change UNHELD -> HANGUP
  521. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:850 (sofia/external/sipp@127.0.0.1:5055) State HANGUP
  522. 2020-02-14 19:00:55.983411 [DEBUG] mod_sofia.c:453 Channel sofia/external/sipp@127.0.0.1:5055 hanging up, cause: NORMAL_CLEARING
  523. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:60 sofia/external/sipp@127.0.0.1:5055 Standard HANGUP, cause: NORMAL_CLEARING
  524. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:850 (sofia/external/sipp@127.0.0.1:5055) State HANGUP going to sleep
  525. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:620 (sofia/external/sipp@127.0.0.1:5055) State Change CS_HANGUP -> CS_REPORTING
  526. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:585 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_REPORTING (Cur 2 Tot 169)
  527. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:936 (sofia/external/sipp@127.0.0.1:5055) State REPORTING
  528. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:174 sofia/external/sipp@127.0.0.1:5055 Standard REPORTING, cause: NORMAL_CLEARING
  529. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:936 (sofia/external/sipp@127.0.0.1:5055) State REPORTING going to sleep
  530. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_state_machine.c:611 (sofia/external/sipp@127.0.0.1:5055) State Change CS_REPORTING -> CS_DESTROY
  531. 2020-02-14 19:00:55.983411 [DEBUG] switch_core_session.c:1726 Session 168 (sofia/external/sipp@127.0.0.1:5055) Locked, Waiting on external entities
  532. 2020-02-14 19:00:56.003392 [DEBUG] switch_ivr_play_say.c:1933 done playing file local_stream://moh
  533. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_session.c:2905 sofia/external/service@139.59.28.136:5031 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  534. 2020-02-14 19:00:56.003392 [DEBUG] switch_ivr_bridge.c:571 sofia/external/service@139.59.28.136:5031 skip receive message [BRIDGE] (channel is hungup already)
  535. 2020-02-14 19:00:56.003392 [DEBUG] switch_ivr.c:679 sofia/external/service@139.59.28.136:5031 skip receive message [AUDIO_SYNC] (channel is hungup already)
  536. 2020-02-14 19:00:56.003392 [DEBUG] switch_ivr_bridge.c:829 sofia/external/service@139.59.28.136:5031 ending bridge by request from read function
  537. 2020-02-14 19:00:56.003392 [DEBUG] switch_ivr_bridge.c:915 BRIDGE THREAD DONE [sofia/external/service@139.59.28.136:5031]
  538. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:654 (sofia/external/service@139.59.28.136:5031) State EXCHANGE_MEDIA going to sleep
  539. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_HANGUP (Cur 2 Tot 169)
  540. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:848 (sofia/external/service@139.59.28.136:5031) Callstate Change ACTIVE -> HANGUP
  541. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:850 (sofia/external/service@139.59.28.136:5031) State HANGUP
  542. 2020-02-14 19:00:56.003392 [DEBUG] mod_sofia.c:447 sofia/external/service@139.59.28.136:5031 Overriding SIP cause 480 with 200 from the other leg
  543. 2020-02-14 19:00:56.003392 [DEBUG] mod_sofia.c:453 Channel sofia/external/service@139.59.28.136:5031 hanging up, cause: NORMAL_CLEARING
  544. 2020-02-14 19:00:56.003392 [DEBUG] mod_sofia.c:507 Sending BYE to sofia/external/service@139.59.28.136:5031
  545. send 582 bytes to udp/[139.59.28.136]:5031 at 19:00:56.009666:
  546. ------------------------------------------------------------------------
  547. BYE sip:139.59.28.136:5031;transport=UDP SIP/2.0
  548. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKUaZUrZp7c1KFa
  549. Max-Forwards: 70
  550. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  551. To: <sip:service@139.59.28.136:5031;transport=udp>;tag=1
  552. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  553. CSeq: 16299628 BYE
  554. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  555. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  556. Supported: timer, path, replaces
  557. Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  558. Content-Length: 0
  559.  
  560. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:60 sofia/external/service@139.59.28.136:5031 Standard HANGUP, cause: NORMAL_CLEARING
  561. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:850 (sofia/external/service@139.59.28.136:5031) State HANGUP going to sleep
  562. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:620 (sofia/external/service@139.59.28.136:5031) State Change CS_HANGUP -> CS_REPORTING
  563. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:585 (sofia/external/service@139.59.28.136:5031) Running State Change CS_REPORTING (Cur 2 Tot 169)
  564. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:936 (sofia/external/service@139.59.28.136:5031) State REPORTING
  565. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:174 sofia/external/service@139.59.28.136:5031 Standard REPORTING, cause: NORMAL_CLEARING
  566. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:936 (sofia/external/service@139.59.28.136:5031) State REPORTING going to sleep
  567. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:611 (sofia/external/service@139.59.28.136:5031) State Change CS_REPORTING -> CS_DESTROY
  568. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_session.c:1726 Session 169 (sofia/external/service@139.59.28.136:5031) Locked, Waiting on external entities
  569. 2020-02-14 19:00:56.003392 [NOTICE] switch_core_session.c:1744 Session 169 (sofia/external/service@139.59.28.136:5031) Ended
  570. 2020-02-14 19:00:56.003392 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/service@139.59.28.136:5031 [CS_DESTROY]
  571. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:739 (sofia/external/service@139.59.28.136:5031) Running State Change CS_DESTROY (Cur 1 Tot 169)
  572. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:749 (sofia/external/service@139.59.28.136:5031) State DESTROY
  573. 2020-02-14 19:00:56.003392 [DEBUG] mod_sofia.c:364 sofia/external/service@139.59.28.136:5031 SOFIA DESTROY
  574. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:181 sofia/external/service@139.59.28.136:5031 Standard DESTROY
  575. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:749 (sofia/external/service@139.59.28.136:5031) State DESTROY going to sleep
  576. 2020-02-14 19:00:56.003392 [NOTICE] switch_core_session.c:1744 Session 168 (sofia/external/sipp@127.0.0.1:5055) Ended
  577. 2020-02-14 19:00:56.003392 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/sipp@127.0.0.1:5055 [CS_DESTROY]
  578. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:739 (sofia/external/sipp@127.0.0.1:5055) Running State Change CS_DESTROY (Cur 0 Tot 169)
  579. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:749 (sofia/external/sipp@127.0.0.1:5055) State DESTROY
  580. 2020-02-14 19:00:56.003392 [DEBUG] mod_sofia.c:364 sofia/external/sipp@127.0.0.1:5055 SOFIA DESTROY
  581. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:181 sofia/external/sipp@127.0.0.1:5055 Standard DESTROY
  582. 2020-02-14 19:00:56.003392 [DEBUG] switch_core_state_machine.c:749 (sofia/external/sipp@127.0.0.1:5055) State DESTROY going to sleep
  583. send 582 bytes to udp/[139.59.28.136]:5031 at 19:00:57.010348:
  584. ------------------------------------------------------------------------
  585. BYE sip:139.59.28.136:5031;transport=UDP SIP/2.0
  586. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKUaZUrZp7c1KFa
  587. Max-Forwards: 70
  588. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  589. To: <sip:service@139.59.28.136:5031;transport=udp>;tag=1
  590. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  591. CSeq: 16299628 BYE
  592. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  593. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  594. Supported: timer, path, replaces
  595. Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  596. Content-Length: 0
  597.  
  598. send 582 bytes to udp/[139.59.28.136]:5031 at 19:00:59.011417:
  599. ------------------------------------------------------------------------
  600. BYE sip:139.59.28.136:5031;transport=UDP SIP/2.0
  601. Via: SIP/2.0/UDP 139.59.28.136:14080;rport;branch=z9hG4bKUaZUrZp7c1KFa
  602. Max-Forwards: 70
  603. From: "sipp" <sip:sipp@139.59.28.136>;tag=cg7gcKDvcyZ2S
  604. To: <sip:service@139.59.28.136:5031;transport=udp>;tag=1
  605. Call-ID: 220b026c-c9ff-1238-30a9-f656cab764bb
  606. CSeq: 16299628 BYE
  607. User-Agent: FreeSWITCH-mod_sofia/20.19.10-dev-792-e8a938982b~64bit
  608. Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  609. Supported: timer, path, replaces
  610. Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  611. Content-Length: 0
  612.  
  613. freeswitch@shashi-lab> ...
  614.  

Reply to "hold-unhold"