External Calls dropping for most of the Exts

Status
Not open for further replies.
Andyd358

Andyd358

Member
Aug 23, 2018
260
9
18
55
UK
Hi so got a strange one here at least I think it is.

PBX has been som eissues recently when trying to set it up on a new internet connection. Traffic was not passing correctly. They switched back to the current internet connection but now have an issue with some of the Extentions not being able to make out bound calls. The call connects but then drops of there is no audio. The caller can not here the call ringing either. Strangley one of the Ext, does work but I cant see any dofference between that one or any of th eothers.
Here is some of the log file hope someone can help here I'm lost (but I am trying to learn)

7f7c5403-7da6-492c-af75-013d6d424549 a=rtpmap:9 G722/8000
7f7c5403-7da6-492c-af75-013d6d424549 a=rtpmap:0 PCMU/8000
7f7c5403-7da6-492c-af75-013d6d424549 a=rtpmap:101 telephone-event/8000
7f7c5403-7da6-492c-af75-013d6d424549 a=fmtp:101 0-16
7f7c5403-7da6-492c-af75-013d6d424549 a=rtpmap:13 CN/8000
7f7c5403-7da6-492c-af75-013d6d424549 a=ptime:20
7f7c5403-7da6-492c-af75-013d6d424549 a=sendrecv
7f7c5403-7da6-492c-af75-013d6d424549
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:40 sofia/internal/101@192.168.1.102:5074 Standard INIT
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/101@192.168.1.102:5074) State Change CS_INIT -> CS_ROUTING
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/101@192.168.1.102:5074) State INIT going to sleep
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/101@192.168.1.102:5074) Running State Change CS_ROUTING (Cur 2 Tot 627)
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] sofia.c:7084 Channel sofia/internal/101@192.168.1.102:5074 entering state [calling][0]
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/101@192.168.1.102:5074) State ROUTING
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] mod_sofia.c:143 sofia/internal/101@192.168.1.102:5074 SOFIA ROUTING
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/101@192.168.1.102:5074) State Change CS_ROUTING -> CS_CONSUME_MEDIA
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/101@192.168.1.102:5074) State ROUTING going to sleep
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/101@192.168.1.102:5074) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 627)
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/101@192.168.1.102:5074) State CONSUME_MEDIA
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.774757 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/101@192.168.1.102:5074) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.774757 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/103@192.168.1.46:5073 [3f6bd6e8-dde7-4d34-8c34-a21d34658ccc]
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:4819 (sofia/internal/103@192.168.1.46:5073) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/103@192.168.1.46:5073 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/103@192.168.1.46:5073 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/103@192.168.1.46:5073) Running State Change CS_INIT (Cur 3 Tot 628)
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/103@192.168.1.46:5073) State INIT
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:90 sofia/internal/103@192.168.1.46:5073 SOFIA INIT
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] sofia_glue.c:1295 sofia/internal/103@192.168.1.46:5073 sending invite version: 1.6.20 -37-987c9b9 64bit
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc Local SDP:
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc v=0
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc o=FreeSWITCH 1582158196 1582158197 IN IP4 192.168.1.200
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc s=FreeSWITCH
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc c=IN IP4 192.168.1.200
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc t=0 0
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc m=audio 40272 RTP/AVP 8 9 0 101 13
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=rtpmap:8 PCMA/8000
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=rtpmap:9 G722/8000
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=rtpmap:0 PCMU/8000
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=rtpmap:101 telephone-event/8000
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=fmtp:101 0-16
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=rtpmap:13 CN/8000
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=ptime:20
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc a=sendrecv
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:40 sofia/internal/103@192.168.1.46:5073 Standard INIT
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/103@192.168.1.46:5073) State Change CS_INIT -> CS_ROUTING
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/103@192.168.1.46:5073) State INIT going to sleep
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/103@192.168.1.46:5073) Running State Change CS_ROUTING (Cur 3 Tot 628)
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] sofia.c:7084 Channel sofia/internal/103@192.168.1.46:5073 entering state [calling][0]
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/103@192.168.1.46:5073) State ROUTING
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:143 sofia/internal/103@192.168.1.46:5073 SOFIA ROUTING
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/103@192.168.1.46:5073) State Change CS_ROUTING -> CS_CONSUME_MEDIA
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/103@192.168.1.46:5073) State ROUTING going to sleep
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/103@192.168.1.46:5073) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 628)
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/103@192.168.1.46:5073) State CONSUME_MEDIA
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/103@192.168.1.46:5073) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/104@192.168.1.64:5060 [21c6447c-24b1-42b9-acac-10bfcdf4081a]
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:4819 (sofia/internal/104@192.168.1.64:5060) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/104@192.168.1.64:5060 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/104@192.168.1.64:5060 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/104@192.168.1.64:5060) Running State Change CS_INIT (Cur 4 Tot 629)
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/104@192.168.1.64:5060) State INIT
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:90 sofia/internal/104@192.168.1.64:5060 SOFIA INIT
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] sofia_glue.c:1295 sofia/internal/104@192.168.1.64:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
21c6447c-24b1-42b9-acac-10bfcdf4081a Local SDP:
21c6447c-24b1-42b9-acac-10bfcdf4081a v=0
21c6447c-24b1-42b9-acac-10bfcdf4081a o=FreeSWITCH 1582158090 1582158091 IN IP4 192.168.1.200
21c6447c-24b1-42b9-acac-10bfcdf4081a s=FreeSWITCH
21c6447c-24b1-42b9-acac-10bfcdf4081a c=IN IP4 192.168.1.200
21c6447c-24b1-42b9-acac-10bfcdf4081a t=0 0
21c6447c-24b1-42b9-acac-10bfcdf4081a m=audio 40378 RTP/AVP 8 9 0 101 13
21c6447c-24b1-42b9-acac-10bfcdf4081a a=rtpmap:8 PCMA/8000
21c6447c-24b1-42b9-acac-10bfcdf4081a a=rtpmap:9 G722/8000
21c6447c-24b1-42b9-acac-10bfcdf4081a a=rtpmap:0 PCMU/8000
21c6447c-24b1-42b9-acac-10bfcdf4081a a=rtpmap:101 telephone-event/8000
21c6447c-24b1-42b9-acac-10bfcdf4081a a=fmtp:101 0-16
21c6447c-24b1-42b9-acac-10bfcdf4081a a=rtpmap:13 CN/8000
21c6447c-24b1-42b9-acac-10bfcdf4081a a=ptime:20
21c6447c-24b1-42b9-acac-10bfcdf4081a a=sendrecv
21c6447c-24b1-42b9-acac-10bfcdf4081a
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:40 sofia/internal/104@192.168.1.64:5060 Standard INIT
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/104@192.168.1.64:5060) State Change CS_INIT -> CS_ROUTING
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/104@192.168.1.64:5060) State INIT going to sleep
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/104@192.168.1.64:5060) Running State Change CS_ROUTING (Cur 4 Tot 629)
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] sofia.c:7084 Channel sofia/internal/104@192.168.1.64:5060 entering state [calling][0]
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/104@192.168.1.64:5060) State ROUTING
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:143 sofia/internal/104@192.168.1.64:5060 SOFIA ROUTING
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/104@192.168.1.64:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/104@192.168.1.64:5060) State ROUTING going to sleep
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/104@192.168.1.64:5060) Running State Change CS_CONSUME_MEDIA (Cur 4 Tot 629)
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/104@192.168.1.64:5060) State CONSUME_MEDIA
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/104@192.168.1.64:5060) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/105@192.168.1.75:5064 [36b228c1-4102-4875-9ba2-872503a05cc6]
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:4819 (sofia/internal/105@192.168.1.75:5064) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/105@192.168.1.75:5064 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/105@192.168.1.75:5064 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/105@192.168.1.75:5064) Running State Change CS_INIT (Cur 5 Tot 630)
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/105@192.168.1.75:5064) State INIT
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:90 sofia/internal/105@192.168.1.75:5064 SOFIA INIT
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] sofia_glue.c:1295 sofia/internal/105@192.168.1.75:5064 sending invite version: 1.6.20 -37-987c9b9 64bit
36b228c1-4102-4875-9ba2-872503a05cc6 Local SDP:
36b228c1-4102-4875-9ba2-872503a05cc6 v=0
36b228c1-4102-4875-9ba2-872503a05cc6 o=FreeSWITCH 1582158040 1582158041 IN IP4 192.168.1.200
36b228c1-4102-4875-9ba2-872503a05cc6 s=FreeSWITCH
36b228c1-4102-4875-9ba2-872503a05cc6 c=IN IP4 192.168.1.200
36b228c1-4102-4875-9ba2-872503a05cc6 t=0 0
36b228c1-4102-4875-9ba2-872503a05cc6 m=audio 40428 RTP/AVP 8 9 0 101 13
36b228c1-4102-4875-9ba2-872503a05cc6 a=rtpmap:8 PCMA/8000
36b228c1-4102-4875-9ba2-872503a05cc6 a=rtpmap:9 G722/8000
36b228c1-4102-4875-9ba2-872503a05cc6 a=rtpmap:0 PCMU/8000
36b228c1-4102-4875-9ba2-872503a05cc6 a=rtpmap:101 telephone-event/8000
36b228c1-4102-4875-9ba2-872503a05cc6 a=fmtp:101 0-16
36b228c1-4102-4875-9ba2-872503a05cc6 a=rtpmap:13 CN/8000
36b228c1-4102-4875-9ba2-872503a05cc6 a=ptime:20
36b228c1-4102-4875-9ba2-872503a05cc6 a=sendrecv
36b228c1-4102-4875-9ba2-872503a05cc6
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:40 sofia/internal/105@192.168.1.75:5064 Standard INIT
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/105@192.168.1.75:5064) State Change CS_INIT -> CS_ROUTING
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/105@192.168.1.75:5064) State INIT going to sleep
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/105@192.168.1.75:5064) Running State Change CS_ROUTING (Cur 5 Tot 630)
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] sofia.c:7084 Channel sofia/internal/105@192.168.1.75:5064 entering state [calling][0]
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/105@192.168.1.75:5064) State ROUTING
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:143 sofia/internal/105@192.168.1.75:5064 SOFIA ROUTING
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/105@192.168.1.75:5064) State Change CS_ROUTING -> CS_CONSUME_MEDIA
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/105@192.168.1.75:5064) State ROUTING going to sleep
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/105@192.168.1.75:5064) Running State Change CS_CONSUME_MEDIA (Cur 5 Tot 630)
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/105@192.168.1.75:5064) State CONSUME_MEDIA
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/105@192.168.1.75:5064) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/106@192.168.1.76:5063 [2c412c6c-b1e2-43b2-a8f7-bfefce13daef]
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:4819 (sofia/internal/106@192.168.1.76:5063) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/106@192.168.1.76:5063 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/106@192.168.1.76:5063 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@192.168.1.76:5063) Running State Change CS_INIT (Cur 6 Tot 631)
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/106@192.168.1.76:5063) State INIT
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:90 sofia/internal/106@192.168.1.76:5063 SOFIA INIT
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] sofia_glue.c:1295 sofia/internal/106@192.168.1.76:5063 sending invite version: 1.6.20 -37-987c9b9 64bit
2c412c6c-b1e2-43b2-a8f7-bfefce13daef Local SDP:
2c412c6c-b1e2-43b2-a8f7-bfefce13daef v=0
2c412c6c-b1e2-43b2-a8f7-bfefce13daef o=FreeSWITCH 1582158434 1582158435 IN IP4 192.168.1.200
2c412c6c-b1e2-43b2-a8f7-bfefce13daef s=FreeSWITCH
2c412c6c-b1e2-43b2-a8f7-bfefce13daef c=IN IP4 192.168.1.200
2c412c6c-b1e2-43b2-a8f7-bfefce13daef t=0 0
2c412c6c-b1e2-43b2-a8f7-bfefce13daef m=audio 40034 RTP/AVP 8 9 0 101 13
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=rtpmap:8 PCMA/8000
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=rtpmap:9 G722/8000
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=rtpmap:0 PCMU/8000
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=rtpmap:101 telephone-event/8000
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=fmtp:101 0-16
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=rtpmap:13 CN/8000
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=ptime:20
2c412c6c-b1e2-43b2-a8f7-bfefce13daef a=sendrecv
2c412c6c-b1e2-43b2-a8f7-bfefce13daef
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:40 sofia/internal/106@192.168.1.76:5063 Standard INIT
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/106@192.168.1.76:5063) State Change CS_INIT -> CS_ROUTING
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/106@192.168.1.76:5063) State INIT going to sleep
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@192.168.1.76:5063) Running State Change CS_ROUTING (Cur 6 Tot 631)
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] sofia.c:7084 Channel sofia/internal/106@192.168.1.76:5063 entering state [calling][0]
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/106@192.168.1.76:5063) State ROUTING
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:143 sofia/internal/106@192.168.1.76:5063 SOFIA ROUTING
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/106@192.168.1.76:5063) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/106@192.168.1.76:5063) State ROUTING going to sleep
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/106@192.168.1.76:5063) Running State Change CS_CONSUME_MEDIA (Cur 6 Tot 631)
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/106@192.168.1.76:5063) State CONSUME_MEDIA
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/106@192.168.1.76:5063) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/109@192.168.1.31:5076 [84f9b219-5ca4-4c8a-a051-ff75596b5bf2]
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:4819 (sofia/internal/109@192.168.1.31:5076) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/109@192.168.1.31:5076 Setting leg timeout to 30
2020-02-20 11:34:28.794748 [NOTICE] mod_logfile.c:192 New log started.
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/109@192.168.1.31:5076 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/109@192.168.1.31:5076) Running State Change CS_INIT (Cur 7 Tot 632)
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/109@192.168.1.31:5076) State INIT
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:90 sofia/internal/109@192.168.1.31:5076 SOFIA INIT
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] sofia_glue.c:1295 sofia/internal/109@192.168.1.31:5076 sending invite version: 1.6.20 -37-987c9b9 64bit
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 Local SDP:
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 v=0
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 o=FreeSWITCH 1582158374 1582158375 IN IP4 192.168.1.200
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 s=FreeSWITCH
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 c=IN IP4 192.168.1.200
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 t=0 0
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 m=audio 40094 RTP/AVP 8 9 0 101 13
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=rtpmap:8 PCMA/8000
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=rtpmap:9 G722/8000
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=rtpmap:0 PCMU/8000
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=rtpmap:101 telephone-event/8000
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=fmtp:101 0-16
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=rtpmap:13 CN/8000
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=ptime:20
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 a=sendrecv
84f9b219-5ca4-4c8a-a051-ff75596b5bf2
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:40 sofia/internal/109@192.168.1.31:5076 Standard INIT
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/109@192.168.1.31:5076) State Change CS_INIT -> CS_ROUTING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/109@192.168.1.31:5076) State INIT going to sleep
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/109@192.168.1.31:5076) Running State Change CS_ROUTING (Cur 7 Tot 632)
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] sofia.c:7084 Channel sofia/internal/109@192.168.1.31:5076 entering state [calling][0]
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/109@192.168.1.31:5076) State ROUTING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] mod_sofia.c:143 sofia/internal/109@192.168.1.31:5076 SOFIA ROUTING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/109@192.168.1.31:5076) State Change CS_ROUTING -> CS_CONSUME_MEDIA
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/109@192.168.1.31:5076) State ROUTING going to sleep
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/109@192.168.1.31:5076) Running State Change CS_CONSUME_MEDIA (Cur 7 Tot 632)
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/109@192.168.1.31:5076) State CONSUME_MEDIA
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.794748 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/109@192.168.1.31:5076) State CONSUME_MEDIA going to sleep
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_channel.c:1250 sofia/external/01912704370@88.215.61.201 EXPORTING[export_vars] [origination_callee_id_name]=[500] to event
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/113@192.168.1.225:8233 [a98d0a58-a25b-4db3-a75f-11c9ae3777bc]
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] mod_sofia.c:4819 (sofia/internal/113@192.168.1.225:8233) State Change CS_NEW -> CS_INIT
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/113@192.168.1.225:8233 Setting leg timeout to 30
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/113@192.168.1.225:8233 Setting leg timeout to 30
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/113@192.168.1.225:8233) Running State Change CS_INIT (Cur 8 Tot 633)
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/113@192.168.1.225:8233) State INIT
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] mod_sofia.c:90 sofia/internal/113@192.168.1.225:8233 SOFIA INIT
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] sofia_glue.c:1295 sofia/internal/113@192.168.1.225:8233 sending invite version: 1.6.20 -37-987c9b9 64bit
a98d0a58-a25b-4db3-a75f-11c9ae3777bc Local SDP:
a98d0a58-a25b-4db3-a75f-11c9ae3777bc v=0
a98d0a58-a25b-4db3-a75f-11c9ae3777bc o=FreeSWITCH 1582158234 1582158235 IN IP4 192.168.1.200
a98d0a58-a25b-4db3-a75f-11c9ae3777bc s=FreeSWITCH
a98d0a58-a25b-4db3-a75f-11c9ae3777bc c=IN IP4 192.168.1.200
a98d0a58-a25b-4db3-a75f-11c9ae3777bc t=0 0
a98d0a58-a25b-4db3-a75f-11c9ae3777bc m=audio 40234 RTP/AVP 8 9 0 101 13
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=rtpmap:8 PCMA/8000
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=rtpmap:9 G722/8000
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=rtpmap:0 PCMU/8000
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=rtpmap:101 telephone-event/8000
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=fmtp:101 0-16
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=rtpmap:13 CN/8000
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=ptime:20
a98d0a58-a25b-4db3-a75f-11c9ae3777bc a=sendrecv
a98d0a58-a25b-4db3-a75f-11c9ae3777bc
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:40 sofia/internal/113@192.168.1.225:8233 Standard INIT
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/113@192.168.1.225:8233) State Change CS_INIT -> CS_ROUTING
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/113@192.168.1.225:8233) State INIT going to sleep
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/113@192.168.1.225:8233) Running State Change CS_ROUTING (Cur 8 Tot 633)
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] sofia.c:7084 Channel sofia/internal/113@192.168.1.225:8233 entering state [calling][0]
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/113@192.168.1.225:8233) State ROUTING
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] mod_sofia.c:143 sofia/internal/113@192.168.1.225:8233 SOFIA ROUTING
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/113@192.168.1.225:8233) State Change CS_ROUTING -> CS_CONSUME_MEDIA
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/113@192.168.1.225:8233) State ROUTING going to sleep
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/113@192.168.1.225:8233) Running State Change CS_CONSUME_MEDIA (Cur 8 Tot 633)
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/113@192.168.1.225:8233) State CONSUME_MEDIA
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.814750 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/113@192.168.1.225:8233) State CONSUME_MEDIA going to sleep
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] sofia.c:7084 Channel sofia/internal/103@192.168.1.46:5073 entering state [terminated][486]
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [NOTICE] sofia.c:8273 Hangup sofia/internal/103@192.168.1.46:5073 [CS_CONSUME_MEDIA] [USER_BUSY]
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/103@192.168.1.46:5073) Running State Change CS_HANGUP (Cur 8 Tot 633)
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/103@192.168.1.46:5073) Callstate Change DOWN -> HANGUP
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/103@192.168.1.46:5073) State HANGUP
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] mod_sofia.c:438 Channel sofia/internal/103@192.168.1.46:5073 hanging up, cause: USER_BUSY
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:60 sofia/internal/103@192.168.1.46:5073 Standard HANGUP, cause: USER_BUSY
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/103@192.168.1.46:5073) State HANGUP going to sleep
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/103@192.168.1.46:5073) State Change CS_HANGUP -> CS_REPORTING
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/103@192.168.1.46:5073) Running State Change CS_REPORTING (Cur 8 Tot 633)
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/103@192.168.1.46:5073) State REPORTING
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:174 sofia/internal/103@192.168.1.46:5073 Standard REPORTING, cause: USER_BUSY
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/103@192.168.1.46:5073) State REPORTING going to sleep
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/103@192.168.1.46:5073) State Change CS_REPORTING -> CS_DESTROY
3f6bd6e8-dde7-4d34-8c34-a21d34658ccc 2020-02-20 11:34:28.834773 [DEBUG] switch_core_session.c:1665 Session 628 (sofia/internal/103@192.168.1.46:5073) Locked, Waiting on external entities
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.854746 [DEBUG] sofia.c:7084 Channel sofia/internal/101@192.168.1.102:5074 entering state [proceeding][180]
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.854746 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/101@192.168.1.102:5074!
7f7c5403-7da6-492c-af75-013d6d424549 2020-02-20 11:34:28.854746 [DEBUG] switch_channel.c:3346 (sofia/internal/101@192.168.1.102:5074) Callstate Change DOWN -> RINGING
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.854746 [DEBUG] sofia.c:7084 Channel sofia/internal/104@192.168.1.64:5060 entering state [proceeding][180]
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.854746 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/104@192.168.1.64:5060!
21c6447c-24b1-42b9-acac-10bfcdf4081a 2020-02-20 11:34:28.854746 [DEBUG] switch_channel.c:3346 (sofia/internal/104@192.168.1.64:5060) Callstate Change DOWN -> RINGING
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [INFO] switch_ivr_originate.c:1215 Sending early media
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/external/01912704370@88.215.61.201] 192.168.1.200 port 40232 -> 88.215.61.202 port 38648 codec: 8 ms: 20
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_core_media.c:7180 sofia/external/01912704370@88.215.61.201 Set 2833 dtmf send payload to 101
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_core_media.c:7187 sofia/external/01912704370@88.215.61.201 Set 2833 dtmf receive payload to 101
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_core_media.c:7210 sofia/external/01912704370@88.215.61.201 Set rtp dtmf delay to 40
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] mod_sofia.c:2364 Ring SDP:
5214ce5c-733d-4f63-bab5-e2098ab3de82 v=0
5214ce5c-733d-4f63-bab5-e2098ab3de82 o=FreeSWITCH 1582158236 1582158237 IN IP4 82.42.133.33
5214ce5c-733d-4f63-bab5-e2098ab3de82 s=FreeSWITCH
5214ce5c-733d-4f63-bab5-e2098ab3de82 c=IN IP4 82.42.133.33
5214ce5c-733d-4f63-bab5-e2098ab3de82 t=0 0
5214ce5c-733d-4f63-bab5-e2098ab3de82 m=audio 40232 RTP/AVP 8 101
5214ce5c-733d-4f63-bab5-e2098ab3de82 a=rtpmap:8 PCMA/8000
5214ce5c-733d-4f63-bab5-e2098ab3de82 a=rtpmap:101 telephone-event/8000
5214ce5c-733d-4f63-bab5-e2098ab3de82 a=fmtp:101 0-16
5214ce5c-733d-4f63-bab5-e2098ab3de82 a=ptime:20
5214ce5c-733d-4f63-bab5-e2098ab3de82 a=sendrecv
5214ce5c-733d-4f63-bab5-e2098ab3de82
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [NOTICE] mod_sofia.c:2367 Pre-Answer sofia/external/01912704370@88.215.61.201!
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_channel.c:3474 (sofia/external/01912704370@88.215.61.201) Callstate Change RINGING -> EARLY
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_core_codec.c:223 sofia/external/01912704370@88.215.61.201 Push codec L16:100
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.854746 [DEBUG] switch_ivr_originate.c:1305 Play Ringback File [tone_stream://%(400,200,400,450);%(400,2000,400,450);loops=-1]
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.854746 [DEBUG] sofia.c:7084 Channel sofia/internal/106@192.168.1.76:5063 entering state [proceeding][180]
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.854746 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/106@192.168.1.76:5063!
2c412c6c-b1e2-43b2-a8f7-bfefce13daef 2020-02-20 11:34:28.854746 [DEBUG] switch_channel.c:3346 (sofia/internal/106@192.168.1.76:5063) Callstate Change DOWN -> RINGING
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.854746 [DEBUG] sofia.c:7084 Channel sofia/internal/105@192.168.1.75:5064 entering state [proceeding][180]
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.854746 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/105@192.168.1.75:5064!
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:28.854746 [DEBUG] switch_channel.c:3346 (sofia/internal/105@192.168.1.75:5064) Callstate Change DOWN -> RINGING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] sofia.c:7084 Channel sofia/internal/109@192.168.1.31:5076 entering state [terminated][486]
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [NOTICE] sofia.c:8273 Hangup sofia/internal/109@192.168.1.31:5076 [CS_CONSUME_MEDIA] [USER_BUSY]
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/109@192.168.1.31:5076) Running State Change CS_HANGUP (Cur 8 Tot 633)
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/109@192.168.1.31:5076) Callstate Change DOWN -> HANGUP
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/109@192.168.1.31:5076) State HANGUP
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] mod_sofia.c:438 Channel sofia/internal/109@192.168.1.31:5076 hanging up, cause: USER_BUSY
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.874776 [DEBUG] sofia.c:7084 Channel sofia/internal/113@192.168.1.225:8233 entering state [proceeding][180]
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.874776 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/113@192.168.1.225:8233!
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:60 sofia/internal/109@192.168.1.31:5076 Standard HANGUP, cause: USER_BUSY
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/109@192.168.1.31:5076) State HANGUP going to sleep
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/109@192.168.1.31:5076) State Change CS_HANGUP -> CS_REPORTING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/109@192.168.1.31:5076) Running State Change CS_REPORTING (Cur 8 Tot 633)
a98d0a58-a25b-4db3-a75f-11c9ae3777bc 2020-02-20 11:34:28.874776 [DEBUG] switch_channel.c:3346 (sofia/internal/113@192.168.1.225:8233) Callstate Change DOWN -> RINGING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/109@192.168.1.31:5076) State REPORTING
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:174 sofia/internal/109@192.168.1.31:5076 Standard REPORTING, cause: USER_BUSY
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/109@192.168.1.31:5076) State REPORTING going to sleep
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/109@192.168.1.31:5076) State Change CS_REPORTING -> CS_DESTROY
84f9b219-5ca4-4c8a-a051-ff75596b5bf2 2020-02-20 11:34:28.874776 [DEBUG] switch_core_session.c:1665 Session 632 (sofia/internal/109@192.168.1.31:5076) Locked, Waiting on external entities
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.874776 [DEBUG] sofia.c:7084 Channel sofia/external/01912704370@88.215.61.201 entering state [early][183]
5214ce5c-733d-4f63-bab5-e2098ab3de82 2020-02-20 11:34:28.954776 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:37.194776 [DEBUG] sofia.c:7084 Channel sofia/internal/105@192.168.1.75:5064 entering state [completing][200]
36b228c1-4102-4875-9ba2-872503a05cc6 2020-02-20 11:34:37.194776 [DEBUG] sofia.c:7094 Remote SDP:
36b228c1-4102-4875-9ba2-872503a05cc6 v=0
 
Last edited:
Adrian Fretwell

Adrian Fretwell

Well-Known Member
Aug 13, 2017
1,498
413
83
Code: 
root@a2es-test-green:~# tcpdump -i any -w mycapture.pcap host <your-server-ip>
Code: 
root@a2es-test-green:~# sngrep -I mycapture.pcap

You can capture live with just sngrep at the command line but it will sometimes segfault on a busy server, taking the capture with tcpdump is safer and you will always have the capture file, useful if you want to inspect it in another tool like Wireshark.

You can be very selective with tcpdump like only capture a single tenants packets or only on the SIP ports, not RTP, or just the external profile... You are only limited by your imagination.
 
Last edited:
Status
Not open for further replies.
Top Bottom