Hey all, I am creating a WebRTC interface for work that interfaces to our legacy intercom system. I have set up my span in FreeTDM as analog_em and have green lights all around for signaling. I need to be able to originate the DS0 into a conference, but attempting to do so causes the extension to ring for about 30 sec before finally going from DIALING to BUSY. I believe the endpoint isn't being answered. I had this working successfully in Asterisk by setting immediate=yes in chan_dahdi.conf. I found sip_auto_answer, and immediate_accept in the open_r2 module, but nothing for analog_em. I have nothing that would let me configure this on my conferencing switch, but believe there must be a way to configure it from my side as Asterisk could do it. Any help is greatly appreciated. Thanks, JD Some info: Freetdm.conf: [span zt OIS] trunk_type => EM em-channel => 1-24 freetdm.conf.xml: <analog_em_spans> <span name="OIS"> <param name="dialplan" value="XML"/> <param name="context" value="basic"/> </span> </analog_em_spans> Dialplan: <context name="basic"> <extension name="conf1"> <condition field="destination_number" expression="^200$"> <app name="answer"/> <action application="conference" data="conf1"/> </condition> </extension> </context> freeswitch@internal> ftdm list +OK span: 1 (OIS) type: analog_em physical_status: ok signaling_status: UP chan_count: 24 dialplan: XML context: basic dial_regex: fail_dial_regex: hold_music: analog_options: none freeswitch@internal> ftdm dump 1 1 span_id: 1 chan_id: 1 physical_span_id: 1 physical_chan_id: 1 physical_status: ok physical_status_red: 0 physical_status_yellow: 0 physical_status_rai: 0 physical_status_blue: 0 physical_status_ais: 0 physical_status_general: 0 signaling_status: UP type: EM state: DOWN last_state: DOWN txgain: 0.00 rxgain: 0.00 cid_date: cid_name: cid_num: ani: aniII: dnis: rdnis: cause: NONE session: (none) -- No state history - freeswitch@internal> bgapi originate freetdm/1/1 200 +OK Job-UUID: 603fb938-e214-11e4-97e6-43b5b7de6600 freeswitch@internal> 2015-04-13 15:36:26.979819 [DEBUG] switch_ivr_originate.c:2100 Parsing global variables 2015-04-13 15:36:26.979819 [INFO] ftmod_zt.c:671 Setting echo cancel to 64 taps for 1:1 2015-04-13 15:36:26.979819 [DEBUG] mod_freetdm.c:403 Set codec PCMU 20ms 2015-04-13 15:36:26.979819 [DEBUG] mod_freetdm.c:1251 Connect outbound channel FreeTDM/1:1/ 2015-04-13 15:36:26.979819 [NOTICE] switch_channel.c:1055 New Channel FreeTDM/1:1/ [603fc6f8-e214-11e4-97e8-43b5b7de6600] 2015-04-13 15:36:26.979819 [DEBUG] mod_freetdm.c:1260 (FreeTDM/1:1/) State Change CS_NEW -> CS_INIT 2015-04-13 15:36:26.979819 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:26.979819 [DEBUG] mod_freetdm.c:1279 Attached session 603fc6f8-e214-11e4-97e8-43b5b7de6600 to channel 1:1 2015-04-13 15:36:26.979819 [DEBUG] ftmod_zt.c:754 [s1c1][1:1] Channel is now offhook 2015-04-13 15:36:26.979819 [DEBUG] ftmod_analog_em.c:168 [s1c1][1:1] Changed state from DOWN to DIALING 2015-04-13 15:36:26.979819 [DEBUG] ftmod_analog_em.c:528 ANALOG EM CHANNEL thread starting. 2015-04-13 15:36:26.979819 [INFO] ftmod_zt.c:671 Setting echo cancel to 64 taps for 1:1 2015-04-13 15:36:26.999821 [DEBUG] ftdm_io.c:3395 [s1c1][1:1] Enabled software DTMF detector 2015-04-13 15:36:26.999821 [DEBUG] ftmod_analog_em.c:565 [s1c1][1:1] IO Interval: 20 2015-04-13 15:36:26.999821 [DEBUG] ftmod_analog_em.c:708 [s1c1][1:1] Completed state change from DOWN to DIALING in 1 ms 2015-04-13 15:36:26.999821 [DEBUG] ftmod_analog_em.c:712 Executing state handler on 1:1 for DIALING 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:472 (FreeTDM/1:1/) Running State Change CS_INIT 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:512 (FreeTDM/1:1/) State INIT 2015-04-13 15:36:27.479818 [DEBUG] mod_freetdm.c:430 (FreeTDM/1:1/) State Change CS_INIT -> CS_ROUTING 2015-04-13 15:36:27.479818 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:512 (FreeTDM/1:1/) State INIT going to sleep 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:472 (FreeTDM/1:1/) Running State Change CS_ROUTING 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:528 (FreeTDM/1:1/) State ROUTING 2015-04-13 15:36:27.479818 [DEBUG] mod_freetdm.c:453 FreeTDM/1:1/ CHANNEL ROUTING 2015-04-13 15:36:27.479818 [DEBUG] switch_ivr_originate.c:67 (FreeTDM/1:1/) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2015-04-13 15:36:27.479818 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:528 (FreeTDM/1:1/) State ROUTING going to sleep 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:472 (FreeTDM/1:1/) Running State Change CS_CONSUME_MEDIA 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:547 (FreeTDM/1:1/) State CONSUME_MEDIA 2015-04-13 15:36:27.479818 [DEBUG] switch_core_state_machine.c:547 (FreeTDM/1:1/) State CONSUME_MEDIA going to sleep 2015-04-13 15:36:27.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:28.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:29.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:30.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:31.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:32.979818 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:33.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:34.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:35.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:36.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:37.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:38.979821 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:39.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:40.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:41.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:42.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:43.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:44.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:45.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:46.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:47.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:48.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:49.979818 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:50.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:51.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:52.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:53.979819 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:54.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:55.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:56.979820 [DEBUG] ftmod_analog_em.c:628 [s1c1][1:1] CAS bits: 0x0 2015-04-13 15:36:56.999820 [DEBUG] ftmod_analog_em.c:620 [s1c1][1:1] Changed state from DIALING to BUSY 2015-04-13 15:36:57.019820 [DEBUG] ftmod_analog_em.c:708 [s1c1][1:1] Completed state change from DIALING to BUSY in 20 ms 2015-04-13 15:36:57.019820 [DEBUG] ftmod_analog_em.c:712 Executing state handler on 1:1 for BUSY 2015-04-13 15:36:57.019820 [DEBUG] ftmod_analog_em.c:789 [s1c1][1:1] Changed state from BUSY to DOWN 2015-04-13 15:36:57.039820 [DEBUG] ftmod_analog_em.c:708 [s1c1][1:1] Completed state change from BUSY to DOWN in 20 ms 2015-04-13 15:36:57.039820 [DEBUG] ftmod_analog_em.c:712 Executing state handler on 1:1 for DOWN 2015-04-13 15:36:57.039820 [DEBUG] mod_freetdm.c:2262 got FXO sig 1:1 [STOP] 2015-04-13 15:36:57.039820 [NOTICE] mod_freetdm.c:2282 Hangup FreeTDM/1:1/ [CS_CONSUME_MEDIA] [NORMAL_CIRCUIT_CONGESTION] 2015-04-13 15:36:57.039820 [DEBUG] switch_channel.c:3222 Send signal FreeTDM/1:1/ [KILL] 2015-04-13 15:36:57.039820 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:57.039820 [DEBUG] ftmod_zt.c:765 [s1c1][1:1] Channel is now onhook 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:472 (FreeTDM/1:1/) Running State Change CS_HANGUP 2015-04-13 15:36:57.039820 [DEBUG] ftdm_io.c:3194 [s1c1][1:1] DTMF debug is already disabled 2015-04-13 15:36:57.039820 [DEBUG] ftdm_io.c:3226 [s1c1][1:1] No need to disable input dump 2015-04-13 15:36:57.039820 [DEBUG] ftdm_io.c:3257 [s1c1][1:1] No need to disable output dump 2015-04-13 15:36:57.039820 [DEBUG] ftdm_io.c:6873 Cleared call with id 2 2015-04-13 15:36:57.039820 [DEBUG] ftdm_io.c:2999 [s1c1][1:1] channel done 2015-04-13 15:36:57.039820 [DEBUG] ftmod_analog_em.c:993 ANALOG EM CHANNEL thread ended. 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:735 (FreeTDM/1:1/) Callstate Change DOWN -> HANGUP 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:737 (FreeTDM/1:1/) State HANGUP 2015-04-13 15:36:57.039820 [DEBUG] mod_freetdm.c:544 [1:1] FreeTDM/1:1/ CHANNEL HANGUP ENTER 2015-04-13 15:36:57.039820 [DEBUG] mod_freetdm.c:569 Device [1:1] is no longer attached to FreeTDM/1:1/ 2015-04-13 15:36:57.039820 [DEBUG] mod_freetdm.c:643 [1:1] FreeTDM/1:1/ CHANNEL HANGUP EXIT 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:60 FreeTDM/1:1/ Standard HANGUP, cause: NORMAL_CIRCUIT_CONGESTION 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:737 (FreeTDM/1:1/) State HANGUP going to sleep 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:504 (FreeTDM/1:1/) State Change CS_HANGUP -> CS_REPORTING 2015-04-13 15:36:57.039820 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:472 (FreeTDM/1:1/) Running State Change CS_REPORTING 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:823 (FreeTDM/1:1/) State REPORTING 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:104 FreeTDM/1:1/ Standard REPORTING, cause: NORMAL_CIRCUIT_CONGESTION 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:823 (FreeTDM/1:1/) State REPORTING going to sleep 2015-04-13 15:36:57.039820 [DEBUG] switch_core_state_machine.c:498 (FreeTDM/1:1/) State Change CS_REPORTING -> CS_DESTROY 2015-04-13 15:36:57.039820 [DEBUG] switch_core_session.c:1396 Send signal FreeTDM/1:1/ [BREAK] 2015-04-13 15:36:57.039820 [DEBUG] switch_core_session.c:1623 Session 2 (FreeTDM/1:1/) Locked, Waiting on external entities 2015-04-13 15:36:57.059821 [DEBUG] switch_ivr_originate.c:3720 Originate Resulted in Error Cause: 34 [NORMAL_CIRCUIT_CONGESTION] 2015-04-13 15:36:57.059821 [NOTICE] switch_core_session.c:1641 Session 2 (FreeTDM/1:1/) Ended 2015-04-13 15:36:57.059821 [NOTICE] switch_core_session.c:1645 Close Channel FreeTDM/1:1/ [CS_DESTROY] 2015-04-13 15:36:57.059821 [DEBUG] switch_core_state_machine.c:626 (FreeTDM/1:1/) Running State Change CS_DESTROY 2015-04-13 15:36:57.059821 [DEBUG] switch_core_state_machine.c:636 (FreeTDM/1:1/) State DESTROY 2015-04-13 15:36:57.059821 [DEBUG] switch_core_state_machine.c:111 FreeTDM/1:1/ Standard DESTROY 2015-04-13 15:36:57.059821 [DEBUG] switch_core_state_machine.c:636 (FreeTDM/1:1/) State DESTROY going to sleep