IVR stopped working with error message to callers

[Jonners59]

I have two analogue PSTN lines connected to my server via a Grandstream GWX FXO/FXS. I also have a VOIPTalk line too. I also have two Gigaset N330A IP DECT base stations running 3 handsets. Each also connects one of the two PSTN lines as a backup. The 3CX sits on a Windows 7 32-bit hosted ona virtual machine, which runs Linux Ubuntu 11.11 64-bit
These are working fine and the system has worked without any intervention for the past 12 months.

This problem start about a week ago.

I have different call routing for each line as one is for HOME/personal and the other is for WORK. In both cases the IVR does not engage and an automated message to the caller, not very clear says something like "the IVR did not engage" or something. I have also noticed that the outbound message on voice mailboxes do not work either, it just goes straight in to the mailbox with the automated message about how to leave messages.

It is as if the 3CX server can not access the wav files.... They all appear in their respective extension set ups and have be re attached too, and tried, yet they do not pick up.

I have made two calls to both numbers and attached the configs.

09:18:58.941  [CM503003]: Call(8): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.90:5060
09:18:58.839  Session 15541 of leg C:8.1 is confirmed
09:18:58.809  [CM503007]: Call(8): Device joined: sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:18:58.744  [CM503007]: Call(8): Device joined: sip:[email protected]:5064;transport=udp
09:18:58.739  [MS210005] C:8.1:Answer provided. Connection(proxy mode):192.168.1.51:7056(7057)
09:18:58.733  [MS210001] C:8.5:Answer received. RTP connection[unsecure]: 127.0.0.1:40622(40623)
09:18:58.717  Remote SDP is set for legC:8.5
09:18:58.717  [CM503002]: Call(8): Alerting sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:18:58.569  [CM503025]: Call(8): Calling Unknown:Ext.EndCall@[Dev:sip:[email protected]:40600;rinstance=8a1c59101f31d83b]
09:18:58.567  [MS210004] C:8.5:Offer provided. Connection(proxy mode): 127.0.0.1:7064(7065)
09:18:58.506  [CM503016]: Call(8): Attempt to reach <sip:[email protected]:5060> failed. Reason: Temporarily Unavailable
09:18:58.485  [CM503003]: Call(8): Call to sip:[email protected] has failed; Cause: 480 Temporarily not available; from IP:192.168.1.91:5060
09:18:50.468  [CM503003]: Call(8): Call to sip:[email protected] has failed; Cause: 503 Service Unavailable; warning: ; internal
09:18:50.277  [CM505001]: Ext.110: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300 IP/42.051.01.000.000] PBX contact: [sip:[email protected]:5060]
09:18:50.277  [CM503002]: Call(8): Alerting sip:[email protected]:5060
09:18:49.329  [CM503025]: Call(8): Calling RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060]
09:18:49.324  [MS210002] C:8.4:Offer provided. Connection(transcoding mode): 192.168.1.51:7062(7063)
09:18:49.295  [CM503025]: Call(8): Calling RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060]
09:18:49.291  [MS210006] C:8.3:Offer provided. Connection(by pass mode): 192.168.1.95:5012(5013)
09:18:49.259  [CM503025]: Call(8): Calling RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060]
09:18:49.258  [MS210006] C:8.2:Offer provided. Connection(by pass mode): 192.168.1.95:5012(5013)
09:18:49.194  [CM503004]: Call(8): Route 1: RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060]
09:18:49.175  [CM503010]: Making route(s) to <sip:[email protected]:5060>
09:18:49.174  [MS210000] C:8.1:Offer received. RTP connection: 192.168.1.95:5012(5013)
09:18:49.171  Remote SDP is set for legC:8.1
09:18:49.169  [CM505002]: Gateway:[GWX 4104] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream GXW4104 (HW 1.1, Ch:2) 1.3.4.10] PBX contact: [sip:[email protected]:5060]
09:18:49.062  [CM503001]: Call(8): Incoming call from unknown@(Ln.10003@GWX 4104) to <sip:[email protected]:5060>
09:18:49.004  [CM503012]: Inbound out-of-office hours rule (unnamed) for 10003 forwards to DN:801
09:18:49.004  Looking for inbound target: called=10003-10004; caller=unknown
09:18:48.999  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected] SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.95:5064;branch=z9hG4bK53512952c6138d50
  Max-Forwards: 70
  Contact: <sip:[email protected]:5064;transport=udp>
  To: <sip:[email protected]>
  From: <sip:[email protected]>;tag=f3768500dd857144
  Call-ID: [email protected]
  CSeq: 30065 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, INFO, SUBSCRIBE, UPDATE, PRACK
  Proxy-Authorization: Digest username="10003",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected]",nonce="414d535c0580b76803:1c9f5dae0ef909a4921dc27dbbc80dbc",response="c726db2dd0bfb782837df47f96b4746b"
  Supported: replaces, timer, path
  User-Agent: Grandstream GXW4104 (HW 1.1, Ch:2) 1.3.4.10
  Content-Length: 0
  
