Event but no identification with ZMES

[funix]

Hello,
I have a problem with ZMES since the upgrade to version 1.36.35, the events are detected but then ZMES does not identify anything to me.
The logs send me this message.

Code: Select all

ars 01 13:19:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:15 PARENT: checkEvents() new events found=1
mars 01 13:19:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:15 PARENT: There are 1 new Events to process
mars 01 13:19:15 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:15 PARENT: Forked process:1495816 to handle alarm eid:14414
mars 01 13:19:15 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:15 |----> FORK:Camera entree (4), eid:14414 Adding event path:/media/motion/events/4/2025-03-0>
mars 01 13:19:15 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:15 |----> FORK:Camera entree (4), eid:14414 Invoking hook on event start:'/var/lib/zmeventnoti>
mars 01 13:19:20 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3195.
mars 01 13:19:20 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3197.
mars 01 13:19:22 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3672.
mars 01 13:19:22 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3834.
mars 01 13:19:22 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in string eq at /usr/bin/zmeventnotification.pl line 3935.
mars 01 13:19:26 ultra.kervao.fr zmeventnotification.pl[1495816]: Use of uninitialized value in index at /usr/bin/zmeventnotification.pl line 3197.
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:18 |----> FORK:Camera entree (4), eid:14414 parse of hook: and [] from
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:18 |----> FORK:Camera entree (4), eid:14414 hook start returned with text: json:[] exit:1
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:20 |----> FORK:Camera entree (4), eid:14414 rules: Checking rules for alarm caused by eid:1441>
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:20 |----> FORK:Camera entree (4), eid:14414 rules: No rules found for Monitor, allowing:4
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:20 |----> FORK:Camera entree (4), eid:14414 Matching alarm to connection rules...
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:22 |----> FORK:Camera entree (4), eid:14414 For 4 (Camera entree), SHM says: state=1, eid=14414
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: INF:2025-03-01,13:19:22 |----> FORK:Camera entree (4), eid:14414 Event 14414 for Monitor 4 has finished
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:22 |----> FORK:Camera entree (4), eid:14414 Event end object is: state=>pending with cause=>Mo>
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: INF:2025-03-01,13:19:24 |----> FORK:Camera entree (4), eid:14414 end hooks/use hooks not being used, going to directl>
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-2:2025-03-01,13:19:26 |----> FORK:Camera entree (4), eid:14414 rules: Checking rules for alarm caused by eid:1441>
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:26 |----> FORK:Camera entree (4), eid:14414 rules: No rules found for Monitor, allowing:4
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: INF:2025-03-01,13:19:26 |----> FORK:Camera entree (4), eid:14414 Not sending event end alarm, as we did not send a st>
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:30 |----> FORK:Camera entree (4), eid:14414 exiting
mars 01 13:19:30 ultra.kervao.fr zmeventnotification.pl[1495816]: DBG-1:2025-03-01,13:19:30 |----> FORK:Camera entree (4), eid:14414 Ending process:1495816 to handle alarms
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:15 PARENT: ---------->Tick END (active forks:1, total forks:10, active hooks: 0)<--------------
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: ----------> Tick START (active forks:1, total forks:10, active hooks: 0 running for>
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: After tick: TOTAL: 0 ,  ES_CONTROL: 0, FCM+WEB: 0, FCM: 0, WEB: 0, MQTT:0, invalid >
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: RAW TEXT-->update_parallel_hooks--TYPE--add
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: RAW TEXT-->update_parallel_hooks--TYPE--del
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: There are 1 active child forks & 0 zm_detect processes running...
mars 01 13:20:15 ultra.kervao.fr zmeventnotification.pl[1495253]: DBG-2:2025-03-01,13:19:20 PARENT: We've already worked on Monitor:4, Event:14414, not doing anything more

I specify that with version 1.36.33 it worked

[Quantum]

I'm missing events with v1.36.35 and ZMES.

Last time I tried 1.37 (beta) it didn't work, and I'm afraid to try it again.

[funix]

Hello, I'm still with my problem

the debug message of this command

/var/lib/zmeventnotification/bin/zm_detect.py --config /etc/zm/objectconfig.ini --eventid 29103 --monitorid 1 --debug

gives me

Code: Select all

04/20/25 18:07:10 zmesdetect_m1[1747988] INF ZMLog.py:292 [Setting up signal handler for logs]

04/20/25 18:07:10 zmesdetect_m1[1747988] INF ZMLog.py:301 [Switching global logger to ZMLog]

04/20/25 18:07:11 zmesdetect_m1[1747988] INF zm_detect.py:283 [---------| app:6.1.29, pyzm:0.3.64, ES:6.1.29
 , OpenCV:4.10.0|------------]

04/20/25 18:07:11 zmesdetect_m1[1747988] INF utils.py:404 [Reading config from: /etc/zm/objectconfig.ini]

04/20/25 18:07:11 zmesdetect_m1[1747988] INF utils.py:409 [Reading secrets from: /etc/zm/secrets.ini]

DBG2 [zmesdetect_m1] [Secret token found in config: !ZM_PORTAL]
DBG2 [zmesdetect_m1] [Secret token found in config: !ZM_USER]
DBG2 [zmesdetect_m1] [Secret token found in config: !ZM_PASSWORD]
DBG2 [zmesdetect_m1] [Secret token found in config: !ZM_API_PORTAL]
DBG2 [zmesdetect_m1] [Secret token found in config: !ML_USER]
DBG2 [zmesdetect_m1] [Secret token found in config: !ML_PASSWORD]
DBG2 [zmesdetect_m1] [Secret token found in config: !PLATEREC_ALPR_KEY]
DBG1 [zmesdetect_m1] [allowing self-signed certs to work...]
DBG2 [zmesdetect_m1] [Now checking for monitor overrides]
DBG3 [zmesdetect_m1] [Finally, doing parameter substitution]
04/20/25 18:07:11 zmesdetect_m1[1747988] INF zm_detect.py:308 [Importing local classes for Object/Face]

04/20/25 18:07:11 zmesdetect_m1[1747988] INF zm_detect.py:333 [Connecting with ZM APIs]

DBG2 [zmesdetect_m1] [Basic auth requested, configuring]
DBG2 [zmesdetect_m1] [API SSL certificate check has been disbled]
DBG1 [zmesdetect_m1] [using username/password for login]
DBG1 [zmesdetect_m1] [{"access_token":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk","access_token_expires":7200,"refresh_token":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUyNTE2MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoicmVmcmVzaCJ9.91JFBRXiXJ5vnG_a41XR_JX8rcSAzhWC21CFSq-NFWk","refresh_token_expires":86400,"credentials":"auth=","append_password":0,"version":"1.36.35","apiversion":"2.0"}]
DBG2 [zmesdetect_m1] [Using new token API]
DBG1 [zmesdetect_m1] [Access token expires on:2025-04-20 20:07:12.071587 [7200s]]
DBG1 [zmesdetect_m1] [Refresh token expires on:2025-04-21 18:07:12.072136 [86400s]]
DBG2 [zmesdetect_m1] [using ml_sequence]
DBG2 [zmesdetect_m1] [using stream_sequence]
DBG1 [zmesdetect_m1] [Resetting models, will be loaded on next run]
DBG2 [zmesdetect_m1] [Called detect_stream(stream=29103, ml_overrides={}, options={'frame_strategy': 'most_models', 'frame_set': 'snapshot,alarm', 'contig_frames_before_error': 5, 'max_attempts': 3, 'sleep_between_attempts': 4, 'resize': 800, 'api': <pyzm.api.ZMApi object at 0x7f098d453fd0>, 'polygons': [], 'mid': '1'})]
DBG3 [zmesdetect_m1] [Using automatic locking as we are switching between models]
DBG2 [zmesdetect_m1] [Media get SSL certificate check has been disbled]
DBG2 [zmesdetect_m1] [Using URL 29103 for stream]
DBG2 [zmesdetect_m1] [We will only process frames: ['snapshot', 'alarm']]
DBG2 [zmesdetect_m1] [No need to start streams, we are picking images from https://monserveur.ddns.net/zm/index.php?view=image&eid=29103]
DBG2 [zmesdetect_m1] [in detect_stream() polygons=[]]
DBG3 [zmesdetect_m1] [Reading https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=snapshot]
DBG3 [zmesdetect_m1] [No need to relogin as access token still has 119.99983268333334 minutes remaining]
DBG3 [zmesdetect_m1] [make_request called with url=https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=snapshot payload={} type=get query={'token': 'eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk'}]
DBG2 [zmesdetect_m1] [Raising RELOGIN ValueError]
DBG1 [zmesdetect_m1] [Got ValueError access error: RELOGIN]
DBG1 [zmesdetect_m1] [Retrying login once]
DBG2 [zmesdetect_m1] [Going to use refresh token as it still has 1439.9959097333333 minutes remaining]
DBG1 [zmesdetect_m1] [Using token for login [eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUyNTE2MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoicmVmcmVzaCJ9.91JFBRXiXJ5vnG_a41XR_JX8rcSAzhWC21CFSq-NFWk]]
DBG1 [zmesdetect_m1] [{"access_token":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk","access_token_expires":7200,"credentials":"auth=","append_password":0,"version":"1.36.35","apiversion":"2.0"}]
DBG2 [zmesdetect_m1] [Using new token API]
DBG1 [zmesdetect_m1] [Access token expires on:2025-04-20 20:07:12.364548 [7200s]]
DBG1 [zmesdetect_m1] [Retrying failed request again...]
DBG3 [zmesdetect_m1] [No need to relogin as access token still has 119.99997601666668 minutes remaining]
DBG3 [zmesdetect_m1] [make_request called with url=https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=snapshot payload={} type=get query={'token': 'eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk'}]
DBG2 [zmesdetect_m1] [Raising RELOGIN ValueError]
DBG1 [zmesdetect_m1] [Error reading frame: 1 of max 5 contiguous errors]
DBG3 [zmesdetect_m1] [Reading https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=alarm]
DBG3 [zmesdetect_m1] [No need to relogin as access token still has 119.99681994999999 minutes remaining]
DBG3 [zmesdetect_m1] [make_request called with url=https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=alarm payload={} type=get query={'token': 'eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk'}]
DBG2 [zmesdetect_m1] [Raising RELOGIN ValueError]
DBG1 [zmesdetect_m1] [Got ValueError access error: RELOGIN]
DBG1 [zmesdetect_m1] [Retrying login once]
DBG2 [zmesdetect_m1] [Going to use refresh token as it still has 1439.9886447 minutes remaining]
DBG1 [zmesdetect_m1] [Using token for login [eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUyNTE2MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoicmVmcmVzaCJ9.91JFBRXiXJ5vnG_a41XR_JX8rcSAzhWC21CFSq-NFWk]]
DBG1 [zmesdetect_m1] [{"access_token":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk","access_token_expires":7200,"credentials":"auth=","append_password":0,"version":"1.36.35","apiversion":"2.0"}]
DBG2 [zmesdetect_m1] [Using new token API]
DBG1 [zmesdetect_m1] [Access token expires on:2025-04-20 20:07:12.802778 [7200s]]
DBG1 [zmesdetect_m1] [Retrying failed request again...]
DBG3 [zmesdetect_m1] [No need to relogin as access token still has 119.99996825 minutes remaining]
DBG3 [zmesdetect_m1] [make_request called with url=https://monserveur.ddns.net/zm/index.php?view=image&eid=29103&fid=alarm payload={} type=get query={'token': 'eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiJab25lTWluZGVyIiwiaWF0IjoxNzQ1MTY1MjMyLCJleHAiOjE3NDUxNzI0MzIsInVzZXIiOiJvbGl2aWVyem0iLCJ0eXBlIjoiYWNjZXNzIn0.CNcpvoEZgKyQ5drPhtSnODnEwY7T3_rgSQCon0iFOIk'}]
DBG2 [zmesdetect_m1] [Raising RELOGIN ValueError]
DBG1 [zmesdetect_m1] [Error reading frame: 2 of max 5 contiguous errors]
DBG1 [zmesdetect_m1] [Reached end of frame_set]
DBG1 [zmesdetect_m1] [Ran out of frames to read]
DBG1 [zmesdetect_m1] [perf: TOTAL detection sequence (with image loads) took: 913.25 ms  to process 29103]
DBG1 [zmesdetect_m1] [Closing logs]

It looks like a login problem

[funix]

It works by unchecking the opt_use_auth box
Now when detecting I have this error

04/27/25 08:45:39 zmesdetect_m1[2038493] ERR detect_sequence.py:182 [Error loading same model variation for object:No module named 'pycoral.adapters']

but it's a other problem

[funix]

Does anyone have the same problem here ?
removing authentication to have zmes working does not please me at all

[funix]

I ask my question differently, has anyone managed to get authentication working with ZMES?