Hi Nick,
here the log of ougoing call from ext 108 with rule 9 for GSM GW:
19:42:35.434|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.10.76 tid=909c8ad10ecf08684b9833fe8ecff3ac cseq=REGISTER
[email protected]:5060 / 4 from(wire)
19:42:35.434|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
19:42:35.434|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
19:42:35.434|.\Authorization.cpp(257)|Trace5|Authorization|AuthMgr:

nAuthSuccess:Caller <sip:
[email protected]>;tag=56db20ea has been authenticated successfully
19:42:35.434|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.10.76 tid=909c8ad10ecf08684b9833fe8ecff3ac cseq=REGISTER
[email protected]:5060 / 4 from(wire)
19:42:35.434|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:
[email protected] -> <sip:
[email protected]:5060>
19:42:35.554|.\Registrar.cpp(81)|Trace5|Registrar|ServRegs:

nAdd:Got registration from Ln:10001@Altesys;
Contacts: [<sip:
[email protected]:5060>]
19:42:35.554|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: OnHook; DN 10001
19:42:35.554|.\Registrar.cpp(83)|Log2|Registrar|ServRegs:

nAdd:Registered: Ln:10001@Altesys
19:42:35.554|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:
[email protected]
19:42:56.875|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for linksysspa3102 @ 3CXPhoneSystem
19:42:56.995|Helper.cxx(865)|Trace5|Resip|>>: username=linksysspa3102 password=carpediem realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.10.76 nonce=12825624851:685cac192583ca48c05237cb364f291c
19:42:56.995|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.10.76 tid=-1eadcccb cseq=REGISTER
[email protected]:5061 / 34165 from(wire)
19:42:56.995|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
19:42:56.995|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
19:42:56.995|.\Authorization.cpp(257)|Trace5|Authorization|AuthMgr:

nAuthSuccess:Caller "SPA-3102"<sip:
[email protected]>;tag=f6f9ea58c587do1 has been authenticated successfully
19:42:56.995|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.10.76 tid=-1eadcccb cseq=REGISTER
[email protected]:5061 / 34165 from(wire)
19:42:56.995|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:
[email protected] -> "SPA-3102"<sip:
[email protected]:5061>;expires=60
19:42:56.995|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:
[email protected]
19:43:27.249|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
19:43:55.199|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for linksysspa3102 @ 3CXPhoneSystem
19:43:55.299|Helper.cxx(865)|Trace5|Resip|>>: username=linksysspa3102 password=carpediem realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.10.76 nonce=12825624851:685cac192583ca48c05237cb364f291c
19:43:55.299|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.10.76 tid=-639febba cseq=REGISTER
[email protected]:5061 / 34166 from(wire)
19:43:55.299|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
19:43:55.299|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
19:43:55.299|.\Authorization.cpp(257)|Trace5|Authorization|AuthMgr:

nAuthSuccess:Caller "SPA-3102"<sip:
[email protected]>;tag=f6f9ea58c587do1 has been authenticated successfully
19:43:55.299|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.10.76 tid=-639febba cseq=REGISTER
[email protected]:5061 / 34166 from(wire)
19:43:55.299|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:
[email protected] -> "SPA-3102"<sip:
[email protected]:5061>;expires=60
19:43:55.309|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:
[email protected]
19:44:27.246|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
19:44:53.504|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for linksysspa3102 @ 3CXPhoneSystem
19:44:53.624|Helper.cxx(865)|Trace5|Resip|>>: username=linksysspa3102 password=carpediem realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.10.76 nonce=12825624851:685cac192583ca48c05237cb364f291c
19:44:53.624|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.10.76 tid=-9c57585d cseq=REGISTER
[email protected]:5061 / 34167 from(wire)
19:44:53.624|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
19:44:53.624|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
19:44:53.624|.\Authorization.cpp(257)|Trace5|Authorization|AuthMgr:

nAuthSuccess:Caller "SPA-3102"<sip:
[email protected]>;tag=f6f9ea58c587do1 has been authenticated successfully
19:44:53.624|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.10.76 tid=-9c57585d cseq=REGISTER
[email protected]:5061 / 34167 from(wire)
19:44:53.624|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:
[email protected] -> "SPA-3102"<sip:
[email protected]:5061>;expires=60
19:44:53.634|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:
[email protected]
19:45:02.206|ServerAuthManager.cxx(363)|Trace5|Resip|>>:Sending challenge to SipReq: INVITE
[email protected] tid=ad943a3588da1635 cseq=INVITE
[email protected] / 44433 from(wire)
19:45:02.206|ServerAuthManager.cxx(41)|Trace5|Resip|>>:ServerAuth challenged request SipReq: INVITE
[email protected] tid=ad943a3588da1635 cseq=INVITE
[email protected] / 44433 from(wire)
19:45:02.316|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 108 @ 3CXPhoneSystem
19:45:02.326|Helper.cxx(865)|Trace5|Resip|>>: username=108 password=108001 realm=3CXPhoneSystem method=INVITE uri=sip:
[email protected] nonce=12825625502:8ee085a6dc21bee91d4a70801aaafcea
19:45:02.326|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: INVITE
[email protected] tid=d6b4c54554c41c45 cseq=INVITE
[email protected] / 44434 from(wire)
19:45:02.326|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
19:45:02.326|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
19:45:02.326|.\Authorization.cpp(257)|Trace5|Authorization|AuthMgr:

