PUSH Notifications stop working

Status
Not open for further replies.

patrickrivard

Joined
May 29, 2008
Messages
104
Reaction score
0
3CX server V15.0.0 (Activated Standard 15.0.60903.0)
3CX (Beta) Clien V15.0.01
Android V7.0 (BN: NPL25.86-15)
MOTO Z (XT1650-03)

Push notifications are no longer working after latest client upgrade...

In troubleshooting I've deleted my old Google API project, both in Google and 3CX
I then rebuilt a new project in Google as stated here: http://www.3cx.com/docs/configuring-google-push/
Making sure our public IP was properly inserted as mentioned in step 9 and 10.
But still not working.
 
Hello,
Do you have a device that is not running the Beta version? Is it working there?
 
I tried it on a:
-NEXUS 5 running Android 6.0.1, with 3CX client V14.0.57 -- Does not work

It does work with iOS, but it's a different story altogether...
 
Hello,

Can you please update your device to the latest version (V15.0.05) and see if the problem solved?
 
Sorry, no luck with that version either...
Still not working.
 
Re-provision your clients and if this does not solve the problem then put the PBX activity logs to Verbose mode and copy/paste some logs here from 3CXDialer.log:

C:\ProgramData\3CX\Instance1\Data\Logs\3CXDialer.log
 
