v=0
o=FreeSWITCH 1628062263 1628062265 IN IP4 89.46.223.194
s=FreeSWITCH
c=IN IP4 89.46.223.194
t=0 0
m=audio 18248 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2021-08-04 08:35:13.360650 [NOTICE] switch_ivr_bridge.c:623 Channel [sofia/default/498008001050@193.109.216.112] has been answered
2021-08-04 08:35:13.360650 [DEBUG] sofia.c:7084 Channel sofia/default/498008001050@193.109.216.112 entering state [completed][200]
EXECUTE sofia/default/498008001050@193.109.216.112 record_session(/var/lib/freeswitch/recordings/6817b6ee-f520-11eb-bea5-b1a3947a3cab.wav)
2021-08-04 08:35:13.380656 [DEBUG] switch_ivr_async.c:1500 No silence detection configured; assuming start of speech
2021-08-04 08:35:13.380656 [DEBUG] switch_core_media_bug.c:945 Attaching BUG to sofia/default/498008001050@193.109.216.112
2021-08-04 08:35:13.380656 [DEBUG] switch_channel.c:3773 (sofia/default/498008001050@193.109.216.112) Callstate Change EARLY -> ACTIVE
2021-08-04 08:35:13.380656 [DEBUG] switch_ivr_async.c:1500 No silence detection configured; assuming start of speech
2021-08-04 08:35:13.400655 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
2021-08-04 08:35:13.400655 [DEBUG] switch_core_io.c:448 Setting BUG Codec PCMA:8
2021-08-04 08:35:13.420650 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
2021-08-04 08:35:13.420650 [DEBUG] switch_core_io.c:448 Setting BUG Codec PCMA:8
2021-08-04 08:35:13.420650 [DEBUG] sofia.c:7084 Channel sofia/default/498008001050@193.109.216.112 entering state [ready][200]
2021-08-04 08:35:14.920651 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 6:960
2021-08-04 08:35:14.920651 [INFO] switch_channel.c:515 RECV DTMF 6:960
2021-08-04 08:35:15.640645 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 6:960
2021-08-04 08:35:15.640645 [INFO] switch_channel.c:515 RECV DTMF 6:960
2021-08-04 08:35:16.320655 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 6:960
2021-08-04 08:35:16.320655 [INFO] switch_channel.c:515 RECV DTMF 6:960
2021-08-04 08:35:16.620641 [NOTICE] sofia.c:1012 Hangup sofia/default/498008001050@193.109.216.112 [CS_EXECUTE] [NORMAL_CLEARING]
2021-08-04 08:35:16.620641 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/498008001050@193.109.216.112]
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_bridge.c:706 sofia/default/498008001050@193.109.216.112 ending bridge by request from write function
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/4915759322375]
2021-08-04 08:35:16.640640 [NOTICE] switch_ivr_bridge.c:904 Hangup sofia/default/4915759322375 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:653 (sofia/default/4915759322375) State EXCHANGE_MEDIA going to sleep
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4915759322375) Running State Change CS_HANGUP (Cur 15 Tot 1047378)
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_async.c:1316 Stop recording file /var/lib/freeswitch/recordings/6817b6ee-f520-11eb-bea5-b1a3947a3cab.wav
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_bridge.c:1712 sofia/default/4915759322375 skip receive message [UNBRIDGE] (channel is hungup already)
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_bridge.c:1715 sofia/default/498008001050@193.109.216.112 skip receive message [UNBRIDGE] (channel is hungup already)
2021-08-04 08:35:16.640640 [DEBUG] switch_core_session.c:2815 sofia/default/498008001050@193.109.216.112 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:650 (sofia/default/498008001050@193.109.216.112) State EXECUTE going to sleep
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:584 (sofia/default/498008001050@193.109.216.112) Running State Change CS_HANGUP (Cur 15 Tot 1047378)
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_async.c:1316 Stop recording file /var/lib/freeswitch/recordings/6817b6ee-f520-11eb-bea5-b1a3947a3cab.wav
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_async.c:1380 Channel is hung up
2021-08-04 08:35:16.640640 [DEBUG] switch_core_media_bug.c:1298 Removing BUG from sofia/default/498008001050@193.109.216.112
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:850 (sofia/default/498008001050@193.109.216.112) Callstate Change ACTIVE -> HANGUP
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:852 (sofia/default/498008001050@193.109.216.112) State HANGUP
2021-08-04 08:35:16.640640 [DEBUG] mod_sofia.c:438 Channel sofia/default/498008001050@193.109.216.112 hanging up, cause: NORMAL_CLEARING
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:60 sofia/default/498008001050@193.109.216.112 Standard HANGUP, cause: NORMAL_CLEARING
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:852 (sofia/default/498008001050@193.109.216.112) State HANGUP going to sleep
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:619 (sofia/default/498008001050@193.109.216.112) State Change CS_HANGUP -> CS_REPORTING
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:584 (sofia/default/498008001050@193.109.216.112) Running State Change CS_REPORTING (Cur 15 Tot 1047378)
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:938 (sofia/default/498008001050@193.109.216.112) State REPORTING
2021-08-04 08:35:16.640640 [INFO] mod_json_cdr.c:271 Process [6817b6ee-f520-11eb-bea5-b1a3947a3cab.cdr.json]
2021-08-04 08:35:16.640640 [DEBUG] switch_ivr_async.c:1380 Channel is hung up
2021-08-04 08:35:16.640640 [DEBUG] switch_core_media_bug.c:1298 Removing BUG from sofia/default/4915759322375
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:850 (sofia/default/4915759322375) Callstate Change ACTIVE -> HANGUP
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:852 (sofia/default/4915759322375) State HANGUP
2021-08-04 08:35:16.640640 [DEBUG] mod_sofia.c:432 sofia/default/4915759322375 Overriding SIP cause 480 with 200 from the other leg
2021-08-04 08:35:16.640640 [DEBUG] mod_sofia.c:438 Channel sofia/default/4915759322375 hanging up, cause: NORMAL_CLEARING
2021-08-04 08:35:16.640640 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/default/4915759322375
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:60 sofia/default/4915759322375 Standard HANGUP, cause: NORMAL_CLEARING
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:852 (sofia/default/4915759322375) State HANGUP going to sleep
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:619 (sofia/default/4915759322375) State Change CS_HANGUP -> CS_REPORTING
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4915759322375) Running State Change CS_REPORTING (Cur 15 Tot 1047378)
2021-08-04 08:35:16.640640 [DEBUG] switch_core_state_machine.c:938 (sofia/default/4915759322375) State REPORTING
2021-08-04 08:35:16.640640 [INFO] mod_json_cdr.c:271 Process [681dfe0a-f520-11eb-becb-b1a3947a3cab.cdr.json]
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:174 sofia/default/4915759322375 Standard REPORTING, cause: NORMAL_CLEARING
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:938 (sofia/default/4915759322375) State REPORTING going to sleep
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:610 (sofia/default/4915759322375) State Change CS_REPORTING -> CS_DESTROY
2021-08-04 08:35:16.660644 [DEBUG] switch_core_session.c:1665 Session 1047378 (sofia/default/4915759322375) Locked, Waiting on external entities
2021-08-04 08:35:16.660644 [NOTICE] switch_core_session.c:1683 Session 1047378 (sofia/default/4915759322375) Ended
2021-08-04 08:35:16.660644 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/4915759322375 [CS_DESTROY]
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:741 (sofia/default/4915759322375) Running State Change CS_DESTROY (Cur 14 Tot 1047378)
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:751 (sofia/default/4915759322375) State DESTROY
2021-08-04 08:35:16.660644 [DEBUG] mod_sofia.c:343 sofia/default/4915759322375 SOFIA DESTROY
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:181 sofia/default/4915759322375 Standard DESTROY
2021-08-04 08:35:16.660644 [DEBUG] switch_core_state_machine.c:751 (sofia/default/4915759322375) State DESTROY going to sleep
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:174 sofia/default/498008001050@193.109.216.112 Standard REPORTING, cause: NORMAL_CLEARING
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:938 (sofia/default/498008001050@193.109.216.112) State REPORTING going to sleep
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:610 (sofia/default/498008001050@193.109.216.112) State Change CS_REPORTING -> CS_DESTROY
2021-08-04 08:35:16.720652 [DEBUG] switch_core_session.c:1665 Session 1047377 (sofia/default/498008001050@193.109.216.112) Locked, Waiting on external entities
2021-08-04 08:35:16.720652 [NOTICE] switch_core_session.c:1683 Session 1047377 (sofia/default/498008001050@193.109.216.112) Ended
2021-08-04 08:35:16.720652 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/498008001050@193.109.216.112 [CS_DESTROY]
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:741 (sofia/default/498008001050@193.109.216.112) Running State Change CS_DESTROY (Cur 13 Tot 1047378)
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:751 (sofia/default/498008001050@193.109.216.112) State DESTROY
2021-08-04 08:35:16.720652 [DEBUG] mod_sofia.c:343 sofia/default/498008001050@193.109.216.112 SOFIA DESTROY
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:181 sofia/default/498008001050@193.109.216.112 Standard DESTROY
2021-08-04 08:35:16.720652 [DEBUG] switch_core_state_machine.c:751 (sofia/default/498008001050@193.109.216.112) State DESTROY going to sleep
2021-08-04 08:35:16.880644 [DEBUG] switch_scheduler.c:144 Deleting task 77372 switch_ivr_schedule_hangup (681dfe0a-f520-11eb-becb-b1a3947a3cab)
2021-08-04 08:35:17.020644 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 6:960
2021-08-04 08:35:17.020644 [INFO] switch_channel.c:515 RECV DTMF 6:960
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2021-08-04 08:35:17.020644 [DEBUG] switch_core_codec.c:223 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com Push codec L16:100
2021-08-04 08:35:17.020644 [ERR] switch_core_video.c:2267 This function is not available, libpng not installed
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '0' to 'mute'
2021-08-04 08:35:17.020644 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4043fd8
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '1' to 'vol talk dn'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044008
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '2' to 'vol talk up'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044038
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '3' to 'vol talk zero'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044068
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '4' to 'vol listen dn'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044098
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '5' to 'vol listen zero'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a40440c8
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '6' to 'vol listen up'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a40440f8
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '7' to 'energy dn'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044128
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '8' to 'energy equ'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044158
2021-08-04 08:35:17.020644 [DEBUG] conference_member.c:128 sofia/default/4345433960@Lirontest11138.newsip.israelnumber.com binding '9' to 'energy up'
2021-08-04 08:35:17.020644 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7f6a5aeb1400 data: 0x7f69a4044188
2021-08-04 08:35:17.020644 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20 samples: 160 from codec PCMA
2021-08-04 08:35:18.440722 [NOTICE] switch_channel.c:1104 New Channel sofia/default/86@89.46.223.194 [6d2e755a-f520-11eb-bed7-b1a3947a3cab]
2021-08-04 08:35:18.440722 [DEBUG] switch_core_state_machine.c:584 (sofia/default/86@89.46.223.194) Running State Change CS_NEW (Cur 14 Tot 1047379)
2021-08-04 08:35:18.440722 [DEBUG] sofia.c:9873 sofia/default/86@89.46.223.194 receiving invite from 91.132.58.82:64218 version: 1.6.20 64bit
2021-08-04 08:35:18.440722 [DEBUG] sofia.c:10044 IP 91.132.58.82 Rejected by acl "default". Falling back to Digest auth.
2021-08-04 08:35:18.440722 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'default' for [66601112074174013@89.46.223.194] from ip 91.132.58.82
2021-08-04 08:35:18.440722 [DEBUG] switch_core_state_machine.c:603 (sofia/default/86@89.46.223.194) State NEW
2021-08-04 08:35:18.440722 [DEBUG] sofia.c:2334 detaching session 6d2e755a-f520-11eb-bed7-b1a3947a3cab