00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State DESTROY going to sleep
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:181 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 Standard DESTROY
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] mod_sofia.c:364 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 SOFIA DESTROY
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State DESTROY
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Running State Change CS_DESTROY (Cur 4 Tot 1161)
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [NOTICE] switch_core_session.c:1758 Close Channel sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 [CS_DESTROY]
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [NOTICE] switch_core_session.c:1754 Session 1159 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Ended
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_session.c:1736 Session 1159 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Locked, Waiting on external entities
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State Change CS_REPORTING -> CS_DESTROY
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State REPORTING going to sleep
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.497411 [DEBUG] switch_core_state_machine.c:174 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State REPORTING
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Running State Change CS_REPORTING (Cur 5 Tot 1161)
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State Change CS_HANGUP -> CS_REPORTING
00fe5038-76a9-46a5-b4e3-d5abe9ed463a
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:781 Hangup Command with no Session lua(app.lua hangup):
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State HANGUP going to sleep
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:60 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:453 Channel sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 hanging up, cause: ORIGINATOR_CANCEL
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:447 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 Overriding SIP cause 487 with 503 from the other leg
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State HANGUP
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Callstate Change RINGING -> HANGUP
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) Running State Change CS_HANGUP (Cur 5 Tot 1161)
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060) State EXECUTE going to sleep
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_core_session.c:2914 sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/4274@10.0.0.2:5085) State DESTROY going to sleep
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:181 sofia/internal/4274@10.0.0.2:5085 Standard DESTROY
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:364 sofia/internal/4274@10.0.0.2:5085 SOFIA DESTROY
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/4274@10.0.0.2:5085) State DESTROY
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [INFO] mod_dptools.c:3643 Originate Failed. Cause: ORIGINATOR_CANCEL
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_DESTROY (Cur 5 Tot 1161)
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [NOTICE] switch_core_session.c:1758 Close Channel sofia/internal/4274@10.0.0.2:5085 [CS_DESTROY]
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [NOTICE] switch_core_session.c:1754 Session 1161 (sofia/internal/4274@10.0.0.2:5085) Ended
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_session.c:1736 Session 1161 (sofia/internal/4274@10.0.0.2:5085) Locked, Waiting on external entities
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/4274@10.0.0.2:5085) State Change CS_REPORTING -> CS_DESTROY
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/4274@10.0.0.2:5085) State REPORTING going to sleep
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:174 sofia/internal/4274@10.0.0.2:5085 Standard REPORTING, cause: ORIGINATOR_CANCEL
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/4274@10.0.0.2:5085) State REPORTING
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_REPORTING (Cur 6 Tot 1161)
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_ivr_originate.c:4026 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [NOTICE] switch_ivr_originate.c:3030 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/4274@10.0.0.2:5085) State Change CS_HANGUP -> CS_REPORTING
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/4274@10.0.0.2:5085) State HANGUP going to sleep
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:60 sofia/internal/4274@10.0.0.2:5085 Standard HANGUP, cause: ORIGINATOR_CANCEL
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:521 Sending CANCEL to sofia/internal/4274@10.0.0.2:5085
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/4274@10.0.0.2:5085) State DESTROY going to sleep
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:181 sofia/internal/4274@10.0.0.2:5085 Standard DESTROY
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:364 sofia/internal/4274@10.0.0.2:5085 SOFIA DESTROY
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/4274@10.0.0.2:5085) State DESTROY
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:453 Channel sofia/internal/4274@10.0.0.2:5085 hanging up, cause: ORIGINATOR_CANCEL
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] mod_sofia.c:447 sofia/internal/4274@10.0.0.2:5085 Overriding SIP cause 487 with 487 from the other leg
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/4274@10.0.0.2:5085) State HANGUP
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_DESTROY (Cur 6 Tot 1161)
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/4274@10.0.0.2:5085) Callstate Change DOWN -> HANGUP
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [NOTICE] switch_core_session.c:1758 Close Channel sofia/internal/4274@10.0.0.2:5085 [CS_DESTROY]
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:58.377384 [NOTICE] switch_core_session.c:1754 Session 1160 (sofia/internal/4274@10.0.0.2:5085) Ended
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_HANGUP (Cur 7 Tot 1161)
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.377384 [DEBUG] switch_ivr_originate.c:4015 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
c2e1c8f3-c20b-428a-97a2-d9fd3fae9a6e 2021-07-26 20:13:58.377384 [NOTICE] switch_ivr_originate.c:3790 Hangup sofia/internal/4274@10.0.0.2:5085 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.357430 [DEBUG] mod_hash.c:296 Usage for linskill.XXXXXXXXXXX.co.uk_4274 is now 0
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.357430 [NOTICE] sofia.c:8641 Hangup sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 [CS_EXECUTE] [ORIGINATOR_CANCEL]
00fe5038-76a9-46a5-b4e3-d5abe9ed463a 2021-07-26 20:13:58.357430 [DEBUG] sofia.c:7406 Channel sofia/internal/
4241@linskill.XXXXXXXXXXX.co.uk:5060 entering state [terminated][487]
2021-07-26 20:13:54.137433 [WARNING] sofia_reg.c:1795 SIP auth challenge (INVITE) on sofia profile 'internal' for [
201@cfedental.XXXXXXXXXXX.co.uk] from ip 185.9.233.165
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_session.c:1736 Session 1160 (sofia/internal/4274@10.0.0.2:5085) Locked, Waiting on external entities
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/4274@10.0.0.2:5085) State Change CS_REPORTING -> CS_DESTROY
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/4274@10.0.0.2:5085) State REPORTING going to sleep
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:174 sofia/internal/4274@10.0.0.2:5085 Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/4274@10.0.0.2:5085) State REPORTING
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_REPORTING (Cur 7 Tot 1161)
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/4274@10.0.0.2:5085) State Change CS_HANGUP -> CS_REPORTING
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/4274@10.0.0.2:5085) State HANGUP going to sleep
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:60 sofia/internal/4274@10.0.0.2:5085 Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] mod_sofia.c:453 Channel sofia/internal/4274@10.0.0.2:5085 hanging up, cause: NORMAL_TEMPORARY_FAILURE
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/4274@10.0.0.2:5085) State HANGUP
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/4274@10.0.0.2:5085) Callstate Change DOWN -> HANGUP
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/4274@10.0.0.2:5085) Running State Change CS_HANGUP (Cur 7 Tot 1161)
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [NOTICE] sofia.c:8641 Hangup sofia/internal/4274@10.0.0.2:5085 [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
a8a9a634-106a-4f98-967b-4cd97edb2e60 2021-07-26 20:13:48.797433 [DEBUG] sofia.c:7406 Channel sofia/internal/4274@10.0.0.2:5085 entering state [terminated][503]