09:18:47.642  Currently active calls [none]
09:18:36.524  [CM503003]: Call(7): Call to sip:[email protected] has failed; Cause: 408 Request Timeout; internal
09:18:32.030  [CM503008]: Call(7): Call is terminated
09:18:26.320  Session 15522 of leg C:7.1 is confirmed
09:18:26.214  [CM503007]: Call(7): Device joined: sip:[email protected]:40600;rinstance=b9a155f9ad6c9008
09:18:26.154  [CM503007]: Call(7): Device joined: sip:[email protected]:5060;transport=udp
09:18:26.139  [MS210005] C:7.1:Answer provided. Connection(proxy mode):192.168.1.51:7046(7047)
09:18:26.132  [MS210001] C:7.5:Answer received. RTP connection[unsecure]: 127.0.0.1:40620(40621)
09:18:26.126  Remote SDP is set for legC:7.5
09:18:26.121  [CM505001]: Ext.900: 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]
09:18:26.121  [CM503002]: Call(7): Alerting sip:[email protected]:40600;rinstance=b9a155f9ad6c9008
09:18:25.935  [CM503025]: Call(7): Calling Ext:Ext.900@[Dev:sip:[email protected]:40600;rinstance=b9a155f9ad6c9008]
09:18:25.932  [MS210004] C:7.5:Offer provided. Connection(proxy mode): 127.0.0.1:7054(7055)
09:18:25.792  [CM503005]: Call(7): Forwarding: Ext:Ext.900@[Dev:sip:[email protected]:40600;rinstance=b9a155f9ad6c9008]
09:18:18.663  Currently active calls - 1: [7]
09:18:13.575  [CM503003]: Call(7): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.91:5060
09:18:13.171  [CM503003]: Call(7): Call to sip:[email protected] has failed; Cause: 480 Temporarily not available; from IP:192.168.1.90:5060
09:18:05.156  [CM505001]: Ext.100: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300A IP/42.050.00.000.000] PBX contact: [sip:[email protected]:5060]
09:18:05.156  [CM503002]: Call(7): Alerting sip:[email protected]:5060
09:18:04.372  [CM503025]: Call(7): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:18:04.370  [MS210002] C:7.4:Offer provided. Connection(transcoding mode): 192.168.1.51:7052(7053)
09:18:04.347  [CM503025]: Call(7): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:18:04.343  [MS210006] C:7.3:Offer provided. Connection(by pass mode): 192.168.1.95:5008(5009)
09:18:04.319  [CM503025]: Call(7): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:18:04.314  [MS210006] C:7.2:Offer provided. Connection(by pass mode): 192.168.1.95:5008(5009)
09:18:04.219  [CM503004]: Call(7): Route 1: RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060]
09:18:04.187  [CM503010]: Making route(s) to <sip:[email protected]:5060>
09:18:04.182  [MS210000] C:7.1:Offer received. RTP connection: 192.168.1.95:5008(5009)
09:18:04.170  Remote SDP is set for legC:7.1
09:18:04.168  [CM505002]: Gateway:[GWX 4104] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream GXW4104 (HW 1.1, Ch:1) 1.3.4.10] PBX contact: [sip:[email protected]:5060]
09:18:04.033  [CM503001]: Call(7): Incoming call from 07770740133@(Ln.10001@GWX 4104) to <sip:[email protected]:5060>
09:18:04.008  [CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:800
09:18:04.008  Looking for inbound target: called=10001-10002; caller=07770740133
09:18:03.998  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected] SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.95:5060;branch=z9hG4bK59f0071341b743a2
  Max-Forwards: 70
  Contact: <sip:[email protected]:5060;transport=udp>
  To: <sip:[email protected]>
  From: <sip:[email protected]>;tag=b4e39706a8e68724
  Call-ID: [email protected]
  CSeq: 17463 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, INFO, SUBSCRIBE, UPDATE, PRACK
  Proxy-Authorization: Digest username="10001",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected]",nonce="414d535c0580b73b66:e315e76a04a7c4f60ef13976b3d4a5be",response="c1eb7e1aae352f1a422c1502b619279b"
  Supported: replaces, timer, path
  User-Agent: Grandstream GXW4104 (HW 1.1, Ch:1) 1.3.4.10
  Content-Length: 0
  
