Everything looks good but no push notifications

[woodsjimd]

Before you create an issue, please make sure you have read the FAQ. Common questions on API, no image etc are covered there. Please also read HOWTO REPORT ISSUES

Platform & OS Version

IOS 12.2

The version of zmNinja you are reporting:

example: 1.3.050 

The version and OS of ZoneMinder you are using:

example: 1.32.3, Ubuntu 18.04 Bionic

Device details:

example: iPhone 6s

What is the nature of your issue

(one of Bug, Enhancement, Question)

Details

I have shut down zmNinja deleted tokens in token.txt. Ran zmNinja manually using 👍 sudo -u www-data /usr/bin/zmeventnotification.pl

I see all of the correct logs that the documentation says that I should see on both devices but I never receive push notifications to my phone.

zmNinja Debug Logs

Configuration (read /etc/zm/zmeventnotification.ini):

Port .......................... 9000
Address ....................... [::]
Event check interval .......... 5
Monitor reload interval ....... 300

Auth enabled .................. yes
Auth timeout .................. 20

Use FCM ....................... yes
FCM API key ................... (defined)
Token file .................... /var/lib/zmeventnotification/push/tokens.txt

Use MQTT .......................no
MQTT Server ....................127.0.0.1
MQTT Username ..................(undefined)
MQTT Password ..................(undefined)

SSL enabled ................... yes
SSL cert file ................. /etc/apache2/ssl/cert.pem
SSL key file .................. /etc/apache2/ssl/key.pem

Verbose ....................... yes
Read alarm cause .............. yes
Tag alarm event id ............ yes
Use custom notification sound . no

Hook .......................... '/usr/bin/detect_wrapper.sh'
Use Hook Description........... yes
Keep frame match type.......... yes
Skipped monitors............... (undefined)
Store Frame in ZM...............no


Picture URL ................... https://yourdomain.org:8889/zm/index.php?view=image&eid=EVENTID&fid=objdetect&width=600&username=admin&password=password
Include picture................ yes

2019-03-30,10:51:55 Push enabled via FCM
03/30/2019 10:51:55.667827 zmeventnotification[1889].INF [main:533] [Push enabled via FCM]
2019-03-30,10:51:55 MQTT Disabled
03/30/2019 10:51:55.704612 zmeventnotification[1889].INF [main:533] [MQTT Disabled]
2019-03-30,10:51:55 You are running version: 3.3
03/30/2019 10:51:55.738288 zmeventnotification[1889].INF [main:533] [You are running version: 3.3]
2019-03-30,10:51:55 Parent<--Child pipe ready
2019-03-30,10:51:55 Event Notification daemon v 3.3 starting

03/30/2019 10:51:55.771518 zmeventnotification[1889].INF [main:533] [Event Notification daemon v 3.3 starting]
2019-03-30,10:51:55 Initializing FCM tokens...
03/30/2019 10:51:55.804862 zmeventnotification[1889].INF [main:533] [Initializing FCM tokens...]
2019-03-30,10:51:55 Total event client connections: 0

03/30/2019 10:51:55.838421 zmeventnotification[1889].INF [main:533] [Total event client connections: 0]
2019-03-30,10:51:55 Reloading Monitors...

03/30/2019 10:51:55.871775 zmeventnotification[1889].INF [main:533] [Reloading Monitors...]
2019-03-30,10:51:55 Loading monitors

03/30/2019 10:51:55.905196 zmeventnotification[1889].INF [main:533] [Loading monitors]
2019-03-30,10:51:55 checkEvents() events found=0
2019-03-30,10:51:55 About to start listening to socket
03/30/2019 10:51:55.940254 zmeventnotification[1889].INF [main:533] [About to start listening to socket]
2019-03-30,10:51:55 Secure WS(WSS) is enabled...
03/30/2019 10:51:55.973958 zmeventnotification[1889].INF [main:533] [Secure WS(WSS) is enabled...]
2019-03-30,10:51:56 Web Socket Event Server listening on port 9000

