Simple dial problem

i use
Linux ubuntu 3.0.0-13-server x86_64 GNU/Linux
Asterisk 1.8.4.4~dfsg-2ubuntu1
FreePBX 2.9.0.7
add 2 extension (1001, 1002) from FreePbx. in another softphones i registered them. When i call from 1001 to 1002 calling immediately hung up. my debug log its

== Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Executing [[email protected]:1] ExecIf("SIP/5151312-0000000a", "0?Set(__RINGTIMER=0)") in new stack
    -- Executing [[email protected]:2] Macro("SIP/5151312-0000000a", "exten-vm,novm,1001,0,0,0") in new stack
    -- Executing [[email protected]:1] Macro("SIP/5151312-0000000a", "user-callerid,") in new stack
    -- Executing [[email protected]:1] Set("SIP/5151312-0000000a", "AMPUSER=5151312") in new stack
    -- Executing [[email protected]:2] GotoIf("SIP/5151312-0000000a", "0?report") in new stack
    -- Executing [[email protected]:3] ExecIf("SIP/5151312-0000000a", "1?Set(REALCALLERIDNUM=5151312)") in new stack
    -- Executing [[email protected]:4] Set("SIP/5151312-0000000a", "AMPUSER=5151312") in new stack
    -- Executing [[email protected]:5] Set("SIP/5151312-0000000a", "AMPUSERCIDNAME=5151312") in new stack
    -- Executing [[email protected]:6] GotoIf("SIP/5151312-0000000a", "0?report") in new stack
    -- Executing [[email protected]:7] Set("SIP/5151312-0000000a", "AMPUSERCID=5151312") in new stack
    -- Executing [[email protected]:8] Set("SIP/5151312-0000000a", "CALLERID(all)="5151312" <5151312>") in new stack
    -- Executing [[email protected]:9] GotoIf("SIP/5151312-0000000a", "0?limit") in new stack
    -- Executing [[email protected]:10] ExecIf("SIP/5151312-0000000a", "0?Set(GROUP(concurrency_limit)=5151312)") in new stack
    -- Executing [[email protected]:11] GotoIf("SIP/5151312-0000000a", "0?continue") in new stack
    -- Executing [[email protected]:12] Set("SIP/5151312-0000000a", "__TTL=64") in new stack
    -- Executing [[email protected]:13] GotoIf("SIP/5151312-0000000a", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,24)
    -- Executing [[email protected]er-callerid:24] Set("SIP/5151312-0000000a", "CALLERID(number)=5151312") in new stack
    -- Executing [[email protected]:25] Set("SIP/5151312-0000000a", "CALLERID(name)=5151312") in new stack
    -- Executing [[email protected]:26] Set("SIP/5151312-0000000a", "CHANNEL(language)=en") in new stack
    -- Executing [[email protected]:2] Set("SIP/5151312-0000000a", "RingGroupMethod=none") in new stack
    -- Executing [[email protected]:3] Set("SIP/5151312-0000000a", "__EXTTOCALL=1001") in new stack
    -- Executing [[email protected]:4] Set("SIP/5151312-0000000a", "__PICKUPMARK=1001") in new stack
    -- Executing [[email protected]:5] Set("SIP/5151312-0000000a", "RT=""") in new stack
    -- Executing [[email protected]:6] Macro("SIP/5151312-0000000a", "record-enable,1001,IN") in new stack
    -- Executing [[email protected]:1] GotoIf("SIP/5151312-0000000a", "1?check") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing [[email protected]:4] ExecIf("SIP/5151312-0000000a", "0?MacroExit()") in new stack
    -- Executing [[email protected]:5] GotoIf("SIP/5151312-0000000a", "0?Group:OUT") in new stack
    -- Goto (macro-record-enable,s,14)
    -- Executing [[email protected]:14] GotoIf("SIP/5151312-0000000a", "1?IN") in new stack
    -- Goto (macro-record-enable,s,18)
    -- Executing [[email protected]:18] ExecIf("SIP/5151312-0000000a", "1?MacroExit()") in new stack
    -- Executing [[email protected]:7] Macro("SIP/5151312-0000000a", "dial-one,"",tr,1001") in new stack
    -- Executing [[email protected]:1] Set("SIP/5151312-0000000a", "DEXTEN=1001") in new stack
    -- Executing [[email protected]:2] Set("SIP/5151312-0000000a", "DIALSTATUS_CW=") in new stack
[Dec  3 13:07:52] WARNING[2165]: pbx.c:4054 pbx_extension_helper: No application 'GosubIf' for extension (macro-dial-one, s, 3)
  == Spawn extension (macro-dial-one, s, 3) exited non-zero on 'SIP/5151312-0000000a' in macro 'dial-one'
  == Spawn extension (macro-exten-vm, s, 7) exited non-zero on 'SIP/5151312-0000000a' in macro 'exten-vm'
  == Spawn extension (from-internal, 1001, 2) exited non-zero on 'SIP/5151312-0000000a'
    -- Executing [[email protected]:1] Hangup("SIP/5151312-0000000a", "") in new stack
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/5151312-0000000a'
[Dec  3 13:08:05] WARNING[1178]: chan_sip.c:3551 retrans_pkt: Retransmission timeout reached on transmission [email protected] for seqno 2 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 12416ms with no response