09:17:47.478  Currently active calls [none]
09:17:17.371  Currently active calls [none]
09:16:47.000  Currently active calls [none]
09:16:16.378  Currently active calls [none]
09:15:46.789  Currently active calls [none]
09:15:37.973  [CM503003]: Call(5): Call to sip:[email protected] has failed; Cause: 408 Request Timeout; internal
09:15:32.761  [CM503008]: Call(5): Call is terminated
09:15:31.925  [CM503008]: Call(6): Call is terminated
09:15:26.884  Session 15459 of leg C:5.1 is confirmed

and again

09:15:32.761  [CM503008]: Call(5): Call is terminated
09:15:31.925  [CM503008]: Call(6): Call is terminated
09:15:26.884  Session 15459 of leg C:5.1 is confirmed
09:15:26.743  [CM503007]: Call(5): Device joined: sip:[email protected]:40600;rinstance=b9a155f9ad6c9008
09:15:26.675  [CM503007]: Call(5): Device joined: sip:[email protected]:5060;transport=udp
09:15:26.656  [MS210005] C:5.1:Answer provided. Connection(proxy mode):192.168.1.51:7032(7033)
09:15:26.640  [MS210001] C:5.5:Answer received. RTP connection[unsecure]: 127.0.0.1:40618(40619)
09:15:26.636  Remote SDP is set for legC:5.5
09:15:26.624  [CM505001]: Ext.900: 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]
09:15:26.624  [CM503002]: Call(5): Alerting sip:[email protected]:40600;rinstance=b9a155f9ad6c9008
09:15:26.297  [CM503025]: Call(5): Calling Ext:Ext.900@[Dev:sip:[email protected]:40600;rinstance=b9a155f9ad6c9008]
09:15:26.293  [MS210004] C:5.5:Offer provided. Connection(proxy mode): 127.0.0.1:7044(7045)
09:15:26.247  Session 15471 of leg C:6.1 is confirmed
09:15:26.172  [CM503005]: Call(5): Forwarding: Ext:Ext.900@[Dev:sip:[email protected]:40600;rinstance=b9a155f9ad6c9008]
09:15:26.070  [CM503007]: Call(6): Device joined: sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:15:25.914  [CM503007]: Call(6): Device joined: sip:[email protected]:5060
09:15:25.888  [MS210005] C:6.1:Answer provided. Connection(proxy mode):192.168.1.51:7040(7041)
09:15:25.883  [MS210001] C:6.2:Answer received. RTP connection[unsecure]: 127.0.0.1:40616(40617)
09:15:25.878  Remote SDP is set for legC:6.2
09:15:25.868  [CM503002]: Call(6): Alerting sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:15:25.689  [CM503025]: Call(6): Calling Unknown:Ext.EndCall@[Dev:sip:[email protected]:40600;rinstance=8a1c59101f31d83b]
09:15:25.685  [MS210004] C:6.2:Offer provided. Connection(proxy mode): 127.0.0.1:7042(7043)
09:15:25.639  [CM503016]: Call(6): Attempt to reach <sip:[email protected];user=phone> failed. Reason: Not Found
09:15:25.638  [CM503014]: Call(6): No known route to target: <sip:[email protected];user=phone>
09:15:25.564  [CM503010]: Making route(s) to <sip:[email protected];user=phone>
09:15:25.564  [MS210000] C:6.1:Offer received. RTP connection: 192.168.1.91:5010(5011)
09:15:25.560  Remote SDP is set for legC:6.1
09:15:25.558  [CM505001]: Ext.100: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300A IP/42.050.00.000.000] PBX contact: [sip:[email protected]:5060]
09:15:25.452  [CM503001]: Call(6): Incoming call from Ext.100 to <sip:[email protected];user=phone>
09:15:25.432  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected];user=phone SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.91:5060;branch=z9hG4bK2fc374dd9fff131f41134b57f480e14;rport=5060
  Max-Forwards: 70
  Contact: <sip:[email protected]:5060>
  To: <sip:[email protected];user=phone>
  From: "Baroni Limited"<sip:[email protected]>;tag=3074029216
  Call-ID: 3948065209@192_168_1_91
  CSeq: 3 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, INFO, REFER, SUBSCRIBE, NOTIFY
  Proxy-Authorization: Digest username="100",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected];user=phone",nonce="414d535c0580b69d79:217ae06fb49919e9caa09e0c9d67cd7a",response="6fd3e471961316659f7a2cb5aec3edf6"
  Supported: replaces
  User-Agent: N300A IP/42.050.00.000.000
  Allow-Events: message-summary, refer, ua-profile, talk
  Content-Length: 0
  