As requested:
16-12-22 06:00:00.030|100019| Inf|50|0008|: Update PUSH client for Extn.2222: Allowed, regid = APA91bHyazhIuH3a1bmiIItbrmwyTUva_SV40Hak8sY21k1zMVBgx5Zkm3d_pd8ZQ8f6j9oUlB-tqM2Rp5XV6IAX6_5EEv-cA1AmIXWKZaytb96IjAZQibVd_FQQnwZmmoCOKqfx1ZsU,A,f220b5dc
16-12-22 06:00:00.189|100019| Inf|50|0008|: Update PUSH client for Extn.1321: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,C4A048
16-12-22 06:00:00.525|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 07:00:00.039|100019| Inf|50|0008|: Update PUSH client for Extn.1323: Allowed, regid = APA91bEMkfQiDOpWwk2aHW4Jk34sSymZSDMgrxsLNy5jg_ZeOJctRkuiHrVYPs7Wi7rBSvhugaqKDt-UCMkEMpzScEvQBaPyFOy1-yfGodDm4SEoihy1FpsVFJLMTX6nLQsM5tbuTygX,A,73a4d596
16-12-22 07:00:00.083|100019| Inf|50|0008|: Update PUSH client for Extn.1324: Allowed, regid = aVf7SOt2qrPIQkpfbL+r3SXzxsDJBUeLN1rbJC4Pjig=,I,4B0FD7
16-12-22 08:28:34.745|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:30:34 AM
16-12-22 08:28:34.778|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:30:34 AM
16-12-22 08:28:34.778|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:30:34 AM
16-12-22 08:28:34.910|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:30:34 AM
16-12-22 08:28:34.954|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:30:34 AM
16-12-22 08:28:34.968|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:02.673|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:26.279|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:31:26 AM
16-12-22 08:29:26.289|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:26.296|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:31:26 AM
16-12-22 08:29:26.296|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:31:26 AM
16-12-22 08:29:26.367|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:26.498|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:31:26 AM
16-12-22 08:29:26.509|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:28.635|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:31:26 AM
16-12-22 08:29:41.199|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:29:42.313|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.338|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 08:29:42.345|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.345|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.438|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 08:29:42.516|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.519|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.519|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.529|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 08:29:42.705|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:29:42.715|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 08:29:50.982|200002| Trc|75|0008|: Ins: Call(11) [Dialing] DN=2221 IP=2221 EP=1322
Attached: [sip_displayname=Sonia Coe;lookup_displayname=Sonia Coe;chid=00000BF0576FA481_11;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:59726;rinstance=0-kndzirvh1cwcgpruskozjdxzpolh52eb;ob;inst="DA4589"]
16-12-22 08:29:51.179|200003| Trc|50|0010|: DBG: _phone_OnNewCall called: BDHKAKPIBWYD
16-12-22 08:29:51.179|200003| Trc|50|0012|: DBG: OnNewCall called: BDHKAKPIBWYD
16-12-22 08:29:51.332|200002| Trc|75|0008|: Ins: Call(11) [Ringing] DN=1322 IP=2221 EP=2221
Attached: [chid=00000BF0576FA481_11;prevCall=0;prevLeg=0;extnumber=2221;devcontact=sip:[email protected]:5488;rinstance=28a7fff229648753;lookup_displayname=Patrick Cell]
16-12-22 08:29:51.341|100017| Inf|50|0012|: Call(BDHKAKPIBWYD): sent push request:
{"registration_ids" : [ "APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V" ], "data": {"replaces": "zsH1A7SQmAs_iM3v051iyg..;from-tag=4254bd2c;to-tag=aa779319", "callerid": "2221", "inst": "b04e3dc2", "reason": 0 } }
GCM response: Unauthorized Unauthorized
16-12-22 08:29:59.987|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:30:01.803|200002| Trc|75|0008|: Del: Call(11) [Dialing] DN=2221 IP=1322 EP=1322
Attached: [sip_displayname=Sonia Coe;lookup_displayname=Sonia Coe;chid=00000BF0576FA481_11;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:59726;rinstance=0-kndzirvh1cwcgpruskozjdxzpolh52eb;ob;inst="DA4589"]
16-12-22 08:30:01.806|200002| Trc|75|0008|: Del: Call(11) [Ringing] DN=1322 IP=(null) EP=2221
Attached: [chid=00000BF0576FA481_11;prevCall=0;prevLeg=0;extnumber=2221;devcontact=sip:[email protected]:5488;rinstance=28a7fff229648753;lookup_displayname=Patrick Cell]
16-12-22 08:30:01.926|200003| Trc|50|0010|: DBG: incall_OnTerminated called: BDHKAKPIBWYD
16-12-22 08:30:01.926|200003| Trc|50|0012|: DBG: OnTerminated called:BDHKAKPIBWYD
16-12-22 08:30:02.043|100017| Inf|50|0015|: Call(BDHKAKPIBWYD): sent push request:
{"registration_ids" : [ "APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V" ], "data": {"replaces": "zsH1A7SQmAs_iM3v051iyg..;from-tag=4254bd2c;to-tag=aa779319", "callerid": "2221", "inst": "b04e3dc2", "reason": 1 } }
GCM response: Unauthorized Unauthorized
16-12-22 08:30:03.696|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:32:03 AM
16-12-22 08:30:03.707|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
 