03/30/2019 10:51:56.005522 zmeventnotification[1889].INF [main:533] [Web Socket Event Server listening on port 9000]
2019-03-30,10:52:01 ---------->Tick START<--------------
2019-03-30,10:52:01 After tick: TOTAL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:01 Empty job queue
2019-03-30,10:52:01 checkEvents() events found=0
2019-03-30,10:52:01 ---------->Tick END<--------------
2019-03-30,10:52:05 ---------->onConnect START<--------------
2019-03-30,10:52:05 got a websocket connection from ::ffff:174.193.164.203 (0) active connections
03/30/2019 10:52:05.351443 zmeventnotification[1889].INF [main:533] [got a websocket connection from ::ffff:174.193.164.203 (0) active connections]
2019-03-30,10:52:05 ---------->onConnect STOP<--------------
2019-03-30,10:52:05 ---------->onConnect:handshake START<--------------
2019-03-30,10:52:05 Websockets: New Connection Handshake requested from ::ffff:174.193.164.203:8063 state=pending auth, id=1553957525.43946
03/30/2019 10:52:05.439783 zmeventnotification[1889].INF [main:533] [Websockets: New Connection Handshake requested from ::ffff:174.193.164.203:8063 state=pending auth, id=1553957525.43946]
2019-03-30,10:52:05 ---------->onConnect:handshake END<--------------
2019-03-30,10:52:05 ---------->onConnect msg START<--------------
2019-03-30,10:52:05 Raw incoming message: {"event":"auth","data":{"user":"admin","password":"XXXXXXX","monlist":"1,2,3,4","intlist":"0,0,0,0"}}
2019-03-30,10:52:05 Correct authentication provided by ::ffff:174.193.164.203
03/30/2019 10:52:05.541089 zmeventnotification[1889].INF [main:533] [Correct authentication provided by ::ffff:174.193.164.203]
2019-03-30,10:52:05 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:06 ---------->Tick START<--------------
2019-03-30,10:52:06 After tick: TOTAL: 1, FCM+WEB: 0, FCM: 0, WEB: 1, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:06 Empty job queue
2019-03-30,10:52:06 checkEvents() events found=0
2019-03-30,10:52:06 ---------->Tick END<--------------
2019-03-30,10:52:06 ---------->onConnect msg START<--------------
2019-03-30,10:52:06 Raw incoming message: {"event":"push","data":{"type":"token","platform":"ios","token":"c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf","monlist":"1,2,3,4","intlist":"0,0,0,0","state":"enabled"}}
2019-03-30,10:52:06 connection matched but token did not. first registration?
2019-03-30,10:52:06 Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled

03/30/2019 10:52:06.382735 zmeventnotification[1889].INF [main:533] [Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled]
2019-03-30,10:52:06 SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled
03/30/2019 10:52:06.435195 zmeventnotification[1889].INF [main:533] [SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled]
2019-03-30,10:52:06 token not found, creating new record with monlist=1,2,3,4
03/30/2019 10:52:06.476986 zmeventnotification[1889].INF [main:533] [token not found, creating new record with monlist=1,2,3,4]
2019-03-30,10:52:06 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:11 ---------->Tick START<--------------
2019-03-30,10:52:11 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:11 Empty job queue
2019-03-30,10:52:11 checkEvents() events found=0
2019-03-30,10:52:11 ---------->Tick END<--------------
2019-03-30,10:52:16 ---------->Tick START<--------------
2019-03-30,10:52:16 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:16 Empty job queue
2019-03-30,10:52:16 checkEvents() events found=0
2019-03-30,10:52:16 ---------->Tick END<--------------
2019-03-30,10:52:18 ---------->onConnect:disconnect START<--------------
2019-03-30,10:52:18 Websocket remotely disconnected from ::ffff:174.193.164.203
03/30/2019 10:52:18.778327 zmeventnotification[1889].INF [main:533] [Websocket remotely disconnected from ::ffff:174.193.164.203]
2019-03-30,10:52:18 Invaliding websocket, but NOT Marking ::ffff:174.193.164.203 for deletion as token c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf active

