[Freeswitch-users] Audio problems in freeswitch

9 Oct 2015

      My freeswitch status is:

               Name  Type                                       DataState

=================================================================================================

            external-ipv6profile   sip:mod_sofia@[2401:1800:7800:101:4628:b452:ff1c:8e5]:5080RUNNING (0)

external-ipv6::example.comgateway                   sip:joeuser@example.com<mailto:joeuser@example.com>NOREG

             119.9.73.183  alias                                   internalALIASED

                 externalprofile           sip:mod_sofia@119.9.73.183<mailto:mod_sofia@119.9.73.183>:5092RUNNING (0)

    external::example.comgateway                   sip:joeuser@example.com<mailto:joeuser@example.com>NOREG

            internal-ipv6profile   sip:mod_sofia@[2401:1800:7800:101:4628:b452:ff1c:8e5]:5060RUNNING (0)

                 internalprofile           sip:mod_sofia@119.9.73.183<mailto:mod_sofia@119.9.73.183>:5090RUNNING (0)

=================================================================================================

I have integrated freeswitch with kamailio on the same server. When I only use kamailio as voip. I am able to listen to voice , but when I use only freeswitch or both freeswitch and kamailio I do not get voice.
I EVEN DO NOT GET FREESWITCH VOICEMAIL SOUNDS.(WHEN USER IS NOT REGISTERED).
I think its a minor issue but I am not able to figure it out.
The logs are:

Dialplan: sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Action sleep(1000)

Dialplan: sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})

2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_ROUTING -> CS_EXECUTE

2015-10-09 17:13:07.460415 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State ROUTING going to sleep

2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_EXECUTE

2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State EXECUTE

2015-10-09 17:13:07.460415 [DEBUG] mod_sofia.c:178 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SOFIA EXECUTE

2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard EXECUTE

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(open=true)

2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [open]=[true]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-spymap/1014/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/1014/1018)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/global/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 export(RFC2822_DATE=Fri, 09 Oct 2015 17:13:07 +0530)

2015-10-09 17:13:07.460415 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 export(dialed_extension=1018)

2015-10-09 17:13:07.460415 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [dialed_extension]=[1018]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(1 b s execute_extension::dx XML features)

2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *1 execute_extension::dx XML features

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1014.2015-10-09-17-13-07.wav)

2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1014.2015-10-09-17-13-07.wav

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(3 b s execute_extension::cf XML features)

2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *3 execute_extension::cf XML features

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(4 b s execute_extension::att_xfer XML features)

2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *4 execute_extension::att_xfer XML features

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(ringback=%(2000,4000,440,480))

2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [ringback]=[%(2000,4000,440,480)]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(transfer_ringback=local_stream://moh)

2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [transfer_ringback]=[local_stream://moh]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(call_timeout=30)

2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [call_timeout]=[30]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(hangup_after_bridge=true)

2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [hangup_after_bridge]=[true]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(continue_on_fail=true)

2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [continue_on_fail]=[true]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-call_return/1018/1014)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/1018/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(called_party_callgroup=techsupport)

2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [called_party_callgroup]=[techsupport]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/techsupport/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/global/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/techsupport/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d)

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bridge(user/1018@119.9.73.183<mailto:user/1018@119.9.73.183>)

2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event

2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event

2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables

2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event

2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event

2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables

2015-10-09 17:13:07.480408 [DEBUG] switch_event.c:1698 Parsing variable [sip_invite_domain]=[119.9.73.183]

2015-10-09 17:13:07.480408 [DEBUG] switch_event.c:1698 Parsing variable [presence_id]=[1018@119.9.73.183<mailto:1018@119.9.73.183>]

2015-10-09 17:13:07.480408 [NOTICE] switch_ivr_originate.c:2736 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]

2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:3724 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]

2015-10-09 17:13:07.480408 [NOTICE] switch_ivr_originate.c:2736 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]

2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:3724 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]