following...
16-12-22 08:30:03.715|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:32:03 AM
16-12-22 08:30:03.715|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:32:03 AM
16-12-22 08:30:03.791|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:30:03.925|200003| Trc|50|0008|: DBG: Contact for b04e3dc2 is active, expires at 2016-12-22 8:32:03 AM
16-12-22 08:30:03.936|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:30:09.616|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:30:16.584|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bH-wVz8vqJRQ5wjqNkT1HgbuzpUzq5HGwN5K95vyz7P5lnNdScOckAI_4buPdK1upa4Gsph6Tc1N0kP38R1Lyd9fT_oiUZOWPbiaixDrQkVYyG2V3XaDikHjOkB2l1k8BgkWg7V,A,b04e3dc2
16-12-22 08:31:01.904|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:31:42 AM
16-12-22 08:31:37.624|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:33:37 AM
16-12-22 08:31:37.635|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 08:32:04.819|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:33:37 AM
16-12-22 08:32:50.624|200003| Trc|50|0008|: DBG: Contact for DA4589 is active, expires at 2016-12-22 8:33:37 AM
16-12-22 08:32:51.847|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 09:00:02.129|100019| Inf|50|0008|: Update PUSH client for Extn.2221: Allowed, regid = DaSSdDgFaAlthrcdDzElxhxgasUgr99lY03uoLqif2A=,I,DA4589
16-12-22 09:43:59.853|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6,A,72a15a8b
16-12-22 09:43:59.853|100020| Inf|50|0008|: PUSH client for Extn.1322: Unregistering
16-12-22 09:43:59.853|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6,A,72a15a8b
16-12-22 09:43:59.857|100020| Inf|50|0008|: PUSH client for Extn.1322: Registering
16-12-22 09:43:59.877|200003| Trc|50|0008|: DBG: Contact for 72a15a8b is active, expires at 2016-12-22 9:45:59 AM
16-12-22 09:43:59.877|200003| Trc|50|0008|: DBG: Contact for 72a15a8b is active, expires at 2016-12-22 9:45:59 AM
16-12-22 09:43:59.898|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6,A,72a15a8b
16-12-22 09:43:59.959|200003| Trc|50|0008|: DBG: Contact for 72a15a8b is active, expires at 2016-12-22 9:45:59 AM
16-12-22 09:43:59.968|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6,A,72a15a8b
16-12-22 09:44:00.136|200003| Trc|50|0008|: DBG: Contact for 72a15a8b is active, expires at 2016-12-22 9:45:59 AM
16-12-22 09:44:00.139|200003| Trc|50|0008|: DBG: Contact for 72a15a8b is active, expires at 2016-12-22 9:45:59 AM
16-12-22 09:44:20.769|100019| Inf|50|0008|: Update PUSH client for Extn.1322: Allowed, regid = APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6,A,72a15a8b
16-12-22 09:46:11.700|200002| Trc|75|0008|: Ins: Call(12) [Dialing] DN=2222 IP=2222 EP=1322
Attached: [sip_displayname=Patrick Rivard;lookup_displayname=Patrick Rivard;chid=00000BF057B589EF_12;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:5060]
16-12-22 09:46:11.922|200003| Trc|50|0010|: DBG: _phone_OnNewCall called: OMABQGAMRLOC
16-12-22 09:46:11.922|200003| Trc|50|0017|: DBG: OnNewCall called: OMABQGAMRLOC
16-12-22 09:46:12.074|200002| Trc|75|0008|: Ins: Call(12) [Ringing] DN=1322 IP=2222 EP=2222
Attached: [chid=00000BF057B589EF_12;prevCall=0;prevLeg=0;extnumber=2222;devcontact=sip:[email protected]:5488;rinstance=e7f13bac6e44be1e;lookup_displayname=Patrick Cell]
16-12-22 09:46:12.085|100017| Inf|50|0017|: Call(OMABQGAMRLOC): sent push request:
{"registration_ids" : [ "APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6" ], "data": {"replaces": "YkFbSdPqel2gngo3XQGQVg..;from-tag=c1537257;to-tag=3321b422", "callerid": "2222", "inst": "72a15a8b", "reason": 0 } }
GCM response: Unauthorized Unauthorized
16-12-22 09:46:26.551|200002| Trc|75|0008|: Del: Call(12) [Dialing] DN=2222 IP=1322 EP=1322
Attached: [sip_displayname=Patrick Rivard;lookup_displayname=Patrick Rivard;chid=00000BF057B589EF_12;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:5060]
16-12-22 09:46:26.554|200002| Trc|75|0008|: Del: Call(12) [Ringing] DN=1322 IP=(null) EP=2222
Attached: [chid=00000BF057B589EF_12;prevCall=0;prevLeg=0;extnumber=2222;devcontact=sip:[email protected]:5488;rinstance=e7f13bac6e44be1e;lookup_displayname=Patrick Cell]
16-12-22 09:46:26.750|200003| Trc|50|0010|: DBG: incall_OnTerminated called: OMABQGAMRLOC
16-12-22 09:46:26.750|200003| Trc|50|0017|: DBG: OnTerminated called:OMABQGAMRLOC
16-12-22 09:46:26.864|100017| Inf|50|0012|: Call(OMABQGAMRLOC): sent push request:
{"registration_ids" : [ "APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6" ], "data": {"replaces": "YkFbSdPqel2gngo3XQGQVg..;from-tag=c1537257;to-tag=3321b422", "callerid": "2222", "inst": "72a15a8b", "reason": 1 } }
GCM response: Unauthorized Unauthorized
16-12-22 09:49:20.277|200002| Trc|75|0008|: Ins: Call(13) [Dialing] DN=2222 IP=2222 EP=1322
Attached: [sip_displayname=Patrick Rivard;lookup_displayname=Patrick Rivard;chid=00000BF057B86A90_13;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:5060]
16-12-22 09:49:20.475|200003| Trc|50|0010|: DBG: _phone_OnNewCall called: ILTPOOOSJLAN
16-12-22 09:49:20.476|200003| Trc|50|0012|: DBG: OnNewCall called: ILTPOOOSJLAN
16-12-22 09:49:20.596|100017| Inf|50|0012|: Call(ILTPOOOSJLAN): sent push request:
{"registration_ids" : [ "APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6" ], "data": {"replaces": "CDXntQySX0129dgat-KcLw..;from-tag=647c624a;to-tag=76310806", "callerid": "2222", "inst": "72a15a8b", "reason": 0 } }
GCM response: Unauthorized Unauthorized
16-12-22 09:49:20.627|200002| Trc|75|0008|: Ins: Call(13) [Ringing] DN=1322 IP=2222 EP=2222
Attached: [chid=00000BF057B86A90_13;prevCall=0;prevLeg=0;extnumber=2222;devcontact=sip:[email protected]:5488;rinstance=e7f13bac6e44be1e;lookup_displayname=Patrick Cell]
16-12-22 09:49:34.742|200002| Trc|75|0008|: Del: Call(13) [Dialing] DN=2222 IP=1322 EP=1322
Attached: [sip_displayname=Patrick Rivard;lookup_displayname=Patrick Rivard;chid=00000BF057B86A90_13;prevCall=0;prevLeg=0;extnumber=1322;devcontact=sip:[email protected]:5060]
16-12-22 09:49:34.745|200002| Trc|75|0008|: Del: Call(13) [Ringing] DN=1322 IP=(null) EP=2222
Attached: [chid=00000BF057B86A90_13;prevCall=0;prevLeg=0;extnumber=2222;devcontact=sip:[email protected]:5488;rinstance=e7f13bac6e44be1e;lookup_displayname=Patrick Cell]
16-12-22 09:49:34.944|200003| Trc|50|0010|: DBG: incall_OnTerminated called: ILTPOOOSJLAN
16-12-22 09:49:34.944|200003| Trc|50|0012|: DBG: OnTerminated called:ILTPOOOSJLAN
16-12-22 09:49:35.068|100017| Inf|50|0012|: Call(ILTPOOOSJLAN): sent push request:
{"registration_ids" : [ "APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6" ], "data": {"replaces": "CDXntQySX0129dgat-KcLw..;from-tag=647c624a;to-tag=76310806", "callerid": "2222", "inst": "72a15a8b", "reason": 1 } }
GCM response: Unauthorized Unauthorized
 