03/30/2019 10:52:18.839291 zmeventnotification[1889].INF [main:533] [Invaliding websocket, but NOT Marking ::ffff:174.193.164.203 for deletion as token c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf active]
2019-03-30,10:52:18 ---------->onConnect:disconnect END<--------------
2019-03-30,10:52:19 ---------->onConnect START<--------------
2019-03-30,10:52:19 got a websocket connection from ::ffff:174.193.164.203 (1) active connections
03/30/2019 10:52:19.071324 zmeventnotification[1889].INF [main:533] [got a websocket connection from ::ffff:174.193.164.203 (1) active connections]
2019-03-30,10:52:19 ---------->onConnect STOP<--------------
2019-03-30,10:52:19 ---------->onConnect:handshake START<--------------
2019-03-30,10:52:19 Websockets: New Connection Handshake requested from ::ffff:174.193.164.203:8034 state=pending auth, id=1553957539.10653
03/30/2019 10:52:19.106790 zmeventnotification[1889].INF [main:533] [Websockets: New Connection Handshake requested from ::ffff:174.193.164.203:8034 state=pending auth, id=1553957539.10653]
2019-03-30,10:52:19 ---------->onConnect:handshake END<--------------
2019-03-30,10:52:19 ---------->onConnect msg START<--------------
2019-03-30,10:52:19 Raw incoming message: {"event":"auth","data":{"user":"admin","password":"blaze007","monlist":"1,2,3,4","intlist":"0,0,0,0"}}
2019-03-30,10:52:19 Correct authentication provided by ::ffff:174.193.164.203
03/30/2019 10:52:19.229890 zmeventnotification[1889].INF [main:533] [Correct authentication provided by ::ffff:174.193.164.203]
2019-03-30,10:52:19 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:19 ---------->onConnect msg START<--------------
2019-03-30,10:52:19 Raw incoming message: {"event":"push","data":{"type":"token","platform":"ios","token":"c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf","state":"enabled"}}
2019-03-30,10:52:19 token matched but connection did not
2019-03-30,10:52:19 Duplicate token found: marking ...4LthIVIlRf to be deleted
03/30/2019 10:52:19.319713 zmeventnotification[1889].INF [main:533] [Duplicate token found: marking ...4LthIVIlRf to be deleted]
2019-03-30,10:52:19 connection matched but token did not. first registration?
2019-03-30,10:52:19 Storing token ...4LthIVIlRf,monlist:-1,intlist:-1,pushstate:enabled

03/30/2019 10:52:19.348416 zmeventnotification[1889].INF [main:533] [Storing token ...4LthIVIlRf,monlist:-1,intlist:-1,pushstate:enabled]
2019-03-30,10:52:19 SaveTokens called with:monlist=-1, intlist=-1, platform=ios, push=enabled
03/30/2019 10:52:19.381624 zmeventnotification[1889].INF [main:533] [SaveTokens called with:monlist=-1, intlist=-1, platform=ios, push=enabled]
2019-03-30,10:52:19 token matched, previously stored monlist is: 1,2,3,4
03/30/2019 10:52:19.415401 zmeventnotification[1889].INF [main:533] [token matched, previously stored monlist is: 1,2,3,4]
2019-03-30,10:52:19 updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4
03/30/2019 10:52:19.448789 zmeventnotification[1889].INF [main:533] [updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4]
2019-03-30,10:52:19 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:19 ---------->onConnect msg START<--------------
2019-03-30,10:52:19 Raw incoming message: {"event":"control","data":{"type":"filter","monlist":"1,2,3,4","intlist":"0,0,0,0","token":"c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf"}}
2019-03-30,10:52:19 Contrl: Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled

03/30/2019 10:52:19.482804 zmeventnotification[1889].INF [main:533] [Contrl: Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled]
2019-03-30,10:52:19 SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled
03/30/2019 10:52:19.707396 zmeventnotification[1889].INF [main:533] [SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled]
2019-03-30,10:52:20 token matched, previously stored monlist is: 1,2,3,4
03/30/2019 10:52:20.249819 zmeventnotification[1889].INF [main:533] [token matched, previously stored monlist is: 1,2,3,4]
2019-03-30,10:52:20 updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4
03/30/2019 10:52:20.366696 zmeventnotification[1889].INF [main:533] [updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4]
2019-03-30,10:52:20 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:20 ---------->onConnect msg START<--------------
2019-03-30,10:52:20 Raw incoming message: {"event":"push","data":{"type":"token","platform":"ios","token":"c-iy4mgHcYA:APA91bFkjLu--nyactzOeN4xmxEKxbpL196JImLA63hgisJHHBkVyA3JkQV00UV2CUOsaL_mB-XQmrUg5zKlTpfds7kNMXLjHeMnJy6GXLK5c5BWGqdoChgafXPtvDFhOr4LthIVIlRf","monlist":"1,2,3,4","intlist":"0,0,0,0","state":"enabled"}}
2019-03-30,10:52:20 token matched but connection did not
2019-03-30,10:52:20 Duplicate token found: marking ...4LthIVIlRf to be deleted
03/30/2019 10:52:20.400929 zmeventnotification[1889].INF [main:533] [Duplicate token found: marking ...4LthIVIlRf to be deleted]
2019-03-30,10:52:20 token and connection matched
2019-03-30,10:52:20 Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled

03/30/2019 10:52:20.442008 zmeventnotification[1889].INF [main:533] [Storing token ...4LthIVIlRf,monlist:1,2,3,4,intlist:0,0,0,0,pushstate:enabled]
2019-03-30,10:52:20 SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled
03/30/2019 10:52:20.475417 zmeventnotification[1889].INF [main:533] [SaveTokens called with:monlist=1,2,3,4, intlist=0,0,0,0, platform=ios, push=enabled]
2019-03-30,10:52:20 token matched, previously stored monlist is: 1,2,3,4
03/30/2019 10:52:20.542357 zmeventnotification[1889].INF [main:533] [token matched, previously stored monlist is: 1,2,3,4]
2019-03-30,10:52:20 updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4
03/30/2019 10:52:20.575823 zmeventnotification[1889].INF [main:533] [updating ...4LthIVIlRf with push:enabled & monlist:1,2,3,4]
2019-03-30,10:52:20 ---------->onConnect msg STOP<--------------
2019-03-30,10:52:21 ---------->Tick START<--------------
2019-03-30,10:52:21 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:21 Empty job queue
2019-03-30,10:52:21 checkEvents() events found=0
2019-03-30,10:52:21 ---------->Tick END<--------------
2019-03-30,10:52:26 ---------->Tick START<--------------
2019-03-30,10:52:26 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:26 Empty job queue
2019-03-30,10:52:26 checkEvents() events found=0
2019-03-30,10:52:26 ---------->Tick END<--------------
2019-03-30,10:52:31 ---------->Tick START<--------------
2019-03-30,10:52:31 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:31 Empty job queue
2019-03-30,10:52:31 checkEvents() events found=0
2019-03-30,10:52:31 ---------->Tick END<--------------
2019-03-30,10:52:36 ---------->Tick START<--------------
2019-03-30,10:52:36 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:36 Empty job queue
2019-03-30,10:52:36 checkEvents() events found=0
2019-03-30,10:52:36 ---------->Tick END<--------------
2019-03-30,10:52:41 ---------->Tick START<--------------
2019-03-30,10:52:41 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:41 Empty job queue
2019-03-30,10:52:41 checkEvents() events found=0
2019-03-30,10:52:41 ---------->Tick END<--------------
2019-03-30,10:52:46 ---------->Tick START<--------------
2019-03-30,10:52:46 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:46 Empty job queue
2019-03-30,10:52:46 checkEvents() events found=0
2019-03-30,10:52:46 ---------->Tick END<--------------
2019-03-30,10:52:51 ---------->Tick START<--------------
2019-03-30,10:52:51 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:51 Empty job queue
2019-03-30,10:52:51 checkEvents() events found=0
2019-03-30,10:52:51 ---------->Tick END<--------------
2019-03-30,10:52:56 ---------->Tick START<--------------
2019-03-30,10:52:56 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:52:56 Empty job queue
2019-03-30,10:52:56 checkEvents() events found=0
2019-03-30,10:52:56 ---------->Tick END<--------------
2019-03-30,10:53:01 ---------->Tick START<--------------
2019-03-30,10:53:01 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:01 Empty job queue
2019-03-30,10:53:01 checkEvents() events found=0
2019-03-30,10:53:01 ---------->Tick END<--------------
2019-03-30,10:53:06 ---------->Tick START<--------------
2019-03-30,10:53:06 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:06 Empty job queue
2019-03-30,10:53:06 checkEvents() events found=0
2019-03-30,10:53:06 ---------->Tick END<--------------
2019-03-30,10:53:11 ---------->Tick START<--------------
2019-03-30,10:53:11 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:11 Empty job queue
2019-03-30,10:53:11 checkEvents() events found=0
2019-03-30,10:53:11 ---------->Tick END<--------------
2019-03-30,10:53:16 ---------->Tick START<--------------
2019-03-30,10:53:16 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:16 Empty job queue
2019-03-30,10:53:16 checkEvents() events found=0
2019-03-30,10:53:16 ---------->Tick END<--------------
2019-03-30,10:53:21 ---------->Tick START<--------------
2019-03-30,10:53:21 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:21 Empty job queue
2019-03-30,10:53:21 checkEvents() events found=0
2019-03-30,10:53:21 ---------->Tick END<--------------
2019-03-30,10:53:26 ---------->Tick START<--------------
2019-03-30,10:53:26 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:26 Empty job queue
2019-03-30,10:53:26 checkEvents() events found=0
2019-03-30,10:53:26 ---------->Tick END<--------------
2019-03-30,10:53:31 ---------->Tick START<--------------
2019-03-30,10:53:31 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:31 Empty job queue
2019-03-30,10:53:31 checkEvents() events found=0
2019-03-30,10:53:31 ---------->Tick END<--------------
2019-03-30,10:53:36 ---------->Tick START<--------------
2019-03-30,10:53:36 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:36 Empty job queue
2019-03-30,10:53:36 checkEvents() events found=0
2019-03-30,10:53:36 ---------->Tick END<--------------
2019-03-30,10:53:41 ---------->Tick START<--------------
2019-03-30,10:53:41 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:41 Empty job queue
2019-03-30,10:53:41 checkEvents() events found=0
2019-03-30,10:53:41 ---------->Tick END<--------------
2019-03-30,10:53:46 ---------->Tick START<--------------
2019-03-30,10:53:46 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:46 Empty job queue
2019-03-30,10:53:46 checkEvents() events found=0
2019-03-30,10:53:46 ---------->Tick END<--------------
2019-03-30,10:53:51 ---------->Tick START<--------------
2019-03-30,10:53:51 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:51 Empty job queue
2019-03-30,10:53:51 checkEvents() events found=0
2019-03-30,10:53:51 ---------->Tick END<--------------
2019-03-30,10:53:56 ---------->Tick START<--------------
2019-03-30,10:53:56 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:53:56 Empty job queue
2019-03-30,10:53:56 checkEvents() events found=0
2019-03-30,10:53:56 ---------->Tick END<--------------
2019-03-30,10:54:01 ---------->Tick START<--------------
2019-03-30,10:54:01 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:01 Empty job queue
2019-03-30,10:54:01 checkEvents() events found=0
2019-03-30,10:54:01 ---------->Tick END<--------------
2019-03-30,10:54:06 ---------->Tick START<--------------
2019-03-30,10:54:06 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:06 Empty job queue
2019-03-30,10:54:06 New event 370 reported for Front Porch Motion All