2015-10-09 17:13:07.480408 [INFO] mod_dptools.c:3535 Originate Failed.  Cause: USER_NOT_REGISTERED

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 answer()

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G729:18:8000:20:8000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[GSM:3:8000:20:13200:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [GSM:3:8000:20:13200:1] ++++ is saved as a match

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[G729:18:8000:20:8000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[GSM:3:8000:20:13200:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[G729:18:8000:20:8000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[GSM:3:8000:20:13200:1]

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 GSM/8000 20 ms 160 samples 13200 bits 1 channels

2015-10-09 17:13:07.480408 [DEBUG] switch_core_codec.c:111 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Original read codec set to GSM:3

2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3942 Set 2833 dtmf send/recv payload to 101

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:4725 STUN Success [119.9.73.183]:[31858]

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:4729 STUN Not Required ip and port match. [119.9.73.183]:[31858]

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090] 119.9.73.183 port 31858 -> 10.150.216.71 port 8000 codec: 3 ms: 20

2015-10-09 17:13:08.720433 [DEBUG] switch_rtp.c:3579 Starting timer [soft] 160 bytes per 20ms

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101

2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5504 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Set rtp dtmf delay to 40

2015-10-09 17:13:08.720433 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090!

2015-10-09 17:13:08.720433 [DEBUG] switch_channel.c:3419 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change RINGING -> EARLY

2015-10-09 17:13:08.720433 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090:

v=0

o=FreeSWITCH 1444359130 1444359131 IN IP4 119.9.73.183

s=FreeSWITCH

c=IN IP4 119.9.73.183

t=0 0

m=audio 31858 RTP/AVP 3 101

a=rtpmap:3 GSM/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

a=sendrecv

2015-10-09 17:13:08.720433 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:08.720433 [NOTICE] mod_dptools.c:1378 Channel [sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090] has been answered

2015-10-09 17:13:08.720433 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:08.720433 [DEBUG] switch_channel.c:3711 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change EARLY -> ACTIVE

2015-10-09 17:13:08.720433 [DEBUG] sofia.c:6659 Channel sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 entering state [completed][200]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 sleep(1000)

2015-10-09 17:13:08.720433 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:08.860540 [DEBUG] sofia.c:6659 Channel sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 entering state [ready][200]

EXECUTE sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bridge(loopback/app=voicemail:default 119.9.73.183 1018)

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1786 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change ACTIVE -> RING_WAIT

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1221 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event

2015-10-09 17:13:09.740418 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables

2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1075 New Channel loopback/app=voicemail:default 119.9.73.183 1018-a [ea1cd2ec-6e7a-11e5-80e5-0d55cfaac62d]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:157 loopback/app=voicemail:default 119.9.73.183 1018-a setup codec GSM/8000/20

2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1073 Rename Channel loopback/app=voicemail:default 119.9.73.183 1018-a->loopback/voicemail-a [ea1cd2ec-6e7a-11e5-80e5-0d55cfaac62d]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:1160 (loopback/voicemail-a) State Change CS_NEW -> CS_INIT

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_INIT

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-a) State INIT

2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1075 New Channel loopback/voicemail-b [ea1cfa74-6e7a-11e5-80e9-0d55cfaac62d]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:157 loopback/voicemail-b setup codec GSM/8000/20

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:273 (loopback/voicemail-b) State Change CS_NEW -> CS_INIT

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:359 (loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-a) State INIT going to sleep

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_INIT

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-b) State INIT

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:359 (loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-b) State INIT going to sleep

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_ROUTING

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_ROUTING

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:2204 (loopback/voicemail-b) Callstate Change DOWN -> RINGING

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-a) State ROUTING

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:391 loopback/voicemail-a CHANNEL ROUTING