09:15:15.956  Currently active calls - 1: [5]
09:15:14.701  [CM503003]: Call(5): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.91:5060
09:15:14.413  [CM503003]: Call(5): Call to sip:[email protected] has failed; Cause: 480 Temporarily not available; from IP:192.168.1.90:5060
09:15:06.668  [CM505001]: Ext.100: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300A IP/42.050.00.000.000] PBX contact: [sip:[email protected]:5060]
09:15:06.668  [CM503002]: Call(5): Alerting sip:[email protected]:5060
09:15:05.846  [CM503025]: Call(5): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:15:05.843  [MS210002] C:5.4:Offer provided. Connection(transcoding mode): 192.168.1.51:7038(7039)
09:15:05.826  [CM503025]: Call(5): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:15:05.824  [MS210006] C:5.3:Offer provided. Connection(by pass mode): 192.168.1.95:5004(5005)
09:15:05.804  [CM503025]: Call(5): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
09:15:05.800  [MS210006] C:5.2:Offer provided. Connection(by pass mode): 192.168.1.95:5004(5005)
09:15:05.755  [CM503004]: Call(5): Route 1: RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060]
09:15:05.577  [CM503010]: Making route(s) to <sip:[email protected]:5060>
09:15:05.577  [MS210000] C:5.1:Offer received. RTP connection: 192.168.1.95:5004(5005)
09:15:05.572  Remote SDP is set for legC:5.1
09:15:05.569  [CM505002]: Gateway:[GWX 4104] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream GXW4104 (HW 1.1, Ch:0) 1.3.4.10] PBX contact: [sip:[email protected]:5060]
09:15:05.501  [CM503001]: Call(5): Incoming call from 07770740133@(Ln.10001@GWX 4104) to <sip:[email protected]:5060>
09:15:05.471  [CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:800
09:15:05.446  Looking for inbound target: called=10001-10002; caller=07770740133
09:15:05.381  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected] SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.95:5060;branch=z9hG4bKc85784a43cf7a483
  Max-Forwards: 70
  Contact: <sip:[email protected]:5060;transport=udp>
  To: <sip:[email protected]>
  From: <sip:[email protected]>;tag=18e3bc7135700554
  Call-ID: [email protected]
  CSeq: 20965 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, INFO, SUBSCRIBE, UPDATE, PRACK
  Proxy-Authorization: Digest username="10001",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected]",nonce="414d535c0580b68946:8e98f109110bacc9a4cea0941ea75d50",response="9b17c586b988c7e7ec2bd29bc222caf4"
  Supported: replaces, timer, path
  User-Agent: Grandstream GXW4104 (HW 1.1, Ch:0) 1.3.4.10
  Content-Length: 0
  
09:14:45.787  Currently active calls [none]
09:14:15.725  Currently active calls [none]
09:13:45.619  Currently active calls [none]
09:13:15.400  Currently active calls [none]
09:12:45.328  Currently active calls [none]
09:12:15.267  Currently active calls [none]
09:11:45.203  Currently active calls [none]
09:11:15.066  Currently active calls [none]
09:10:44.594  Currently active calls [none]
09:10:15.351  Currently active calls [none]
09:10:09.722  [CM503008]: Call(4): Call is terminated
09:10:02.940  Session 15366 of leg C:4.1 is confirmed
09:10:02.841  [CM503007]: Call(4): Device joined: sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:10:02.794  [CM503007]: Call(4): Device joined: sip:[email protected]:5064;transport=udp
09:10:02.789  [MS210005] C:4.1:Answer provided. Connection(proxy mode):192.168.1.51:7022(7023)
09:10:02.784  [MS210001] C:4.5:Answer received. RTP connection[unsecure]: 127.0.0.1:40614(40615)
09:10:02.779  Remote SDP is set for legC:4.5
09:10:02.554  [CM503002]: Call(4): Alerting sip:[email protected]:40600;rinstance=8a1c59101f31d83b
09:10:02.354  [CM503003]: Call(4): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.90:5060
09:10:02.099  [CM503025]: Call(4): Calling Unknown:Ext.EndCall@[Dev:sip:[email protected]:40600;rinstance=8a1c59101f31d83b]
09:10:02.099  [MS210004] C:4.5:Offer provided. Connection(proxy mode): 127.0.0.1:7030(7031)
09:10:02.026  [CM503016]: Call(4): Attempt to reach <sip:[email protected]:5060> failed. Reason: Temporarily Unavailable

 