03/30/2019 10:54:06.092312 zmeventnotification[1889].INF [main:533] [New event 370 reported for Front Porch Motion All]
2019-03-30,10:54:06 HOOK: 370 Creating event object for Front Porch, setting state to recording
2019-03-30,10:54:06 checkEvents() events found=1
2019-03-30,10:54:06 ---------->Tick END<--------------
2019-03-30,10:54:06 Forking process:1912 to handle 1 alarms
03/30/2019 10:54:06.123029 zmeventnotification[1912].INF [main:533] [Forking process:1912 to handle 1 alarms]
2019-03-30,10:54:06 processAlarms: EID:370 Monitor:Front Porch (id):2 cause:Motion All
03/30/2019 10:54:06.155371 zmeventnotification[1912].INF [main:533] [processAlarms: EID:370 Monitor:Front Porch (id):2 cause:Motion All]
2019-03-30,10:54:06 Invoking hook:'/usr/bin/detect_wrapper.sh' 370 2 "Front Porch" "Motion All"
03/30/2019 10:54:06.188851 zmeventnotification[1912].INF [main:533] [Invoking hook:'/usr/bin/detect_wrapper.sh' 370 2 "Front Porch" "Motion All"]
Traceback (most recent call last):
  File "/usr/bin/detect.py", line 8, in <module>
    import cv2