2015-10-09 17:13:09.740418 [DEBUG] switch_ivr_originate.c:67 (loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-a) State ROUTING going to sleep

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-b) State ROUTING

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:391 loopback/voicemail-b CHANNEL ROUTING

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:410 (loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-b) State ROUTING going to sleep

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_EXECUTE

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:547 (loopback/voicemail-a) State CONSUME_MEDIA

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:535 (loopback/voicemail-b) State EXECUTE

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:650 CHANNEL CONSUME_MEDIA

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:433 loopback/voicemail-b CHANNEL EXECUTE

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:547 (loopback/voicemail-a) State CONSUME_MEDIA going to sleep

2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:258 loopback/voicemail-b Standard EXECUTE

EXECUTE loopback/voicemail-b pre_answer()

2015-10-09 17:13:09.740418 [NOTICE] mod_loopback.c:947 Pre-Answer loopback/voicemail-a!

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3415 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3419 (loopback/voicemail-a) Callstate Change DOWN -> EARLY

2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:913 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:09.740418 [NOTICE] mod_dptools.c:1413 Pre-Answer loopback/voicemail-b!

2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3419 (loopback/voicemail-b) Callstate Change RINGING -> EARLY

EXECUTE loopback/voicemail-b voicemail(default 119.9.73.183 1018)

2015-10-09 17:13:09.740418 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:09.760410 [DEBUG] switch_ivr_originate.c:3581 Originate Resulted in Success: [loopback/voicemail-a]

2015-10-09 17:13:09.760410 [DEBUG] switch_channel.c:1999 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change RING_WAIT -> ACTIVE

2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:913 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:09.760410 [DEBUG] switch_ivr_bridge.c:1474 (loopback/voicemail-a) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA

2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:09.760410 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA

2015-10-09 17:13:09.760410 [DEBUG] switch_core_state_machine.c:538 (loopback/voicemail-a) State EXCHANGE_MEDIA

2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:612 CHANNEL LOOPBACK

2015-10-09 17:13:09.840422 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]

2015-10-09 17:13:09.860417 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-person.wav] (en:en)

2015-10-09 17:13:09.860417 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:11.200540 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-person.wav

2015-10-09 17:13:11.200540 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:11.320536 [DEBUG] switch_ivr_play_say.c:250 Handle say:[1018] (en:en)

2015-10-09 17:13:11.320536 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:13.340417 [DEBUG] switch_ivr_play_say.c:1747 done playing file file_string://digits/1.wav!digits/0.wav!digits/1.wav!digits/8.wav

2015-10-09 17:13:13.340417 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:13.460543 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-not_available.wav] (en:en)

2015-10-09 17:13:13.460543 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:14.440420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-not_available.wav

2015-10-09 17:13:14.440420 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:14.540443 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]

2015-10-09 17:13:14.560425 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-record_message.wav] (en:en)

2015-10-09 17:13:14.560425 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:19.140420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-record_message.wav

2015-10-09 17:13:19.140420 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:20.260422 [DEBUG] switch_ivr_play_say.c:593 Raw Codec Activated

2015-10-09 17:13:20.260422 [DEBUG] switch_core_codec.c:221 loopback/voicemail-b Push codec L16:100

2015-10-09 17:13:22.260461 [DEBUG] switch_core_codec.c:246 loopback/voicemail-b Restore previous codec GSM:3.

2015-10-09 17:13:22.260461 [DEBUG] mod_voicemail.c:1245 Message is less than minimum record length: 3, discarding it.

2015-10-09 17:13:22.260461 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]

2015-10-09 17:13:22.260461 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-too-small.wav] (en:en)

2015-10-09 17:13:22.280421 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:26.320413 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-too-small.wav

2015-10-09 17:13:26.320413 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:26.420413 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]

2015-10-09 17:13:26.420413 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-record_message.wav] (en:en)

2015-10-09 17:13:26.440408 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:31.020425 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-record_message.wav

2015-10-09 17:13:31.020425 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:32.140423 [DEBUG] switch_ivr_play_say.c:593 Raw Codec Activated

2015-10-09 17:13:32.140423 [DEBUG] switch_core_codec.c:221 loopback/voicemail-b Push codec L16:100