16-12-22 09:46:12.085|100017| Inf|50|0017|: Call(OMABQGAMRLOC): sent push request:
{"registration_ids" : [ "APA91bFZjFEWYK-OvfddtIQ3-ir2625-KuLat3aOpIWS2K8zkdzlVM79Yk45dIO1Z5Yvfz9T8kFAnQ2azkid_gKIWYUPsQry0tsHVlLv4utuQU0vHew1lLeeWKcqvZDv9FuwZCFO1nf6" ], "data": {"replaces": "YkFbSdPqel2gngo3XQGQVg..;from-tag=c1537257;to-tag=3321b422", "callerid": "2222", "inst": "72a15a8b", "reason": 0 } }
GCM response: Unauthorized Unauthorized

As I can see on your logs you received Unauthorized response from GCM. (Google Cloud Messaging)
1. Check your API Key
2. Check Project Number
3. Check your public IP if it changed for any reason

Are you using IPV6?
 
I deleted and recreated a new project.
I made certain to enter all the proper info in the (2) fields
Our Public IP has not changed
We are not using IPV6

But it still does not work...

12/26/2016 4:24:30 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:30 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:29 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:50155> for device Dev(936974493):[sip:[email protected]:50155;rinstance=0-5aafc4e297b44d3dbadb803a7ee20423;ob / 2222]
12/26/2016 4:24:26 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:26 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:19 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:18 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:24:04 PM - Stop call record for leg L:41.1[Extn:2222]
12/26/2016 4:24:04 PM - Removing leg L:41.1[Extn:2222]
12/26/2016 4:24:04 PM - L:41.1[Extn:2222]: Terminating targets, reason: SIP ;cause=200 ;text="User hangup"
12/26/2016 4:24:04 PM - Leg L:41.1[Extn:2222] is terminated: Cause: BYE from 192.168.18.222:5060
12/26/2016 4:24:04 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Terminated / I)
12/26/2016 4:24:04 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:24:04 PM - L:41.1[Extn:2222] got Terminated Recv Req BYE from 192.168.18.222:5060 tid=dd9cd4152890f940b Call-ID=7ebbab2607e3b78d:
BYE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bKdd9cd4152890f940b
Max-Forwards: 70
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1338 BYE
Proxy-Authorization: Digest username="2222",realm="3CXPhoneSystem",nonce="414d535c0e721b5a59:9550b9b260efea0efad7ca7e978ad430",uri="sip:[email protected]:5060",response="5e203c4b556aac356146e9a2de7deee2",algorithm=MD5
User-Agent: Aastra 9480i/3.3.1.4345
Content-Length: 0