ImportError: No module named cv2
2019-03-30,10:54:06 hook script returned with text: exit:1
03/30/2019 10:54:06.615397 zmeventnotification[1912].INF [main:533] [hook script returned with text: exit:1]
2019-03-30,10:54:06 Ending process:1912 to handle alarms
03/30/2019 10:54:06.689350 zmeventnotification[1912].INF [main:533] [Ending process:1912 to handle alarms]
2019-03-30,10:54:11 ---------->Tick START<--------------
2019-03-30,10:54:11 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:11 Empty job queue
2019-03-30,10:54:11 checkEvents() events found=0
2019-03-30,10:54:11 ---------->Tick END<--------------
2019-03-30,10:54:16 ---------->Tick START<--------------
2019-03-30,10:54:16 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:16 Empty job queue
2019-03-30,10:54:16 Alarm 370 for monitor:2 has ended
2019-03-30,10:54:16 HOOK: 370 NOT writing hook to DB as hook text was empty
2019-03-30,10:54:16 checkEvents() events found=0
2019-03-30,10:54:16 ---------->Tick END<--------------
2019-03-30,10:54:21 ---------->Tick START<--------------
2019-03-30,10:54:21 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:21 Empty job queue
2019-03-30,10:54:21 checkEvents() events found=0
2019-03-30,10:54:21 ---------->Tick END<--------------
2019-03-30,10:54:26 ---------->Tick START<--------------
2019-03-30,10:54:26 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:26 Empty job queue
2019-03-30,10:54:26 checkEvents() events found=0
2019-03-30,10:54:26 ---------->Tick END<--------------
2019-03-30,10:54:31 ---------->Tick START<--------------
2019-03-30,10:54:31 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:31 Empty job queue
2019-03-30,10:54:31 checkEvents() events found=0
2019-03-30,10:54:31 ---------->Tick END<--------------
2019-03-30,10:54:36 ---------->Tick START<--------------
2019-03-30,10:54:36 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:36 Empty job queue
2019-03-30,10:54:36 checkEvents() events found=0
2019-03-30,10:54:36 ---------->Tick END<--------------
2019-03-30,10:54:41 ---------->Tick START<--------------
2019-03-30,10:54:41 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:41 Empty job queue
2019-03-30,10:54:41 checkEvents() events found=0
2019-03-30,10:54:41 ---------->Tick END<--------------
2019-03-30,10:54:46 ---------->Tick START<--------------
2019-03-30,10:54:46 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:46 Empty job queue
2019-03-30,10:54:46 checkEvents() events found=0
2019-03-30,10:54:46 ---------->Tick END<--------------
2019-03-30,10:54:51 ---------->Tick START<--------------
2019-03-30,10:54:51 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:51 Empty job queue
2019-03-30,10:54:51 checkEvents() events found=0
2019-03-30,10:54:51 ---------->Tick END<--------------
2019-03-30,10:54:56 ---------->Tick START<--------------
2019-03-30,10:54:56 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:54:56 Empty job queue
2019-03-30,10:54:56 checkEvents() events found=0
2019-03-30,10:54:56 ---------->Tick END<--------------
2019-03-30,10:55:01 ---------->Tick START<--------------
2019-03-30,10:55:01 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0
2019-03-30,10:55:01 Empty job queue
2019-03-30,10:55:01 checkEvents() events found=0
2019-03-30,10:55:01 ---------->Tick END<--------------
2019-03-30,10:55:06 ---------->Tick START<--------------
2019-03-30,10:55:06 After tick: TOTAL: 1, FCM+WEB: 1, FCM: 0, WEB: 0, MQTT:0, invalid WEB: 0, PENDING: 0

Zoneminder Logs (if applicable)

Zoneminder syslogs at the time the error occurs. Please add context to the logs (don't just add 1-2 lines)
<insert debug logs here, please make sure they are within the ``` quotes so they are formatted properly>

Web Server Error Logs (if applicable, especially for streaming errors or API error)

typically tail -f /var/log/apache2/error.log - change to your web server of choice

Thanks!

[welcome]

👋 Thanks for opening your first issue here! If you're reporting a 🐞 bug, please make sure you follow the issue template or I may not respond.

[pliablepixels]

The reason you are not getting push is due to this:

03/30/2019 10:54:06.155371 zmeventnotification[1912].INF [main:533] [processAlarms: EID:370 Monitor:Front Porch (id):2 cause:Motion All]
2019-03-30,10:54:06 Invoking hook:'/usr/bin/detect_wrapper.sh' 370 2 "Front Porch" "Motion All"
03/30/2019 10:54:06.188851 zmeventnotification[1912].INF [main:533] [Invoking hook:'/usr/bin/detect_wrapper.sh' 370 2 "Front Porch" "Motion All"]
Traceback (most recent call last):
  File "/usr/bin/detect.py", line 8, in <module>
    import cv2
ImportError: No module named cv2

Are you using the machine learning hooks? If not, turn it off by commenting out the hook_script tag

[woodsjimd]

I commented out the hook_script tag and that fixed it. Thanks!