2015-10-09 17:13:34.140416 [DEBUG] switch_core_codec.c:246 loopback/voicemail-b Restore previous codec GSM:3.

2015-10-09 17:13:34.140416 [DEBUG] mod_voicemail.c:1245 Message is less than minimum record length: 3, discarding it.

2015-10-09 17:13:34.140416 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]

2015-10-09 17:13:34.140416 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-too-small.wav] (en:en)

2015-10-09 17:13:34.160413 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms

2015-10-09 17:13:37.100420 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:37.120420 [NOTICE] sofia.c:971 Hangup sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [CS_EXECUTE] [NORMAL_CLEARING]

2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [KILL]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090]

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:690 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:579 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 ending bridge by request from write function

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [loopback/voicemail-a]

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:37.120420 [NOTICE] switch_ivr_bridge.c:758 Hangup loopback/voicemail-a [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]

2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal loopback/voicemail-a [KILL]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:538 (loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (loopback/voicemail-a) Callstate Change EARLY -> HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-a) State HANGUP

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:537 loopback/voicemail-a CHANNEL HANGUP

2015-10-09 17:13:37.120420 [NOTICE] mod_loopback.c:553 Hangup loopback/voicemail-b [CS_EXECUTE] [ORIGINATOR_CANCEL]

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-too-small.wav

2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal loopback/voicemail-b [KILL]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-a Standard HANGUP, cause: ORIGINATOR_CANCEL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-a) State HANGUP going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:1572 loopback/voicemail-a skip receive message [UNBRIDGE] (channel is hungup already)

2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:1575 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 skip receive message [UNBRIDGE] (channel is hungup already)

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-a) State REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 loopback/voicemail-a Standard REPORTING, cause: ORIGINATOR_CANCEL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-a) State REPORTING going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:2767 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State EXECUTE going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 17 (loopback/voicemail-a) Locked, Waiting on external entities

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change ACTIVE -> HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State HANGUP

2015-10-09 17:13:37.120420 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hanging up, cause: NORMAL_CLEARING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard HANGUP, cause: NORMAL_CLEARING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State HANGUP going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_HANGUP -> CS_REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard REPORTING, cause: NORMAL_CLEARING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State REPORTING going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:2767 loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:535 (loopback/voicemail-b) State EXECUTE going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_REPORTING -> CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 16 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Locked, Waiting on external entities

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 16 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Ended

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [CS_DESTROY]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (loopback/voicemail-b) Callstate Change EARLY -> HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-b) State HANGUP

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:537 loopback/voicemail-b CHANNEL HANGUP

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-b Standard HANGUP, cause: ORIGINATOR_CANCEL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-b) State HANGUP going to sleep

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 17 (loopback/voicemail-a) Ended

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel loopback/voicemail-a [CS_DESTROY]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (loopback/voicemail-a) Running State Change CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-b) State REPORTING

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State DESTROY

2015-10-09 17:13:37.120420 [DEBUG] mod_sofia.c:323 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SOFIA DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 loopback/voicemail-b Standard REPORTING, cause: ORIGINATOR_CANCEL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-b) State REPORTING going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1014@119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State DESTROY going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-a) State DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 loopback/voicemail-a Standard DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-a) State DESTROY going to sleep

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK]

2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL

2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 18 (loopback/voicemail-b) Locked, Waiting on external entities

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 18 (loopback/voicemail-b) Ended

2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel loopback/voicemail-b [CS_DESTROY]

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (loopback/voicemail-b) Running State Change CS_DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-b) State DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 loopback/voicemail-b Standard DESTROY

2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-b) State DESTROY going to sleep

2015-10-09 17:15:01.140419 [NOTICE] mod_cdr_csv.c:123 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/Master.csv

2015-10-09 17:15:01.140419 [NOTICE] mod_logfile.c:213 New log started.

Thanks in advance !!!

Utkarsh

[Freeswitch-users] Audio problems in freeswitch

Utkarsh Singh