[Jonners59]

I have just tried changing the prompt set language and restarted the system.

Same arror message...

Logs again

10:14:25.691  [CM503008]: Call(2): Call is terminated
10:14:19.000  Session 239 of leg C:2.1 is confirmed
10:14:18.995  [CM503003]: Call(2): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.91:5060
10:14:18.950  [CM503007]: Call(2): Device joined: sip:[email protected]:40600;rinstance=afb1c1c32574095e
10:14:18.888  [CM503007]: Call(2): Device joined: sip:[email protected]:5060;transport=udp
10:14:18.888  [MS210005] C:2.1:Answer provided. Connection(proxy mode):192.168.1.51:7008(7009)
10:14:18.877  [MS210001] C:2.4:Answer received. RTP connection[unsecure]: 127.0.0.1:40612(40613)
10:14:18.871  Remote SDP is set for legC:2.4
10:14:18.871  [CM503002]: Call(2): Alerting sip:[email protected]:40600;rinstance=afb1c1c32574095e
10:14:18.631  [CM503025]: Call(2): Calling Unknown:Ext.EndCall@[Dev:sip:[email protected]:40600;rinstance=afb1c1c32574095e]
10:14:18.626  [MS210004] C:2.4:Offer provided. Connection(proxy mode): 127.0.0.1:7014(7015)
10:14:18.548  [CM503016]: Call(2): Attempt to reach <sip:[email protected]:5060> failed. Reason: Temporarily Unavailable
10:14:18.472  [CM503003]: Call(2): Call to sip:[email protected] has failed; Cause: 480 Temporarily not available; from IP:192.168.1.90:5060
10:14:10.163  [CM505001]: Ext.100: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300A IP/42.050.00.000.000] PBX contact: [sip:[email protected]:5060]
10:14:10.163  [CM503002]: Call(2): Alerting sip:[email protected]:5060
10:14:08.833  [CM503025]: Call(2): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
10:14:08.832  [MS210006] C:2.3:Offer provided. Connection(by pass mode): 192.168.1.95:5020(5021)
10:14:08.807  [CM503025]: Call(2): Calling RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060]
10:14:08.798  [MS210006] C:2.2:Offer provided. Connection(by pass mode): 192.168.1.95:5020(5021)
10:14:08.726  [CM503004]: Call(2): Route 1: RingAll800:100Ext.100101Ext.101102103Ext.103105Ext.105@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060]
10:14:08.616  [CM503010]: Making route(s) to <sip:[email protected]:5060>
10:14:08.616  [MS210000] C:2.1:Offer received. RTP connection: 192.168.1.95:5020(5021)
10:14:08.611  Remote SDP is set for legC:2.1
10:14:08.609  [CM505002]: Gateway:[GWX 4104] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream GXW4104 (HW 1.1, Ch:4) 1.3.4.10] PBX contact: [sip:[email protected]:5060]
10:14:08.512  [CM503001]: Call(2): Incoming call from 07770740133@(Ln.10001@GWX 4104) to <sip:[email protected]:5060>
10:14:08.461  [CM503012]: Inbound out-of-office hours rule (unnamed) for 10001 forwards to DN:800
10:14:08.445  Looking for inbound target: called=10001-10002; caller=07770740133
10:14:08.434  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected] SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.95:5060;branch=z9hG4bK46060f74f4532862
  Max-Forwards: 70
  Contact: <sip:[email protected]:5060;transport=udp>
  To: <sip:[email protected]>
  From: <sip:[email protected]>;tag=4d0172752657b7f1
  Call-ID: [email protected]
  CSeq: 29730 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, INFO, SUBSCRIBE, UPDATE, PRACK
  Proxy-Authorization: Digest username="10001",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected]",nonce="414d535c0580c46044:8b52367f785ab15c7bfadc4e2c8e1d60",response="c90f6a1a7606a8595c541a9bf7724da4"
  Supported: replaces, timer, path
  User-Agent: Grandstream GXW4104 (HW 1.1, Ch:4) 1.3.4.10
  Content-Length: 0
  
