<action application="log" data="INFO: ******************************************************************************"/> <action application="set" data="ringback=${uk-ring}"/> <action application="pre_answer"/> <action application="sleep" data="5000"/> <action application="log" data="INFO: ******************************************************************************"/> Results in EXECUTE sofia/internal/02070604380@87.238.73.146 log(INFO: ******************************************************************************) 2015-08-18 09:35:33.274143 [DEBUG] mod_dptools.c:1595 ****************************************************************************** EXECUTE sofia/internal/02070604380@87.238.73.146 set(ringback=%(400,200,400,450);%(400,2000,400,450)) 2015-08-18 09:35:33.274143 [DEBUG] mod_dptools.c:1402 sofia/internal/02070604380@87.238.73.146 SET [ringback]=[%(400,200,400,450);%(400,2000,400,450)] EXECUTE sofia/internal/02070604380@87.238.73.146 pre_answer() 2015-08-18 09:35:33.274143 [INFO] mod_dptools.c:1260 Sending early media 2015-08-18 09:35:33.274143 [DEBUG] sofia_glue.c:3449 AUDIO RTP [sofia/internal/02070604380@87.238.73.146] 176.9.31.72 port 13254 -> 87.238.73.160 port 19206 codec: 8 ms: 20 2015-08-18 09:35:33.274143 [DEBUG] switch_rtp.c:2033 Starting timer [soft] 160 bytes per 20ms 2015-08-18 09:35:33.274143 [DEBUG] sofia_glue.c:3716 Set 2833 dtmf send payload to 101 2015-08-18 09:35:33.274143 [DEBUG] sofia_glue.c:3722 Set 2833 dtmf receive payload to 101 2015-08-18 09:35:33.274143 [DEBUG] sofia_glue.c:3749 sofia/internal/02070604380@87.238.73.146 Set rtp dtmf delay to 40 2015-08-18 09:35:33.274143 [DEBUG] mod_sofia.c:2885 Ring SDP: v=0 o=FreeSWITCH 1439877279 1439877280 IN IP4 176.9.31.72 s=FreeSWITCH c=IN IP4 176.9.31.72 t=0 0 m=audio 13254 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 2015-08-18 09:35:33.274143 [NOTICE] mod_sofia.c:2888 Pre-Answer sofia/internal/02070604380@87.238.73.146! 2015-08-18 09:35:33.274143 [DEBUG] switch_channel.c:3367 (sofia/internal/02070604380@87.238.73.146) Callstate Change RINGING -> EARLY 2015-08-18 09:35:33.274143 [DEBUG] switch_core_session.c:871 Send signal sofia/internal/02070604380@87.238.73.146 [BREAK] EXECUTE sofia/internal/02070604380@87.238.73.146 sleep(5000) 2015-08-18 09:35:33.274143 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/02070604380@87.238.73.146 [BREAK] 2015-08-18 09:35:33.274143 [DEBUG] sofia.c:5811 Channel sofia/internal/02070604380@87.238.73.146 entering state [early][183] 2015-08-18 09:35:33.314141 [DEBUG] switch_rtp.c:3749 Correct ip/port confirmed. EXECUTE sofia/internal/02070604380@87.238.73.146 log(INFO: ******************************************************************************) 2015-08-18 09:35:38.274186 [DEBUG] mod_dptools.c:1595 ****************************************************************************** And I hear silence. I'm slightly concerned about who's responsible for all this work - I know that Anthony sometimes says "so which thread do you think is generating the sounds?" and I suspect this may be one of those cases. Trouble is, that dialplan often seems like magic to me!