FreeSWITCH Pastebin

Untitled

From Jittery Cockroach, 2 Weeks ago, written in HTML5.
- go back
URL https://pastebin.freeswitch.org/view/f7ca1053
Embed
Viewing differences between and Untitled
  1. GROUP:2|MARKUP:0|CI:184|ACCID:6)                                                                                                                                                                                  
  2. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [origination_rates]=[ID:12|CODE:^46.*|DESTINATION:Sverige|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|CT:|COST:0.0000000000|INC:1|INITIALBLOCK:1|RATEGROUP:2|MARKUP:0|CI:184|ACCID:6]                                                                                                                                    
  3. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(original_caller_id_name=0708516331)
  4. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [original_caller_id_name]=[0708516331]
  5. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(original_caller_id_number=0708516331)
  6. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [original_caller_id_number]=[0708516331]
  7. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(effective_caller_id_name=0708516331)
  8. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [effective_caller_id_name]=[0708516331]
  9. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(effective_caller_id_number=0708516331)
  10. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [effective_caller_id_number]=[0708516331]
  11. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(calltype=STANDARD)
  12. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [calltype]=[STANDARD]
  13. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(termination_rates=ID:4|CODE:^46.*|DESTINATION:Sverige|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:4|PROVIDER:7)                                                                                                                                                                                                        
  14. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [termination_rates]=[ID:4|CODE:^46.*|DESTINATION:Sverige|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:4|PROVIDER:7]                                                                                                                                                          
  15. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(trunk_id=4)
  16. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [trunk_id]=[4]
  17. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(provider_id=7)
  18. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [provider_id]=[7]
  19. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(rate_flag=0)
  20. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [rate_flag]=[0]
  21. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(daily_call_credit_limit=0.00000)
  22. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [daily_call_credit_limit]=[0.00000]
  23. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(monthly_call_credit_limit=0.00000)
  24. 2024-12-09 17:02:39.902490 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [monthly_call_credit_limit]=[0.00000]
  25. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(daily_call_used_limit=0.00000)
  26. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [daily_call_used_limit]=[0.00000]
  27. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(monthly_call_used_limit=0.00000)
  28. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [monthly_call_used_limit]=[0.00000]
  29. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(quality_trunk_seq=4)
  30. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [quality_trunk_seq]=[4]
  31. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(force_trunk_flag=12)
  32. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [force_trunk_flag]=[12]
  33. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 export(presence_data=trunk_id=4)
  34. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_data]=[trunk_id=4]
  35. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 set(intcall=0)
  36. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46708516331@62.80.216.236 [intcall]=[0]
  37. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 export(presence_id=46455655400)
  38. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_id]=[46455655400]
  39. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 export(presence_data=x|||GOTANET(5504929424)|||^46.* // Sverige // 0.0000000000|||miniel_incoming // ^46.* // Sverige // 0.0000000000 // trunk_id=4|||STD|||62.80.216.236)                                                                                                                                                                                                
  40. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_data]=[x|||GOTANET(5504929424)|||^46.* // Sverige // 0.0000000000|||miniel_incoming // ^46.* // Sverige // 0.0000000000 // trunk_id=4|||STD|||62.80.216.236]                                                                                                                                                                          
  41. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 bridge({sip_cid_type=none}[leg_timeout=0]sofia/gateway/minitel_inc/46455655400)
  42. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1288 sofia/default/+46708516331@62.80.216.236 EXPORTING[export_vars] [presence_data]=[x|||GOTANET(5504929424)|||^46.* // Sverige // 0.0000000000|||miniel_incoming // ^46.* // Sverige // 0.0000000000 // trunk_id=4|||STD|||62.80.216.236] to event                                                                                                                      
  43. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1288 sofia/default/+46708516331@62.80.216.236 EXPORTING[export_vars] [presence_id]=[46455655400] to event
  44. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_channel.c:1288 sofia/default/+46708516331@62.80.216.236 EXPORTING[export_vars] [presence_data]=[x|||GOTANET(5504929424)|||^46.* // Sverige // 0.0000000000|||miniel_incoming // ^46.* // Sverige // 0.0000000000 // trunk_id=4|||STD|||62.80.216.236] to event                                                                                                                      
  45. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_ivr_originate.c:2297 Parsing global variables
  46. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_ivr_originate.c:2859 Parsing session specific variables
  47. 2024-12-09 17:02:39.922482 80.67% [NOTICE] switch_channel.c:1142 New Channel sofia/default/46455655400 [6883d05e-f80b-4ecc-a05f-40e38f7b25f7]
  48. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_sofia.c:5110 (sofia/default/46455655400) State Change CS_NEW -> CS_INIT
  49. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/46455655400) Running State Change CS_INIT (Cur 142 Tot 134742)
  50. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:624 (sofia/default/46455655400) State INIT
  51. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_sofia.c:97 sofia/default/46455655400 SOFIA INIT
  52. 2024-12-09 17:02:39.922482 80.67% [INFO] sofia_glue.c:1659 sofia/default/46455655400 sending invite call-id: (null)
  53. 2024-12-09 17:02:39.922482 80.67% [DEBUG] sofia_glue.c:1662 sofia/default/46455655400 sending invite version: 1.10.10-release  64bit
  54. Local SDP:                                                                                                                                                                                                        
  55. v=0                                                                                                                                                                                                                
  56. o=FreeSWITCH 1733739349 1733739350 IN IP4 172.232.155.199                                                                                                                                                          
  57. s=FreeSWITCH                                                                                                                                                                                                      
  58. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  59. t=0 0                                                                                                                                                                                                              
  60. m=audio 24410 RTP/AVP 8 101                                                                                                                                                                                        
  61. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  62. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  63. a=fmtp:101 0-15                                                                                                                                                                                                    
  64. a=ptime:20                                                                                                                                                                                                        
  65. a=sendrecv                                                                                                                                                                                                        
  66.  
  67. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:40 sofia/default/46455655400 Standard INIT
  68. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:48 (sofia/default/46455655400) State Change CS_INIT -> CS_ROUTING
  69. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:624 (sofia/default/46455655400) State INIT going to sleep
  70. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/46455655400) Running State Change CS_ROUTING (Cur 142 Tot 134742)
  71. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:640 (sofia/default/46455655400) State ROUTING
  72. 2024-12-09 17:02:39.922482 80.67% [DEBUG] mod_sofia.c:158 sofia/default/46455655400 SOFIA ROUTING
  73. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_ivr_originate.c:67 (sofia/default/46455655400) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  74. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:640 (sofia/default/46455655400) State ROUTING going to sleep
  75. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/46455655400) Running State Change CS_CONSUME_MEDIA (Cur 142 Tot 134742)
  76. 2024-12-09 17:02:39.922482 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/46455655400 entering state [calling][0]
  77. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:659 (sofia/default/46455655400) State CONSUME_MEDIA
  78. 2024-12-09 17:02:39.922482 80.67% [DEBUG] switch_core_state_machine.c:659 (sofia/default/46455655400) State CONSUME_MEDIA going to sleep
  79. 2024-12-09 17:02:40.022471 80.67% [NOTICE] sofia.c:1065 Hangup sofia/default/+46731218760@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  80. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218760@46.246.2.119]
  81. 2024-12-09 17:02:40.022471 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/46455655400 entering state [proceeding][180]
  82. 2024-12-09 17:02:40.022471 80.67% [NOTICE] sofia.c:7604 Ring-Ready sofia/default/46455655400!
  83. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_channel.c:3513 (sofia/default/46455655400) Callstate Change DOWN -> RINGING
  84. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218760@46.246.2.119 ending bridge by request from write function
  85. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46707166943]
  86. 2024-12-09 17:02:40.022471 80.67% [NOTICE] switch_ivr_bridge.c:1027 Hangup sofia/default/+46707166943 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  87. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46707166943) State EXCHANGE_MEDIA going to sleep
  88. 2024-12-09 17:02:40.022471 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46707166943) Running State Change CS_HANGUP (Cur 142 Tot 134742)
  89. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46707166943) Callstate Change ACTIVE -> HANGUP
  90. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46707166943) State HANGUP
  91. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:463 sofia/default/+46707166943 Overriding SIP cause 480 with 200 from the other leg
  92. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46707166943 hanging up, cause: NORMAL_CLEARING
  93. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46707166943 skip receive message [UNBRIDGE] (channel is hungup already)
  94. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218760@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  95. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218760@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  96. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218760@46.246.2.119) State EXECUTE going to sleep
  97. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218760@46.246.2.119) Running State Change CS_HANGUP (Cur 142 Tot 134742)
  98. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46707166943
  99. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218760@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  100. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46707166943 Standard HANGUP, cause: NORMAL_CLEARING
  101. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46707166943) State HANGUP going to sleep
  102. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218760@46.246.2.119) State HANGUP
  103. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218760@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  104. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46707166943) State Change CS_HANGUP -> CS_REPORTING
  105. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46707166943) Running State Change CS_REPORTING (Cur 142 Tot 134742)
  106. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46707166943) State REPORTING
  107. 2024-12-09 17:02:40.042475 80.67% [INFO] mod_json_cdr.c:272 Process [34062ecd-d61c-4172-b60c-76c11440458a.cdr.json]
  108. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218760@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  109. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218760@46.246.2.119) State HANGUP going to sleep
  110. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218760@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  111. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218760@46.246.2.119) Running State Change CS_REPORTING (Cur 142 Tot 134742)
  112. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218760@46.246.2.119) State REPORTING
  113. 2024-12-09 17:02:40.042475 80.67% [INFO] mod_json_cdr.c:272 Process [a22ff739-b702-4b15-874e-1b15b80430e1.cdr.json]
  114. 2024-12-09 17:02:40.042475 80.67% [NOTICE] mod_sofia.c:2514 Ring-Ready sofia/default/+46708516331@62.80.216.236!
  115. 2024-12-09 17:02:40.042475 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46708516331@62.80.216.236 entering state [early][180]
  116. 2024-12-09 17:02:40.042475 80.67% [NOTICE] switch_ivr_originate.c:568 Ring Ready sofia/default/+46708516331@62.80.216.236!
  117. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46707166943 Standard REPORTING, cause: NORMAL_CLEARING
  118. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46707166943) State REPORTING going to sleep
  119. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46707166943) State Change CS_REPORTING -> CS_DESTROY
  120. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_session.c:1744 Session 134561 (sofia/default/+46707166943) Locked, Waiting on external entities
  121. 2024-12-09 17:02:40.042475 80.67% [NOTICE] switch_core_session.c:1762 Session 134561 (sofia/default/+46707166943) Ended
  122. 2024-12-09 17:02:40.042475 80.67% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46707166943 [CS_DESTROY]
  123. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46707166943) Running State Change CS_DESTROY (Cur 141 Tot 134742)
  124. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46707166943) State DESTROY
  125. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:380 sofia/default/+46707166943 SOFIA DESTROY
  126. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46707166943 Standard DESTROY
  127. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46707166943) State DESTROY going to sleep
  128. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218760@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  129. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218760@46.246.2.119) State REPORTING going to sleep
  130. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218760@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  131. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_session.c:1744 Session 134557 (sofia/default/+46731218760@46.246.2.119) Locked, Waiting on external entities
  132. 2024-12-09 17:02:40.042475 80.67% [NOTICE] switch_core_session.c:1762 Session 134557 (sofia/default/+46731218760@46.246.2.119) Ended
  133. 2024-12-09 17:02:40.042475 80.67% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218760@46.246.2.119 [CS_DESTROY]
  134. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218760@46.246.2.119) Running State Change CS_DESTROY (Cur 140 Tot 134742)
  135. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218760@46.246.2.119) State DESTROY
  136. 2024-12-09 17:02:40.042475 80.67% [DEBUG] mod_sofia.c:380 sofia/default/+46731218760@46.246.2.119 SOFIA DESTROY
  137. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218760@46.246.2.119 Standard DESTROY
  138. 2024-12-09 17:02:40.042475 80.67% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218760@46.246.2.119) State DESTROY going to sleep
  139. 2024-12-09 17:02:40.182474 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46705359757 entering state [completing][200]
  140. 2024-12-09 17:02:40.182474 80.67% [DEBUG] sofia.c:7500 Duplicate SDP
  141. v=0                                                                                                                                                                                                                
  142. o=Sonus_UAC 115340 613419 IN IP4 216.155.239.86                                                                                                                                                                    
  143. s=SIP Media Capabilities                                                                                                                                                                                          
  144. c=IN IP4 216.155.239.84                                                                                                                                                                                            
  145. t=0 0                                                                                                                                                                                                              
  146. m=audio 60364 RTP/AVP 8 101                                                                                                                                                                                        
  147. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  148. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  149. a=fmtp:101 0-15                                                                                                                                                                                                    
  150. a=maxptime:20                                                                                                                                                                                                      
  151.  
  152. 2024-12-09 17:02:40.202475 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46705359757 entering state [ready][200]
  153. 2024-12-09 17:02:40.202475 80.67% [NOTICE] sofia.c:8622 Channel [sofia/default/+46705359757] has been answered
  154. 2024-12-09 17:02:40.202475 80.67% [DEBUG] switch_channel.c:3912 (sofia/default/+46705359757) Callstate Change RINGING -> ACTIVE
  155. 2024-12-09 17:02:40.202475 80.67% [DEBUG] switch_core_media.c:8641 Audio params are unchanged for sofia/default/+46731218962@46.246.2.119.
  156. 2024-12-09 17:02:40.202475 80.67% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/+46731218962@46.246.2.119:
  157. v=0                                                                                                                                                                                                                
  158. o=FreeSWITCH 1733745049 1733745051 IN IP4 172.232.155.199                                                                                                                                                          
  159. s=FreeSWITCH                                                                                                                                                                                                      
  160. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  161. t=0 0                                                                                                                                                                                                              
  162. m=audio 18698 RTP/AVP 8 101                                                                                                                                                                                        
  163. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  164. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  165. a=fmtp:101 0-15                                                                                                                                                                                                    
  166. a=ptime:20                                                                                                                                                                                                        
  167. a=sendrecv                                                                                                                                                                                                        
  168.  
  169. 2024-12-09 17:02:40.202475 80.67% [NOTICE] switch_ivr_bridge.c:730 Channel [sofia/default/+46731218962@46.246.2.119] has been answered
  170. EXECUTE [depth=0] sofia/default/+46731218962@46.246.2.119 sched_hangup(+6000 normal_clearing)
  171. 2024-12-09 17:02:40.202475 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [completed][200]
  172. 2024-12-09 17:02:40.202475 80.67% [DEBUG] switch_scheduler.c:263 Added task 39929 switch_ivr_schedule_hangup (fa7dc7da-7d72-46ad-98cb-12156ad4c132) to run at 1733769760
  173. 2024-12-09 17:02:40.202475 80.67% [DEBUG] switch_scheduler.c:147 Deleting task 39905 switch_ivr_schedule_hangup (a22ff739-b702-4b15-874e-1b15b80430e1)
  174. 2024-12-09 17:02:40.202475 80.67% [DEBUG] switch_channel.c:3912 (sofia/default/+46731218962@46.246.2.119) Callstate Change EARLY -> ACTIVE
  175. 2024-12-09 17:02:40.222465 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [ready][200]
  176. 2024-12-09 17:02:40.242473 80.67% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  177. 2024-12-09 17:02:40.262473 80.67% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  178. 2024-12-09 17:02:40.282471 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/46455655400 entering state [completing][200]
  179. 2024-12-09 17:02:40.282471 80.67% [DEBUG] sofia.c:7503 Remote SDP:
  180. v=0                                                                                                                                                                                                                
  181. o=root 954783167 954783167 IN IP4 46.246.2.119                                                                                                                                                                    
  182. s=Asterisk PBX 16.29.0                                                                                                                                                                                            
  183. c=IN IP4 46.246.2.119                                                                                                                                                                                              
  184. t=0 0                                                                                                                                                                                                              
  185. m=audio 14784 RTP/AVP 8 101                                                                                                                                                                                        
  186. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  187. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  188. a=fmtp:101 0-16                                                                                                                                                                                                    
  189. a=maxptime:150                                                                                                                                                                                                    
  190.  
  191. 2024-12-09 17:02:40.282471 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/46455655400 entering state [ready][200]
  192. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:150:64000:1]/[PCMA:8:8000:20:64000:1]
  193. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  194. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
  195. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/46455655400 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  196. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_codec.c:111 sofia/default/46455655400 Original read codec set to PCMA:8
  197. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
  198. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:5856 sofia/default/46455655400 Set 2833 dtmf send payload to 101 recv payload to 101
  199. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/46455655400] 172.232.155.199 port 24410 -> 46.246.2.119 port 14784 codec: 8 ms: 20
  200. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  201. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:8972 sofia/default/46455655400 Set 2833 dtmf send payload to 101
  202. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:8979 sofia/default/46455655400 Set 2833 dtmf receive payload to 101
  203. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_core_media.c:9002 sofia/default/46455655400 Set rtp dtmf delay to 40
  204. 2024-12-09 17:02:40.282471 80.67% [NOTICE] sofia.c:8680 Channel [sofia/default/46455655400] has been answered
  205. 2024-12-09 17:02:40.282471 80.67% [DEBUG] switch_channel.c:3912 (sofia/default/46455655400) Callstate Change RINGING -> ACTIVE
  206. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/+46708516331@62.80.216.236] 172.232.155.199 port 18536 -> 62.80.216.236 port 44664 codec: 8 ms: 20
  207. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  208. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_media.c:8972 sofia/default/+46708516331@62.80.216.236 Set 2833 dtmf send payload to 110
  209. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_media.c:8979 sofia/default/+46708516331@62.80.216.236 Set 2833 dtmf receive payload to 110
  210. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_media.c:9002 sofia/default/+46708516331@62.80.216.236 Set rtp dtmf delay to 40
  211. 2024-12-09 17:02:40.302472 80.67% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/+46708516331@62.80.216.236:
  212. v=0                                                                                                                                                                                                                
  213. o=FreeSWITCH 1733745224 1733745225 IN IP4 172.232.155.199                                                                                                                                                          
  214. s=FreeSWITCH                                                                                                                                                                                                      
  215. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  216. t=0 0                                                                                                                                                                                                              
  217. m=audio 18536 RTP/AVP 8 110                                                                                                                                                                                        
  218. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  219. a=rtpmap:110 telephone-event/8000                                                                                                                                                                                  
  220. a=fmtp:110 0-15                                                                                                                                                                                                    
  221. a=ptime:20                                                                                                                                                                                                        
  222. a=sendrecv                                                                                                                                                                                                        
  223.  
  224. 2024-12-09 17:02:40.302472 80.67% [NOTICE] switch_ivr_originate.c:3851 Channel [sofia/default/+46708516331@62.80.216.236] has been answered
  225. EXECUTE [depth=0] sofia/default/+46708516331@62.80.216.236 sched_hangup(+6000 normal_clearing)
  226. 2024-12-09 17:02:40.302472 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46708516331@62.80.216.236 entering state [completed][200]
  227. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_scheduler.c:263 Added task 39930 switch_ivr_schedule_hangup (3923dfbf-697e-4e6f-9aff-3144ae9390a3) to run at 1733769760
  228. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_channel.c:3912 (sofia/default/+46708516331@62.80.216.236) Callstate Change RINGING -> ACTIVE
  229. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_ivr_originate.c:3909 Originate Resulted in Success: [sofia/default/46455655400] Peer UUID: 6883d05e-f80b-4ecc-a05f-40e38f7b25f7
  230. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_ivr_bridge.c:1791 (sofia/default/46455655400) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  231. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_state_machine.c:581 (sofia/default/46455655400) Running State Change CS_EXCHANGE_MEDIA (Cur 140 Tot 134742)
  232. 2024-12-09 17:02:40.302472 80.67% [DEBUG] switch_core_state_machine.c:650 (sofia/default/46455655400) State EXCHANGE_MEDIA
  233. 2024-12-09 17:02:40.302472 80.67% [DEBUG] mod_sofia.c:672 SOFIA EXCHANGE_MEDIA
  234. 2024-12-09 17:02:40.322469 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46708516331@62.80.216.236 entering state [ready][200]
  235. 2024-12-09 17:02:40.382469 80.67% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  236. 2024-12-09 17:02:40.462463 80.67% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  237. 2024-12-09 17:02:40.662471 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46706217547 entering state [proceeding][180]
  238. 2024-12-09 17:02:40.662471 80.67% [NOTICE] sofia.c:7604 Ring-Ready sofia/default/+46706217547!
  239. 2024-12-09 17:02:40.662471 80.67% [DEBUG] switch_channel.c:3513 (sofia/default/+46706217547) Callstate Change DOWN -> RINGING
  240. 2024-12-09 17:02:40.662471 80.67% [NOTICE] mod_sofia.c:2514 Ring-Ready sofia/default/+46791400926@46.246.2.119!
  241. 2024-12-09 17:02:40.662471 80.67% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400926@46.246.2.119 entering state [early][180]
  242. 2024-12-09 17:02:40.662471 80.67% [NOTICE] switch_ivr_originate.c:568 Ring Ready sofia/default/+46791400926@46.246.2.119!
  243. 2024-12-09 17:02:40.682468 80.67% [WARNING] sofia_reg.c:1842 SIP auth challenge (REGISTER) on sofia profile 'default' for [46455680810.minitel.se@sip.minitel.se] from ip 194.0.227.250
  244. 2024-12-09 17:02:40.702470 80.67% [NOTICE] sofia.c:1065 Hangup sofia/default/+46731218962@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  245. 2024-12-09 17:02:40.702470 80.67% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218962@46.246.2.119]
  246. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218962@46.246.2.119 ending bridge by request from write function
  247. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46732032095]
  248. 2024-12-09 17:02:40.722468 80.00% [NOTICE] switch_ivr_bridge.c:1027 Hangup sofia/default/+46732032095 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  249. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46732032095) State EXCHANGE_MEDIA going to sleep
  250. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46732032095) Running State Change CS_HANGUP (Cur 140 Tot 134742)
  251. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46732032095) Callstate Change ACTIVE -> HANGUP
  252. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46732032095) State HANGUP
  253. 2024-12-09 17:02:40.722468 80.00% [DEBUG] mod_sofia.c:463 sofia/default/+46732032095 Overriding SIP cause 480 with 200 from the other leg
  254. 2024-12-09 17:02:40.722468 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46732032095 hanging up, cause: NORMAL_CLEARING
  255. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46732032095 skip receive message [UNBRIDGE] (channel is hungup already)
  256. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218962@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  257. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218962@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  258. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218962@46.246.2.119) State EXECUTE going to sleep
  259. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_HANGUP (Cur 140 Tot 134742)
  260. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218962@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  261. 2024-12-09 17:02:40.722468 80.00% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46732032095
  262. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP
  263. 2024-12-09 17:02:40.722468 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218962@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  264. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46732032095 Standard HANGUP, cause: NORMAL_CLEARING
  265. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46732032095) State HANGUP going to sleep
  266. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46732032095) State Change CS_HANGUP -> CS_REPORTING
  267. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46732032095) Running State Change CS_REPORTING (Cur 140 Tot 134742)
  268. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46732032095) State REPORTING
  269. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218962@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  270. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP going to sleep
  271. 2024-12-09 17:02:40.722468 80.00% [INFO] mod_json_cdr.c:272 Process [bbcbf181-55c2-415d-8e3f-20e20240a0ae.cdr.json]
  272. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218962@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  273. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_REPORTING (Cur 140 Tot 134742)
  274. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING
  275. 2024-12-09 17:02:40.722468 80.00% [INFO] mod_json_cdr.c:272 Process [f8cfd707-cae9-4550-8f7b-8249388c5fcf.cdr.json]
  276. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46732032095 Standard REPORTING, cause: NORMAL_CLEARING
  277. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46732032095) State REPORTING going to sleep
  278. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46732032095) State Change CS_REPORTING -> CS_DESTROY
  279. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_session.c:1744 Session 134584 (sofia/default/+46732032095) Locked, Waiting on external entities
  280. 2024-12-09 17:02:40.722468 80.00% [NOTICE] switch_core_session.c:1762 Session 134584 (sofia/default/+46732032095) Ended
  281. 2024-12-09 17:02:40.722468 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46732032095 [CS_DESTROY]
  282. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46732032095) Running State Change CS_DESTROY (Cur 139 Tot 134742)
  283. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46732032095) State DESTROY
  284. 2024-12-09 17:02:40.722468 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46732032095 SOFIA DESTROY
  285. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46732032095 Standard DESTROY
  286. 2024-12-09 17:02:40.722468 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46732032095) State DESTROY going to sleep
  287. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218962@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  288. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING going to sleep
  289. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218962@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  290. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_session.c:1744 Session 134583 (sofia/default/+46731218962@46.246.2.119) Locked, Waiting on external entities
  291. 2024-12-09 17:02:40.742465 80.00% [NOTICE] switch_core_session.c:1762 Session 134583 (sofia/default/+46731218962@46.246.2.119) Ended
  292. 2024-12-09 17:02:40.742465 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218962@46.246.2.119 [CS_DESTROY]
  293. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_DESTROY (Cur 138 Tot 134742)
  294. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY
  295. 2024-12-09 17:02:40.742465 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46731218962@46.246.2.119 SOFIA DESTROY
  296. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218962@46.246.2.119 Standard DESTROY
  297. 2024-12-09 17:02:40.742465 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY going to sleep
  298. 2024-12-09 17:02:40.802471 80.00% [DEBUG] switch_scheduler.c:147 Deleting task 39911 switch_ivr_schedule_hangup (f8cfd707-cae9-4550-8f7b-8249388c5fcf)
  299. 2024-12-09 17:02:40.862469 80.00% [WARNING] sofia_reg.c:1842 SIP auth challenge (REGISTER) on sofia profile 'default' for [464293390.minitel.se@sip.minitel.se] from ip 194.0.225.136
  300. 2024-12-09 17:02:41.182470 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46851760489 entering state [completing][200]
  301. 2024-12-09 17:02:41.182470 80.00% [DEBUG] sofia.c:7503 Remote SDP:
  302. v=0                                                                                                                                                                                                                
  303. o=Sonus_UAC 19784 352050 IN IP4 216.155.239.86                                                                                                                                                                    
  304. s=SIP Media Capabilities                                                                                                                                                                                          
  305. c=IN IP4 216.155.239.84                                                                                                                                                                                            
  306. t=0 0                                                                                                                                                                                                              
  307. m=audio 49784 RTP/AVP 8 101                                                                                                                                                                                        
  308. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  309. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  310. a=fmtp:101 0-15                                                                                                                                                                                                    
  311. a=maxptime:20                                                                                                                                                                                                      
  312.  
  313. 2024-12-09 17:02:41.182470 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46851760489 entering state [ready][200]
  314. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  315. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  316. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
  317. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/+46851760489 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  318. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_codec.c:111 sofia/default/+46851760489 Original read codec set to PCMA:8
  319. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
  320. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:5856 sofia/default/+46851760489 Set 2833 dtmf send payload to 101 recv payload to 101
  321. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/+46851760489] 172.232.155.199 port 20678 -> 216.155.239.84 port 49784 codec: 8 ms: 20
  322. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  323. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:8972 sofia/default/+46851760489 Set 2833 dtmf send payload to 101
  324. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:8979 sofia/default/+46851760489 Set 2833 dtmf receive payload to 101
  325. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_core_media.c:9002 sofia/default/+46851760489 Set rtp dtmf delay to 40
  326. 2024-12-09 17:02:41.182470 80.00% [NOTICE] sofia.c:8680 Channel [sofia/default/+46851760489] has been answered
  327. 2024-12-09 17:02:41.182470 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46851760489) Callstate Change RINGING -> ACTIVE
  328. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/+46731218752@46.246.2.119] 172.232.155.199 port 24612 -> 46.246.2.119 port 17488 codec: 8 ms: 20
  329. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  330. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_media.c:8972 sofia/default/+46731218752@46.246.2.119 Set 2833 dtmf send payload to 101
  331. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_media.c:8979 sofia/default/+46731218752@46.246.2.119 Set 2833 dtmf receive payload to 101
  332. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_media.c:9002 sofia/default/+46731218752@46.246.2.119 Set rtp dtmf delay to 40
  333. 2024-12-09 17:02:41.202466 80.00% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/+46731218752@46.246.2.119:
  334. v=0                                                                                                                                                                                                                
  335. o=FreeSWITCH 1733739149 1733739150 IN IP4 172.232.155.199                                                                                                                                                          
  336. s=FreeSWITCH                                                                                                                                                                                                      
  337. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  338. t=0 0                                                                                                                                                                                                              
  339. m=audio 24612 RTP/AVP 8 101                                                                                                                                                                                        
  340. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  341. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  342. a=fmtp:101 0-15                                                                                                                                                                                                    
  343. a=ptime:20                                                                                                                                                                                                        
  344. a=sendrecv                                                                                                                                                                                                        
  345.  
  346. 2024-12-09 17:02:41.202466 80.00% [NOTICE] switch_ivr_originate.c:3851 Channel [sofia/default/+46731218752@46.246.2.119] has been answered
  347. EXECUTE [depth=0] sofia/default/+46731218752@46.246.2.119 sched_hangup(+6000 normal_clearing)
  348. 2024-12-09 17:02:41.202466 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218752@46.246.2.119 entering state [completed][200]
  349. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_scheduler.c:263 Added task 39931 switch_ivr_schedule_hangup (78dbee39-12c5-4b20-89a0-fa1300200f5b) to run at 1733769761
  350. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46731218752@46.246.2.119) Callstate Change RINGING -> ACTIVE
  351. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_ivr_originate.c:3909 Originate Resulted in Success: [sofia/default/+46851760489] Peer UUID: 0661ea4e-8229-4c97-8300-4aac86a5d7d4
  352. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_ivr_bridge.c:1791 (sofia/default/+46851760489) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  353. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46851760489) Running State Change CS_EXCHANGE_MEDIA (Cur 138 Tot 134742)
  354. 2024-12-09 17:02:41.202466 80.00% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46851760489) State EXCHANGE_MEDIA
  355. 2024-12-09 17:02:41.202466 80.00% [DEBUG] mod_sofia.c:672 SOFIA EXCHANGE_MEDIA
  356. 2024-12-09 17:02:41.222468 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218752@46.246.2.119 entering state [ready][200]
  357. 2024-12-09 17:02:41.242475 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  358. 2024-12-09 17:02:41.242475 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  359. 2024-12-09 17:02:41.302465 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400609@46.246.2.119 entering state [terminated][487]
  360. 2024-12-09 17:02:41.302465 80.00% [NOTICE] sofia.c:8735 Hangup sofia/default/+46791400609@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  361. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:825 sofia/default/+46791400609@46.246.2.119 ending bridge by request from read function
  362. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46791400609@46.246.2.119]
  363. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46791400609@46.246.2.119 ending bridge by request from write function
  364. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46739492020]
  365. 2024-12-09 17:02:41.302465 80.00% [NOTICE] switch_ivr_bridge.c:1023 Hangup sofia/default/+46739492020 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  366. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46739492020) State EXCHANGE_MEDIA going to sleep
  367. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46739492020) Running State Change CS_HANGUP (Cur 138 Tot 134742)
  368. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46739492020) Callstate Change RINGING -> HANGUP
  369. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46739492020) State HANGUP
  370. 2024-12-09 17:02:41.302465 80.00% [DEBUG] mod_sofia.c:463 sofia/default/+46739492020 Overriding SIP cause 487 with 487 from the other leg
  371. 2024-12-09 17:02:41.302465 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46739492020 hanging up, cause: ORIGINATOR_CANCEL
  372. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46739492020 skip receive message [UNBRIDGE] (channel is hungup already)
  373. 2024-12-09 17:02:41.302465 80.00% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46739492020
  374. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46739492020 Standard HANGUP, cause: ORIGINATOR_CANCEL
  375. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46739492020) State HANGUP going to sleep
  376. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46739492020) State Change CS_HANGUP -> CS_REPORTING
  377. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46739492020) Running State Change CS_REPORTING (Cur 138 Tot 134742)
  378. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46739492020) State REPORTING
  379. 2024-12-09 17:02:41.302465 80.00% [INFO] mod_json_cdr.c:272 Process [c71be975-7ff8-4843-a46b-2f3968004062.cdr.json]
  380. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46791400609@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  381. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_session.c:2979 sofia/default/+46791400609@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  382. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46791400609@46.246.2.119) State EXECUTE going to sleep
  383. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_HANGUP (Cur 138 Tot 134742)
  384. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46791400609@46.246.2.119) Callstate Change EARLY -> HANGUP
  385. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400609@46.246.2.119) State HANGUP
  386. 2024-12-09 17:02:41.302465 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46791400609@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  387. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46791400609@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  388. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400609@46.246.2.119) State HANGUP going to sleep
  389. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46791400609@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  390. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_REPORTING (Cur 138 Tot 134742)
  391. 2024-12-09 17:02:41.302465 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400609@46.246.2.119) State REPORTING
  392. 2024-12-09 17:02:41.302465 80.00% [INFO] mod_json_cdr.c:272 Process [86a56420-4bea-45aa-8897-558a7b7cd826.cdr.json]
  393. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46739492020 Standard REPORTING, cause: ORIGINATOR_CANCEL
  394. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46739492020) State REPORTING going to sleep
  395. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46739492020) State Change CS_REPORTING -> CS_DESTROY
  396. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_session.c:1744 Session 134606 (sofia/default/+46739492020) Locked, Waiting on external entities
  397. 2024-12-09 17:02:41.322466 80.00% [NOTICE] switch_core_session.c:1762 Session 134606 (sofia/default/+46739492020) Ended
  398. 2024-12-09 17:02:41.322466 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46739492020 [CS_DESTROY]
  399. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46739492020) Running State Change CS_DESTROY (Cur 137 Tot 134742)
  400. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46739492020) State DESTROY
  401. 2024-12-09 17:02:41.322466 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46739492020 SOFIA DESTROY
  402. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46739492020 Standard DESTROY
  403. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46739492020) State DESTROY going to sleep
  404. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46791400609@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  405. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400609@46.246.2.119) State REPORTING going to sleep
  406. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46791400609@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  407. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_session.c:1744 Session 134605 (sofia/default/+46791400609@46.246.2.119) Locked, Waiting on external entities
  408. 2024-12-09 17:02:41.322466 80.00% [NOTICE] switch_core_session.c:1762 Session 134605 (sofia/default/+46791400609@46.246.2.119) Ended
  409. 2024-12-09 17:02:41.322466 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46791400609@46.246.2.119 [CS_DESTROY]
  410. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_DESTROY (Cur 136 Tot 134742)
  411. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400609@46.246.2.119) State DESTROY
  412. 2024-12-09 17:02:41.322466 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46791400609@46.246.2.119 SOFIA DESTROY
  413. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46791400609@46.246.2.119 Standard DESTROY
  414. 2024-12-09 17:02:41.322466 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400609@46.246.2.119) State DESTROY going to sleep
  415. 2024-12-09 17:02:41.322466 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46707688734 entering state [completing][200]
  416. 2024-12-09 17:02:41.322466 80.00% [DEBUG] sofia.c:7500 Duplicate SDP
  417. v=0                                                                                                                                                                                                                
  418. o=Sonus_UAC 551164 909405 IN IP4 216.155.239.86                                                                                                                                                                    
  419. s=SIP Media Capabilities                                                                                                                                                                                          
  420. c=IN IP4 216.155.239.84                                                                                                                                                                                            
  421. t=0 0                                                                                                                                                                                                              
  422. m=audio 49534 RTP/AVP 8 101                                                                                                                                                                                        
  423. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  424. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  425. a=fmtp:101 0-15                                                                                                                                                                                                    
  426. a=maxptime:20                                                                                                                                                                                                      
  427.  
  428. 2024-12-09 17:02:41.342470 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46707688734 entering state [ready][200]
  429. 2024-12-09 17:02:41.342470 80.00% [NOTICE] sofia.c:8622 Channel [sofia/default/+46707688734] has been answered
  430. 2024-12-09 17:02:41.342470 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46707688734) Callstate Change RINGING -> ACTIVE
  431. 2024-12-09 17:02:41.362470 80.00% [DEBUG] switch_core_media.c:8641 Audio params are unchanged for sofia/default/+46731218962@46.246.2.119.
  432. 2024-12-09 17:02:41.362470 80.00% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/+46731218962@46.246.2.119:
  433. v=0                                                                                                                                                                                                                
  434. o=FreeSWITCH 1733745807 1733745809 IN IP4 172.232.155.199                                                                                                                                                          
  435. s=FreeSWITCH                                                                                                                                                                                                      
  436. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  437. t=0 0                                                                                                                                                                                                              
  438. m=audio 17944 RTP/AVP 8 101                                                                                                                                                                                        
  439. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  440. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  441. a=fmtp:101 0-15                                                                                                                                                                                                    
  442. a=ptime:20                                                                                                                                                                                                        
  443. a=sendrecv                                                                                                                                                                                                        
  444.  
  445. 2024-12-09 17:02:41.362470 80.00% [NOTICE] switch_ivr_bridge.c:730 Channel [sofia/default/+46731218962@46.246.2.119] has been answered
  446. EXECUTE [depth=0] sofia/default/+46731218962@46.246.2.119 sched_hangup(+6000 normal_clearing)
  447. 2024-12-09 17:02:41.362470 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [completed][200]
  448. 2024-12-09 17:02:41.362470 80.00% [DEBUG] switch_scheduler.c:263 Added task 39932 switch_ivr_schedule_hangup (62e2f76d-5343-4065-8d46-ab3912b5376c) to run at 1733769761
  449. 2024-12-09 17:02:41.362470 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46731218962@46.246.2.119) Callstate Change EARLY -> ACTIVE
  450. 2024-12-09 17:02:41.382470 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [ready][200]
  451. 2024-12-09 17:02:41.402465 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  452. 2024-12-09 17:02:41.422470 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  453. 2024-12-09 17:02:41.442471 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+4686922557@46.246.2.119 entering state [terminated][487]
  454. 2024-12-09 17:02:41.442471 80.00% [NOTICE] sofia.c:8735 Hangup sofia/default/+4686922557@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  455. 2024-12-09 17:02:41.462469 80.00% [NOTICE] switch_ivr_originate.c:3816 Hangup sofia/default/+46734066142 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  456. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_ivr_originate.c:4041 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  457. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46734066142) Running State Change CS_HANGUP (Cur 136 Tot 134742)
  458. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46734066142) Callstate Change RINGING -> HANGUP
  459. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46734066142) State HANGUP
  460. 2024-12-09 17:02:41.462469 80.00% [DEBUG] mod_sofia.c:463 sofia/default/+46734066142 Overriding SIP cause 487 with 487 from the other leg
  461. 2024-12-09 17:02:41.462469 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46734066142 hanging up, cause: ORIGINATOR_CANCEL
  462. 2024-12-09 17:02:41.462469 80.00% [INFO] mod_dptools.c:3635 Originate Failed.  Cause: ORIGINATOR_CANCEL
  463. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_session.c:2979 sofia/default/+4686922557@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  464. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+4686922557@46.246.2.119) State EXECUTE going to sleep
  465. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+4686922557@46.246.2.119) Running State Change CS_HANGUP (Cur 136 Tot 134742)
  466. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+4686922557@46.246.2.119) Callstate Change RINGING -> HANGUP
  467. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+4686922557@46.246.2.119) State HANGUP
  468. 2024-12-09 17:02:41.462469 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+4686922557@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  469. 2024-12-09 17:02:41.462469 80.00% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46734066142
  470. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46734066142 Standard HANGUP, cause: ORIGINATOR_CANCEL
  471. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46734066142) State HANGUP going to sleep
  472. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46734066142) State Change CS_HANGUP -> CS_REPORTING
  473. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46734066142) Running State Change CS_REPORTING (Cur 136 Tot 134742)
  474. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46734066142) State REPORTING
  475. 2024-12-09 17:02:41.462469 80.00% [INFO] mod_json_cdr.c:272 Process [2d024302-e877-4097-b800-01cd084bb473.cdr.json]
  476. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+4686922557@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  477. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+4686922557@46.246.2.119) State HANGUP going to sleep
  478. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+4686922557@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  479. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+4686922557@46.246.2.119) Running State Change CS_REPORTING (Cur 136 Tot 134742)
  480. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+4686922557@46.246.2.119) State REPORTING
  481. 2024-12-09 17:02:41.462469 80.00% [INFO] mod_json_cdr.c:272 Process [07dcec95-49e8-42b1-af13-63c4e0503b66.cdr.json]
  482. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46734066142 Standard REPORTING, cause: ORIGINATOR_CANCEL
  483. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46734066142) State REPORTING going to sleep
  484. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46734066142) State Change CS_REPORTING -> CS_DESTROY
  485. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_session.c:1744 Session 134578 (sofia/default/+46734066142) Locked, Waiting on external entities
  486. 2024-12-09 17:02:41.462469 80.00% [NOTICE] switch_core_session.c:1762 Session 134578 (sofia/default/+46734066142) Ended
  487. 2024-12-09 17:02:41.462469 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46734066142 [CS_DESTROY]
  488. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46734066142) Running State Change CS_DESTROY (Cur 135 Tot 134742)
  489. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46734066142) State DESTROY
  490. 2024-12-09 17:02:41.462469 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46734066142 SOFIA DESTROY
  491. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46734066142 Standard DESTROY
  492. 2024-12-09 17:02:41.462469 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46734066142) State DESTROY going to sleep
  493. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+4686922557@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  494. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+4686922557@46.246.2.119) State REPORTING going to sleep
  495. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+4686922557@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  496. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_session.c:1744 Session 134577 (sofia/default/+4686922557@46.246.2.119) Locked, Waiting on external entities
  497. 2024-12-09 17:02:41.482469 80.00% [NOTICE] switch_core_session.c:1762 Session 134577 (sofia/default/+4686922557@46.246.2.119) Ended
  498. 2024-12-09 17:02:41.482469 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+4686922557@46.246.2.119 [CS_DESTROY]
  499. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+4686922557@46.246.2.119) Running State Change CS_DESTROY (Cur 134 Tot 134742)
  500. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+4686922557@46.246.2.119) State DESTROY
  501. 2024-12-09 17:02:41.482469 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+4686922557@46.246.2.119 SOFIA DESTROY
  502. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+4686922557@46.246.2.119 Standard DESTROY
  503. 2024-12-09 17:02:41.482469 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+4686922557@46.246.2.119) State DESTROY going to sleep
  504. 2024-12-09 17:02:41.582464 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  505. 2024-12-09 17:02:41.602485 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46703585379 entering state [completing][200]
  506. 2024-12-09 17:02:41.602485 80.00% [DEBUG] sofia.c:7500 Duplicate SDP
  507. v=0                                                                                                                                                                                                                
  508. o=Sonus_UAC 157110 692637 IN IP4 216.155.239.86                                                                                                                                                                    
  509. s=SIP Media Capabilities                                                                                                                                                                                          
  510. c=IN IP4 216.155.239.84                                                                                                                                                                                            
  511. t=0 0                                                                                                                                                                                                              
  512. m=audio 52182 RTP/AVP 8 101                                                                                                                                                                                        
  513. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  514. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  515. a=fmtp:101 0-15                                                                                                                                                                                                    
  516. a=maxptime:20                                                                                                                                                                                                      
  517.  
  518. 2024-12-09 17:02:41.602485 80.00% [NOTICE] sofia.c:1065 Hangup sofia/default/+46730822965 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  519. 2024-12-09 17:02:41.602485 80.00% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46730822965]
  520. 2024-12-09 17:02:41.602485 80.00% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46730822965) State EXCHANGE_MEDIA going to sleep
  521. 2024-12-09 17:02:41.602485 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46730822965) Running State Change CS_HANGUP (Cur 134 Tot 134742)
  522. 2024-12-09 17:02:41.602485 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46730822965) Callstate Change ACTIVE -> HANGUP
  523. 2024-12-09 17:02:41.602485 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46730822965) State HANGUP
  524. 2024-12-09 17:02:41.602485 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46730822965 hanging up, cause: NORMAL_CLEARING
  525. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46730822965 Standard HANGUP, cause: NORMAL_CLEARING
  526. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46730822965) State HANGUP going to sleep
  527. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46730822965) State Change CS_HANGUP -> CS_REPORTING
  528. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46730822965) Running State Change CS_REPORTING (Cur 134 Tot 134742)
  529. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46730822965) State REPORTING
  530. 2024-12-09 17:02:41.622474 80.00% [INFO] mod_json_cdr.c:272 Process [240b2f4e-f2a5-4ac8-82dd-f69b4a87c1dc.cdr.json]
  531. 2024-12-09 17:02:41.622474 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46703585379 entering state [ready][200]
  532. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  533. 2024-12-09 17:02:41.622474 80.00% [NOTICE] sofia.c:8622 Channel [sofia/default/+46703585379] has been answered
  534. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46703585379) Callstate Change RINGING -> ACTIVE
  535. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46730822965 Standard REPORTING, cause: NORMAL_CLEARING
  536. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46730822965) State REPORTING going to sleep
  537. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46730822965) State Change CS_REPORTING -> CS_DESTROY
  538. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_session.c:1744 Session 134182 (sofia/default/+46730822965) Locked, Waiting on external entities
  539. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46730822965 ending bridge by request from write function
  540. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46910217808@46.246.2.119]
  541. 2024-12-09 17:02:41.622474 80.00% [NOTICE] switch_ivr_bridge.c:1942 Hangup sofia/default/+46910217808@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  542. 2024-12-09 17:02:41.622474 80.00% [NOTICE] switch_core_session.c:1762 Session 134182 (sofia/default/+46730822965) Ended
  543. 2024-12-09 17:02:41.622474 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46730822965 [CS_DESTROY]
  544. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_session.c:2979 sofia/default/+46910217808@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  545. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46910217808@46.246.2.119) State EXECUTE going to sleep
  546. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46910217808@46.246.2.119) Running State Change CS_HANGUP (Cur 133 Tot 134742)
  547. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46730822965) Running State Change CS_DESTROY (Cur 133 Tot 134742)
  548. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46730822965) State DESTROY
  549. 2024-12-09 17:02:41.622474 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46730822965 SOFIA DESTROY
  550. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46910217808@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  551. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46730822965 Standard DESTROY
  552. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46730822965) State DESTROY going to sleep
  553. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46910217808@46.246.2.119) State HANGUP
  554. 2024-12-09 17:02:41.622474 80.00% [DEBUG] mod_sofia.c:463 sofia/default/+46910217808@46.246.2.119 Overriding SIP cause 480 with 200 from the other leg
  555. 2024-12-09 17:02:41.622474 80.00% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46910217808@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  556. 2024-12-09 17:02:41.622474 80.00% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46910217808@46.246.2.119
  557. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46910217808@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  558. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46910217808@46.246.2.119) State HANGUP going to sleep
  559. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46910217808@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  560. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46910217808@46.246.2.119) Running State Change CS_REPORTING (Cur 133 Tot 134742)
  561. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46910217808@46.246.2.119) State REPORTING
  562. 2024-12-09 17:02:41.622474 80.00% [DEBUG] switch_core_media.c:8641 Audio params are unchanged for sofia/default/+46731218752@46.246.2.119.
  563. 2024-12-09 17:02:41.622474 80.00% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/+46731218752@46.246.2.119:
  564. v=0                                                                                                                                                                                                                
  565. o=FreeSWITCH 1733734601 1733734603 IN IP4 172.232.155.199                                                                                                                                                          
  566. s=FreeSWITCH                                                                                                                                                                                                      
  567. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  568. t=0 0                                                                                                                                                                                                              
  569. m=audio 29154 RTP/AVP 8 101                                                                                                                                                                                        
  570. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  571. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  572. a=fmtp:101 0-15                                                                                                                                                                                                    
  573. a=ptime:20                                                                                                                                                                                                        
  574. a=sendrecv                                                                                                                                                                                                        
  575.  
  576. 2024-12-09 17:02:41.622474 80.00% [NOTICE] switch_ivr_bridge.c:730 Channel [sofia/default/+46731218752@46.246.2.119] has been answered
  577. 2024-12-09 17:02:41.642481 80.00% [INFO] mod_json_cdr.c:272 Process [adf0f2b6-b251-414b-b22b-444ac2dda96f.cdr.json]
  578. EXECUTE [depth=0] sofia/default/+46731218752@46.246.2.119 sched_hangup(+6000 normal_clearing)
  579. 2024-12-09 17:02:41.642481 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218752@46.246.2.119 entering state [completed][200]
  580. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_scheduler.c:263 Added task 39933 switch_ivr_schedule_hangup (439fe0fa-04d0-40e6-a38f-e834e4b07690) to run at 1733769761
  581. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_channel.c:3912 (sofia/default/+46731218752@46.246.2.119) Callstate Change EARLY -> ACTIVE
  582. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46910217808@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  583. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46910217808@46.246.2.119) State REPORTING going to sleep
  584. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46910217808@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  585. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_session.c:1744 Session 134181 (sofia/default/+46910217808@46.246.2.119) Locked, Waiting on external entities
  586. 2024-12-09 17:02:41.642481 80.00% [NOTICE] switch_core_session.c:1762 Session 134181 (sofia/default/+46910217808@46.246.2.119) Ended
  587. 2024-12-09 17:02:41.642481 80.00% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46910217808@46.246.2.119 [CS_DESTROY]
  588. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46910217808@46.246.2.119) Running State Change CS_DESTROY (Cur 132 Tot 134742)
  589. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46910217808@46.246.2.119) State DESTROY
  590. 2024-12-09 17:02:41.642481 80.00% [DEBUG] mod_sofia.c:380 sofia/default/+46910217808@46.246.2.119 SOFIA DESTROY
  591. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46910217808@46.246.2.119 Standard DESTROY
  592. 2024-12-09 17:02:41.642481 80.00% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46910217808@46.246.2.119) State DESTROY going to sleep
  593. 2024-12-09 17:02:41.642481 80.00% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218752@46.246.2.119 entering state [ready][200]
  594. 2024-12-09 17:02:41.682482 80.00% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  595. 2024-12-09 17:02:42.022471 79.90% [NOTICE] sofia.c:1065 Hangup sofia/default/+46731218962@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  596. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218962@46.246.2.119]
  597. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218962@46.246.2.119 ending bridge by request from write function
  598. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46761899251]
  599. 2024-12-09 17:02:42.022471 79.90% [NOTICE] switch_ivr_bridge.c:1027 Hangup sofia/default/+46761899251 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  600. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46761899251) State EXCHANGE_MEDIA going to sleep
  601. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46761899251) Running State Change CS_HANGUP (Cur 132 Tot 134742)
  602. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46761899251 skip receive message [UNBRIDGE] (channel is hungup already)
  603. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218962@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  604. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46761899251) Callstate Change ACTIVE -> HANGUP
  605. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218962@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  606. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46761899251) State HANGUP
  607. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218962@46.246.2.119) State EXECUTE going to sleep
  608. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_HANGUP (Cur 132 Tot 134742)
  609. 2024-12-09 17:02:42.022471 79.90% [DEBUG] mod_sofia.c:463 sofia/default/+46761899251 Overriding SIP cause 480 with 200 from the other leg
  610. 2024-12-09 17:02:42.022471 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46761899251 hanging up, cause: NORMAL_CLEARING
  611. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218962@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  612. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP
  613. 2024-12-09 17:02:42.022471 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218962@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  614. 2024-12-09 17:02:42.022471 79.90% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46761899251
  615. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46761899251 Standard HANGUP, cause: NORMAL_CLEARING
  616. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46761899251) State HANGUP going to sleep
  617. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46761899251) State Change CS_HANGUP -> CS_REPORTING
  618. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46761899251) Running State Change CS_REPORTING (Cur 132 Tot 134742)
  619. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46761899251) State REPORTING
  620. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218962@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  621. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP going to sleep
  622. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218962@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  623. 2024-12-09 17:02:42.022471 79.90% [INFO] mod_json_cdr.c:272 Process [2a75b9dd-9257-4a42-8bc7-cc736dfa5c54.cdr.json]
  624. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_REPORTING (Cur 132 Tot 134742)
  625. 2024-12-09 17:02:42.022471 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING
  626. 2024-12-09 17:02:42.022471 79.90% [INFO] mod_json_cdr.c:272 Process [c40c546e-8990-4143-bdaa-207e59e1c06c.cdr.json]
  627. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46761899251 Standard REPORTING, cause: NORMAL_CLEARING
  628. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46761899251) State REPORTING going to sleep
  629. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46761899251) State Change CS_REPORTING -> CS_DESTROY
  630. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_session.c:1744 Session 134649 (sofia/default/+46761899251) Locked, Waiting on external entities
  631. 2024-12-09 17:02:42.042489 79.90% [NOTICE] switch_core_session.c:1762 Session 134649 (sofia/default/+46761899251) Ended
  632. 2024-12-09 17:02:42.042489 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46761899251 [CS_DESTROY]
  633. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46761899251) Running State Change CS_DESTROY (Cur 131 Tot 134742)
  634. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46761899251) State DESTROY
  635. 2024-12-09 17:02:42.042489 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46761899251 SOFIA DESTROY
  636. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46761899251 Standard DESTROY
  637. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46761899251) State DESTROY going to sleep
  638. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218962@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  639. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING going to sleep
  640. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218962@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  641. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_session.c:1744 Session 134648 (sofia/default/+46731218962@46.246.2.119) Locked, Waiting on external entities
  642. 2024-12-09 17:02:42.042489 79.90% [NOTICE] switch_core_session.c:1762 Session 134648 (sofia/default/+46731218962@46.246.2.119) Ended
  643. 2024-12-09 17:02:42.042489 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218962@46.246.2.119 [CS_DESTROY]
  644. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_DESTROY (Cur 130 Tot 134742)
  645. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY
  646. 2024-12-09 17:02:42.042489 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46731218962@46.246.2.119 SOFIA DESTROY
  647. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218962@46.246.2.119 Standard DESTROY
  648. 2024-12-09 17:02:42.042489 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY going to sleep
  649. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_scheduler.c:147 Deleting task 39842 switch_ivr_schedule_hangup (adf0f2b6-b251-414b-b22b-444ac2dda96f)
  650. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_scheduler.c:147 Deleting task 39921 switch_ivr_schedule_hangup (c40c546e-8990-4143-bdaa-207e59e1c06c)
  651. 2024-12-09 17:02:42.142466 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46704399539 entering state [proceeding][183]
  652. 2024-12-09 17:02:42.142466 79.90% [DEBUG] sofia.c:7503 Remote SDP:
  653. v=0                                                                                                                                                                                                                
  654. o=Sonus_UAC 262779 609918 IN IP4 216.155.239.86                                                                                                                                                                    
  655. s=SIP Media Capabilities                                                                                                                                                                                          
  656. c=IN IP4 216.155.239.84                                                                                                                                                                                            
  657. t=0 0                                                                                                                                                                                                              
  658. m=audio 58622 RTP/AVP 8 101                                                                                                                                                                                        
  659. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  660. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  661. a=fmtp:101 0-15                                                                                                                                                                                                    
  662. a=maxptime:20                                                                                                                                                                                                      
  663.  
  664. 2024-12-09 17:02:42.142466 79.90% [NOTICE] sofia.c:7506 Pre-Answer sofia/default/+46704399539!
  665. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_channel.c:3585 (sofia/default/+46704399539) Callstate Change DOWN -> EARLY
  666. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  667. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  668. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
  669. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/+46704399539 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  670. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_codec.c:111 sofia/default/+46704399539 Original read codec set to PCMA:8
  671. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
  672. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:5856 sofia/default/+46704399539 Set 2833 dtmf send payload to 101 recv payload to 101
  673. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/+46704399539] 172.232.155.199 port 28804 -> 216.155.239.84 port 58622 codec: 8 ms: 20
  674. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  675. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8972 sofia/default/+46704399539 Set 2833 dtmf send payload to 101
  676. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8979 sofia/default/+46704399539 Set 2833 dtmf receive payload to 101
  677. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:9002 sofia/default/+46704399539 Set rtp dtmf delay to 40
  678. 2024-12-09 17:02:42.142466 79.90% [INFO] switch_ivr_originate.c:3858 Sending early media
  679. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/+46791400478@46.246.2.119] 172.232.155.199 port 24850 -> 46.246.2.119 port 12284 codec: 8 ms: 20
  680. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  681. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8972 sofia/default/+46791400478@46.246.2.119 Set 2833 dtmf send payload to 101
  682. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:8979 sofia/default/+46791400478@46.246.2.119 Set 2833 dtmf receive payload to 101
  683. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_media.c:9002 sofia/default/+46791400478@46.246.2.119 Set rtp dtmf delay to 40
  684. 2024-12-09 17:02:42.142466 79.90% [DEBUG] mod_sofia.c:2607 Ring SDP:
  685. v=0                                                                                                                                                                                                                
  686. o=FreeSWITCH 1733738912 1733738913 IN IP4 172.232.155.199                                                                                                                                                          
  687. s=FreeSWITCH                                                                                                                                                                                                      
  688. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  689. t=0 0                                                                                                                                                                                                              
  690. m=audio 24850 RTP/AVP 8 101                                                                                                                                                                                        
  691. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  692. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  693. a=fmtp:101 0-15                                                                                                                                                                                                    
  694. a=ptime:20                                                                                                                                                                                                        
  695. a=sendrecv                                                                                                                                                                                                        
  696.  
  697. 2024-12-09 17:02:42.142466 79.90% [NOTICE] mod_sofia.c:2610 Pre-Answer sofia/default/+46791400478@46.246.2.119!
  698. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_channel.c:3585 (sofia/default/+46791400478@46.246.2.119) Callstate Change RINGING -> EARLY
  699. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_ivr_originate.c:3909 Originate Resulted in Success: [sofia/default/+46704399539] Peer UUID: b75bf056-3d39-4333-aa4f-48e0312e59e8
  700. 2024-12-09 17:02:42.142466 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400478@46.246.2.119 entering state [early][183]
  701. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_ivr_bridge.c:1791 (sofia/default/+46704399539) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  702. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46704399539) Running State Change CS_EXCHANGE_MEDIA (Cur 130 Tot 134742)
  703. 2024-12-09 17:02:42.142466 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46704399539) State EXCHANGE_MEDIA
  704. 2024-12-09 17:02:42.142466 79.90% [DEBUG] mod_sofia.c:672 SOFIA EXCHANGE_MEDIA
  705. 2024-12-09 17:02:42.142466 79.90% [NOTICE] sofia.c:1065 Hangup sofia/default/+46731218752@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  706. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218752@46.246.2.119]
  707. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218752@46.246.2.119 ending bridge by request from write function
  708. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46703414795]
  709. 2024-12-09 17:02:42.162488 79.90% [NOTICE] switch_ivr_bridge.c:1027 Hangup sofia/default/+46703414795 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  710. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46703414795) State EXCHANGE_MEDIA going to sleep
  711. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46703414795) Running State Change CS_HANGUP (Cur 130 Tot 134742)
  712. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46703414795) Callstate Change ACTIVE -> HANGUP
  713. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46703414795) State HANGUP
  714. 2024-12-09 17:02:42.162488 79.90% [DEBUG] mod_sofia.c:463 sofia/default/+46703414795 Overriding SIP cause 480 with 200 from the other leg
  715. 2024-12-09 17:02:42.162488 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46703414795 hanging up, cause: NORMAL_CLEARING
  716. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46703414795 skip receive message [UNBRIDGE] (channel is hungup already)
  717. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218752@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  718. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218752@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  719. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218752@46.246.2.119) State EXECUTE going to sleep
  720. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218752@46.246.2.119) Running State Change CS_HANGUP (Cur 130 Tot 134742)
  721. 2024-12-09 17:02:42.162488 79.90% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46703414795
  722. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46703414795 Standard HANGUP, cause: NORMAL_CLEARING
  723. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46703414795) State HANGUP going to sleep
  724. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218752@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  725. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46703414795) State Change CS_HANGUP -> CS_REPORTING
  726. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218752@46.246.2.119) State HANGUP
  727. 2024-12-09 17:02:42.162488 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218752@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  728. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46703414795) Running State Change CS_REPORTING (Cur 130 Tot 134742)
  729. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46703414795) State REPORTING
  730. 2024-12-09 17:02:42.162488 79.90% [INFO] mod_json_cdr.c:272 Process [bee2b664-4cfb-4641-a10e-c85e8c0e0e36.cdr.json]
  731. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218752@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  732. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218752@46.246.2.119) State HANGUP going to sleep
  733. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218752@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  734. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218752@46.246.2.119) Running State Change CS_REPORTING (Cur 130 Tot 134742)
  735. 2024-12-09 17:02:42.162488 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218752@46.246.2.119) State REPORTING
  736. 2024-12-09 17:02:42.162488 79.90% [INFO] mod_json_cdr.c:272 Process [a5237b0d-aa69-4930-9e12-6359cdf8882d.cdr.json]
  737. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46703414795 Standard REPORTING, cause: NORMAL_CLEARING
  738. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46703414795) State REPORTING going to sleep
  739. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46703414795) State Change CS_REPORTING -> CS_DESTROY
  740. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_session.c:1744 Session 134588 (sofia/default/+46703414795) Locked, Waiting on external entities
  741. 2024-12-09 17:02:42.182474 79.90% [NOTICE] switch_core_session.c:1762 Session 134588 (sofia/default/+46703414795) Ended
  742. 2024-12-09 17:02:42.182474 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46703414795 [CS_DESTROY]
  743. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46703414795) Running State Change CS_DESTROY (Cur 129 Tot 134742)
  744. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46703414795) State DESTROY
  745. 2024-12-09 17:02:42.182474 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46703414795 SOFIA DESTROY
  746. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46703414795 Standard DESTROY
  747. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46703414795) State DESTROY going to sleep
  748. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218752@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  749. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218752@46.246.2.119) State REPORTING going to sleep
  750. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218752@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  751. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_session.c:1744 Session 134586 (sofia/default/+46731218752@46.246.2.119) Locked, Waiting on external entities
  752. 2024-12-09 17:02:42.182474 79.90% [NOTICE] switch_core_session.c:1762 Session 134586 (sofia/default/+46731218752@46.246.2.119) Ended
  753. 2024-12-09 17:02:42.182474 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218752@46.246.2.119 [CS_DESTROY]
  754. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218752@46.246.2.119) Running State Change CS_DESTROY (Cur 128 Tot 134742)
  755. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218752@46.246.2.119) State DESTROY
  756. 2024-12-09 17:02:42.182474 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46731218752@46.246.2.119 SOFIA DESTROY
  757. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218752@46.246.2.119 Standard DESTROY
  758. 2024-12-09 17:02:42.182474 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218752@46.246.2.119) State DESTROY going to sleep
  759. 2024-12-09 17:02:42.202475 79.90% [NOTICE] switch_channel.c:1142 New Channel sofia/default/+46791400609@46.246.2.119 [1fed5909-9aef-4363-a611-69c6494936f2]
  760. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_NEW (Cur 129 Tot 134743)
  761. 2024-12-09 17:02:42.202475 79.90% [INFO] sofia.c:10459 sofia/default/+46791400609@46.246.2.119 receiving invite from 46.246.2.119:5060 version: 1.10.10-release  64bit call-id: 0cf5daee77085186337224b64e0e6ac9@46.246.2.119:5060                                                                                                                                                                                                    
  762. 2024-12-09 17:02:42.202475 79.90% [DEBUG] sofia.c:10553 verifying acl "default" for ip/port 46.246.2.119:0.
  763. 2024-12-09 17:02:42.202475 79.90% [DEBUG] sofia.c:10582 IP 46.246.2.119 Approved by acl "default[]". Access Granted.
  764. 2024-12-09 17:02:42.202475 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400609@46.246.2.119 entering state [received][100]
  765. 2024-12-09 17:02:42.202475 79.90% [DEBUG] sofia.c:7503 Remote SDP:
  766. v=0                                                                                                                                                                                                                
  767. o=root 427258605 427258605 IN IP4 46.246.2.119                                                                                                                                                                    
  768. s=Asterisk PBX 16.29.0                                                                                                                                                                                            
  769. c=IN IP4 46.246.2.119                                                                                                                                                                                              
  770. t=0 0                                                                                                                                                                                                              
  771. m=audio 62010 RTP/AVP 8 0 3 111 112 5 10 122 118 123 124 125 126 127 96 7 110 117 119 97 9 101                                                                                                                    
  772. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  773. a=rtpmap:0 PCMU/8000                                                                                                                                                                                              
  774. a=rtpmap:3 GSM/8000                                                                                                                                                                                                
  775. a=rtpmap:111 G726-32/8000                                                                                                                                                                                          
  776. a=rtpmap:112 AAL2-G726-32/8000                                                                                                                                                                                    
  777. a=rtpmap:5 DVI4/8000                                                                                                                                                                                              
  778. a=rtpmap:10 L16/8000                                                                                                                                                                                              
  779. a=rtpmap:122 L16/12000                                                                                                                                                                                            
  780. a=rtpmap:118 L16/16000                                                                                                                                                                                            
  781. a=rtpmap:123 L16/24000                                                                                                                                                                                            
  782. a=rtpmap:124 L16/32000                                                                                                                                                                                            
  783. a=rtpmap:125 L16/44000                                                                                                                                                                                            
  784. a=rtpmap:126 L16/48000                                                                                                                                                                                            
  785. a=rtpmap:127 L16/96000                                                                                                                                                                                            
  786. a=rtpmap:96 L16/192000                                                                                                                                                                                            
  787. a=rtpmap:7 LPC/8000                                                                                                                                                                                                
  788. a=rtpmap:110 speex/8000                                                                                                                                                                                            
  789. a=rtpmap:117 speex/16000                                                                                                                                                                                          
  790. a=rtpmap:119 speex/32000                                                                                                                                                                                          
  791. a=rtpmap:97 iLBC/8000                                                                                                                                                                                              
  792. a=fmtp:97 mode=20                                                                                                                                                                                                  
  793. a=rtpmap:9 G722/8000                                                                                                                                                                                              
  794. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  795. a=fmtp:101 0-16                                                                                                                                                                                                    
  796. a=maxptime:20                                                                                                                                                                                                      
  797.  
  798. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  799. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  800. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  801. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  802. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  803. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  804. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  805. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  806. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G726-32:111:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  807. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G726-32:111:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  808. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [AAL2-G726-32:112:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  809. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [AAL2-G726-32:112:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  810. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [DVI4:5:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  811. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [DVI4:5:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  812. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:10:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  813. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:10:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  814. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:122:12000:20:0:1]/[PCMA:8:8000:20:64000:1]
  815. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:122:12000:20:0:1]/[PCMU:0:8000:20:64000:1]
  816. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:118:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
  817. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:118:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
  818. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:123:24000:20:0:1]/[PCMA:8:8000:20:64000:1]
  819. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:123:24000:20:0:1]/[PCMU:0:8000:20:64000:1]
  820. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:124:32000:20:0:1]/[PCMA:8:8000:20:64000:1]
  821. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:124:32000:20:0:1]/[PCMU:0:8000:20:64000:1]
  822. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:125:44000:20:0:1]/[PCMA:8:8000:20:64000:1]
  823. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:125:44000:20:0:1]/[PCMU:0:8000:20:64000:1]
  824. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:126:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
  825. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:126:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
  826. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:127:96000:20:0:1]/[PCMA:8:8000:20:64000:1]
  827. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:127:96000:20:0:1]/[PCMU:0:8000:20:64000:1]
  828. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:96:192000:20:0:1]/[PCMA:8:8000:20:64000:1]
  829. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [L16:96:192000:20:0:1]/[PCMU:0:8000:20:64000:1]
  830. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [LPC:7:8000:20:2400:1]/[PCMA:8:8000:20:64000:1]
  831. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [LPC:7:8000:20:2400:1]/[PCMU:0:8000:20:64000:1]
  832. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  833. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  834. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:117:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
  835. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:117:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
  836. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:119:32000:20:0:1]/[PCMA:8:8000:20:64000:1]
  837. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:119:32000:20:0:1]/[PCMU:0:8000:20:64000:1]
  838. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  839. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  840. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  841. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  842. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
  843. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/+46791400609@46.246.2.119 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  844. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_codec.c:111 sofia/default/+46791400609@46.246.2.119 Original read codec set to PCMA:8
  845. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
  846. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_media.c:5856 sofia/default/+46791400609@46.246.2.119 Set 2833 dtmf send payload to 101 recv payload to 101
  847. 2024-12-09 17:02:42.202475 79.90% [DEBUG] sofia.c:7927 (sofia/default/+46791400609@46.246.2.119) State Change CS_NEW -> CS_INIT
  848. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:600 (sofia/default/+46791400609@46.246.2.119) State NEW
  849. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_INIT (Cur 129 Tot 134743)
  850. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/+46791400609@46.246.2.119) State INIT
  851. 2024-12-09 17:02:42.202475 79.90% [DEBUG] mod_sofia.c:97 sofia/default/+46791400609@46.246.2.119 SOFIA INIT
  852. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:40 sofia/default/+46791400609@46.246.2.119 Standard INIT
  853. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:48 (sofia/default/+46791400609@46.246.2.119) State Change CS_INIT -> CS_ROUTING
  854. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/+46791400609@46.246.2.119) State INIT going to sleep
  855. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_ROUTING (Cur 129 Tot 134743)
  856. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_channel.c:2399 (sofia/default/+46791400609@46.246.2.119) Callstate Change DOWN -> RINGING
  857. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/+46791400609@46.246.2.119) State ROUTING
  858. 2024-12-09 17:02:42.202475 79.90% [DEBUG] mod_sofia.c:158 sofia/default/+46791400609@46.246.2.119 SOFIA ROUTING
  859. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_core_state_machine.c:230 sofia/default/+46791400609@46.246.2.119 Standard ROUTING
  860. 2024-12-09 17:02:42.202475 79.90% [INFO] mod_dialplan_xml.c:639 Processing +46791400609 <+46791400609>->+46760182569 in context default
  861. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] CACHE FAIL
  862. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  863. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','international_prefixes','interconnect_code','vanity_number')                                                                                                                                                                                
  864. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  865. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : +46760182569
  866. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '+46760182569' AND status=0 limit 1
  867. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] SOURCE NUMBER+46791400609
  868. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  869. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION LOCAL SOURCE] Query :SELECT accountid FROM sip_devices WHERE username = '+46760182569' limit 1
  870. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Caller Id name / number  : +46791400609 / +46791400609
  871. 2024-12-09 17:02:42.202475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] DID Global Translation Id: 2
  872. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 2 AND status=0 limit 1                                                                                                                                                                                            
  873. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"+46/46/*/*".....+46760182569
  874. 2024-12-09 17:02:42.202475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : +46760182569
  875. 2024-12-09 17:02:42.202475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 46760182569
  876. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag, A.codec as did_codec,A.provider_id as provider_id,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number = 46760182569 ORDER BY LENGTH(A.number) DESC LIMIT 1      
  877. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  878. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation,sip_devices.codec as sip_codec FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="+46760182569" limit 1                                                                                                                                                                  
  879. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Call direction : outbound
  880. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IPAUTHENTICATION] Query :SELECT ip_map.*, (SELECT number FROM accounts where id=accountid AND status=0 AND deleted=0) AS account_code FROM ip_map WHERE INET_ATON("46.246.2.119") BETWEEN(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) & 0xffffffff ^((0x1 <<(32 -  SUBSTRING_INDEX(`ip`, '/', -1))) -1 )) AND(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) |((0x100000000 >> SUBSTRING_INDEX(`ip`,'/', -1)) -1))  AND "+46760182569"  LIKE CONCAT(prefix,'%') ORDER BY LENGTH(prefix) DESC LIMIT 1                                                                                      
  881. 2024-12-09 17:02:42.202475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 3261792583]
  882. 2024-12-09 17:02:42.202475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE (number = "3261792583" OR id = "3261792583") AND deleted = 0 limit 1
  883. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^+46760182569.*' OR blocked_patterns = '^+4676018256.*' OR blocked_patterns = '^+467601825.*' OR blocked_patterns = '^+46760182.*' OR blocked_patterns = '^+4676018.*' OR blocked_patterns = '^+467601.*' OR blocked_patterns = '^+46760.*' OR blocked_patterns = '^+4676.*' OR blocked_patterns = '^+467.*' OR blocked_patterns = '^+46.*' OR blocked_patterns = '^+4.*' OR blocked_patterns = '^+.*' OR blocked_patterns ='--') AND accountid = 7 limit 1                                  
  884. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] DID Global Translation Id : 2
  885. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 2 AND status=0 limit 1                                                                                                                                                                                            
  886. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"+46/46/*/*".....+46760182569
  887. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : +46760182569
  888. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 46760182569
  889. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number = 46760182569 AND (accountid = 0 OR status = 1) LIMIT 1
  890. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] Localization Id: 62
  891. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 62 AND status=0 limit 1                                                                                                                                                                                          
  892. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/*/*/*,+46/46/*/*,0/46/*/*".....+46760182569
  893. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/*/*/*,+46/46/*/*,0/46/*/*".....+46760182569
  894. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : +46760182569
  895. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 46760182569
  896. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/*/*/*,+46/46/*/*,0/46/*/*".....46760182569
  897. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE P.is_terminated = 0 AND (patterns = '^46760182569.*' OR patterns = '^4676018256.*' OR patterns = '^467601825.*' OR patterns = '^46760182.*' OR patterns = '^4676018.*' OR patterns = '^467601.*' OR patterns = '^46760.*' OR patterns = '^4676.*' OR patterns = '^467.*' OR patterns = '^46.*' OR patterns = '^4.*' OR patterns ='--') AND accountid = 7 ORDER BY LENGTH(PKGPTR.patterns) DESC                                                                                                                                                                                                              
  898. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="46760182569" AND A.accountid = '7' limit 1                                                                                                                                                                  
  899. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 46760182569
  900. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] DID Global Translation Id: 2
  901. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 2 AND status=0 limit 1                                                                                                                                                                                            
  902. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"+46/46/*/*".....46760182569
  903. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag, A.codec as did_codec,A.provider_id as provider_id,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number = 46760182569 ORDER BY LENGTH(A.number) DESC LIMIT 1      
  904. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  905. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation,sip_devices.codec as sip_codec FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="46760182569" limit 1                                                                                                                                                                  
  906. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  907. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] New Call Direction : outbound
  908. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type,accountid FROM call_barring WHERE ((number = '46760182569' OR number = '4676018256' OR number = '467601825' OR number = '46760182' OR number = '4676018' OR number = '467601' OR number = '46760' OR number = '4676' OR number = '467' OR number = '46' OR number = '4' OR number ='--') OR (number = '46760182569*' OR number = '4676018256*' OR number = '467601825*' OR number = '46760182*' OR number = '4676018*' OR number = '467601*' OR number = '46760*' OR number = '4676*' OR number = '467*' OR number = '46*' OR number = '4*' OR number ='--') OR (number = '+46791400609' OR number = '+4679140060' OR number = '+467914006' OR number = '+46791400' OR number = '+4679140' OR number = '+467914' OR number = '+46791' OR number = '+4679' OR number = '+467' OR number = '+46' OR number = '+4' OR number = '+' OR number ='--') OR (number = '+46791400609*' OR number = '+4679140060*' OR number = '+467914006*' OR number = '+46791400*' OR number = '+4679140*' OR number = '+467914*' OR number = '+46791*' OR number = '+4679*' OR number = '+467*' OR number = '+46*' OR number = '+4*' OR number = '+*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC                                                                                                                            
  909. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  910. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '46760182569' OR routing_prefix = '4676018256' OR routing_prefix = '467601825' OR routing_prefix = '46760182' OR routing_prefix = '4676018' OR routing_prefix = '467601' OR routing_prefix = '46760' OR routing_prefix = '4676' OR routing_prefix = '467' OR routing_prefix = '46' OR routing_prefix = '4' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1                                                                            
  911. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  912. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 7
  913. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 3261792583
  914. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 997.334
  915. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
  916. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 7
  917. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  918. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  919. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  920. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  921. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  922. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  923. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  924. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  925. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  926. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  927. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  928. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  929. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  930. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"00/+/*/*,46/+46/*/*,0/+46/*/*".....+46791400609
  931. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 7 AND status = 0
  932. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
  933. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 7 AND status = 0
  934. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query HP :SELECT * FROM routes WHERE (pattern = '^46760182569.*' OR pattern = '^4676018256.*' OR pattern = '^467601825.*' OR pattern = '^46760182.*' OR pattern = '^4676018.*' OR pattern = '^467601.*' OR pattern = '^46760.*' OR pattern = '^4676.*' OR pattern = '^467.*' OR pattern = '^46.*' OR pattern = '^4.*' OR pattern ='--') AND (caller_id_pattern = '^+46791400609.*' OR caller_id_pattern = '^+4679140060.*' OR caller_id_pattern = '^+467914006.*' OR caller_id_pattern = '^+46791400.*' OR caller_id_pattern = '^+4679140.*' OR caller_id_pattern = '^+467914.*' OR caller_id_pattern = '^+46791.*' OR caller_id_pattern = '^+4679.*' OR caller_id_pattern = '^+467.*' OR caller_id_pattern = '^+46.*' OR caller_id_pattern = '^+4.*' OR caller_id_pattern = '^+.*' OR caller_id_pattern ='^.*') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 7 OR accountid=7)  ORDER BY accountid DESC,cost ASC,effective_date DESC LIMIT 1                                    
  935. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction : outbound
  936. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  937. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 146523
  938. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.0000000000
  939. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  940. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 0.0000000000
  941. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment : SWEDEN
  942. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 184
  943. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 7
  944. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  945. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  946. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  947. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your997.334 balance Accountid 7 !!!
  948. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Call Is Free - Assigning Max Length  :: 100
  949. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Call Max Length Duration : 100 minutes
  950. 2024-12-09 17:02:42.222475 79.90% [WARNING] switch_cpp.cpp:1465 [ASTPP] [DIALPLAN] rate_carrier_id:
  951. 2024-12-09 17:02:42.222475 79.90% [WARNING] switch_cpp.cpp:1465 [ASTPP] [DIALPLAN] User Rate country_id: 184
  952. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES] Query Rate Carrier Id :
  953. 2024-12-09 17:02:42.222475 79.90% [WARNING] switch_cpp.cpp:1465 [ASTPP] or_country_id :184
  954. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES_TRUNKS from routing] Query :SELECT GROUP_CONCAT(trunk_id) as ids FROM routing WHERE pricelist_id=7 ORDER by id asc
  955. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES] Query :SELECT TK.id as trunk_id,TK.name as trunk_name,TK.sip_cid_type,TK.codec,GW.name as path,GW.dialplan_variable,TK.provider_id,TR.init_inc,TK.status,TK.maxchannels,TK.cps,TK.leg_timeout,TR.pattern,TR.id as outbound_route_id,TR.connectcost,TR.comment,TR.includedseconds,TR.cost,TR.inc,TR.prepend,TR.strip,(select name from gateways where status=0 AND id = TK.failover_gateway_id) as path1,(select name from gateways where status=0 AND id = TK.failover_gateway_id1) as path2 FROM outbound_routes as TR,trunks as TK,gateways as GW WHERE GW.status=0 AND GW.id= TK.gateway_id AND TK.status=0 AND TK.id= TR.trunk_id AND (pattern = '^46760182569.*' OR pattern = '^4676018256.*' OR pattern = '^467601825.*' OR pattern = '^46760182.*' OR pattern = '^4676018.*' OR pattern = '^467601.*' OR pattern = '^46760.*' OR pattern = '^4676.*' OR pattern = '^467.*' OR pattern = '^46.*' OR pattern = '^4.*' OR pattern ='--') AND TR.status = 0  AND TR.trunk_id IN (5) AND TR.effective_date <= UTC_TIMESTAMP() ORDER by TR.cost ASC,TR.precedence ASC, TK.precedence,TR.effective_date DESC                                                                                                            
  956. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Termination Rates Information ===================
  957. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 5
  958. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Code : ^46.*
  959. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Destination : sweden
  960. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.0000000000
  961. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Free Seconds : 0
  962. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Prefix : ^46.*
  963. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Strip :
  964. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Prepend :
  965. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Carrier id : 5
  966. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] carrier_name : GC1
  967. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] dialplan_variable :
  968. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Failover gateway :
  969. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Vendor id : 763
  970. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Max channels : 0
  971. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================END OF TERMINATION RATES=======================
  972. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 7 AND status=0 LIMIT 1                                                                                                                                                                                        
  973. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP]  Maxlength : 100
  974. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_sip_device_info_for_did_pstn_call] Query :SELECT username FROM sip_devices WHERE username = '+46791400609' and status = 0 limit 1
  975. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  976. 2024-12-09 17:02:42.222475 79.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [XML] Customer Recording Flag : 1
  977. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 7 AND status = 0
  978. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from accounts where id = 763) AND status=0 limit 1                                                                                                                                                                
  979. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"*/+/*/*".....46760182569
  980. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : 46760182569
  981. 2024-12-09 17:02:42.222475 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : +46760182569
  982. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from trunks where id = 5) AND status=0 limit 1                                                                                                                                                                    
  983. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  984. 2024-12-09 17:02:42.222475 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [sip_codec_for_outbound] Query :SELECT sip_devices.codec as sip_codec  FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="+46791400609" limit 1                                                                                              
  985. 2024-12-09 17:02:42.242474 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] DID Global Translation Id: 2
  986. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 2 AND status=0 limit 1                                                                                                                                                                                            
  987. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :"+46/46/*/*".....+46760182569
  988. 2024-12-09 17:02:42.242474 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : +46760182569
  989. 2024-12-09 17:02:42.242474 79.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 46760182569
  990. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag, A.codec as did_codec,A.provider_id as provider_id,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number = 46760182569 ORDER BY LENGTH(A.number) DESC LIMIT 1      
  991. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  992. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Generated XML:
  993. <?xml version="1.0" encoding="UTF-8" standalone="no"?>                                                                                                                                                            
  994. <document type="freeswitch/xml">                                                                                                                                                                                  
  995. <section name="dialplan" description="ASTPP Dialplan">                                                                                                                                                            
  996. <context name="default">                                                                                                                                                                                          
  997. <extension name="46760182569">                                                                                                                                                                                    
  998. <condition field="destination_number" expression="46760182569">                                                                                                                                                    
  999. <action application="set" data="effective_destination_number=46760182569"/>                                                                                                                                        
  1000. <action application="set" data="execute_on_answer_1=sched_hangup +6000 normal_clearing"/>                                                                                                                          
  1001. <action application="set" data="notify_flag=0"/>                                                                                                                                                                  
  1002. <action application="set" data="notify_credit_limit=5.00000"/>                                                                                                                                                    
  1003. <action application="set" data="type=3"/>                                                                                                                                                                          
  1004. <action application="set" data="callstart=2024-12-09 17:02:42"/>                                                                                                                                                  
  1005. <action application="set" data="hangup_after_bridge=true"/>                                                                                                                                                        
  1006. <action application="set" data="continue_on_fail=TRUE"/>                                                                                                                                                          
  1007. <action application="set" data="account_id=7"/>                                                                                                                                                                    
  1008. <action application="set" data="parent_id=0"/>                                                                                                                                                                    
  1009. <action application="set" data="entity_id=3"/>                                                                                                                                                                    
  1010. <action application="set" data="call_processed=internal"/>                                                                                                                                                        
  1011. <action application="set" data="call_direction=outbound"/>                                                                                                                                                        
  1012. <action application="set" data="accountname=MINITEL_CC"/>                                                                                                                                                          
  1013. <action application="set" data="origination_rates=ID:146523|CODE:^46.*|DESTINATION:SWEDEN|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|CT:|COST:0.0000000000|INC:1|INITIALBLOCK:1|RATEGROUP:7|MARKUP:0|CI:184|ACCID:7"/>                                                                                                                                                                                                            
  1014. <action application="set" data="original_caller_id_name=+46791400609"/>                                                                                                                                            
  1015. <action application="set" data="original_caller_id_number=+46791400609"/>                                                                                                                                          
  1016.  
  1017. <action application="set" data="effective_caller_id_name=+46791400609"/>                                                                                                                                          
  1018. <action application="set" data="effective_caller_id_number=+46791400609"/>                                                                                                                                        
  1019. <action application="set" data="calltype=STANDARD"/>                                                                                                                                                              
  1020. <action application="set" data="termination_rates=ID:5|CODE:^46.*|DESTINATION:sweden|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:5|PROVIDER:763"/>                  
  1021. <action application="set" data="trunk_id=5"/>                                                                                                                                                                      
  1022. <action application="set" data="provider_id=763"/>                                                                                                                                                                
  1023. <action application="set" data="rate_flag=1"/>                                                                                                                                                                    
  1024. <action application="set" data="daily_call_credit_limit=0.00000"/>                                                                                                                                                
  1025. <action application="set" data="monthly_call_credit_limit=0.00000"/>                                                                                                                                              
  1026. <action application="set" data="daily_call_used_limit=0.00000"/>                                                                                                                                                  
  1027. <action application="set" data="monthly_call_used_limit=0.00000"/>                                                                                                                                                
  1028. <action application="set" data="quality_trunk_seq=5"/>                                                                                                                                                            
  1029. <action application="set" data="force_trunk_flag=0"/>                                                                                                                                                              
  1030. <action application="export" data="presence_data=trunk_id=5"/>                                                                                                                                                    
  1031. <action application="set" data="intcall=0"/>                                                                                                                                                                      
  1032. <action application="export" data="presence_id=+46760182569"/>                                                                                                                                                    
  1033. <action application="export" data="presence_data=x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119"/>                  
  1034. <action application="bridge" data="{sip_cid_type=none}[leg_timeout=0]sofia/gateway/GC1/+46760182569"/>                                                                                                            
  1035. </condition>                                                                                                                                                                                                      
  1036. </extension>                                                                                                                                                                                                      
  1037. </context>                                                                                                                                                                                                        
  1038. </section>                                                                                                                                                                                                        
  1039. </document>                                                                                                                                                                                                        
  1040. Dialplan: sofia/default/+46791400609@46.246.2.119 parsing [default->46760182569] continue=false
  1041. Dialplan: sofia/default/+46791400609@46.246.2.119 Regex (PASS) [46760182569] destination_number(+46760182569) =~ /46760182569/ break=on-false
  1042. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(effective_destination_number=46760182569)
  1043. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(execute_on_answer_1=sched_hangup +6000 normal_clearing)
  1044. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(notify_flag=0)
  1045. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(notify_credit_limit=5.00000)
  1046. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(type=3)
  1047. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(callstart=2024-12-09 17:02:42)
  1048. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(hangup_after_bridge=true)
  1049. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(continue_on_fail=TRUE)
  1050. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(account_id=7)
  1051. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(parent_id=0)
  1052. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(entity_id=3)
  1053. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(call_processed=internal)
  1054. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(call_direction=outbound)
  1055. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(accountname=MINITEL_CC)
  1056. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(origination_rates=ID:146523|CODE:^46.*|DESTINATION:SWEDEN|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|CT:|COST:0.0000000000|INC:1|INITIALBLOCK:1|RATEGROUP:7|MARKUP:0|CI:184|ACCID:7)                                                                                                                                                                                  
  1057. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(original_caller_id_name=+46791400609)
  1058. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(original_caller_id_number=+46791400609)
  1059. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(effective_caller_id_name=+46791400609)
  1060. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(effective_caller_id_number=+46791400609)
  1061. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(calltype=STANDARD)
  1062. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(termination_rates=ID:5|CODE:^46.*|DESTINATION:sweden|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:5|PROVIDER:763)                                                                                                                                                                                                          
  1063. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(trunk_id=5)
  1064. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(provider_id=763)
  1065. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(rate_flag=1)
  1066. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(daily_call_credit_limit=0.00000)
  1067. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(monthly_call_credit_limit=0.00000)
  1068. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(daily_call_used_limit=0.00000)
  1069. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(monthly_call_used_limit=0.00000)
  1070. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(quality_trunk_seq=5)
  1071. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(force_trunk_flag=0)
  1072. Dialplan: sofia/default/+46791400609@46.246.2.119 Action export(presence_data=trunk_id=5)
  1073. Dialplan: sofia/default/+46791400609@46.246.2.119 Action set(intcall=0)
  1074. Dialplan: sofia/default/+46791400609@46.246.2.119 Action export(presence_id=+46760182569)
  1075. Dialplan: sofia/default/+46791400609@46.246.2.119 Action export(presence_data=x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119)                                                                                                                                                                                                          
  1076. Dialplan: sofia/default/+46791400609@46.246.2.119 Action bridge({sip_cid_type=none}[leg_timeout=0]sofia/gateway/GC1/+46760182569)
  1077. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:281 (sofia/default/+46791400609@46.246.2.119) State Change CS_ROUTING -> CS_EXECUTE
  1078. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/+46791400609@46.246.2.119) State ROUTING going to sleep
  1079. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400609@46.246.2.119) Running State Change CS_EXECUTE (Cur 129 Tot 134743)
  1080. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46791400609@46.246.2.119) State EXECUTE
  1081. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_sofia.c:213 sofia/default/+46791400609@46.246.2.119 SOFIA EXECUTE
  1082. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:323 sofia/default/+46791400609@46.246.2.119 Standard EXECUTE
  1083. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(effective_destination_number=46760182569)
  1084. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [effective_destination_number]=[46760182569]
  1085. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(execute_on_answer_1=sched_hangup +6000 normal_clearing)
  1086. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [execute_on_answer_1]=[sched_hangup +6000 normal_clearing]
  1087. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(notify_flag=0)
  1088. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [notify_flag]=[0]
  1089. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(notify_credit_limit=5.00000)
  1090. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [notify_credit_limit]=[5.00000]
  1091. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(type=3)
  1092. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [type]=[3]
  1093. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(callstart=2024-12-09 17:02:42)
  1094. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [callstart]=[2024-12-09 17:02:42]
  1095. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(hangup_after_bridge=true)
  1096. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [hangup_after_bridge]=[true]
  1097. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(continue_on_fail=TRUE)
  1098. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [continue_on_fail]=[TRUE]
  1099. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(account_id=7)
  1100. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [account_id]=[7]
  1101. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(parent_id=0)
  1102. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [parent_id]=[0]
  1103. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(entity_id=3)
  1104. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [entity_id]=[3]
  1105. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(call_processed=internal)
  1106. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [call_processed]=[internal]
  1107. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(call_direction=outbound)
  1108. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [call_direction]=[outbound]
  1109. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(accountname=MINITEL_CC)
  1110. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [accountname]=[MINITEL_CC]
  1111. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(origination_rates=ID:146523|CODE:^46.*|DESTINATION:SWEDEN|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|CT:|COST:0.0000000000|INC:1|INITIALBLOCK:1|RATEGROUP:7|MARKUP:0|CI:184|ACCID:7)                                                                                                                                                                                
  1112. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [origination_rates]=[ID:146523|CODE:^46.*|DESTINATION:SWEDEN|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|CT:|COST:0.0000000000|INC:1|INITIALBLOCK:1|RATEGROUP:7|MARKUP:0|CI:184|ACCID:7]                                                                                                                                  
  1113. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(original_caller_id_name=+46791400609)
  1114. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [original_caller_id_name]=[+46791400609]
  1115. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(original_caller_id_number=+46791400609)
  1116. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [original_caller_id_number]=[+46791400609]
  1117. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(effective_caller_id_name=+46791400609)
  1118. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [effective_caller_id_name]=[+46791400609]
  1119. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(effective_caller_id_number=+46791400609)
  1120. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [effective_caller_id_number]=[+46791400609]
  1121. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(calltype=STANDARD)
  1122. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [calltype]=[STANDARD]
  1123. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(termination_rates=ID:5|CODE:^46.*|DESTINATION:sweden|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:5|PROVIDER:763)                                                                                                                                                                                                        
  1124. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [termination_rates]=[ID:5|CODE:^46.*|DESTINATION:sweden|CONNECTIONCOST:0.0000000000|INCLUDEDSECONDS:0|COST:0.0000000000|INC:0|INITIALBLOCK:0|TRUNK:5|PROVIDER:763]                                                                                                                                                          
  1125. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(trunk_id=5)
  1126. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [trunk_id]=[5]
  1127. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(provider_id=763)
  1128. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [provider_id]=[763]
  1129. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(rate_flag=1)
  1130. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [rate_flag]=[1]
  1131. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(daily_call_credit_limit=0.00000)
  1132. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [daily_call_credit_limit]=[0.00000]
  1133. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(monthly_call_credit_limit=0.00000)
  1134. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [monthly_call_credit_limit]=[0.00000]
  1135. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(daily_call_used_limit=0.00000)
  1136. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [daily_call_used_limit]=[0.00000]
  1137. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(monthly_call_used_limit=0.00000)
  1138. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [monthly_call_used_limit]=[0.00000]
  1139. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(quality_trunk_seq=5)
  1140. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [quality_trunk_seq]=[5]
  1141. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(force_trunk_flag=0)
  1142. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [force_trunk_flag]=[0]
  1143. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 export(presence_data=trunk_id=5)
  1144. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_data]=[trunk_id=5]
  1145. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 set(intcall=0)
  1146. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_dptools.c:1671 SET sofia/default/+46791400609@46.246.2.119 [intcall]=[0]
  1147. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 export(presence_id=+46760182569)
  1148. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_id]=[+46760182569]
  1149. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 export(presence_data=x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119)                                                                                                                                                                                                        
  1150. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [presence_data]=[x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119]                                                                                                                                                                                  
  1151. EXECUTE [depth=0] sofia/default/+46791400609@46.246.2.119 bridge({sip_cid_type=none}[leg_timeout=0]sofia/gateway/GC1/+46760182569)
  1152. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1288 sofia/default/+46791400609@46.246.2.119 EXPORTING[export_vars] [presence_data]=[x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119] to event                                                                                                                              
  1153. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1288 sofia/default/+46791400609@46.246.2.119 EXPORTING[export_vars] [presence_id]=[+46760182569] to event
  1154. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_channel.c:1288 sofia/default/+46791400609@46.246.2.119 EXPORTING[export_vars] [presence_data]=[x|||miniTel Incoming(3261792583)|||^46.* // SWEDEN // 0.0000000000|||GC // ^46.* // sweden // 0.0000000000 // trunk_id=5|||STD|||46.246.2.119] to event                                                                                                                              
  1155. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_ivr_originate.c:2297 Parsing global variables
  1156. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_ivr_originate.c:2859 Parsing session specific variables
  1157. 2024-12-09 17:02:42.242474 79.90% [NOTICE] switch_channel.c:1142 New Channel sofia/default/+46760182569 [db56e155-3397-43ec-b555-01744907c31f]
  1158. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_sofia.c:5110 (sofia/default/+46760182569) State Change CS_NEW -> CS_INIT
  1159. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46760182569) Running State Change CS_INIT (Cur 130 Tot 134744)
  1160. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/+46760182569) State INIT
  1161. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_sofia.c:97 sofia/default/+46760182569 SOFIA INIT
  1162. 2024-12-09 17:02:42.242474 79.90% [INFO] sofia_glue.c:1659 sofia/default/+46760182569 sending invite call-id: (null)
  1163. 2024-12-09 17:02:42.242474 79.90% [DEBUG] sofia_glue.c:1662 sofia/default/+46760182569 sending invite version: 1.10.10-release  64bit
  1164. Local SDP:                                                                                                                                                                                                        
  1165. v=0                                                                                                                                                                                                                
  1166. o=FreeSWITCH 1733738624 1733738625 IN IP4 172.232.155.199                                                                                                                                                          
  1167. s=FreeSWITCH                                                                                                                                                                                                      
  1168. c=IN IP4 172.232.155.199                                                                                                                                                                                          
  1169. t=0 0                                                                                                                                                                                                              
  1170. m=audio 25138 RTP/AVP 8 101                                                                                                                                                                                        
  1171. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
  1172. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
  1173. a=fmtp:101 0-15                                                                                                                                                                                                    
  1174. a=ptime:20                                                                                                                                                                                                        
  1175. a=sendrecv                                                                                                                                                                                                        
  1176.  
  1177. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:40 sofia/default/+46760182569 Standard INIT
  1178. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:48 (sofia/default/+46760182569) State Change CS_INIT -> CS_ROUTING
  1179. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/+46760182569) State INIT going to sleep
  1180. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46760182569) Running State Change CS_ROUTING (Cur 130 Tot 134744)
  1181. 2024-12-09 17:02:42.242474 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46760182569 entering state [calling][0]
  1182. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/+46760182569) State ROUTING
  1183. 2024-12-09 17:02:42.242474 79.90% [DEBUG] mod_sofia.c:158 sofia/default/+46760182569 SOFIA ROUTING
  1184. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_ivr_originate.c:67 (sofia/default/+46760182569) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  1185. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/+46760182569) State ROUTING going to sleep
  1186. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46760182569) Running State Change CS_CONSUME_MEDIA (Cur 130 Tot 134744)
  1187. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:659 (sofia/default/+46760182569) State CONSUME_MEDIA
  1188. 2024-12-09 17:02:42.242474 79.90% [DEBUG] switch_core_state_machine.c:659 (sofia/default/+46760182569) State CONSUME_MEDIA going to sleep
  1189. 2024-12-09 17:02:42.262469 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46704399539 entering state [proceeding][180]
  1190. 2024-12-09 17:02:42.262469 79.90% [NOTICE] sofia.c:7604 Ring-Ready sofia/default/+46704399539!
  1191. 2024-12-09 17:02:42.262469 79.90% [DEBUG] switch_channel.c:3513 (sofia/default/+46704399539) Callstate Change EARLY -> RINGING
  1192. 2024-12-09 17:02:42.402472 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400478@46.246.2.119 entering state [terminated][487]
  1193. 2024-12-09 17:02:42.402472 79.90% [NOTICE] sofia.c:8735 Hangup sofia/default/+46791400478@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1194. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:825 sofia/default/+46791400478@46.246.2.119 ending bridge by request from read function
  1195. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46791400478@46.246.2.119]
  1196. 2024-12-09 17:02:42.402472 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400478@46.246.2.119 entering state [terminated][487]
  1197. 2024-12-09 17:02:42.402472 79.90% [NOTICE] sofia.c:8735 Hangup sofia/default/+46791400478@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1198. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:825 sofia/default/+46791400478@46.246.2.119 ending bridge by request from read function
  1199. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46791400478@46.246.2.119]
  1200. 2024-12-09 17:02:42.402472 79.90% [DEBUG] sofia.c:7493 Channel sofia/default/+46791400478@46.246.2.119 entering state [terminated][487]
  1201. 2024-12-09 17:02:42.402472 79.90% [NOTICE] sofia.c:8735 Hangup sofia/default/+46791400478@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1202. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:825 sofia/default/+46791400478@46.246.2.119 ending bridge by request from read function
  1203. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46791400478@46.246.2.119]
  1204. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46791400478@46.246.2.119 ending bridge by request from write function
  1205. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46735404473]
  1206. 2024-12-09 17:02:42.402472 79.90% [NOTICE] switch_ivr_bridge.c:1023 Hangup sofia/default/+46735404473 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  1207. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46735404473) State EXCHANGE_MEDIA going to sleep
  1208. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46735404473) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1209. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46735404473) Callstate Change RINGING -> HANGUP
  1210. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46735404473) State HANGUP
  1211. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:463 sofia/default/+46735404473 Overriding SIP cause 487 with 487 from the other leg
  1212. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46735404473 hanging up, cause: ORIGINATOR_CANCEL
  1213. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46791400478@46.246.2.119 ending bridge by request from write function
  1214. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46735404473 skip receive message [UNBRIDGE] (channel is hungup already)
  1215. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46791400478@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  1216. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_session.c:2979 sofia/default/+46791400478@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1217. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46791400478@46.246.2.119) State EXECUTE going to sleep
  1218. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1219. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46706168148]
  1220. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46791400478@46.246.2.119) Callstate Change EARLY -> HANGUP
  1221. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46735404473
  1222. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP
  1223. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46791400478@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  1224. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46735404473 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1225. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46735404473) State HANGUP going to sleep
  1226. 2024-12-09 17:02:42.402472 79.90% [NOTICE] switch_ivr_bridge.c:1023 Hangup sofia/default/+46706168148 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  1227. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46735404473) State Change CS_HANGUP -> CS_REPORTING
  1228. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46735404473) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1229. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46706168148) State EXCHANGE_MEDIA going to sleep
  1230. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46706168148) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1231. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46735404473) State REPORTING
  1232. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46706168148) Callstate Change RINGING -> HANGUP
  1233. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46706168148) State HANGUP
  1234. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:463 sofia/default/+46706168148 Overriding SIP cause 487 with 487 from the other leg
  1235. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46706168148 hanging up, cause: ORIGINATOR_CANCEL
  1236. 2024-12-09 17:02:42.402472 79.90% [INFO] mod_json_cdr.c:272 Process [f7dc3855-09b4-4025-81be-f78b2eee2ea0.cdr.json]
  1237. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46791400478@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1238. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP going to sleep
  1239. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46791400478@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1240. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1241. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING
  1242. 2024-12-09 17:02:42.402472 79.90% [INFO] mod_json_cdr.c:272 Process [0352432c-be82-4d41-9538-69fd62ba3974.cdr.json]
  1243. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46706168148 skip receive message [UNBRIDGE] (channel is hungup already)
  1244. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46791400478@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  1245. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46706168148
  1246. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46706168148 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1247. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46706168148) State HANGUP going to sleep
  1248. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46706168148) State Change CS_HANGUP -> CS_REPORTING
  1249. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_session.c:2979 sofia/default/+46791400478@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1250. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46791400478@46.246.2.119) State EXECUTE going to sleep
  1251. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1252. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46706168148) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1253. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46706168148) State REPORTING
  1254. 2024-12-09 17:02:42.402472 79.90% [INFO] mod_json_cdr.c:272 Process [000b1439-3674-4cb0-840f-bfe3f12fcbce.cdr.json]
  1255. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46791400478@46.246.2.119) Callstate Change EARLY -> HANGUP
  1256. 2024-12-09 17:02:42.402472 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP
  1257. 2024-12-09 17:02:42.402472 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46791400478@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  1258. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46791400478@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1259. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP going to sleep
  1260. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46791400478@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1261. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1262. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING
  1263. 2024-12-09 17:02:42.422473 79.90% [INFO] mod_json_cdr.c:272 Process [228b495f-9fe0-41b7-b908-b5c75e021d5f.cdr.json]
  1264. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46791400478@46.246.2.119 ending bridge by request from write function
  1265. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46703697975]
  1266. 2024-12-09 17:02:42.422473 79.90% [NOTICE] switch_ivr_bridge.c:1023 Hangup sofia/default/+46703697975 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  1267. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46703697975) State EXCHANGE_MEDIA going to sleep
  1268. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46703697975) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1269. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46703697975) Callstate Change RINGING -> HANGUP
  1270. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46703697975) State HANGUP
  1271. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:463 sofia/default/+46703697975 Overriding SIP cause 487 with 487 from the other leg
  1272. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46703697975 hanging up, cause: ORIGINATOR_CANCEL
  1273. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46703697975 skip receive message [UNBRIDGE] (channel is hungup already)
  1274. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46791400478@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  1275. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_session.c:2979 sofia/default/+46791400478@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1276. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46791400478@46.246.2.119) State EXECUTE going to sleep
  1277. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_HANGUP (Cur 130 Tot 134744)
  1278. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46791400478@46.246.2.119) Callstate Change EARLY -> HANGUP
  1279. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP
  1280. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46791400478@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  1281. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46703697975
  1282. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46703697975 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1283. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46703697975) State HANGUP going to sleep
  1284. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46703697975) State Change CS_HANGUP -> CS_REPORTING
  1285. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46703697975) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1286. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46703697975) State REPORTING
  1287. 2024-12-09 17:02:42.422473 79.90% [INFO] mod_json_cdr.c:272 Process [3613ff64-4924-4012-9c70-8fabe3229345.cdr.json]
  1288. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46791400478@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1289. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46791400478@46.246.2.119) State HANGUP going to sleep
  1290. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46791400478@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1291. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_REPORTING (Cur 130 Tot 134744)
  1292. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING
  1293. 2024-12-09 17:02:42.422473 79.90% [INFO] mod_json_cdr.c:272 Process [3f8d1bca-b3f8-4f65-988f-8db5bc0201ab.cdr.json]
  1294. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46706168148 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1295. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46706168148) State REPORTING going to sleep
  1296. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46706168148) State Change CS_REPORTING -> CS_DESTROY
  1297. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_session.c:1744 Session 134622 (sofia/default/+46706168148) Locked, Waiting on external entities
  1298. 2024-12-09 17:02:42.422473 79.90% [NOTICE] switch_core_session.c:1762 Session 134622 (sofia/default/+46706168148) Ended
  1299. 2024-12-09 17:02:42.422473 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46706168148 [CS_DESTROY]
  1300. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46706168148) Running State Change CS_DESTROY (Cur 129 Tot 134744)
  1301. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46706168148) State DESTROY
  1302. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46706168148 SOFIA DESTROY
  1303. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46706168148 Standard DESTROY
  1304. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46706168148) State DESTROY going to sleep
  1305. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46703697975 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1306. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46703697975) State REPORTING going to sleep
  1307. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46703697975) State Change CS_REPORTING -> CS_DESTROY
  1308. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_session.c:1744 Session 134624 (sofia/default/+46703697975) Locked, Waiting on external entities
  1309. 2024-12-09 17:02:42.422473 79.90% [NOTICE] switch_core_session.c:1762 Session 134624 (sofia/default/+46703697975) Ended
  1310. 2024-12-09 17:02:42.422473 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46703697975 [CS_DESTROY]
  1311. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46703697975) Running State Change CS_DESTROY (Cur 128 Tot 134744)
  1312. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46703697975) State DESTROY
  1313. 2024-12-09 17:02:42.422473 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46703697975 SOFIA DESTROY
  1314. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46703697975 Standard DESTROY
  1315. 2024-12-09 17:02:42.422473 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46703697975) State DESTROY going to sleep
  1316. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46735404473 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1317. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46735404473) State REPORTING going to sleep
  1318. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46735404473) State Change CS_REPORTING -> CS_DESTROY
  1319. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_session.c:1744 Session 134626 (sofia/default/+46735404473) Locked, Waiting on external entities
  1320. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1762 Session 134626 (sofia/default/+46735404473) Ended
  1321. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46735404473 [CS_DESTROY]
  1322. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46735404473) Running State Change CS_DESTROY (Cur 127 Tot 134744)
  1323. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46735404473) State DESTROY
  1324. 2024-12-09 17:02:42.442470 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46735404473 SOFIA DESTROY
  1325. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46735404473 Standard DESTROY
  1326. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46735404473) State DESTROY going to sleep
  1327. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46791400478@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1328. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING going to sleep
  1329. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46791400478@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1330. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_session.c:1744 Session 134625 (sofia/default/+46791400478@46.246.2.119) Locked, Waiting on external entities
  1331. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1762 Session 134625 (sofia/default/+46791400478@46.246.2.119) Ended
  1332. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46791400478@46.246.2.119 [CS_DESTROY]
  1333. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_DESTROY (Cur 126 Tot 134744)
  1334. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY
  1335. 2024-12-09 17:02:42.442470 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46791400478@46.246.2.119 SOFIA DESTROY
  1336. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46791400478@46.246.2.119 Standard DESTROY
  1337. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY going to sleep
  1338. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46791400478@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1339. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING going to sleep
  1340. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46791400478@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1341. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_session.c:1744 Session 134623 (sofia/default/+46791400478@46.246.2.119) Locked, Waiting on external entities
  1342. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1762 Session 134623 (sofia/default/+46791400478@46.246.2.119) Ended
  1343. 2024-12-09 17:02:42.442470 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46791400478@46.246.2.119 [CS_DESTROY]
  1344. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_DESTROY (Cur 125 Tot 134744)
  1345. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY
  1346. 2024-12-09 17:02:42.442470 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46791400478@46.246.2.119 SOFIA DESTROY
  1347. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46791400478@46.246.2.119 Standard DESTROY
  1348. 2024-12-09 17:02:42.442470 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY going to sleep
  1349. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46791400478@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1350. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46791400478@46.246.2.119) State REPORTING going to sleep
  1351. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46791400478@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1352. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_session.c:1744 Session 134621 (sofia/default/+46791400478@46.246.2.119) Locked, Waiting on external entities
  1353. 2024-12-09 17:02:42.462485 79.90% [NOTICE] switch_core_session.c:1762 Session 134621 (sofia/default/+46791400478@46.246.2.119) Ended
  1354. 2024-12-09 17:02:42.462485 79.90% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46791400478@46.246.2.119 [CS_DESTROY]
  1355. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46791400478@46.246.2.119) Running State Change CS_DESTROY (Cur 124 Tot 134744)
  1356. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY
  1357. 2024-12-09 17:02:42.462485 79.90% [DEBUG] mod_sofia.c:380 sofia/default/+46791400478@46.246.2.119 SOFIA DESTROY
  1358. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46791400478@46.246.2.119 Standard DESTROY
  1359. 2024-12-09 17:02:42.462485 79.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46791400478@46.246.2.119) State DESTROY going to sleep
  1360. 2024-12-09 17:02:42.642472 79.90% [DEBUG] switch_scheduler.c:147 Deleting task 39923 switch_ivr_schedule_hangup (a5237b0d-aa69-4930-9e12-6359cdf8882d)
  1361. 2024-12-09 17:02:42.822471 79.73% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [terminated][487]
  1362. 2024-12-09 17:02:42.822471 79.73% [NOTICE] sofia.c:8735 Hangup sofia/default/+46731218962@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1363. 2024-12-09 17:02:42.842470 79.73% [NOTICE] switch_ivr_originate.c:3816 Hangup sofia/default/+46767786628 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  1364. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_ivr_originate.c:4041 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  1365. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46767786628) Running State Change CS_HANGUP (Cur 124 Tot 134744)
  1366. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46767786628) Callstate Change RINGING -> HANGUP
  1367. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46767786628) State HANGUP
  1368. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:463 sofia/default/+46767786628 Overriding SIP cause 487 with 487 from the other leg
  1369. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46767786628 hanging up, cause: ORIGINATOR_CANCEL
  1370. 2024-12-09 17:02:42.842470 79.73% [INFO] mod_dptools.c:3635 Originate Failed.  Cause: ORIGINATOR_CANCEL
  1371. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218962@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1372. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218962@46.246.2.119) State EXECUTE going to sleep
  1373. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_HANGUP (Cur 124 Tot 134744)
  1374. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218962@46.246.2.119) Callstate Change RINGING -> HANGUP
  1375. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP
  1376. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218962@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  1377. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46767786628
  1378. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46767786628 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1379. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46767786628) State HANGUP going to sleep
  1380. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46767786628) State Change CS_HANGUP -> CS_REPORTING
  1381. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46767786628) Running State Change CS_REPORTING (Cur 124 Tot 134744)
  1382. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46767786628) State REPORTING
  1383. 2024-12-09 17:02:42.842470 79.73% [INFO] mod_json_cdr.c:272 Process [81469a82-ff73-4068-b008-6ff176007e92.cdr.json]
  1384. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218962@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1385. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP going to sleep
  1386. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218962@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1387. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_REPORTING (Cur 124 Tot 134744)
  1388. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING
  1389. 2024-12-09 17:02:42.842470 79.73% [INFO] mod_json_cdr.c:272 Process [786a5ab5-99e4-4a13-8794-d5df834addae.cdr.json]
  1390. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46767786628 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1391. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46767786628) State REPORTING going to sleep
  1392. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46767786628) State Change CS_REPORTING -> CS_DESTROY
  1393. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_session.c:1744 Session 134612 (sofia/default/+46767786628) Locked, Waiting on external entities
  1394. 2024-12-09 17:02:42.842470 79.73% [NOTICE] switch_core_session.c:1762 Session 134612 (sofia/default/+46767786628) Ended
  1395. 2024-12-09 17:02:42.842470 79.73% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46767786628 [CS_DESTROY]
  1396. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46767786628) Running State Change CS_DESTROY (Cur 123 Tot 134744)
  1397. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46767786628) State DESTROY
  1398. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:380 sofia/default/+46767786628 SOFIA DESTROY
  1399. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46767786628 Standard DESTROY
  1400. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46767786628) State DESTROY going to sleep
  1401. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218962@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1402. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING going to sleep
  1403. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218962@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1404. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_session.c:1744 Session 134609 (sofia/default/+46731218962@46.246.2.119) Locked, Waiting on external entities
  1405. 2024-12-09 17:02:42.842470 79.73% [NOTICE] switch_core_session.c:1762 Session 134609 (sofia/default/+46731218962@46.246.2.119) Ended
  1406. 2024-12-09 17:02:42.842470 79.73% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218962@46.246.2.119 [CS_DESTROY]
  1407. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_DESTROY (Cur 122 Tot 134744)
  1408. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY
  1409. 2024-12-09 17:02:42.842470 79.73% [DEBUG] mod_sofia.c:380 sofia/default/+46731218962@46.246.2.119 SOFIA DESTROY
  1410. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218962@46.246.2.119 Standard DESTROY
  1411. 2024-12-09 17:02:42.842470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY going to sleep
  1412. 2024-12-09 17:02:42.862470 79.73% [NOTICE] sofia.c:1065 Hangup sofia/default/+46731218962@46.246.2.119 [CS_EXECUTE] [NORMAL_CLEARING]
  1413. 2024-12-09 17:02:42.862470 79.73% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218962@46.246.2.119]
  1414. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218962@46.246.2.119 ending bridge by request from write function
  1415. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46705359757]
  1416. 2024-12-09 17:02:42.882470 79.73% [NOTICE] switch_ivr_bridge.c:1027 Hangup sofia/default/+46705359757 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  1417. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46705359757) State EXCHANGE_MEDIA going to sleep
  1418. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46705359757) Running State Change CS_HANGUP (Cur 122 Tot 134744)
  1419. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46705359757) Callstate Change ACTIVE -> HANGUP
  1420. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46705359757) State HANGUP
  1421. 2024-12-09 17:02:42.882470 79.73% [DEBUG] mod_sofia.c:463 sofia/default/+46705359757 Overriding SIP cause 480 with 200 from the other leg
  1422. 2024-12-09 17:02:42.882470 79.73% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46705359757 hanging up, cause: NORMAL_CLEARING
  1423. 2024-12-09 17:02:42.882470 79.73% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/+46705359757
  1424. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46705359757 Standard HANGUP, cause: NORMAL_CLEARING
  1425. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46705359757) State HANGUP going to sleep
  1426. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46705359757 skip receive message [UNBRIDGE] (channel is hungup already)
  1427. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218962@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  1428. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46705359757) State Change CS_HANGUP -> CS_REPORTING
  1429. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46705359757) Running State Change CS_REPORTING (Cur 122 Tot 134744)
  1430. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218962@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1431. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218962@46.246.2.119) State EXECUTE going to sleep
  1432. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_HANGUP (Cur 122 Tot 134744)
  1433. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218962@46.246.2.119) Callstate Change ACTIVE -> HANGUP
  1434. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46705359757) State REPORTING
  1435. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP
  1436. 2024-12-09 17:02:42.882470 79.73% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218962@46.246.2.119 hanging up, cause: NORMAL_CLEARING
  1437. 2024-12-09 17:02:42.882470 79.73% [INFO] mod_json_cdr.c:272 Process [acc93987-9d30-4d3d-8804-0a9b0e9ac004.cdr.json]
  1438. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218962@46.246.2.119 Standard HANGUP, cause: NORMAL_CLEARING
  1439. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP going to sleep
  1440. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218962@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1441. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_REPORTING (Cur 122 Tot 134744)
  1442. 2024-12-09 17:02:42.882470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING
  1443. 2024-12-09 17:02:42.882470 79.73% [INFO] mod_json_cdr.c:272 Process [fa7dc7da-7d72-46ad-98cb-12156ad4c132.cdr.json]
  1444. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46705359757 Standard REPORTING, cause: NORMAL_CLEARING
  1445. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46705359757) State REPORTING going to sleep
  1446. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46705359757) State Change CS_REPORTING -> CS_DESTROY
  1447. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_session.c:1744 Session 134644 (sofia/default/+46705359757) Locked, Waiting on external entities
  1448. 2024-12-09 17:02:42.902470 79.73% [NOTICE] switch_core_session.c:1762 Session 134644 (sofia/default/+46705359757) Ended
  1449. 2024-12-09 17:02:42.902470 79.73% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46705359757 [CS_DESTROY]
  1450. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46705359757) Running State Change CS_DESTROY (Cur 121 Tot 134744)
  1451. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46705359757) State DESTROY
  1452. 2024-12-09 17:02:42.902470 79.73% [DEBUG] mod_sofia.c:380 sofia/default/+46705359757 SOFIA DESTROY
  1453. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46705359757 Standard DESTROY
  1454. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46705359757) State DESTROY going to sleep
  1455. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218962@46.246.2.119 Standard REPORTING, cause: NORMAL_CLEARING
  1456. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING going to sleep
  1457. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218962@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1458. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_session.c:1744 Session 134643 (sofia/default/+46731218962@46.246.2.119) Locked, Waiting on external entities
  1459. 2024-12-09 17:02:42.902470 79.73% [NOTICE] switch_core_session.c:1762 Session 134643 (sofia/default/+46731218962@46.246.2.119) Ended
  1460. 2024-12-09 17:02:42.902470 79.73% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218962@46.246.2.119 [CS_DESTROY]
  1461. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_DESTROY (Cur 120 Tot 134744)
  1462. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY
  1463. 2024-12-09 17:02:42.902470 79.73% [DEBUG] mod_sofia.c:380 sofia/default/+46731218962@46.246.2.119 SOFIA DESTROY
  1464. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218962@46.246.2.119 Standard DESTROY
  1465. 2024-12-09 17:02:42.902470 79.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY going to sleep
  1466. 2024-12-09 17:02:42.942470 79.73% [DEBUG] switch_rtp.c:7503 Correct audio ip/port confirmed.
  1467. 2024-12-09 17:02:43.142472 79.73% [DEBUG] switch_scheduler.c:147 Deleting task 39929 switch_ivr_schedule_hangup (fa7dc7da-7d72-46ad-98cb-12156ad4c132)
  1468. 2024-12-09 17:02:43.862470 79.93% [DEBUG] sofia.c:7493 Channel sofia/default/+46731218962@46.246.2.119 entering state [terminated][487]
  1469. 2024-12-09 17:02:43.862470 79.93% [NOTICE] sofia.c:8735 Hangup sofia/default/+46731218962@46.246.2.119 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1470. 2024-12-09 17:02:43.862470 79.93% [DEBUG] switch_ivr_bridge.c:825 sofia/default/+46731218962@46.246.2.119 ending bridge by request from read function
  1471. 2024-12-09 17:02:43.862470 79.93% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46731218962@46.246.2.119]
  1472. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_ivr_bridge.c:819 sofia/default/+46731218962@46.246.2.119 ending bridge by request from write function
  1473. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_ivr_bridge.c:911 BRIDGE THREAD DONE [sofia/default/+46735527281]
  1474. 2024-12-09 17:02:43.882470 79.93% [NOTICE] switch_ivr_bridge.c:1023 Hangup sofia/default/+46735527281 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  1475. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:650 (sofia/default/+46735527281) State EXCHANGE_MEDIA going to sleep
  1476. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46735527281) Running State Change CS_HANGUP (Cur 120 Tot 134744)
  1477. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46735527281) Callstate Change RINGING -> HANGUP
  1478. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46735527281) State HANGUP
  1479. 2024-12-09 17:02:43.882470 79.93% [DEBUG] mod_sofia.c:463 sofia/default/+46735527281 Overriding SIP cause 487 with 487 from the other leg
  1480. 2024-12-09 17:02:43.882470 79.93% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46735527281 hanging up, cause: ORIGINATOR_CANCEL
  1481. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_ivr_bridge.c:1890 sofia/default/+46735527281 skip receive message [UNBRIDGE] (channel is hungup already)
  1482. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_ivr_bridge.c:1893 sofia/default/+46731218962@46.246.2.119 skip receive message [UNBRIDGE] (channel is hungup already)
  1483. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_session.c:2979 sofia/default/+46731218962@46.246.2.119 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1484. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:647 (sofia/default/+46731218962@46.246.2.119) State EXECUTE going to sleep
  1485. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_HANGUP (Cur 120 Tot 134744)
  1486. 2024-12-09 17:02:43.882470 79.93% [DEBUG] mod_sofia.c:537 Sending CANCEL to sofia/default/+46735527281
  1487. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46735527281 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1488. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46735527281) State HANGUP going to sleep
  1489. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:844 (sofia/default/+46731218962@46.246.2.119) Callstate Change EARLY -> HANGUP
  1490. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46735527281) State Change CS_HANGUP -> CS_REPORTING
  1491. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP
  1492. 2024-12-09 17:02:43.882470 79.93% [DEBUG] mod_sofia.c:469 Channel sofia/default/+46731218962@46.246.2.119 hanging up, cause: ORIGINATOR_CANCEL
  1493. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46735527281) Running State Change CS_REPORTING (Cur 120 Tot 134744)
  1494. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46735527281) State REPORTING
  1495. 2024-12-09 17:02:43.882470 79.93% [INFO] mod_json_cdr.c:272 Process [81485bea-ecb5-44de-ab40-86d9ea7852b4.cdr.json]
  1496. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:59 sofia/default/+46731218962@46.246.2.119 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1497. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/+46731218962@46.246.2.119) State HANGUP going to sleep
  1498. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:616 (sofia/default/+46731218962@46.246.2.119) State Change CS_HANGUP -> CS_REPORTING
  1499. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_REPORTING (Cur 120 Tot 134744)
  1500. 2024-12-09 17:02:43.882470 79.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING
  1501. 2024-12-09 17:02:43.902466 79.93% [INFO] mod_json_cdr.c:272 Process [3623f00e-551a-4829-a669-f30237ca8223.cdr.json]
  1502. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46735527281 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1503. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46735527281) State REPORTING going to sleep
  1504. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46735527281) State Change CS_REPORTING -> CS_DESTROY
  1505. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_session.c:1744 Session 134662 (sofia/default/+46735527281) Locked, Waiting on external entities
  1506. 2024-12-09 17:02:43.902466 79.93% [NOTICE] switch_core_session.c:1762 Session 134662 (sofia/default/+46735527281) Ended
  1507. 2024-12-09 17:02:43.902466 79.93% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46735527281 [CS_DESTROY]
  1508. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46735527281) Running State Change CS_DESTROY (Cur 119 Tot 134744)
  1509. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46735527281) State DESTROY
  1510. 2024-12-09 17:02:43.902466 79.93% [DEBUG] mod_sofia.c:380 sofia/default/+46735527281 SOFIA DESTROY
  1511. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46735527281 Standard DESTROY
  1512. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46735527281) State DESTROY going to sleep
  1513. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:168 sofia/default/+46731218962@46.246.2.119 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1514. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/+46731218962@46.246.2.119) State REPORTING going to sleep
  1515. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:607 (sofia/default/+46731218962@46.246.2.119) State Change CS_REPORTING -> CS_DESTROY
  1516. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_session.c:1744 Session 134657 (sofia/default/+46731218962@46.246.2.119) Locked, Waiting on external entities
  1517. 2024-12-09 17:02:43.902466 79.93% [NOTICE] switch_core_session.c:1762 Session 134657 (sofia/default/+46731218962@46.246.2.119) Ended
  1518. 2024-12-09 17:02:43.902466 79.93% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/+46731218962@46.246.2.119 [CS_DESTROY]
  1519. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:735 (sofia/default/+46731218962@46.246.2.119) Running State Change CS_DESTROY (Cur 118 Tot 134744)
  1520. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY
  1521. 2024-12-09 17:02:43.902466 79.93% [DEBUG] mod_sofia.c:380 sofia/default/+46731218962@46.246.2.119 SOFIA DESTROY
  1522. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:175 sofia/default/+46731218962@46.246.2.119 Standard DESTROY
  1523. 2024-12-09 17:02:43.902466 79.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/+46731218962@46.246.2.119) State DESTROY going to sleep
  1524.  

Reply to "Untitled"