Open tibmeister opened 1 year ago
My config doesn't have a use_fcm=... it only has use_fcmv1=. It looks like fcm is controlled with the enable = no setting in the [fcm] block.
weird. FCM disabling works here for me.
The logic around this message is unclear. I had put a todo on it and have just now commit a potential fix. Please update and report back.
I have this in my zmeventnotification.ini file
# Use the new FCM V1 protocol (recommended)
use_fcmv1 = no
I did pull the latest change and re-ran the install.sh file. right off the bat, noticed this in the debug log
10/03/2022 11:51:59.613136 zmeventnotification[2704158].INF [main:1006] [PARENT: Re-loading monitors]
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera1
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera2
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera3
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera1 Motion
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera2 Motion
DBG-1:2022-10-03,11:51:59 PARENT: Loading Camera3 Motion
DBG-2:2022-10-03,11:51:59 PARENT: ESCONTROL_INTERFACE: Saving admin interfaces to /var/lib/zmeventnotification/misc/escontrol_interface.dat
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1449.
INF:2022-10-03,11:51:59 PARENT: New event 65537 reported for Monitor:3 (Name:Camera3) [last processed eid:]
10/03/2022 11:51:59.616068 zmeventnotification[2704158].INF [main:1006] [PARENT: New event 65537 reported for Monitor:3 (Name:Camera3) [last processed eid:]]
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1449.
INF:2022-10-03,11:51:59 PARENT: New event 65427 reported for Monitor:2 (Name:Camera2) [last processed eid:]
10/03/2022 11:51:59.616514 zmeventnotification[2704158].INF [main:1006] [PARENT: New event 65427 reported for Monitor:2 (Name:Camera2) [last processed eid:]]
DBG-2:2022-10-03,11:51:59 PARENT: checkEvents() new events found=2
DBG-2:2022-10-03,11:51:59 PARENT: About to start listening to socket
INF:2022-10-03,11:51:59 PARENT: Secure WS(WSS) is enabled...
10/03/2022 11:51:59.625508 zmeventnotification[2704158].INF [main:1006] [PARENT: Secure WS(WSS) is enabled...]
INF:2022-10-03,11:51:59 PARENT: Web Socket Event Server listening on port 9000
10/03/2022 11:51:59.625562 zmeventnotification[2704158].INF [main:1006] [PARENT: Web Socket Event Server listening on port 9000]
DBG-2:2022-10-03,11:52:04 PARENT: ----------> Tick START (active forks:0, total forks:0, active hooks: 0 running for:1 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
DBG-2:2022-10-03,11:52:04 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:52:04 PARENT: There are 0 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:52:04 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:52:04 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
Looking in ZM, these monitors are not in alarm, and I find those events for those monitors from 12 hours ago, so not sure what's going on there but that's new.
As for the original issue, I still get the start event
DBG-2:2022-10-03,11:58:08 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:58:08 PARENT: There are 0 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:58:08 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1449.
INF:2022-10-03,11:58:08 PARENT: New event 65582 reported for Monitor:1 (Name:Camera1) Forced Web[last processed eid:]
10/03/2022 11:58:08.635006 zmeventnotification[2705223].INF [main:1006] [PARENT: New event 65582 reported for Monitor:1 (Name:Camera1) Forced Web[last processed eid:]]
DBG-2:2022-10-03,11:58:08 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:58:08 PARENT: checkEvents() new events found=1
DBG-2:2022-10-03,11:58:08 PARENT: There are 1 new Events to process
DBG-2:2022-10-03,11:58:08 PARENT: ---------->Tick END (active forks:1, total forks:1, active hooks: 0)<--------------
DBG-1:2022-10-03,11:58:08 PARENT: Forked process:2705348 to handle alarm eid:65582
DBG-2:2022-10-03,11:58:08 |----> FORK:Camera1 (1), eid:65582 Adding event path:/var/cache/zoneminder/events/1/2022-10-03/65582 to hook for image storage
DBG-1:2022-10-03,11:58:08 |----> FORK:Camera1 (1), eid:65582 Invoking hook on event start:'/var/lib/zmeventnotification/bin/zm_event_start.sh' 65582 1 "Camera1" "Forced Web" "/var/cache/zoneminder/events/1/2022-10-03/65582"
DBG-2:2022-10-03,11:58:13 PARENT: ----------> Tick START (active forks:1, total forks:1, active hooks: 0 running for:1 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
...
DBG-2:2022-10-03,11:58:53 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:58:53 PARENT: There are 1 active child forks & 1 zm_detect processes running...
DBG-2:2022-10-03,11:58:53 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
DBG-2:2022-10-03,11:58:53 PARENT: We've already worked on Monitor:1, Event:65582, not doing anything more
DBG-2:2022-10-03,11:58:53 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:58:53 PARENT: checkEvents() new events found=0
DBG-2:2022-10-03,11:58:53 PARENT: There are 0 new Events to process
DBG-2:2022-10-03,11:58:53 PARENT: ---------->Tick END (active forks:1, total forks:1, active hooks: 1)<--------------
DBG-2:2022-10-03,11:58:53 |----> FORK:Camera1 (1), eid:65582 parse of hook: and [] from
DBG-1:2022-10-03,11:58:53 |----> FORK:Camera1 (1), eid:65582 hook start returned with text: json:[] exit:1
Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3195.
Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3197.
DBG-2:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 rules: Checking rules for alarm caused by eid:65582, monitor:1, at: Mon Oct 3 11:58:55 2022 with cause:Forced Web
DBG-1:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 rules: No rules found for Monitor, allowing:1
DBG-1:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 Matching alarm to connection rules...
Use of uninitialized value in substr at /usr/bin/zmeventnotification.pl line 3021.
DBG-1:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 Checking alarm conditions for token ending in:...
Use of uninitialized value $monlist in string eq at /usr/bin/zmeventnotification.pl line 3005.
Use of uninitialized value $monlist in string eq at /usr/bin/zmeventnotification.pl line 3005.
Use of uninitialized value $intlist in split at /usr/bin/zmeventnotification.pl line 2984.
Use of uninitialized value $monlist in split at /usr/bin/zmeventnotification.pl line 2985.
ERR:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 interval not found for mid 1
10/03/2022 11:58:55.772837 zmeventnotification[2705348].ERR [main:1022] [|----> FORK:Camera1 (1), eid:65582 interval not found for mid 1]
DBG-1:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 Monitor 1 event: last time not found, so should send
DBG-1:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 token is unique, shouldSendEventToConn returned true, so calling sendEvent
Use of uninitialized value in string ne at /usr/bin/zmeventnotification.pl line 3073.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 3073.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 3073.
DBG-2:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 isAllowedChannel: got type:event_start resCode:1
INF:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 Sending event_start notification over FCM
10/03/2022 11:58:55.773344 zmeventnotification[2705348].INF [main:1006] [|----> FORK:Camera1 (1), eid:65582 Sending event_start notification over FCM]
DBG-4:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 Using Legacy
DBG-2:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 FCM called when hook failed, so making sure we do not use objdetect in url
Use of uninitialized value in addition (+) at /usr/bin/zmeventnotification.pl line 1992.
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1996.
DBG-2:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 legacy client, NOT setting channel to zmninja
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2071.
Use of uninitialized value in substr at /usr/bin/zmeventnotification.pl line 2084.
DBG-2:2022-10-03,11:58:55 |----> FORK:Camera1 (1), eid:65582 legacy: Final JSON being sent is: {"to":null,"notification":{"image":"https://zm.tiberiansun.us:2417/zm/index.php?view=image&eid=65582&fid=objdetect&width=800&username=admin&password=xxx&eid=65582&fid=objdetect&width=800&username=admin&password=xxx to token: ...
ERR:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 FCM push message Error:400 Bad Request
10/03/2022 11:58:56.023206 zmeventnotification[2705348].ERR [main:1022] [|----> FORK:Camera1 (1), eid:65582 FCM push message Error:400 Bad Request]
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2124.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 child finished writing to parent
Use of uninitialized value in substr at /usr/bin/zmeventnotification.pl line 3021.
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Checking alarm conditions for token ending in:...
Use of uninitialized value $monlist in string eq at /usr/bin/zmeventnotification.pl line 3005.
Use of uninitialized value $monlist in string eq at /usr/bin/zmeventnotification.pl line 3005.
Use of uninitialized value $intlist in split at /usr/bin/zmeventnotification.pl line 2984.
Use of uninitialized value $monlist in split at /usr/bin/zmeventnotification.pl line 2985.
ERR:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 interval not found for mid 1
10/03/2022 11:58:56.023540 zmeventnotification[2705348].ERR [main:1022] [|----> FORK:Camera1 (1), eid:65582 interval not found for mid 1]
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Monitor 1 event: last time not found, so should send
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 token is unique, shouldSendEventToConn returned true, so calling sendEvent
Use of uninitialized value in string ne at /usr/bin/zmeventnotification.pl line 3073.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 3073.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 3073.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 isAllowedChannel: got type:event_start resCode:1
INF:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Sending event_start notification over FCM
10/03/2022 11:58:56.023797 zmeventnotification[2705348].INF [main:1006] [|----> FORK:Camera1 (1), eid:65582 Sending event_start notification over FCM]
DBG-4:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Using Legacy
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 FCM called when hook failed, so making sure we do not use objdetect in url
Use of uninitialized value in addition (+) at /usr/bin/zmeventnotification.pl line 1992.
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1996.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 legacy client, NOT setting channel to zmninja
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2071.
Use of uninitialized value in substr at /usr/bin/zmeventnotification.pl line 2084.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 legacy: Final JSON being sent is: {"to":null,"notification":{"body":"Forced Web at 11:58 AM, 03-Oct","icon":"ic_stat_notification","title":"Camera1 Alarm (65582)","image":"https://zm.tiberiansun.us:2417/zm/index.php?view=image&eid=65582&fid=objdetect&width=800&username=admin&password=xxx&eid=65582&fid=objdetect&width=800&username=admin&password=xxx to token: ...
ERR:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 FCM push message Error:400 Bad Request
10/03/2022 11:58:56.209734 zmeventnotification[2705348].ERR [main:1022] [|----> FORK:Camera1 (1), eid:65582 FCM push message Error:400 Bad Request]
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2124.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 child finished writing to parent
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Checking alarm conditions for MQTT 10.27.200.5
ERR:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 interval not found for mid 1
10/03/2022 11:58:56.210025 zmeventnotification[2705348].ERR [main:1022] [|----> FORK:Camera1 (1), eid:65582 interval not found for mid 1]
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Monitor 1 event: last time not found, so should send
DBG-1:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 token is unique, shouldSendEventToConn returned true, so calling sendEvent
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 isAllowedChannel: got type:event_start resCode:1
INF:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 Sending event_start notification for EID:65582 over MQTT
10/03/2022 11:58:56.210270 zmeventnotification[2705348].INF [main:1006] [|----> FORK:Camera1 (1), eid:65582 Sending event_start notification for EID:65582 over MQTT]
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 requesting MQTT Publishing Job for EID:65582
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 1680.
Use of uninitialized value in concatenation (.) or string at /usr/bin/zmeventnotification.pl line 3130.
DBG-2:2022-10-03,11:58:56 |----> FORK:Camera1 (1), eid:65582 child finished writing to parent
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3686.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3837.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3938.
DBG-2:2022-10-03,11:58:58 PARENT: ----------> Tick START (active forks:1, total forks:1, active hooks: 1 running for:2 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
DBG-2:2022-10-03,11:58:58 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->update_parallel_hooks--TYPE--del
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->fcm_notification--TYPE----SPLIT--1--SPLIT--0--SPLIT--9
DBG-2:2022-10-03,11:58:58 PARENT: GOT JOB==> update badge to 1, count to 0 for: , at: 9
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->timestamp--TYPE--1664816263--SPLIT--1--SPLIT--1664816335.77309
DBG-2:2022-10-03,11:58:58 PARENT: Job: Update last sent timestamp of monitor:1 to 1664816335.77309 for id:1664816263
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2194.
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->fcm_notification--TYPE----SPLIT--1--SPLIT--0--SPLIT--9
DBG-2:2022-10-03,11:58:58 PARENT: GOT JOB==> update badge to 1, count to 0 for: , at: 9
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2172.
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->timestamp--TYPE--1664816263--SPLIT--1--SPLIT--1664816336.02367
DBG-2:2022-10-03,11:58:58 PARENT: Job: Update last sent timestamp of monitor:1 to 1664816336.02367 for id:1664816263
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2194.
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->mqtt_publish--TYPE----SPLIT--zoneminder/1--SPLIT--{"name":"Camera1:(65582) Forced Web","monitor":"1","eventid":"65582","hookvalue":"1","state":"alarm","detection":[],"eventtype":"event_start"}
DBG-2:2022-10-03,11:58:58 PARENT: Job: MQTT Publish on topic: zoneminder/1
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2234.
DBG-2:2022-10-03,11:58:58 PARENT: Job: MQTT Publish with retain
DBG-2:2022-10-03,11:58:58 PARENT: RAW TEXT-->timestamp--TYPE----SPLIT--1--SPLIT--1664816336.21015
DBG-2:2022-10-03,11:58:58 PARENT: Job: Update last sent timestamp of monitor:1 to 1664816336.21015 for id:
Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 2194.
DBG-2:2022-10-03,11:58:58 PARENT: There are 1 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:58:58 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
DBG-2:2022-10-03,11:58:58 PARENT: We've already worked on Monitor:1, Event:65582, not doing anything more
DBG-2:2022-10-03,11:58:58 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:58:58 PARENT: checkEvents() new events found=0
DBG-2:2022-10-03,11:58:58 PARENT: There are 0 new Events to process
...
DBG-2:2022-10-03,11:59:43 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:59:43 PARENT: There are 1 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:59:43 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
DBG-2:2022-10-03,11:59:43 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:59:43 PARENT: checkEvents() new events found=0
DBG-2:2022-10-03,11:59:43 PARENT: There are 0 new Events to process
DBG-2:2022-10-03,11:59:43 PARENT: ---------->Tick END (active forks:1, total forks:1, active hooks: 0)<--------------
DBG-2:2022-10-03,11:59:44 |----> FORK:Driveway (MUS) (1), eid:65582 Adding event path:/var/cache/zoneminder/events/1/2022-10-03/65582 to hook for image storage
DBG-1:2022-10-03,11:59:44 |----> FORK:Driveway (MUS) (1), eid:65582 Invoking hook on event end:'/var/lib/zmeventnotification/bin/zm_event_end.sh' 65582 1 "Driveway (MUS)" "Forced Web: " "/var/cache/zoneminder/events/1/2022-10-03/65582"
DBG-2:2022-10-03,11:59:44 |----> FORK:Driveway (MUS) (1), eid:65582 parse of hook:Forced Web: and [] from Forced Web:
DBG-1:2022-10-03,11:59:44 |----> FORK:Driveway (MUS) (1), eid:65582 hook end returned with text:Forced Web: json:[] exit:0
Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3197.
DBG-2:2022-10-03,11:59:46 |----> FORK:Driveway (MUS) (1), eid:65582 rules: Checking rules for alarm caused by eid:65582, monitor:1, at: Mon Oct 3 11:59:46 2022 with cause:Forced Web
DBG-1:2022-10-03,11:59:46 |----> FORK:Driveway (MUS) (1), eid:65582 rules: No rules found for Monitor, allowing:1
INF:2022-10-03,11:59:46 |----> FORK:Driveway (MUS) (1), eid:65582 Not sending event end alarm, as we did not send a start alarm for this, or start hook processing failed
10/03/2022 11:59:46.227716 zmeventnotification[2705348].INF [main:1006] [|----> FORK:Driveway (MUS) (1), eid:65582 Not sending event end alarm, as we did not send a start alarm for this, or start hook processing failed]
DBG-2:2022-10-03,11:59:48 PARENT: ----------> Tick START (active forks:1, total forks:1, active hooks: 0 running for:3 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
DBG-2:2022-10-03,11:59:48 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:59:48 PARENT: RAW TEXT-->update_parallel_hooks--TYPE--add
DBG-2:2022-10-03,11:59:48 PARENT: RAW TEXT-->update_parallel_hooks--TYPE--del
DBG-2:2022-10-03,11:59:48 PARENT: There are 1 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:59:48 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
DBG-2:2022-10-03,11:59:48 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:59:48 PARENT: checkEvents() new events found=0
DBG-2:2022-10-03,11:59:48 PARENT: There are 0 new Events to process
DBG-2:2022-10-03,11:59:48 PARENT: ---------->Tick END (active forks:1, total forks:1, active hooks: 0)<--------------
DBG-1:2022-10-03,11:59:50 |----> FORK:Driveway (MUS) (1), eid:65582 exiting
DBG-1:2022-10-03,11:59:50 |----> FORK:Driveway (MUS) (1), eid:65582 Ending process:2705348 to handle alarms
DBG-2:2022-10-03,11:59:53 PARENT: ----------> Tick START (active forks:1, total forks:1, active hooks: 0 running for:3 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
DBG-2:2022-10-03,11:59:53 PARENT: After tick: TOTAL: 3 , ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:1, invalid WEB: 0, PENDING: 0
DBG-2:2022-10-03,11:59:53 PARENT: RAW TEXT-->active_event_delete--TYPE--1--SPLIT--65582
DBG-2:2022-10-03,11:59:53 PARENT: Job: Deleting active_event eid:65582, mid:1
DBG-2:2022-10-03,11:59:53 PARENT: There are 0 active child forks & 0 zm_detect processes running...
DBG-2:2022-10-03,11:59:53 PARENT: We've already worked on Monitor:2, Event:65427, not doing anything more
DBG-2:2022-10-03,11:59:53 PARENT: We've already worked on Monitor:3, Event:65537, not doing anything more
DBG-2:2022-10-03,11:59:53 PARENT: checkEvents() new events found=0
DBG-2:2022-10-03,11:59:53 PARENT: There are 0 new Events to process
DBG-2:2022-10-03,11:59:53 PARENT: ---------->Tick END (active forks:0, total forks:1, active hooks: 0)<--------------
DBG-2:2022-10-03,11:59:58 PARENT: ----------> Tick START (active forks:0, total forks:1, active hooks: 0 running for:3 min)<--------------
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2286.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric ne (!=) at /usr/bin/zmeventnotification.pl line 2315.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2318.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2321.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2324.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2327.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2330.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Use of uninitialized value in numeric eq (==) at /usr/bin/zmeventnotification.pl line 2336.
Event Server version 6.1.28
Hooks version (if you are using Object Detection) app:6.1.28, pyzm:0.3.56
Are you using MLAPI? (Y/N) No
The version of ZoneMinder you are using: 1.37.23
What is the nature of your issue Bug
Details Start event is sent, but End event not sent due to "Not sending event end alarm, as we did not send a start alarm for this, or start hook processing failed". I can see the start message in my MQTT. Note, I have set
It is still showing as enabled, which could be generating an error preventing the start script from running properly. Also note, I have three camera, two monitors per camera. The one's suffixed with "Motion" are lower resolution and the one's I intend to have trigger, then trigger the higher resolution monitor via Link.
Debug Logs (if applicable)