12/26/2016 4:24:04 PM - L:41.1[Extn:2222] Sending: OnSendResp Send 200/BYE from 0.0.0.0:0 tid=dd9cd4152890f940b Call-ID=7ebbab2607e3b78d:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bKdd9cd4152890f940b
Contact: <sip:[email protected]:5060>
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1338 BYE
Content-Length: 0

12/26/2016 4:24:04 PM - Call(C:41), Extn:2222 on exit: DlgInfo(41-2597/Terminated / I)
12/26/2016 4:24:04 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Confirmed / I)
12/26/2016 4:24:04 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:24:01 PM - Leg L:41.1[Extn:2222]: session is confirmed
12/26/2016 4:24:01 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Confirmed / I)
12/26/2016 4:24:01 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:24:01 PM - L:41.1[Extn:2222] got Confirmed Recv Req ACK from 192.168.18.222:5060 tid=0746ab2233f4b93e3 Call-ID=7ebbab2607e3b78d:
ACK sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bK0746ab2233f4b93e3
Max-Forwards: 70
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard" <sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1337 ACK
Proxy-Authorization: Digest username="2222",realm="3CXPhoneSystem",nonce="414d535c0e721b5a59:9550b9b260efea0efad7ca7e978ad430",uri="sip:[email protected]:5060;user=phone",response="0663e0c0eba879ce5df457a57c67d2ac",algorithm=MD5
User-Agent: Aastra 9480i/3.3.1.4345
Content-Length: 0

12/26/2016 4:24:01 PM - [CM503007]: Call(C:41): Extn:2222 has joined, contact <sip:[email protected]:5060>
12/26/2016 4:24:01 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Confirmed / I)
12/26/2016 4:24:01 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:24:01 PM - Start call recording request for leg L:41.1[Extn:2222]
12/26/2016 4:24:01 PM - Session 459220 of leg L:41.1[Extn:2222] is connected
12/26/2016 4:24:01 PM - L:41.1[Extn:2222] got Connected.UAS Send 200/INVITE from 0.0.0.0:0 tid=07b522bb8d7473fb1 Call-ID=7ebbab2607e3b78d:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bK07b522bb8d7473fb1
Contact: <sip:[email protected]:5060>
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1337 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Content-Type: application/sdp
Supported: replaces
User-Agent: 3CXPhoneSystem 15.0.60903.0 (60821)
Content-Length: 321
 
