2022-04-20 12:37:56.119254 [WARNING] switch_core_state_machine.c:687 88b64423-bcf4-4dae-b840-ab6195737adc sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:37:56.119254 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1554)
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:37:56.119254 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1554)
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:37:56.119254 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:37:56.119254 [DEBUG] switch_core_session.c:1665 Session 1553 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:37:56.119254 [NOTICE] switch_core_session.c:1683 Session 1553 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:37:56.119254 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:37:56.139241 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1554)
2022-04-20 12:37:56.139241 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:37:56.139241 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:37:56.139241 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:37:56.139241 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:37:59.279271 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [bba3318f-4dca-4739-b5ba-a46095c7c773]
2022-04-20 12:37:59.279271 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1555)
2022-04-20 12:37:59.279271 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:62317 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:37:59.279271 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:37:59.279271 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:37:59.279271 [DEBUG] sofia.c:2334 detaching session bba3318f-4dca-4739-b5ba-a46095c7c773
2022-04-20 12:38:01.539263 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1052@156.0.249.118 [be64492d-7342-4901-9a37-c7a2d3282892]
2022-04-20 12:38:01.539263 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1052@156.0.249.118) Running State Change CS_NEW (Cur 3 Tot 1556)
2022-04-20 12:38:01.539263 [DEBUG] sofia.c:9873 sofia/internal/1052@156.0.249.118 receiving invite from 45.93.16.28:52830 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:01.539263 [DEBUG] sofia.c:10044 IP 45.93.16.28 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:01.539263 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1052@156.0.249.118) State NEW
2022-04-20 12:38:01.539263 [DEBUG] sofia.c:2334 detaching session be64492d-7342-4901-9a37-c7a2d3282892
2022-04-20 12:38:01.739262 [DEBUG] sofia.c:2442 Re-attaching to session be64492d-7342-4901-9a37-c7a2d3282892
2022-04-20 12:38:01.739262 [DEBUG] sofia.c:9873 sofia/internal/1052@156.0.249.118 receiving invite from 45.93.16.28:52830 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:01.739262 [DEBUG] sofia.c:10044 IP 45.93.16.28 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:01.739262 [WARNING] sofia_reg.c:2906 Can't find user [1052@156.0.249.118] from 45.93.16.28
You must define a domain called '156.0.249.118' in your directory and add a user with the id="1052" attribute
and you must configure your device to use the proper domain in it's authentication credentials.
2022-04-20 12:38:01.739262 [NOTICE] sofia.c:2332 Hangup sofia/internal/1052@156.0.249.118 [CS_NEW] [CALL_REJECTED]
2022-04-20 12:38:01.759253 [DEBUG] sofia.c:1453 Channel is already hungup.
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1052@156.0.249.118) Running State Change CS_HANGUP (Cur 3 Tot 1556)
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1052@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1052@156.0.249.118) State HANGUP
2022-04-20 12:38:01.759253 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1052@156.0.249.118 hanging up, cause: CALL_REJECTED
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1052@156.0.249.118 Standard HANGUP, cause: CALL_REJECTED
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1052@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1052@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1052@156.0.249.118) Running State Change CS_REPORTING (Cur 3 Tot 1556)
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1052@156.0.249.118) State REPORTING
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1052@156.0.249.118 Standard REPORTING, cause: CALL_REJECTED
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1052@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1052@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:01.759253 [DEBUG] switch_core_session.c:1665 Session 1556 (sofia/internal/1052@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:01.759253 [NOTICE] switch_core_session.c:1683 Session 1556 (sofia/internal/1052@156.0.249.118) Ended
2022-04-20 12:38:01.759253 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1052@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1052@156.0.249.118) Running State Change CS_DESTROY (Cur 2 Tot 1556)
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1052@156.0.249.118) State DESTROY
2022-04-20 12:38:01.759253 [DEBUG] mod_sofia.c:343 sofia/internal/1052@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1052@156.0.249.118 Standard DESTROY
2022-04-20 12:38:01.759253 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1052@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:02.679278 [WARNING] switch_core_state_machine.c:687 3ab6577e-7482-4d4b-a005-2537d4ab0721 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:02.679278 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1556)
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:02.679278 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1556)
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:02.679278 [DEBUG] switch_core_session.c:1665 Session 1554 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:02.679278 [NOTICE] switch_core_session.c:1683 Session 1554 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:02.679278 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1556)
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:02.679278 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:02.679278 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:05.679269 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [d18c9584-9ff9-4b9e-bed4-cfe7ddfabb15]
2022-04-20 12:38:05.679269 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1557)
2022-04-20 12:38:05.679269 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:57482 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:05.679269 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:05.679269 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:05.679269 [DEBUG] sofia.c:2334 detaching session d18c9584-9ff9-4b9e-bed4-cfe7ddfabb15
2022-04-20 12:38:07.639274 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/0106@156.0.249.118 [2612168c-d391-4485-9beb-92ced25d7c70]
2022-04-20 12:38:07.639274 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/0106@156.0.249.118) Running State Change CS_NEW (Cur 3 Tot 1558)
2022-04-20 12:38:07.639274 [DEBUG] sofia.c:9873 sofia/internal/0106@156.0.249.118 receiving invite from 207.244.235.91:56998 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:07.639274 [DEBUG] sofia.c:10044 IP 207.244.235.91 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:07.639274 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/0106@156.0.249.118) State NEW
2022-04-20 12:38:07.639274 [DEBUG] sofia.c:2334 detaching session 2612168c-d391-4485-9beb-92ced25d7c70
2022-04-20 12:38:07.879275 [DEBUG] sofia.c:2442 Re-attaching to session 2612168c-d391-4485-9beb-92ced25d7c70
2022-04-20 12:38:07.879275 [DEBUG] sofia.c:9873 sofia/internal/0106@156.0.249.118 receiving invite from 207.244.235.91:56998 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:07.879275 [DEBUG] sofia.c:10044 IP 207.244.235.91 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:07.879275 [WARNING] sofia_reg.c:2906 Can't find user [0106@156.0.249.118] from 207.244.235.91
You must define a domain called '156.0.249.118' in your directory and add a user with the id="0106" attribute
and you must configure your device to use the proper domain in it's authentication credentials.
2022-04-20 12:38:07.879275 [NOTICE] sofia.c:2332 Hangup sofia/internal/0106@156.0.249.118 [CS_NEW] [CALL_REJECTED]
2022-04-20 12:38:07.899285 [DEBUG] sofia.c:1453 Channel is already hungup.
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/0106@156.0.249.118) Running State Change CS_HANGUP (Cur 3 Tot 1558)
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/0106@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/0106@156.0.249.118) State HANGUP
2022-04-20 12:38:07.899285 [DEBUG] mod_sofia.c:438 Channel sofia/internal/0106@156.0.249.118 hanging up, cause: CALL_REJECTED
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:60 sofia/internal/0106@156.0.249.118 Standard HANGUP, cause: CALL_REJECTED
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/0106@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/0106@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/0106@156.0.249.118) Running State Change CS_REPORTING (Cur 3 Tot 1558)
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/0106@156.0.249.118) State REPORTING
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:174 sofia/internal/0106@156.0.249.118 Standard REPORTING, cause: CALL_REJECTED
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/0106@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/0106@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:07.899285 [DEBUG] switch_core_session.c:1665 Session 1558 (sofia/internal/0106@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:07.899285 [NOTICE] switch_core_session.c:1683 Session 1558 (sofia/internal/0106@156.0.249.118) Ended
2022-04-20 12:38:07.899285 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/0106@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/0106@156.0.249.118) Running State Change CS_DESTROY (Cur 2 Tot 1558)
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/0106@156.0.249.118) State DESTROY
2022-04-20 12:38:07.899285 [DEBUG] mod_sofia.c:343 sofia/internal/0106@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:181 sofia/internal/0106@156.0.249.118 Standard DESTROY
2022-04-20 12:38:07.899285 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/0106@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:09.299270 [WARNING] switch_core_state_machine.c:687 bba3318f-4dca-4739-b5ba-a46095c7c773 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:09.299270 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1558)
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:09.299270 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1558)
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:09.299270 [DEBUG] switch_core_session.c:1665 Session 1555 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:09.299270 [NOTICE] switch_core_session.c:1683 Session 1555 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:09.299270 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1558)
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:09.299270 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:09.299270 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:12.039267 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [c8d90229-ace2-4505-8281-2081282592f1]
2022-04-20 12:38:12.039267 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1559)
2022-04-20 12:38:12.039267 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:53798 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:12.039267 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:12.039267 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:12.039267 [DEBUG] sofia.c:2334 detaching session c8d90229-ace2-4505-8281-2081282592f1
2022-04-20 12:38:15.699273 [WARNING] switch_core_state_machine.c:687 d18c9584-9ff9-4b9e-bed4-cfe7ddfabb15 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:15.699273 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1559)
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:15.699273 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1559)
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:15.699273 [DEBUG] switch_core_session.c:1665 Session 1557 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:15.699273 [NOTICE] switch_core_session.c:1683 Session 1557 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:15.699273 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1559)
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:15.699273 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:15.699273 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:17.819281 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [dfd50d21-126d-4d54-9145-78e52a5a2cdb]
2022-04-20 12:38:17.819281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1560)
2022-04-20 12:38:17.819281 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:49608 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:17.819281 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:17.819281 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:17.819281 [DEBUG] sofia.c:2334 detaching session dfd50d21-126d-4d54-9145-78e52a5a2cdb
2022-04-20 12:38:18.639253 [NOTICE] switch_channel.c:1104 New Channel sofia/external/08176416480@37.9.63.182:5060 [ff8a7151-8d7e-4054-b8a7-1fb5ff2ae201]
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_NEW (Cur 3 Tot 1561)
2022-04-20 12:38:18.639253 [DEBUG] sofia.c:9873 sofia/external/08176416480@37.9.63.182:5060 receiving invite from 37.9.63.182:5060 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:18.639253 [DEBUG] sofia.c:7084 Channel sofia/external/08176416480@37.9.63.182:5060 entering state [received][100]
2022-04-20 12:38:18.639253 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 67801204 67801205 IN IP4 37.9.63.182
s=VoipSIP
c=IN IP4 37.9.63.182
t=0 0
m=audio 8754 RTP/AVP 0 8 18 116
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:116 telephone-event/8000
2022-04-20 12:38:18.639253 [DEBUG] sofia.c:7486 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_NEW -> CS_INIT
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:603 (sofia/external/08176416480@37.9.63.182:5060) State NEW
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_INIT (Cur 3 Tot 1561)
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT
2022-04-20 12:38:18.639253 [DEBUG] mod_sofia.c:90 sofia/external/08176416480@37.9.63.182:5060 SOFIA INIT
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:40 sofia/external/08176416480@37.9.63.182:5060 Standard INIT
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:48 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_INIT -> CS_ROUTING
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT going to sleep
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 3 Tot 1561)
2022-04-20 12:38:18.639253 [DEBUG] switch_channel.c:2249 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change DOWN -> RINGING
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING
2022-04-20 12:38:18.639253 [DEBUG] mod_sofia.c:143 sofia/external/08176416480@37.9.63.182:5060 SOFIA ROUTING
2022-04-20 12:38:18.639253 [DEBUG] switch_core_state_machine.c:236 sofia/external/08176416480@37.9.63.182:5060 Standard ROUTING
2022-04-20 12:38:18.639253 [INFO] mod_dialplan_xml.c:637 Processing 08176416480 <08176416480>->connekt in context public
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->unloop] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->outside_call] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Absolute Condition [outside_call]
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action set(outside_call=true)
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->call_debug] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_extensions] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_extensions] destination_number(connekt) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_did] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_did] destination_number(connekt) =~ /^(5551212)$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->mydid] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [mydid] destination_number(connekt) =~ /^(018888325)$/ break=on-false
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:286 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING going to sleep
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 3 Tot 1561)
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE
2022-04-20 12:38:18.659251 [DEBUG] mod_sofia.c:198 sofia/external/08176416480@37.9.63.182:5060 SOFIA EXECUTE
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:328 sofia/external/08176416480@37.9.63.182:5060 Standard EXECUTE
EXECUTE sofia/external/08176416480@37.9.63.182:5060 set(outside_call=true)
2022-04-20 12:38:18.659251 [DEBUG] mod_dptools.c:1548 SET sofia/external/08176416480@37.9.63.182:5060 [outside_call]=[true]
EXECUTE sofia/external/08176416480@37.9.63.182:5060 export(RFC2822_DATE=Wed, 20 Apr 2022 12:38:18 +0100)
2022-04-20 12:38:18.659251 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 20 Apr 2022 12:38:18 +0100]
2022-04-20 12:38:18.659251 [NOTICE] switch_core_state_machine.c:385 sofia/external/08176416480@37.9.63.182:5060 has executed the last dialplan instruction, hanging up.
2022-04-20 12:38:18.659251 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/08176416480@37.9.63.182:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE going to sleep
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_HANGUP (Cur 3 Tot 1561)
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:850 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change RINGING -> HANGUP
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP
2022-04-20 12:38:18.659251 [DEBUG] mod_sofia.c:438 Channel sofia/external/08176416480@37.9.63.182:5060 hanging up, cause: NORMAL_CLEARING
2022-04-20 12:38:18.659251 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:60 sofia/external/08176416480@37.9.63.182:5060 Standard HANGUP, cause: NORMAL_CLEARING
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP going to sleep
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:619 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_REPORTING (Cur 3 Tot 1561)
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:174 sofia/external/08176416480@37.9.63.182:5060 Standard REPORTING, cause: NORMAL_CLEARING
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING going to sleep
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:610 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:18.659251 [DEBUG] switch_core_session.c:1665 Session 1561 (sofia/external/08176416480@37.9.63.182:5060) Locked, Waiting on external entities
2022-04-20 12:38:18.659251 [NOTICE] switch_core_session.c:1683 Session 1561 (sofia/external/08176416480@37.9.63.182:5060) Ended
2022-04-20 12:38:18.659251 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/08176416480@37.9.63.182:5060 [CS_DESTROY]
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:741 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_DESTROY (Cur 2 Tot 1561)
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY
2022-04-20 12:38:18.659251 [DEBUG] mod_sofia.c:343 sofia/external/08176416480@37.9.63.182:5060 SOFIA DESTROY
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:181 sofia/external/08176416480@37.9.63.182:5060 Standard DESTROY
2022-04-20 12:38:18.659251 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY going to sleep
2022-04-20 12:38:22.059263 [WARNING] switch_core_state_machine.c:687 c8d90229-ace2-4505-8281-2081282592f1 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:22.059263 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1561)
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:22.059263 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1561)
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:22.059263 [DEBUG] switch_core_session.c:1665 Session 1559 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:22.059263 [NOTICE] switch_core_session.c:1683 Session 1559 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:22.059263 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1561)
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:22.059263 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:22.059263 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:24.159266 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [936a037a-63ce-47e9-b5aa-4361c20bee69]
2022-04-20 12:38:24.159266 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1562)
2022-04-20 12:38:24.159266 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:61754 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:24.159266 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:24.159266 [DEBUG] sofia.c:2334 detaching session 936a037a-63ce-47e9-b5aa-4361c20bee69
2022-04-20 12:38:24.159266 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:25.099308 [DEBUG] mod_verto.c:4139 45.137.23.207:42696 Client Connect from 45.137.23.207:42696 accepted
2022-04-20 12:38:25.099308 [DEBUG] mod_verto.c:1992 45.137.23.207:42696 Starting client thread.
2022-04-20 12:38:25.099308 [DEBUG] mod_verto.c:1839 45.137.23.207:42696 WS SETUP FAILED
2022-04-20 12:38:25.099308 [DEBUG] mod_verto.c:2019 45.137.23.207:42696 Ending client thread.
2022-04-20 12:38:25.099308 [DEBUG] mod_verto.c:2027 45.137.23.207:42696 Thread ended
2022-04-20 12:38:27.839268 [WARNING] switch_core_state_machine.c:687 dfd50d21-126d-4d54-9145-78e52a5a2cdb sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:27.839268 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:27.839268 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1562)
2022-04-20 12:38:27.839268 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:27.839268 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:27.839268 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1562)
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:27.859251 [DEBUG] switch_core_session.c:1665 Session 1560 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:27.859251 [NOTICE] switch_core_session.c:1683 Session 1560 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:27.859251 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1562)
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:27.859251 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:27.859251 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:29.659278 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [2d31c75a-31d5-4917-90ba-073e399aa982]
2022-04-20 12:38:29.659278 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1563)
2022-04-20 12:38:29.659278 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:56194 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:29.659278 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:29.659278 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:29.659278 [DEBUG] sofia.c:2334 detaching session 2d31c75a-31d5-4917-90ba-073e399aa982
2022-04-20 12:38:30.299280 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1201@156.0.249.118 [cfc79497-4387-4cd0-8220-0c2e45977c6c]
2022-04-20 12:38:30.299280 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1201@156.0.249.118) Running State Change CS_NEW (Cur 3 Tot 1564)
2022-04-20 12:38:30.299280 [DEBUG] sofia.c:9873 sofia/internal/1201@156.0.249.118 receiving invite from 45.93.16.45:53176 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:30.299280 [DEBUG] sofia.c:10044 IP 45.93.16.45 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:30.299280 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1201@156.0.249.118) State NEW
2022-04-20 12:38:30.299280 [DEBUG] sofia.c:2334 detaching session cfc79497-4387-4cd0-8220-0c2e45977c6c
2022-04-20 12:38:31.519246 [NOTICE] switch_channel.c:1104 New Channel sofia/external/08176416480@37.9.63.182:5060 [26ef3a4f-b66e-421d-bc29-7c4dae852458]
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_NEW (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] sofia.c:9873 sofia/external/08176416480@37.9.63.182:5060 receiving invite from 37.9.63.182:5060 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:31.519246 [DEBUG] sofia.c:7084 Channel sofia/external/08176416480@37.9.63.182:5060 entering state [received][100]
2022-04-20 12:38:31.519246 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 4087344135 4087344136 IN IP4 37.9.63.182
s=VoipSIP
c=IN IP4 37.9.63.182
t=0 0
m=audio 10752 RTP/AVP 0 8 18 116
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:116 telephone-event/8000
2022-04-20 12:38:31.519246 [DEBUG] sofia.c:7486 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_NEW -> CS_INIT
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:603 (sofia/external/08176416480@37.9.63.182:5060) State NEW
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_INIT (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:90 sofia/external/08176416480@37.9.63.182:5060 SOFIA INIT
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:40 sofia/external/08176416480@37.9.63.182:5060 Standard INIT
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:48 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_INIT -> CS_ROUTING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT going to sleep
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_channel.c:2249 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change DOWN -> RINGING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:143 sofia/external/08176416480@37.9.63.182:5060 SOFIA ROUTING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:236 sofia/external/08176416480@37.9.63.182:5060 Standard ROUTING
2022-04-20 12:38:31.519246 [INFO] mod_dialplan_xml.c:637 Processing 08176416480 <08176416480>->connekt in context public
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->unloop] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->outside_call] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Absolute Condition [outside_call]
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action set(outside_call=true)
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->call_debug] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_extensions] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_extensions] destination_number(connekt) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_did] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_did] destination_number(connekt) =~ /^(5551212)$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->mydid] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [mydid] destination_number(connekt) =~ /^(018888325)$/ break=on-false
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:286 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING going to sleep
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:198 sofia/external/08176416480@37.9.63.182:5060 SOFIA EXECUTE
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:328 sofia/external/08176416480@37.9.63.182:5060 Standard EXECUTE
EXECUTE sofia/external/08176416480@37.9.63.182:5060 set(outside_call=true)
2022-04-20 12:38:31.519246 [DEBUG] mod_dptools.c:1548 SET sofia/external/08176416480@37.9.63.182:5060 [outside_call]=[true]
EXECUTE sofia/external/08176416480@37.9.63.182:5060 export(RFC2822_DATE=Wed, 20 Apr 2022 12:38:31 +0100)
2022-04-20 12:38:31.519246 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 20 Apr 2022 12:38:31 +0100]
2022-04-20 12:38:31.519246 [NOTICE] switch_core_state_machine.c:385 sofia/external/08176416480@37.9.63.182:5060 has executed the last dialplan instruction, hanging up.
2022-04-20 12:38:31.519246 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/08176416480@37.9.63.182:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE going to sleep
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_HANGUP (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:850 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change RINGING -> HANGUP
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:438 Channel sofia/external/08176416480@37.9.63.182:5060 hanging up, cause: NORMAL_CLEARING
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:60 sofia/external/08176416480@37.9.63.182:5060 Standard HANGUP, cause: NORMAL_CLEARING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP going to sleep
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:619 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_REPORTING (Cur 4 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:174 sofia/external/08176416480@37.9.63.182:5060 Standard REPORTING, cause: NORMAL_CLEARING
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING going to sleep
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:610 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:31.519246 [DEBUG] switch_core_session.c:1665 Session 1565 (sofia/external/08176416480@37.9.63.182:5060) Locked, Waiting on external entities
2022-04-20 12:38:31.519246 [NOTICE] switch_core_session.c:1683 Session 1565 (sofia/external/08176416480@37.9.63.182:5060) Ended
2022-04-20 12:38:31.519246 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/08176416480@37.9.63.182:5060 [CS_DESTROY]
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:741 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_DESTROY (Cur 3 Tot 1565)
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY
2022-04-20 12:38:31.519246 [DEBUG] mod_sofia.c:343 sofia/external/08176416480@37.9.63.182:5060 SOFIA DESTROY
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:181 sofia/external/08176416480@37.9.63.182:5060 Standard DESTROY
2022-04-20 12:38:31.519246 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY going to sleep
2022-04-20 12:38:34.199258 [WARNING] switch_core_state_machine.c:687 936a037a-63ce-47e9-b5aa-4361c20bee69 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:34.199258 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 3 Tot 1565)
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:34.199258 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 3 Tot 1565)
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:34.199258 [DEBUG] switch_core_session.c:1665 Session 1562 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:34.199258 [NOTICE] switch_core_session.c:1683 Session 1562 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:34.199258 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 2 Tot 1565)
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:34.199258 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:34.199258 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:36.239265 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [750e2bee-fec9-4d74-9780-43b963ddcd76]
2022-04-20 12:38:36.239265 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 3 Tot 1566)
2022-04-20 12:38:36.239265 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:52161 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:36.239265 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:36.239265 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:36.239265 [DEBUG] sofia.c:2334 detaching session 750e2bee-fec9-4d74-9780-43b963ddcd76
2022-04-20 12:38:38.279253 [NOTICE] switch_channel.c:1104 New Channel sofia/external/08176416480@37.9.63.182:5060 [ed90d8df-0797-426c-af9e-32989f941696]
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_NEW (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] sofia.c:9873 sofia/external/08176416480@37.9.63.182:5060 receiving invite from 37.9.63.182:5060 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:38.279253 [DEBUG] sofia.c:7084 Channel sofia/external/08176416480@37.9.63.182:5060 entering state [received][100]
2022-04-20 12:38:38.279253 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 4213178293 4213178294 IN IP4 37.9.63.182
s=VoipSIP
c=IN IP4 37.9.63.182
t=0 0
m=audio 9290 RTP/AVP 0 8 18 116
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:116 telephone-event/8000
2022-04-20 12:38:38.279253 [DEBUG] sofia.c:7486 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_NEW -> CS_INIT
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:603 (sofia/external/08176416480@37.9.63.182:5060) State NEW
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_INIT (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:90 sofia/external/08176416480@37.9.63.182:5060 SOFIA INIT
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:40 sofia/external/08176416480@37.9.63.182:5060 Standard INIT
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:48 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_INIT -> CS_ROUTING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08176416480@37.9.63.182:5060) State INIT going to sleep
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_channel.c:2249 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change DOWN -> RINGING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:143 sofia/external/08176416480@37.9.63.182:5060 SOFIA ROUTING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:236 sofia/external/08176416480@37.9.63.182:5060 Standard ROUTING
2022-04-20 12:38:38.279253 [INFO] mod_dialplan_xml.c:637 Processing 08176416480 <08176416480>->connekt in context public
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->unloop] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->outside_call] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Absolute Condition [outside_call]
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action set(outside_call=true)
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->call_debug] continue=true
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_extensions] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_extensions] destination_number(connekt) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->public_did] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [public_did] destination_number(connekt) =~ /^(5551212)$/ break=on-false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 parsing [public->mydid] continue=false
Dialplan: sofia/external/08176416480@37.9.63.182:5060 Regex (FAIL) [mydid] destination_number(connekt) =~ /^(018888325)$/ break=on-false
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:286 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08176416480@37.9.63.182:5060) State ROUTING going to sleep
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:198 sofia/external/08176416480@37.9.63.182:5060 SOFIA EXECUTE
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:328 sofia/external/08176416480@37.9.63.182:5060 Standard EXECUTE
EXECUTE sofia/external/08176416480@37.9.63.182:5060 set(outside_call=true)
2022-04-20 12:38:38.279253 [DEBUG] mod_dptools.c:1548 SET sofia/external/08176416480@37.9.63.182:5060 [outside_call]=[true]
EXECUTE sofia/external/08176416480@37.9.63.182:5060 export(RFC2822_DATE=Wed, 20 Apr 2022 12:38:38 +0100)
2022-04-20 12:38:38.279253 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 20 Apr 2022 12:38:38 +0100]
2022-04-20 12:38:38.279253 [NOTICE] switch_core_state_machine.c:385 sofia/external/08176416480@37.9.63.182:5060 has executed the last dialplan instruction, hanging up.
2022-04-20 12:38:38.279253 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/08176416480@37.9.63.182:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:650 (sofia/external/08176416480@37.9.63.182:5060) State EXECUTE going to sleep
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_HANGUP (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:850 (sofia/external/08176416480@37.9.63.182:5060) Callstate Change RINGING -> HANGUP
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:438 Channel sofia/external/08176416480@37.9.63.182:5060 hanging up, cause: NORMAL_CLEARING
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:60 sofia/external/08176416480@37.9.63.182:5060 Standard HANGUP, cause: NORMAL_CLEARING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:852 (sofia/external/08176416480@37.9.63.182:5060) State HANGUP going to sleep
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:619 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_REPORTING (Cur 4 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:174 sofia/external/08176416480@37.9.63.182:5060 Standard REPORTING, cause: NORMAL_CLEARING
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:938 (sofia/external/08176416480@37.9.63.182:5060) State REPORTING going to sleep
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:610 (sofia/external/08176416480@37.9.63.182:5060) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:38.279253 [DEBUG] switch_core_session.c:1665 Session 1567 (sofia/external/08176416480@37.9.63.182:5060) Locked, Waiting on external entities
2022-04-20 12:38:38.279253 [NOTICE] switch_core_session.c:1683 Session 1567 (sofia/external/08176416480@37.9.63.182:5060) Ended
2022-04-20 12:38:38.279253 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/08176416480@37.9.63.182:5060 [CS_DESTROY]
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:741 (sofia/external/08176416480@37.9.63.182:5060) Running State Change CS_DESTROY (Cur 3 Tot 1567)
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY
2022-04-20 12:38:38.279253 [DEBUG] mod_sofia.c:343 sofia/external/08176416480@37.9.63.182:5060 SOFIA DESTROY
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:181 sofia/external/08176416480@37.9.63.182:5060 Standard DESTROY
2022-04-20 12:38:38.279253 [DEBUG] switch_core_state_machine.c:751 (sofia/external/08176416480@37.9.63.182:5060) State DESTROY going to sleep
2022-04-20 12:38:39.679291 [WARNING] switch_core_state_machine.c:687 2d31c75a-31d5-4917-90ba-073e399aa982 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:39.679291 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 3 Tot 1567)
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:39.679291 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 3 Tot 1567)
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:39.679291 [DEBUG] switch_core_session.c:1665 Session 1563 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:39.679291 [NOTICE] switch_core_session.c:1683 Session 1563 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:39.679291 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 2 Tot 1567)
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:39.679291 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:39.679291 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:40.319327 [WARNING] switch_core_state_machine.c:687 cfc79497-4387-4cd0-8220-0c2e45977c6c sofia/internal/1201@156.0.249.118 Abandoned
2022-04-20 12:38:40.319327 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/1201@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1201@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1567)
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1201@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1201@156.0.249.118) State HANGUP
2022-04-20 12:38:40.319327 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1201@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1201@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1201@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1201@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1201@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1567)
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1201@156.0.249.118) State REPORTING
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1201@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1201@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1201@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:40.319327 [DEBUG] switch_core_session.c:1665 Session 1564 (sofia/internal/1201@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:40.319327 [NOTICE] switch_core_session.c:1683 Session 1564 (sofia/internal/1201@156.0.249.118) Ended
2022-04-20 12:38:40.319327 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1201@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1201@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1567)
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1201@156.0.249.118) State DESTROY
2022-04-20 12:38:40.319327 [DEBUG] mod_sofia.c:343 sofia/internal/1201@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1201@156.0.249.118 Standard DESTROY
2022-04-20 12:38:40.319327 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1201@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:41.859284 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [8140bedc-ef93-48db-9e34-87f22e7bb5dc]
2022-04-20 12:38:41.859284 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1568)
2022-04-20 12:38:41.859284 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:63265 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:41.859284 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:41.859284 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:41.859284 [DEBUG] sofia.c:2334 detaching session 8140bedc-ef93-48db-9e34-87f22e7bb5dc
2022-04-20 12:38:46.279268 [WARNING] switch_core_state_machine.c:687 750e2bee-fec9-4d74-9780-43b963ddcd76 sofia/internal/11@156.0.249.118 Abandoned
2022-04-20 12:38:46.279268 [NOTICE] switch_core_state_machine.c:690 Hangup sofia/internal/11@156.0.249.118 [CS_NEW] [WRONG_CALL_STATE]
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_HANGUP (Cur 2 Tot 1568)
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/11@156.0.249.118) Callstate Change DOWN -> HANGUP
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP
2022-04-20 12:38:46.279268 [DEBUG] mod_sofia.c:438 Channel sofia/internal/11@156.0.249.118 hanging up, cause: WRONG_CALL_STATE
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@156.0.249.118 Standard HANGUP, cause: WRONG_CALL_STATE
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/11@156.0.249.118) State HANGUP going to sleep
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@156.0.249.118) State Change CS_HANGUP -> CS_REPORTING
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_REPORTING (Cur 2 Tot 1568)
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@156.0.249.118 Standard REPORTING, cause: WRONG_CALL_STATE
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/11@156.0.249.118) State REPORTING going to sleep
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@156.0.249.118) State Change CS_REPORTING -> CS_DESTROY
2022-04-20 12:38:46.279268 [DEBUG] switch_core_session.c:1665 Session 1566 (sofia/internal/11@156.0.249.118) Locked, Waiting on external entities
2022-04-20 12:38:46.279268 [NOTICE] switch_core_session.c:1683 Session 1566 (sofia/internal/11@156.0.249.118) Ended
2022-04-20 12:38:46.279268 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/11@156.0.249.118 [CS_DESTROY]
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/11@156.0.249.118) Running State Change CS_DESTROY (Cur 1 Tot 1568)
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY
2022-04-20 12:38:46.279268 [DEBUG] mod_sofia.c:343 sofia/internal/11@156.0.249.118 SOFIA DESTROY
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@156.0.249.118 Standard DESTROY
2022-04-20 12:38:46.279268 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/11@156.0.249.118) State DESTROY going to sleep
2022-04-20 12:38:48.279265 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@156.0.249.118 [75937dc3-5f04-41a4-9a1c-426e8b57fc0d]
2022-04-20 12:38:48.279265 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@156.0.249.118) Running State Change CS_NEW (Cur 2 Tot 1569)
2022-04-20 12:38:48.279265 [DEBUG] sofia.c:9873 sofia/internal/11@156.0.249.118 receiving invite from 45.93.16.32:58600 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
2022-04-20 12:38:48.279265 [DEBUG] sofia.c:10044 IP 45.93.16.32 Rejected by acl "domains". Falling back to Digest auth.
2022-04-20 12:38:48.279265 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@156.0.249.118) State NEW
2022-04-20 12:38:48.279265 [DEBUG] sofia.c:2334 detaching session 75937dc3-5f04-41a4-9a1c-426e8b57fc0d
2022-04-20 12:38:49.599294 [WARNING] sofia_reg.c:2906 Can't find user [4309@156.0.249.118] from 185.108.24.44
You must define a domain called '156.0.249.118' in your directory and add a user with the id="4309" attribute
and you must configure your device to use the proper domain in it's authentication credentials.