nAuthSuccess:Caller "StefanoGS"<sip:
[email protected]>;tag=bd5810a06271e409 has been authenticated successfully
19:45:02.326|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: INVITE
[email protected] tid=d6b4c54554c41c45 cseq=INVITE
[email protected] / 44434 from(wire)
19:45:02.326|.\CallMgr.cpp(285)|Trace5|CallControl|ADSFactory::createAppDialogSet:Creating ADS for INVITE
19:45:02.326|.\CallConf.cpp(405)|Trace5|CallControl|CallConf::CallConf:Call created: C:3B
19:45:02.326|.\CallConf.cpp(348)|Trace5|CallControl|CallConf::addCallLeg:Added leg# 1 to call C:3B
19:45:02.326|.\Call.cpp(1322)|Trace5|CallControl|CallLegImpl::CallLegImpl:Leg @L:1@C:3b is created
19:45:02.326|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAS_Start -> UAS_Offer
19:45:02.326|.\ISHandler.cpp(21)|Trace5|CallControl|ISHandler:

nNewSession:Incoming: sis=7156;oat=Offer;rl=INVITE sip:
[email protected] SIP/2.0
19:45:02.336|.\Endpoint.cpp(32)|Trace5|Endpoint|Endpoint::findSource:Settings for caller is found: CfgExt:108
19:45:02.336|.\Call.cpp(122)|Trace5|CallControl|CallLegImpl:

nIncoming:Endpoint is built: Ext.108
19:45:02.386|.\Call.cpp(661)|Trace5|CallControl|CallLegImpl::initMSEndpoint:Created internal MS endpoint for Ext.108: addr=192.168.10.76:7210
19:45:02.386|ServerInviteSession.cxx(91)|Trace5|Resip|>>:UAS_Offer: provisional(100)
19:45:02.386|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAS_Offer -> UAS_EarlyOffer
19:45:02.386|.\ISHandler.cpp(140)|Trace5|CallControl|ISHandler:

nReadyToSend:InviteSession(7156) sends SIP/2.0 100 Trying
19:45:02.386|.\CallConf.cpp(95)|Log2|CallControl|CallConf:

nIncoming:Call(C:3B): Incoming call from Ext.108 to sip:
[email protected]
19:45:02.386|.\CallStrategies.cpp(415)|Trace5|CallManager|StratInOut::initialize:Initialize InOut call strategy
19:45:02.497|.\DBAccessor.cpp(1033)|Trace5|DataBase|DBPostgressAccessor::findDestinationsEx:Will use outbound rule rule ID=5
19:45:02.627|.\CallTarget.cpp(359)|Trace5|CallManager|CT_Lines::selectNextTarget:Select new line for outbound call
19:45:02.657|.\Call.cpp(661)|Trace5|CallControl|CallLegImpl::initMSEndpoint:Created internal MS endpoint for Ln:10001@Altesys: addr=192.168.10.76:7212
19:45:02.657|.\CallConf.cpp(348)|Trace5|CallControl|CallConf::addCallLeg:Added leg# 2 to call C:3B
19:45:02.657|.\Call.cpp(1322)|Trace5|CallControl|CallLegImpl::CallLegImpl:Leg 10001@L:2@C:3b is created
19:45:02.657|.\CallTarget.cpp(372)|Trace5|CallManager|CT_Lines::selectNextTarget:Line Ln:10001@Altesys is found for outbound call
19:45:02.667|.\CallConf.cpp(107)|Trace5|CallControl|CallConf:

nIncoming:MediaServer could be used for this call
19:45:02.667|.\ISHandler.cpp(157)|Trace5|CallControl|ISHandler:

nOffer:Offered: is=7156; rl=INVITE sip:
[email protected] SIP/2.0
19:45:02.667|.\CallStrategies.cpp(605)|Trace5|CallManager|StratInOut:

nOffer:InOut: got offer from 108@L:1@C:3b
19:45:02.667|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Calling; DN 108
19:45:02.667|.\CallTarget.cpp(412)|Trace5|CallManager|CT_Lines::Invite:Rule (Cellulare3409709606): Placing call to line 10001@L:2@C:3b to reach 3287529064
19:45:03.077|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipResp: 100 tid=36093b291e64b35a cseq=INVITE
[email protected]:5060 / 1 from(wire)
19:45:03.188|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipResp: 180 tid=36093b291e64b35a cseq=INVITE
[email protected]:5060 / 1 from(wire)
19:45:03.188|Dialog.cxx(547)|Trace5|Resip|>>