Last edited:
v=0
o=3cxPS 120275861504 486103056385 IN IP4 192.168.18.20
s=3cxPS Audio call
c=IN IP4 192.168.18.20
t=0 0
m=audio 7178 RTP/AVP 0 8 18 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
12/26/2016 4:24:01 PM - L:41.1[Extn:2222] Sending: OnSendResp Send 200/INVITE from 0.0.0.0:0 tid=07b522bb8d7473fb1 Call-ID=7ebbab2607e3b78d:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bK07b522bb8d7473fb1
Contact: <sip:[email protected]:5060>
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1337 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Content-Type: application/sdp
Supported: replaces
Content-Length: 321

v=0
o=3cxPS 120275861504 486103056385 IN IP4 192.168.18.20
s=3cxPS Audio call
c=IN IP4 192.168.18.20
t=0 0
m=audio 7178 RTP/AVP 0 8 18 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
12/26/2016 4:24:01 PM - Call(C:41), Extn:2222 on exit: DlgInfo(41-2597/Confirmed / I)
12/26/2016 4:24:01 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Early / I)
12/26/2016 4:24:01 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:24:01 PM - L:41.1[Extn:2222]: Terminating targets, reason: SIP ;cause=200 ;text="Call completed elsewhere"
12/26/2016 4:24:01 PM - L:41.3[Ivr:IVRForward] has joined to L:41.1[Extn:2222]
12/26/2016 4:24:00 PM - [CM503025]: Call(C:41): Calling T:Ivr:IVRForward@[Dev:sip:[email protected]:5483;rinstance=ff9f6b39bee51cb0] for L:41.1[Extn:2222]
12/26/2016 4:24:00 PM - [Flow] Call(C:41): making call from L:41.1[Extn:2222] to T:Ivr:IVRForward@[Dev:sip:[email protected]:5483;rinstance=ff9f6b39bee51cb0]
12/26/2016 4:24:00 PM - [Flow] L:41.1[Extn:2222]: Build targets for Ivr:IVRForward
12/26/2016 4:24:00 PM - L:41.1[Extn:2222] forwards call from Extn:1322 to Ivr:IVRForward based on rule Fwd[Available/NoAnsw]
12/26/2016 4:24:00 PM - L:41.1[Extn:2222] failed to reach Extn:1322, reason No Answer
12/26/2016 4:23:53 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:23:52 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:23:49 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5488> for device Dev(1503487491):[sip:[email protected]:5488;rinstance=6c29d9d714d4488d / 2222]
12/26/2016 4:23:46 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:23:45 PM - Endpoint Extn:2222 has refreshed contact <sip:[email protected]:5060> for device Dev(19748236):[sip:[email protected]:5060 / 2222]
12/26/2016 4:23:39 PM - L:41.1[Extn:2222] Sending: OnSendResp Send 180/INVITE from 0.0.0.0:0 tid=07b522bb8d7473fb1 Call-ID=7ebbab2607e3b78d:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bK07b522bb8d7473fb1
Contact: <sip:[email protected]:5060>
To: <sip:[email protected]:5060;user=phone>;tag=2f580e1c
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1337 INVITE
Content-Length: 0

