Message Saving Failed (On PSTN calls SPA3102) (resolved)

Status
Not open for further replies.

FGCUHank

Joined
Feb 27, 2010
Messages
100
Reaction score
0
I'm a new 3CX convert, now currently dumping 2 asterisk now and 2 asterisk business editions at home and three of my sites. Setup was a no brainer.

Side question before I get into my question. Is Nick Galea the same Nick from GFI and 2x? I love and still have those products at customer sites.



I have a spa3102 and inbound/outbound calls are working from the pots line.

I'm waiting for a DID from my voip provider to see if this condition exists on voip trunks as well.

On inbound calls from the POTS through the spa I receive a message saving failed when trying to leave a message.

However on internal calls, extension to extension, message saving works.

Any ideas would be greatly appreciated.

Thanks
Hank

Sorry for the bad log posting.


Time Message
00:04:10.140

[CM503008]: Call(107): Call is terminated

00:03:53.233

[CM503007]: Call(107): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

00:03:53.233

[CM503007]: Call(107): Device joined: sip:[email protected]:5062

00:03:53.218

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

00:03:53.218

[CM503002]: Call(107): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

00:03:53.108

[CM503003]: Call(107): Call to sip:[email protected] has failed; Cause: 487 Request Terminated; from IP:192.168.3.7:5060

00:03:53.061

[CM503025]: Call(107): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

00:03:53.046

[CM503005]: Call(107): Forwarding: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

00:03:44.843

Active calls counted toward license limit: [107]

00:03:23.077

[CM505001]: Ext.10: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

00:03:23.077

[CM503002]: Call(107): Alerting sip:[email protected]:5060

00:03:22.999

[CM503025]: Call(107): Calling Ext:Ext.10@[Dev:sip:[email protected]:5060]

00:03:22.968

[CM503004]: Call(107): Route 1: Ext:Ext.10@[Dev:sip:[email protected]:5060]

00:03:22.968

[CM503010]: Making route(s) to <sip:[email protected]:5060>

00:03:22.952

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

00:03:22.936

[CM503001]: Call(107): Incoming call from *10001@(Ln.10001@SPA-3102) to <sip:[email protected]:5060>

00:03:22.936

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:10

00:03:12.843

Active calls counted toward license limit: []

00:02:40.843

Active calls counted toward license limit: []

00:02:08.843

Active calls counted toward license limit: []

00:01:44.296

[CM503008]: Call(106): Call is terminated

00:01:36.843

Active calls counted toward license limit: [106]

00:01:25.640

[CM503007]: Call(106): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

00:01:25.624

[CM503007]: Call(106): Device joined: sip:[email protected]:5062

00:01:25.624

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

00:01:25.624

[CM503002]: Call(106): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

00:01:25.608

[CM503003]: Call(106): Call to sip:[email protected] has failed; Cause: 487 Request Terminated; from IP:192.168.3.7:5060

00:01:25.265

[CM503025]: Call(106): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

00:01:25.249

[CM503005]: Call(106): Forwarding: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

00:01:04.843

Active calls counted toward license limit: [106]

00:00:55.530

[CM505001]: Ext.10: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

00:00:55.530

[CM503002]: Call(106): Alerting sip:[email protected]:5060

00:00:55.249

[CM503025]: Call(106): Calling Ext:Ext.10@[Dev:sip:[email protected]:5060]

00:00:55.202

[CM503004]: Call(106): Route 1: Ext:Ext.10@[Dev:sip:[email protected]:5060]

00:00:55.202

[CM503010]: Making route(s) to <sip:[email protected]:5060>

00:00:55.202

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

00:00:55.186

[CM503001]: Call(106): Incoming call from *10001@(Ln.10001@SPA-3102) to <sip:[email protected]:5060>

00:00:55.186

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:10

00:00:32.843

Active calls counted toward license limit: []

2010/02/27 >>00:00:00.843

Active calls counted toward license limit: []

23:59:28.843

Active calls counted toward license limit: []

23:58:56.843

Active calls counted toward license limit: []

23:58:24.843

Active calls counted toward license limit: []

23:57:52.843

Active calls counted toward license limit: []

23:57:28.952

[CM503008]: Call(105): Call is terminated

23:57:20.843

Active calls counted toward license limit: [105]

23:57:13.061

[CM503007]: Call(105): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

23:57:13.061

[CM503007]: Call(105): Device joined: sip:[email protected]:5060

23:57:13.046

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

23:57:13.046

[CM503002]: Call(105): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:57:12.936

[CM503003]: Call(105): Call to sip:[email protected] has failed; Cause: 487 Request Terminated; from IP:192.168.3.7:5060

23:57:12.921

[CM503025]: Call(105): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:57:12.905

[CM503005]: Call(105): Forwarding: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:56:48.843

Active calls counted toward license limit: [105]

23:56:42.983

[CM505001]: Ext.10: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:56:42.983

[CM503002]: Call(105): Alerting sip:[email protected]:5060

23:56:42.858

[CM503025]: Call(105): Calling Ext:Ext.10@[Dev:sip:[email protected]:5060]

23:56:42.827

