Evening All,
Bit of a newbie question here and I know that there are numerous posts already regarding CID and the Linksys/Cisco/Sipura SPA3102, but here goes anyway! :roll:
I'm using 3CX v10, with the SPA 3102 (Open - Firmware version 5.2.13) in gateway mode, and a few Intertel 8620 phones for a home/SOHO setup.
When an incoming call arrives on the PSTN (UK BT), I can see that the Linksys is parsing the caller ID ok, and also that this is being passed to the 3CX as the ID is visible in the activity log and shows as
"Incoming call from 078xxxxxxxx@(Ln.10000@BT Line)" (I've blanked the digits)
But nothing gets passed to the endpoint(s) other than the gateway extension number. When an incoming call arrives via VOIP, the number is displayed correctly.
This is the log showing a PSTN call followed by a VOIP call:
Can anyone make out why this should be and is there anything I should try first?
Thanks in advance
Bit of a newbie question here and I know that there are numerous posts already regarding CID and the Linksys/Cisco/Sipura SPA3102, but here goes anyway! :roll:
I'm using 3CX v10, with the SPA 3102 (Open - Firmware version 5.2.13) in gateway mode, and a few Intertel 8620 phones for a home/SOHO setup.
When an incoming call arrives on the PSTN (UK BT), I can see that the Linksys is parsing the caller ID ok, and also that this is being passed to the 3CX as the ID is visible in the activity log and shows as
"Incoming call from 078xxxxxxxx@(Ln.10000@BT Line)" (I've blanked the digits)
But nothing gets passed to the endpoint(s) other than the gateway extension number. When an incoming call arrives via VOIP, the number is displayed correctly.
This is the log showing a PSTN call followed by a VOIP call:
Code:
19:30:49.346|.\CallLeg.cpp(143)|Log5||CallLeg::onNewCall:[CM500002]: Info on incoming INVITE:
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 192.168.1.200:5062;branch=z9hG4bK-942f0d3e
Max-Forwards: 70
Contact: "10000"<sip:[email protected]:5062>
To: <sip:[email protected]>
From: "10000"<sip:[email protected]>;tag=339883b436416a2o1
Call-ID: [email protected]
CSeq: 102 INVITE
Expires: 240
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Proxy-Authorization: Digest username="10000",realm="3CXPhoneSystem",nonce="414d535c05f2a7d941:a24fa31ba3c31b22170e8250ddb184d6",uri="sip:[email protected]",algorithm=MD5,response="b04b7b794b5105f14d72ac0800207e84"
Supported: x-sipura, replaces
User-Agent: Linksys/SPA3102-5.2.13(GW002)
Content-Length: 0
Remote-Party-ID: 10000 <sip:[email protected]>;screen=yes;party=calling
<br>
19:30:49.362|.\Line.cpp(301)|Log5||LineCfg::getInboundTarget:Looking for inbound target: called=10000; caller=078xxxxxxxx<br>
19:30:49.362|.\Line.cpp(352)|Log2||LineCfg::getInboundTarget:[CM503012]: Inbound any hours rule (*) for 10000 forwards to DN:901<br>
19:30:49.393|.\CallCtrl.cpp(346)|Log2||CallCtrl::onIncomingCall:[CM503001]: Call(7): Incoming call from 078xxxxxxxx@(Ln.10000@BT Line) to <sip:[email protected]:5060><br>
19:30:49.393|.\Line.cpp(1452)|Log2||Line::printEndpointInfo:[CM505002]: Gateway:[BT Line] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.2.13(GW002)] PBX contact: [sip:[email protected]:5060]<br>
19:30:49.393|.\CallLeg.cpp(1194)|Log5||CallLeg::setRemoteSdp:Remote SDP is set for legC:7.1<br>
19:30:49.393|.\SLServer.cpp(861)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210000] C:7.1:Offer received. RTP connection: 192.168.1.200:16398(16399)<br>
19:30:49.393|.\CallCtrl.cpp(529)|Log3||CallCtrl::onSelectRouteReq:[CM503010]: Making route(s) to <sip:[email protected]:5060><br>
19:30:49.393|.\CallCtrl.cpp(708)|Log2||CallCtrl::onSelectRouteReq:[CM503004]: Call(7): Route 1: Ext:Ext.901@[Dev:sip:[email protected]:5060]<br>
19:30:49.409|.\SLServer.cpp(861)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210006] C:7.2:Offer provided. Connection(by pass mode): 192.168.1.200:16398(16399)<br>
19:30:49.409|.\Target.cpp(441)|Log2||Target::makeOneInvite:[CM503025]: Call(7): Calling Ext:Ext.901@[Dev:sip:[email protected]:5060]<br>
19:30:49.549|.\CallLeg.cpp(315)|Log3||CallLeg::onAnswer:[CM503002]: Call(7): Alerting sip:[email protected]:5060<br>
19:30:49.549|.\Extension.cpp(1407)|Log3||Extension::printEndpointInfo:[CM505001]: Ext.901: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Inter-Tel 8620 0.0 Brcm Callctrl/1.5.1.0 MxSF/v3.2.6.26] PBX contact: [sip:[email protected]:5060]<br>
19:30:55.081|.\Call.cpp(1396)|Log2||Call::Terminate:[CM503008]: Call(7): Call is terminated<br>
19:30:55.206|.\CallLeg.cpp(326)|Log2||CallLeg::onFailure:[CM503003]: Call(7): Call to sip:[email protected]:5060 has failed; Cause: 487 Request Terminated; from IP:192.168.1.41:5060<br>
19:31:03.300|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:31:35.301|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:32:05.317|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:32:37.318|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:33:09.319|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:33:41.320|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:34:13.320|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:34:45.321|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:35:17.322|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:35:47.620|.\StunClient.cpp(356)|Log2|STUN|StunClient::onInitTests:[CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server [ V4 199.192.206.228:3478 UDP target domain=unspecified mFlowKey=0 ] over Transport [ V4 192.168.1.127:5060 UDP target domain=unspecified mFlowKey=0 ]<br>
19:35:49.323|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:35:50.792|.\StunClient.cpp(411)|Log2|STUN|StunClient::onTestTout:[CM506004]: STUN request to STUN server 216.93.246.16:3478 has timed out; used Transport: [ V4 192.168.1.127:5060 UDP target domain=unspecified mFlowKey=0 ]<br>
19:35:53.885|.\StunClient.cpp(411)|Log2|STUN|StunClient::onTestTout:[CM506004]: STUN request to STUN server 216.93.246.16:3478 has timed out; used Transport: [ V4 192.168.1.127:5060 UDP target domain=unspecified mFlowKey=0 ]<br>
19:35:56.979|.\StunClient.cpp(411)|Log2|STUN|StunClient::onTestTout:[CM506004]: STUN request to STUN server 216.93.246.16:3478 has timed out; used Transport: [ V4 192.168.1.127:5060 UDP target domain=unspecified mFlowKey=0 ]<br>
19:36:00.057|.\StunClient.cpp(411)|Log2|STUN|StunClient::onTestTout:[CM506004]: STUN request to STUN server 216.93.246.16:3478 has timed out; used Transport: [ V4 192.168.1.127:5060 UDP target domain=unspecified mFlowKey=0 ]<br>
19:36:21.324|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:36:53.324|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:37:25.325|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:37:57.326|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:38:29.327|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:39:01.328|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:39:33.329|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:40:05.329|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:40:37.330|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:41:09.331|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:41:41.332|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:42:13.333|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:42:45.333|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:43:17.334|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:43:49.335|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:44:21.336|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:44:53.337|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:45:25.338|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:45:57.338|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:46:29.339|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:47:01.340|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:47:33.341|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:48:05.342|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:48:37.342|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:49:07.359|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:49:39.360|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:50:11.360|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:50:43.361|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:51:06.331|.\CallLeg.cpp(143)|Log5||CallLeg::onNewCall:[CM500002]: Info on incoming INVITE:
INVITE sip:[email protected]:5060;rinstance=011f41b110dcdef5 SIP/2.0
Via: SIP/2.0/UDP 217.10.79.23:5060;branch=z9hG4bK8b32.b274d6a2.0
Via: SIP/2.0/UDP 172.20.40.1;branch=z9hG4bK8b32.b274d6a2.0
Via: SIP/2.0/UDP 217.10.79.23:5060;received=217.10.68.222;branch=z9hG4bK68d325d1
Via: SIP/2.0/UDP 217.116.117.8:5060;received=217.116.117.8;branch=z9hG4bK68d325d1;rport=5060
Max-Forwards: 67
Record-Route: <sip:217.10.79.23;lr;ftag=as408a56a3>
Record-Route: <sip:172.20.40.1;lr=on>
Record-Route: <sip:217.10.79.23;lr;ftag=as408a56a3>
Contact: <sip:[email protected]>
To: <sip:[email protected]>
From: "078xxxxxxxx"<sip:[email protected]>;tag=as408a56a3
Call-ID: [email protected]
CSeq: 102 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Length: 0
<br>
19:51:06.346|.\Line.cpp(301)|Log5||LineCfg::getInboundTarget:Looking for inbound target: called=0044xxxxxxx171; caller=078xxxxxxxx<br>
19:51:06.346|.\Line.cpp(357)|Log2||LineCfg::getInboundTarget:[CM503012]: Inbound out-of-office hours rule (unnamed) for 10002 forwards to DN:905<br>
19:51:06.518|.\CallCtrl.cpp(346)|Log2||CallCtrl::onIncomingCall:[CM503001]: Call(8): Incoming call from 078xxxxxxxx@(Ln.10002@sipgate) to <sip:[email protected]:5060><br>
19:51:06.518|.\Line.cpp(1455)|Log2||Line::printEndpointInfo:[CM505003]: Provider:[sipgate] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] PBX contact: [sip:[email protected]:5060]<br>
19:51:06.518|.\CallLeg.cpp(1194)|Log5||CallLeg::setRemoteSdp:Remote SDP is set for legC:8.1<br>
19:51:06.518|.\SLServer.cpp(861)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210000] C:8.1:Offer received. RTP connection: 217.10.77.22:58604(58605)<br>
19:51:06.518|.\CallCtrl.cpp(529)|Log3||CallCtrl::onSelectRouteReq:[CM503010]: Making route(s) to <sip:[email protected]:5060><br>
19:51:06.518|.\CallCtrl.cpp(708)|Log2||CallCtrl::onSelectRouteReq:[CM503004]: Call(8): Route 1: Ext:Ext.905@[Dev:sip:[email protected]:5060]<br>
19:51:06.534|.\SLServer.cpp(861)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210002] C:8.2:Offer provided. Connection(transcoding mode): 192.168.1.127:7030(7031)<br>
19:51:06.549|.\Target.cpp(441)|Log2||Target::makeOneInvite:[CM503025]: Call(8): Calling Ext:Ext.905@[Dev:sip:[email protected]:5060]<br>
19:51:06.721|.\CallLeg.cpp(315)|Log3||CallLeg::onAnswer:[CM503002]: Call(8): Alerting sip:[email protected]:5060<br>
19:51:06.721|.\Extension.cpp(1407)|Log3||Extension::printEndpointInfo:[CM505001]: Ext.905: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Inter-Tel 8620 0.0 Brcm Callctrl/1.5.1.0 MxSF/v3.2.6.26] PBX contact: [sip:[email protected]:5060]<br>
19:51:13.596|.\Call.cpp(1396)|Log2||Call::Terminate:[CM503008]: Call(8): Call is terminated<br>
19:51:13.753|.\CallLeg.cpp(326)|Log2||CallLeg::onFailure:[CM503003]: Call(8): Call to sip:[email protected]:5060 has failed; Cause: 487 Request Terminated; from IP:192.168.1.45:5060<br>
19:51:15.362|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:51:47.363|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:52:19.364|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:52:51.380|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>
19:53:21.397|.\Call.cpp(48)|Log5||??:Currently active calls [none]<br>Can anyone make out why this should be and is there anything I should try first?
Thanks in advance
