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.