12/26/2016 4:23:39 PM - Call(C:41), Extn:2222 on exit: DlgInfo(41-2597/Early / I)
12/26/2016 4:23:39 PM - Call(C:41), Extn:2222 on entry: DlgInfo(41-2597/Initial / I)
12/26/2016 4:23:39 PM - Notify dialog-info: Extn:2222: sip:[email protected]:5060, Call(C:41)
12/26/2016 4:23:38 PM - [CM503025]: Call(C:41): Calling T:Extn:1322@[Dev:sip:[email protected]:5488;rinstance=0f46d3338383b0f6] for L:41.1[Extn:2222]
12/26/2016 4:23:38 PM - [Flow] Call(C:41): making call from L:41.1[Extn:2222] to T:Extn:1322@[Dev:sip:[email protected]:5488;rinstance=0f46d3338383b0f6]
12/26/2016 4:23:38 PM - [CM503027]: Call(C:41): From: Extn:2222 ("Patrick Rivard" <sip:[email protected]:5060>) to T:Extn:1322@[Dev:sip:[email protected]:5488;rinstance=0f46d3338383b0f6]
12/26/2016 4:23:38 PM - [CM503004]: Call(C:41): Route 1: from L:41.1[Extn:2222] to T:Extn:1322@[Dev:sip:[email protected]:5488;rinstance=0f46d3338383b0f6]
12/26/2016 4:23:38 PM - [Flow] Call(C:41): has built target endpoint: Extn:1322 for call from L:41.1[Extn:2222]
12/26/2016 4:23:38 PM - [CM503010]: Call(C:41): Making route(s) from Extn:2222 to <sip:[email protected]:5060>
12/26/2016 4:23:38 PM - Remote SDP is set for leg L:41.1[Extn:2222]
12/26/2016 4:23:38 PM - [CM505001]: Endpoint Extn:2222: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Aastra 9480i/3.3.1.4345] PBX contact: [sip:[email protected]:5060]
12/26/2016 4:23:38 PM - [CM500002]: Call(C:41): Info on incoming INVITE from Extn:2222:
Invite-IN Recv Req INVITE from 192.168.18.222:5060 tid=07b522bb8d7473fb1 Call-ID=7ebbab2607e3b78d:
INVITE sip:[email protected]:5060;user=phone SIP/2.0
Via: SIP/2.0/UDP 192.168.18.222:5060;branch=z9hG4bK07b522bb8d7473fb1
Max-Forwards: 70
Contact: "Patrick Rivard" <sip:[email protected]:5060>;+sip.instance="<urn:uuid:00000000-0000-1000-8000-00085D267CBA>"
To: <sip:[email protected]:5060;user=phone>
From: "Patrick Rivard"<sip:[email protected]:5060>;tag=3f22cb9ecf
Call-ID: 7ebbab2607e3b78d
CSeq: 1337 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO
Content-Type: application/sdp
Proxy-Authorization: Digest username="2222",realm="3CXPhoneSystem",nonce="414d535c0e721b5a59:9550b9b260efea0efad7ca7e978ad430",uri="sip:[email protected]:5060;user=phone",response="0663e0c0eba879ce5df457a57c67d2ac",algorithm=MD5
Supported: path, gruu, 100rel, replaces
User-Agent: Aastra 9480i/3.3.1.4345
Allow-Events: aastra-xml, talk, hold, conference, LocalModeStatus
Content-Length: 332

v=0
o=MxSIP 0 1 IN IP4 192.168.18.222
s=SIP Call
c=IN IP4 192.168.18.222
t=0 0
m=audio 3000 RTP/AVP 0 8 18 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=silenceSupp:off - - - -
a=fmtp:18 annexb=no
a=fmtp:101 0-15
a=ptime:20
a=sendrecv
12/26/2016 4:23:38 PM - [CM503001]: Call(C:41): Incoming call from Extn:2222 to <sip:[email protected]:5060>
12/26/2016 4:23:38 PM - Leg L:41.1[Extn:2222] has external party ID {}
 
I cannot see any issue on these logs. Do the following:
1. Re-provision your phones
2. Restart your services and try again

If you still have any issue then please open a support ticket
 
@ Marios Neophytou

Would you be kind enough as to let me know how to "Open a Support Ticket" ?

Thank you
 
Status
Not open for further replies.

Members Online Now

Forum statistics

Threads
111,832
Messages
589,285
Members
164,662
Latest member
DejanMDS