[CM503004]: Call(105): Route 1: Ext:Ext.10@[Dev:sip:[email protected]:5060]

23:56:42.827

[CM503010]: Making route(s) to <sip:[email protected];user=phone>

23:56:42.811

[CM505001]: Ext.14: Device info: Device Identified: [Man: Polycom;Mod: SoundPoint IP Series;Rev: General] Capabilities:[reinvite, replaces, unable-no-sdp, no-recvonly] UserAgent: [PolycomSoundPointIP-SPIP_550-UA/2.2.2.0084] PBX contact: [sip:[email protected]:5060]

23:56:42.796

[CM503001]: Call(105): Incoming call from Ext.14 to <sip:[email protected];user=phone>

23:56:26.124

[CM306003]: SIP IP:port mapping (71.54.11.98:1024) resolved by STUN server 94.228.101.70:3478 differs from the one (71.54.11.98:5060 resolved by STUN server 193.200.249.2

23:56:26.108

[CM306003]: SIP IP:port mapping (71.54.11.98:5060) resolved by STUN server 94.228.101.70:3478 differs from the one (71.54.11.98:1024 resolved by STUN server 193.200.249.2

23:56:25.577

[CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 94.228.101.70:3478 over Transport 192.168.3.1:5060

23:56:25.577

[CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 94.228.101.70:3478 over Transport 192.168.3.4:5060

23:56:16.843

Active calls counted toward license limit: []

23:55:44.843

Active calls counted toward license limit: []

23:55:12.843

Active calls counted toward license limit: []

23:54:40.843

Active calls counted toward license limit: []

23:54:08.843

Active calls counted toward license limit: []

23:53:39.124

[CM503008]: Call(104): Call is terminated

23:53:36.843

Active calls counted toward license limit: [104]

23:53:22.593

[CM503007]: Call(104): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

23:53:22.593

[CM503007]: Call(104): Device joined: sip:[email protected]:5062

23:53:22.577

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

23:53:22.577

[CM503002]: Call(104): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:53:22.421

[CM503025]: Call(104): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:53:22.374

[CM503004]: Call(104): Route 1: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:53:22.374

[CM503010]: Making route(s) to <sip:[email protected]:5060;user=vmail>

23:53:22.374

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:53:22.358

[CM503001]: Call(104): Incoming call from *10001@(Ln.10001@SPA-3102) to <sip:[email protected]:5060;user=vmail>

23:53:22.358

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to VM:14

23:53:04.843

Active calls counted toward license limit: []

23:53:01.671

[CM503008]: Call(103): Call is terminated

23:52:59.765

[CM503007]: Call(103): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

23:52:59.765

[CM503007]: Call(103): Device joined: sip:[email protected]:5062

23:52:59.749

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

23:52:59.749

[CM503002]: Call(103): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:52:59.593

[CM503025]: Call(103): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:52:59.561

[CM503004]: Call(103): Route 1: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:52:59.561

[CM503010]: Making route(s) to <sip:[email protected]:5060;user=vmail>

23:52:59.561

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:52:59.546

[CM503001]: Call(103): Incoming call from *10001@(Ln.10001@SPA-3102) to <sip:[email protected]:5060;user=vmail>

23:52:59.546

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to VM:14

23:52:32.843

Active calls counted toward license limit: []

23:52:25.311

[CM503008]: Call(102): Call is terminated

23:52:08.218

[CM503007]: Call(102): Device joined: sip:[email protected]:40600;rinstance=db0c86121700d89c

23:52:08.218

[CM503007]: Call(102): Device joined: sip:[email protected]:5062

23:52:08.202

[CM505001]: Ext.99: Device info: Device Identified: [Man: 3CX Ltd.;Mod: Voice Mail Menu;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Voice Mail Menu] PBX contact: [sip:[email protected]:5060]

00:02:08.843

Active calls counted toward license limit: []

00:01:36.843

Active calls counted toward license limit: [106]

00:01:25.624

[CM503007]: Call(106): Device joined: sip:[email protected]:5062

00:01:25.624

[CM503002]: Call(106): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

00:01:25.265

[CM503025]: Call(106): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

00:01:04.843

Active calls counted toward license limit: [106]

00:00:55.530

[CM503002]: Call(106): Alerting sip:[email protected]:5060

00:00:55.202

[CM503004]: Call(106): Route 1: Ext:Ext.10@[Dev:sip:[email protected]:5060]

00:00:55.202

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

00:00:55.186

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:10

2010/02/27 >>00:00:00.843

Active calls counted toward license limit: []

23:58:56.843

Active calls counted toward license limit: []

23:57:52.843

Active calls counted toward license limit: []

23:57:20.843

Active calls counted toward license limit: [105]

23:57:13.061

[CM503007]: Call(105): Device joined: sip:[email protected]:5060

23:57:13.046

[CM503002]: Call(105): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:57:12.921

[CM503025]: Call(105): Calling Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:56:48.843

Active calls counted toward license limit: [105]

23:56:42.983

[CM503002]: Call(105): Alerting sip:[email protected]:5060

23:56:42.827

[CM503004]: Call(105): Route 1: Ext:Ext.10@[Dev:sip:[email protected]:5060]

23:56:42.811

[CM505001]: Ext.14: Device info: Device Identified: [Man: Polycom;Mod: SoundPoint IP Series;Rev: General] Capabilities:[reinvite, replaces, unable-no-sdp, no-recvonly] UserAgent: [PolycomSoundPointIP-SPIP_550-UA/2.2.2.0084] PBX contact: [sip:[email protected]:5060]

23:56:26.124

[CM306003]: SIP IP:port mapping (71.54.11.98:1024) resolved by STUN server 94.228.101.70:3478 differs from the one (71.54.11.98:5060 resolved by STUN server 193.200.249.2

23:56:25.577

[CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 94.228.101.70:3478 over Transport 192.168.3.1:5060

23:56:16.843

Active calls counted toward license limit: []

23:55:12.843

Active calls counted toward license limit: []

23:54:08.843

Active calls counted toward license limit: []

23:53:36.843

Active calls counted toward license limit: [104]

23:53:22.593

[CM503007]: Call(104): Device joined: sip:[email protected]:5062

23:53:22.577

[CM503002]: Call(104): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:53:22.374

[CM503004]: Call(104): Route 1: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:53:22.374

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:53:22.358

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to VM:14

23:53:01.671

[CM503008]: Call(103): Call is terminated

23:52:59.765

[CM503007]: Call(103): Device joined: sip:[email protected]:5062

23:52:59.749

[CM503002]: Call(103): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:52:59.561

[CM503004]: Call(103): Route 1: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:52:59.561

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:52:59.546

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to VM:14

23:52:25.311

[CM503008]: Call(102): Call is terminated

23:52:08.218

[CM503007]: Call(102): Device joined: sip:[email protected]:5062

23:52:08.202

[CM503002]: Call(102): Alerting sip:[email protected]:40600;rinstance=db0c86121700d89c

23:52:08.015

[CM503004]: Call(102): Route 1: Ext:Ext.99@[Dev:sip:[email protected]:40600;rinstance=db0c86121700d89c]

23:52:08.015

[CM505002]: Gateway:[SPA-3102] Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA3102-5.1.10(GW)] PBX contact: [sip:[email protected]:5060]

23:52:07.983

[CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to VM:10

23:51:30.827

Active calls counted toward license limit: []

23:50:26.827

Active calls counted toward license limit: []

23:49:22.827

Active calls counted toward license limit: []

23:48:18.827

Active calls counted toward license limit: []

23:47:14.827

Active calls counted toward license limit: []

23:46:42.827

Active calls counted toward license limit: []
 
Re: Message Saving Failed (On PSTN calls)

I wanted to post back that message saving works on my 2 voipvoip trunks. Just not from spa3102
 
Re: Message Saving Failed (On PSTN calls)

Go back over all of the settings in the 3102. Does the call drop when answered by an extension rather than the VM?
 
Re: Message Saving Failed (On PSTN calls)

Thanks for your reply.

That is the interesting point. Calls coming in on the pstn are just fine. They can be picked up by any extension or ring group. For the moment I have it pointed to go to the voip extension on the spa3102 as it has an old cordless phone with an answering machine attached.
 
Re: Message Saving Failed (On PSTN calls)

Hi Hank,

[CM503001]: Call(106): Incoming call from *10001@(Ln.10001@SPA-3102) to <sip:[email protected]:5060>

http://www.3cx.com/forums/no-incoming-line-on-linksys-spa-13244.html#p68323
There are description and comments/solution for very similar problem.
There was "<" prepended, in your case it is "*"

Is it the same problem?

Thanks
 
Re: Message Saving Failed (On PSTN calls)

That is what's strange. Inbound and outbound calls through the SPA3102 are fine.

Only when I go to leave a message via an inbound call through the SPA3102 do I get the Message Saving Failed error.

Calling extension to extension and leaving a vm works.
Calling in on a voip trunk and leaving a message works.

Unless anyone has any other ideas I may do a factory reset on the spa, deleted it from 3cx and try again.
 
Thanks to Sy for catching the "*" in the logs.

Without a factory reset, I went thought the SPA3102 setup again and using the doc at http: //www.3cx.com/voip-gateways/linksys-3102/ - NO LONGER AVAILABLE

In step 22 "In the PSTN-To_Voip Gateway Setup secton"
see step e: Set the PSTN Caller ID Pattern field to "*" Note that in some geographical areas, this may cause incoming calls to fail, because the device incorrectly interprets the caller id format. If this is the case, you may need to disable callerid parsing by setting this field to empty.

Well, my inbound and outbound calls worked but this was the only "*" I added to the config. So thus I removed it and voicemail from the spa3102 now works.


In a side note on the above doc, step 13, I set line 1 to yes and configured an extension for my wife's favorite analog cordless phone. It works fine.

Thanks again for all the help.
 
That simple little * has caused a number of problems. And, yes, the FXS port can be used along with the FXO port.
 
Status
Not open for further replies.

Latest Posts

Forum statistics

Threads
111,880
Messages
589,533
Members
164,736
Latest member
david_9daa