1. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/106@66.228.34.184) State DESTROY going to sleep
2. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:181 sofia/internal/106@66.228.34.184 Standard DESTROY
3. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] mod_sofia.c:343 sofia/internal/106@66.228.34.184 SOFIA DESTROY
4. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/106@66.228.34.184) State DESTROY
5. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/106@66.228.34.184) Running State Change CS_DESTROY (Cur 0 Tot 84)
6. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/106@66.228.34.184 [CS_DESTROY]
7. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [NOTICE] switch_core_session.c:1683 Session 84 (sofia/internal/106@66.228.34.184) Ended
8. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_session.c:1665 Session 84 (sofia/internal/106@66.228.34.184) Locked, Waiting on external entities
9. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/106@66.228.34.184) State Change CS_REPORTING -> CS_DESTROY
10. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/106@66.228.34.184) State REPORTING going to sleep
11. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.734122 [DEBUG] switch_core_state_machine.c:174 sofia/internal/106@66.228.34.184 Standard REPORTING, cause: NORMAL_CLEARING
12. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.614120 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/106@66.228.34.184) State REPORTING
13. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.614120 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_REPORTING (Cur 1 Tot 84)
14. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/106@66.228.34.184) State Change CS_HANGUP -> CS_REPORTING
15. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/106@66.228.34.184) State HANGUP going to sleep
16. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:60 sofia/internal/106@66.228.34.184 Standard HANGUP, cause: NORMAL_CLEARING
17. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
18. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_sofia.c:438 Channel sofia/internal/106@66.228.34.184 hanging up, cause: NORMAL_CLEARING
19. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/106@66.228.34.184) State HANGUP
20. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/106@66.228.34.184) Callstate Change RINGING -> HANGUP
21. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_HANGUP (Cur 1 Tot 84)
22. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/106@66.228.34.184) State EXECUTE going to sleep
23. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/106@66.228.34.184 [CS_EXECUTE] [NORMAL_CLEARING]
24. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [NOTICE] switch_core_state_machine.c:385 sofia/internal/106@66.228.34.184 has executed the last dialplan instruction, hanging up.
25. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:328 sofia/internal/106@66.228.34.184 Standard EXECUTE
26. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_sofia.c:198 sofia/internal/106@66.228.34.184 SOFIA EXECUTE
27. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/106@66.228.34.184) State EXECUTE
28. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_EXECUTE (Cur 1 Tot 84)
29. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/106@66.228.34.184) State ROUTING going to sleep
30. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/106@66.228.34.184) State Change CS_ROUTING -> CS_EXECUTE
31. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_dptools.c:1742 routes] 404 not found 173.29.209.241
32. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 log([inbound routes] 404 not found 173.29.209.241)
33. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action log([inbound routes] 404 not found ${sip_network_ip}) INLINE
34. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_dptools.c:1548 SET sofia/internal/106@66.228.34.184 [call_direction]=[inbound]
35. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 set(call_direction=inbound)
36. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action set(call_direction=inbound) INLINE
37. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
38. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 export(call_direction=inbound)
39. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action export(call_direction=inbound) INLINE
40. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Regex (PASS) [not-found] () =~ // break=on-false
41. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 parsing [public->not-found] continue=false
42. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_dptools.c:1548 SET sofia/internal/106@66.228.34.184 [caller_id_number]=[106]
43. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 set(caller_id_number=106)
44. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action set(caller_id_number=${caller_id_number}) INLINE
45. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_dptools.c:1548 SET sofia/internal/106@66.228.34.184 [caller_id_name]=[106]
46. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 set(caller_id_name=106)
47. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action set(caller_id_name=${caller_id_name}) INLINE
48. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_dptools.c:1548 SET sofia/internal/106@66.228.34.184 [caller_destination]=[106]
49. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 set(caller_destination=106)
50. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action set(caller_destination=${destination_number}) INLINE
51. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
52. df8715a6-4bbd-4e70-8927-a105e8682a76 EXECUTE sofia/internal/106@66.228.34.184 export(call_direction=inbound)
53. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Action export(call_direction=inbound) INLINE
54. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 Regex (PASS) [caller-details] () =~ // break=never
55. df8715a6-4bbd-4e70-8927-a105e8682a76 Dialplan: sofia/internal/106@66.228.34.184 parsing [public->caller-details] continue=true
56. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [INFO] mod_dialplan_xml.c:637 Processing 106 <106>->106 in context public
57. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:236 sofia/internal/106@66.228.34.184 Standard ROUTING
58. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_sofia.c:143 sofia/internal/106@66.228.34.184 SOFIA ROUTING
59. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/106@66.228.34.184) State ROUTING
60. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_channel.c:2249 (sofia/internal/106@66.228.34.184) Callstate Change DOWN -> RINGING
61. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_ROUTING (Cur 1 Tot 84)
62. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/106@66.228.34.184) State INIT going to sleep
63. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/106@66.228.34.184) State Change CS_INIT -> CS_ROUTING
64. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:40 sofia/internal/106@66.228.34.184 Standard INIT
65. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] mod_sofia.c:90 sofia/internal/106@66.228.34.184 SOFIA INIT
66. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/106@66.228.34.184) State INIT
67. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_INIT (Cur 1 Tot 84)
68. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/106@66.228.34.184) State NEW
69. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:7507 (sofia/internal/106@66.228.34.184) State Change CS_NEW -> CS_INIT
70. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4767 sofia/internal/106@66.228.34.184 Set 2833 dtmf send payload to 101 recv payload to 101
71. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
72. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_codec.c:111 sofia/internal/106@66.228.34.184 Original read codec set to PCMU:0
73. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/106@66.228.34.184 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
74. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
75. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:123:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
76. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:123:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
77. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:123:48000:20:0:2]/[G722:9:8000:20:64000:1]
78. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G726-32:2:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
79. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G726-32:2:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
80. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G726-32:2:8000:20:0:1]/[G722:9:8000:20:64000:1]
81. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
82. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
83. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G722:9:8000:20:64000:1]
84. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
85. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
86. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
87. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
88. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
89. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
90. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
91. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G723:4:8000:20:6300:1]/[PCMA:8:8000:20:64000:1]
92. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G723:4:8000:20:6300:1]/[PCMU:0:8000:20:64000:1]
93. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G723:4:8000:20:6300:1]/[G722:9:8000:20:64000:1]
94. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
95. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
96. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
97. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
98. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
99. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
100. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
101. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
102. df8715a6-4bbd-4e70-8927-a105e8682a76
103. df8715a6-4bbd-4e70-8927-a105e8682a76 a=ptime:20
104. df8715a6-4bbd-4e70-8927-a105e8682a76 a=fmtp:101 0-15
105. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:101 telephone-event/8000
106. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:123 opus/48000/2
107. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:2 G726-32/8000
108. df8715a6-4bbd-4e70-8927-a105e8682a76 a=fmtp:97 mode=30
109. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:97 iLBC/8000
110. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:9 G722/8000
111. df8715a6-4bbd-4e70-8927-a105e8682a76 a=fmtp:18 annexb=no
112. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:18 G729/8000
113. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:4 G723/8000
114. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:8 PCMA/8000
115. df8715a6-4bbd-4e70-8927-a105e8682a76 a=rtpmap:0 PCMU/8000
116. df8715a6-4bbd-4e70-8927-a105e8682a76 m=audio 5006 RTP/AVP 0 8 4 18 9 97 2 123 101
117. df8715a6-4bbd-4e70-8927-a105e8682a76 t=0 0
118. df8715a6-4bbd-4e70-8927-a105e8682a76 c=IN IP4 10.215.5.32
119. df8715a6-4bbd-4e70-8927-a105e8682a76 s=SIP Call
120. df8715a6-4bbd-4e70-8927-a105e8682a76 o=106 8000 8000 IN IP4 10.215.5.32
121. df8715a6-4bbd-4e70-8927-a105e8682a76 v=0
122. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:7094 Remote SDP:
123. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:7084 Channel sofia/internal/106@66.228.34.184 entering state [received][100]
124. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
125. 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:9989 IP 173.29.209.241 Approved by acl "domains[]". Access Granted.
126. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] sofia.c:9873 sofia/internal/106@66.228.34.184 receiving invite from 173.29.209.241:37309 version: 1.6.20 -37-987c9b9 64bit
127. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@66.228.34.184) Running State Change CS_NEW (Cur 1 Tot 84)
128. df8715a6-4bbd-4e70-8927-a105e8682a76 2018-04-17 21:20:38.594152 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/106@66.228.34.184 [df8715a6-4bbd-4e70-8927-a105e8682a76]