10:14:03.774  Currently active calls [none]
10:13:41.303  [CM503008]: Call(1): Call is terminated
10:13:36.599  Currently active calls - 1: [1]
10:13:36.066  Session 209 of leg C:1.1 is confirmed
10:13:36.035  [CM503007]: Call(1): Device joined: sip:[email protected]:40600;rinstance=afb1c1c32574095e
10:13:35.988  [CM503007]: Call(1): Device joined: sip:[email protected]:5064;transport=udp
10:13:35.984  [MS210005] C:1.1:Answer provided. Connection(proxy mode):192.168.1.51:7000(7001)
10:13:35.980  [MS210001] C:1.4:Answer received. RTP connection[unsecure]: 127.0.0.1:40610(40611)
10:13:35.976  Remote SDP is set for legC:1.4
10:13:35.912  [CM503003]: Call(1): Call to sip:[email protected] has failed; Cause: 487 Request Cancelled; from IP:192.168.1.90:5060
10:13:35.886  [CM503002]: Call(1): Alerting sip:[email protected]:40600;rinstance=afb1c1c32574095e
10:13:35.712  [CM503025]: Call(1): Calling Unknown:Ext.EndCall@[Dev:sip:[email protected]:40600;rinstance=afb1c1c32574095e]
10:13:35.709  [MS210004] C:1.4:Offer provided. Connection(proxy mode): 127.0.0.1:7006(7007)
10:13:35.662  [CM503016]: Call(1): Attempt to reach <sip:[email protected]:5060> failed. Reason: Temporarily Unavailable
10:13:35.627  [CM503003]: Call(1): Call to sip:[email protected] has failed; Cause: 480 Temporarily not available; from IP:192.168.1.91:5060
10:13:30.087  [CM505001]: Ext.110: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [N300 IP/42.051.01.000.000] PBX contact: [sip:[email protected]:5060]
10:13:30.087  [CM503002]: Call(1): Alerting sip:[email protected]:5060
10:13:29.421  [CM503025]: Call(1): Calling RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060]
10:13:29.419  [MS210006] C:1.3:Offer provided. Connection(by pass mode): 192.168.1.95:5016(5017)
10:13:29.398  [CM503025]: Call(1): Calling RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060]
10:13:29.387  [MS210006] C:1.2:Offer provided. Connection(by pass mode): 192.168.1.95:5016(5017)
10:13:29.332  [CM503004]: Call(1): Route 1: RingAll801:110Ext.110105Ext.105111Ext.111101Ext.101@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5060]
10:13:29.229  [MS210000] C:1.1:Offer received. RTP connection: 192.168.1.95:5016(5017)
10:13:29.222  [CM503010]: Making route(s) to <sip:[email protected]:5060>
10:13:29.194  Remote SDP is set for legC:1.1
10:13:29.113  [CM505002]: Gateway:[GWX 4104] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream GXW4104 (HW 1.1, Ch:3) 1.3.4.10] PBX contact: [sip:[email protected]:5060]
10:13:29.037  [CM503001]: Call(1): Incoming call from unknown@(Ln.10003@GWX 4104) to <sip:[email protected]:5060>
10:13:28.489  [CM503012]: Inbound out-of-office hours rule (unnamed) for 10003 forwards to DN:801
10:13:28.478  Looking for inbound target: called=10003-10004; caller=unknown
10:13:28.463  [CM500002]: Info on incoming INVITE:
  INVITE sip:[email protected] SIP/2.0
  Via: SIP/2.0/UDP 192.168.1.95:5064;branch=z9hG4bKea17a5b0506423c1
  Max-Forwards: 70
  Contact: <sip:[email protected]:5064;transport=udp>
  To: <sip:[email protected]>
  From: <sip:[email protected]>;tag=59d57e150dc450b7
  Call-ID: [email protected]
  CSeq: 5884 INVITE
  Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, INFO, SUBSCRIBE, UPDATE, PRACK
  Proxy-Authorization: Digest username="10003",realm="3CXPhoneSystem",algorithm=MD5,uri="sip:[email protected]",nonce="414d535c0580c43838:2440db269ce7f1b8e89ff892216e23e8",response="0588dd9efb87b5b5abb5a767d060d163"
  Supported: replaces, timer, path
  User-Agent: Grandstream GXW4104 (HW 1.1, Ch:3) 1.3.4.10
  Content-Length: 0
  