ialog::dispatch, ignoring stray response: SipResp: 180 tid=36093b291e64b35a cseq=INVITE
[email protected]:5060 / 1 from(wire)
19:45:03.188|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAC_Start -> UAC_Early
19:45:03.188|.\ISHandler.cpp(31)|Trace5|CallControl|ISHandler:

nNewSession:Answered: sis=7159;oat=None;rl=SIP/2.0 180 Ringing
19:45:03.188|.\CallStrategies.cpp(561)|Trace5|CallManager|StratInOut:

nAnswered:Call from Ext.108 is answered on Ln:10001@Altesys
19:45:03.188|.\CallTarget.cpp(421)|Trace5|CallManager|CT_Lines::answered:Call is accepted on 10001@L:2@C:3b
19:45:03.188|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Ringing; DN 10001
19:45:03.188|ClientInviteSession.cxx(315)|Trace5|Resip|>>:UAC_Early: startStaleCallTimer
19:45:03.188|.\ISHandler.cpp(57)|Trace5|CallControl|ISHandler:

nProvisional

rovisional: cis=7159;rl=SIP/2.0 180 Ringing
19:45:03.188|.\CallConf.cpp(152)|Log2|CallControl|CallConf:

nProvisional:Call(C:3B): got response from 3287529064
19:45:03.188|.\CallStrategies.cpp(620)|Trace5|CallManager|StratInOut:

nProvisional:InOut: got provisional SIP/2.0 180 Ringing from 10001@L:2@C:3b
19:45:03.188|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Calling; DN 108
19:45:03.188|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Ringing; DN 10001
19:45:03.188|ServerInviteSession.cxx(91)|Trace5|Resip|>>:UAS_EarlyOffer: provisional(180)
19:45:03.188|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAS_EarlyOffer -> UAS_EarlyOffer
19:45:03.188|.\ISHandler.cpp(140)|Trace5|CallControl|ISHandler:

nReadyToSend:InviteSession(7156) sends SIP/2.0 180 Ringing
19:45:14.784|ServerAuthManager.cxx(50)|Trace5|Resip|>>:ServerAuth rejected request SipReq: REGISTER sip.baitech.net tid=622172 cseq=REGISTER
[email protected]:5070 / 64 from(wire)
19:45:27.162|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
19:45:48.724|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: CANCEL
[email protected] tid=d6b4c54554c41c45 cseq=CANCEL / 44434 from(wire)
19:45:48.724|.\ISHandler.cpp(140)|Trace5|CallControl|ISHandler:

nReadyToSend:InviteSession(7156) sends SIP/2.0 200 OK
19:45:48.724|.\ISHandler.cpp(140)|Trace5|CallControl|ISHandler:

nReadyToSend:InviteSession(7156) sends SIP/2.0 487 Request Terminated
19:45:48.724|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAS_EarlyOffer -> InviteSession::Terminated
19:45:48.724|.\ISHandler.cpp(100)|Trace5|CallControl|ISHandler:

nTerminated:Terminated: is=7156;reason=PeerEnded;rl=CANCEL sip:
[email protected] SIP/2.0
19:45:48.724|.\CallStrategies.cpp(690)|Trace5|CallManager|StratInOut:

nHangUp:InOut: got Hang-Up from 108@L:1@C:3b
19:45:48.724|.\CallStrategies.cpp(721)|Log2|CallManager|StratInOut:

nHangUp:Call(C:3B): Call from Ext.108 to 3287529064 has been terminated
19:45:48.724|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: OnHook; DN 108
19:45:48.724|.\CallConf.cpp(413)|Trace5|CallControl|CallConf::~CallConf

estroying call C:3B
19:45:48.734|.\CallStrategies.cpp(850)|Trace5|CallManager|StratInOut::~StratInOut:InOut: strategy is terminated
19:45:48.734|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: OnHook; DN 10001
19:45:48.734|ClientInviteSession.cxx(174)|Trace5|Resip|>>:UAC_Early: end
19:45:48.734|InviteSession.cxx(2360)|Trace5|Resip|>>:"3409709606"<sip:
[email protected]>;tag=047bd354 Sending BYE
19:45:48.744|.\ISHandler.cpp(140)|Trace5|CallControl|ISHandler:

nReadyToSend:InviteSession(7159) sends BYE sip:
[email protected]:5060 SIP/2.0
19:45:48.744|InviteSession.cxx(2046)|Trace5|Resip|>>:Transition UAC_Early -> InviteSession::Terminated
19:45:48.744|.\ISHandler.cpp(101)|Trace5|CallControl|ISHandler:

nTerminated:Terminated: is=7159;reason=Ended
19:45:48.744|.\Call.cpp(1344)|Trace5|CallControl|CallLegImpl::~CallLegImpl:Leg 10001@L:2@C:3b is destroyed
19:45:48.744|.\Call.cpp(1344)|Trace5|CallControl|CallLegImpl::~CallLegImpl:Leg 108@L:1@C:3b is destroyed
19:45:48.964|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipResp: 200 tid=721d962ef05df163 cseq=BYE / 2 from(wire)
Thanks
Stefano