10:13:16.163  Currently active calls [none]
10:13:00.551  Currently active calls [none]
10:12:45.495  Currently active calls [none]
10:12:30.350  Currently active calls [none]
10:12:18.023  [CM504001]: Ext.110: new contact is registered. Contact(s): [sip:[email protected]:5060/110,sip:[email protected]:5060/110]
10:12:17.969  [CM504001]: Ext.100: new contact is registered. Contact(s): [sip:[email protected]:5060/100,sip:[email protected]:5060/100]
10:12:15.008  Currently active calls [none]
10:12:10.739  [CM504001]: Ext.100: new contact is registered. Contact(s): [sip:[email protected]:5060/100]
10:12:10.048  [CM504001]: Ext.110: new contact is registered. Contact(s): [sip:[email protected]:5060/110]
10:12:02.690  [CM504002]: Ext.100: a contact is unregistered. Contact(s): []
10:12:02.678  [CM504002]: Ext.110: a contact is unregistered. Contact(s): []
10:12:02.678  [CM504002]: Ext.100: a contact is unregistered. Contact(s): []
10:12:02.678  [CM504002]: Ext.110: a contact is unregistered. Contact(s): []
10:11:55.255  Currently active calls [none]
10:10:23.386  Currently active calls [none]

 

[leejor]

Were any updates done to the operating system? You don't say which version of windows you are running. Something must have changed for the system to stop after 12 months of running OK. Audio files/drivers? Will the system play a wav file?

 

[Jonners59]

WIndows7 Home Prem 32-bit
All updates are installed automatically.

I ONLY use it for the 3CX. It is a virtual install. I.e. the main op is Linux - Ubuntu 11.011 64-bit (also up to date) running Virtuual Box, also always kept up to date.

I do not tend to run audio files from this PC as it is just used for storage, as a source for accessing stored media for the TV and the VM running the 3CX

I have used 3CX for a number of years in this coinfiguration and had no issues for c12 months, as you have noted. It is odd.

I am out at at meetings all day so shall try audio files when I get back.
PS: Thanks for looking in and getting back.

 

[leejor]

WIndows7 Home Prem 32-bit
All updates are installed automatically.

You may want to see if something was updated/installed about the time that you began having the audio issues.

 

[Jonners59]

OK, had another look, though not conclusive.
I tried playing audio files via my Ubuntu and the Windows and neither played. I tried the headset I was using oin another machine and they worked fine. So I think my adio card may be US...

Now, that may be miss leading because the warning messages play when someone calls. If the audio card was the issue then they would not play either!!!!

Updates, that is hard to say too as it is not clear exactly when it stopped. One thing I can say, is it was c the time we were hit by the sun's radio waves the other Friday. I lost my Siemens DECT base station at the same time, and had to replace it. I am wondering if it may have knocked out the audio card too, but it still does not explain the 3CX audio on incoiming calls.

The message seems to be more about routing the call to the IVR and Voice Mail extensions than just playing the messages, or at least accessing the messages in the first place. I know they are there and I can access them via the 3CX set up, the Windows7 desktop, the Ubuntu desktop and the LAN....

I saw that someone else had a similar issue on a Server version, but thiers was resolved by changing default language back and forth, which I tried to no avail.

 

[leejor]

I tried playing audio files via my Ubuntu and the Windows and neither played. I tried the headset I was using oin another machine and they worked fine. So I think my adio card may be US...

Do you get any sort of error message when you try to play audio? If you can get your hands on another audio card, and get that to work, it may just be related to the issue. It may also be an audio software problem. I would focus on figuring out why you don't get audio. If the solar flares were as bad in your area as to affect your DECT phone, then you may be on to something.

 

[Jonners59]

There is no error message when playing the wave files. Just nothing comes out...

But what I don't. Understand is why then if it is an audio card prob The caller gets the 3CX IVR error message or the no routes available messages... the surely be no sound?