2025-12-16 08:49:21.328765 >>> [routes.py] issue_token 2025-12-16 08:49:21.329301 >>> Auth.token: client_id=Olivos 2025-12-16 08:49:21.811145 >>> Auth.token: ok 2025-12-16 08:49:36.643109 >>> [routes.py] issue_token 2025-12-16 08:49:36.643269 >>> Auth.token: client_id=Olivos 2025-12-16 08:49:37.090138 >>> Auth.token: ok 2025-12-16 08:49:37.124921 >>> [routes.py] issue_token 2025-12-16 08:49:37.125064 >>> Auth.token: client_id=Olivos 2025-12-16 08:49:37.567801 >>> Auth.token: ok 2025-12-16 08:49:37.584195 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765885777, 'jti': '1c39908f-f28a-414d-a2be-5b237fb3b8bc', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765885777, 'exp': 1765903777, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 08:49:44.479203 >>> [routes.py] issue_token 2025-12-16 08:49:44.479358 >>> Auth.token: client_id=Olivos 2025-12-16 08:49:44.935177 >>> Auth.token: ok 2025-12-16 08:49:44.970177 >>> [routes.py] issue_token 2025-12-16 08:49:44.970305 >>> Auth.token: client_id=Olivos 2025-12-16 08:49:45.424661 >>> Auth.token: ok 2025-12-16 08:49:45.443295 >>> [events.py] list_events 2025-12-16 08:49:45.443458 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765885785, 'jti': 'db7e9b72-35fb-40f2-9ff3-cd7680c05d57', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765885785, 'exp': 1765903785, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 08:49:45.576389 >>> hikvision.client fetch_events 2025-12-16 08:49:45.576611 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.578675 >>> [events.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 08:49:45.579091 >>> hikvision.client fetch_events 2025-12-16 08:49:45.579259 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.580705 >>> [events.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 08:49:45.581210 >>> hikvision.client fetch_events 2025-12-16 08:49:45.581369 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.582871 >>> [events.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 08:49:45.588176 >>> hikvision.client fetch_events 2025-12-16 08:49:45.588307 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.589657 >>> [events.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 08:49:45.590635 >>> hikvision.client fetch_events 2025-12-16 08:49:45.590810 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.592622 >>> [events.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 08:49:45.592971 >>> hikvision.client fetch_events 2025-12-16 08:49:45.593109 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.594475 >>> [events.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 08:49:45.594801 >>> hikvision.client fetch_events 2025-12-16 08:49:45.594920 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.596341 >>> [events.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 08:49:45.596668 >>> hikvision.client fetch_events 2025-12-16 08:49:45.596792 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.598076 >>> [events.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 08:49:45.598400 >>> hikvision.client fetch_events 2025-12-16 08:49:45.598501 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.600402 >>> [events.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 08:49:45.600699 >>> hikvision.client fetch_events 2025-12-16 08:49:45.600829 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.602121 >>> [events.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 08:49:45.602424 >>> hikvision.client fetch_events 2025-12-16 08:49:45.602524 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.603864 >>> [events.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 08:49:45.604137 >>> hikvision.client fetch_events 2025-12-16 08:49:45.604233 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 08:49:45.605564 >>> [events.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 08:49:46.430021 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.430194 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.430240 >>> normalized len: 0 2025-12-16 08:49:46.430342 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.489268 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.489645 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.489700 >>> normalized len: 0 2025-12-16 08:49:46.489846 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.490935 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.491037 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.491109 >>> normalized len: 0 2025-12-16 08:49:46.491207 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.492344 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.492444 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.492492 >>> normalized len: 0 2025-12-16 08:49:46.492572 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.496514 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.496611 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.496674 >>> normalized len: 0 2025-12-16 08:49:46.496771 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.497760 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.497870 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.497914 >>> normalized len: 0 2025-12-16 08:49:46.497990 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.498769 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.498877 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.498926 >>> normalized len: 0 2025-12-16 08:49:46.499006 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.499921 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.500018 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.500064 >>> normalized len: 0 2025-12-16 08:49:46.500162 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.501127 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.501221 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.501267 >>> normalized len: 0 2025-12-16 08:49:46.501360 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.501609 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.501765 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.501969 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.517038 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.517185 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.517233 >>> normalized len: 0 2025-12-16 08:49:46.517481 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.517760 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.517892 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.518624 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.518894 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.518952 >>> normalized len: 0 2025-12-16 08:49:46.519039 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.519216 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.519288 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.519330 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.551410 >>> Eventos crudos encontrados >>> 0 2025-12-16 08:49:46.551579 >>> target_minors: [1, 75, 38] 2025-12-16 08:49:46.551644 >>> normalized len: 0 2025-12-16 08:49:46.551773 >>> hikvision.client fetch_events || total: 0 2025-12-16 08:49:46.552088 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.552326 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.552382 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.552421 >>> [events.py] hilos finalizados 2025-12-16 08:49:46.552473 >>> [TIMING] list_events threads total -> 0.976 s 2025-12-16 08:50:42.552506 >>> [routes.py] issue_token 2025-12-16 08:50:42.552662 >>> Auth.token: client_id=Olivos 2025-12-16 08:50:42.995993 >>> Auth.token: ok 2025-12-16 08:50:43.034089 >>> [routes.py] issue_token 2025-12-16 08:50:43.034227 >>> Auth.token: client_id=Olivos 2025-12-16 08:50:43.470866 >>> Auth.token: ok 2025-12-16 08:50:43.488502 >>> [persons.py] list_persons 2025-12-16 08:50:43.488688 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765885843, 'jti': '39d8ae49-9637-4154-aded-e398cf1a9a86', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765885843, 'exp': 1765903843, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 08:50:43.619314 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 08:50:43.621309 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 08:50:43.622882 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 08:50:43.624495 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 08:50:43.626055 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 08:50:43.627562 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 08:50:43.629149 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 08:50:43.630822 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 08:50:43.632872 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 08:50:43.634480 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 08:50:43.636063 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 08:50:43.642369 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 08:50:43.642455 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.564333 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.564554 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.629845 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.630023 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639224 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639364 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639412 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639450 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639486 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639521 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639555 >>> [persons.py] hilos finalizados 2025-12-16 08:50:44.639595 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.022 s 2025-12-16 08:51:35.448429 >>> [routes.py] issue_token 2025-12-16 08:51:35.448586 >>> Auth.token: client_id=Olivos 2025-12-16 08:51:35.921791 >>> Auth.token: ok 2025-12-16 08:52:15.870972 >>> [routes.py] issue_token 2025-12-16 08:52:15.871140 >>> Auth.token: client_id=Olivos 2025-12-16 08:52:16.308336 >>> Auth.token: ok 2025-12-16 08:53:05.873127 >>> [routes.py] issue_token 2025-12-16 08:53:05.873308 >>> Auth.token: client_id=Olivos 2025-12-16 08:53:06.342696 >>> Auth.token: ok 2025-12-16 11:02:42.611219 >>> [routes.py] issue_token 2025-12-16 11:02:42.611601 >>> Auth.token: client_id=Olivos 2025-12-16 11:02:43.076463 >>> Auth.token: ok 2025-12-16 11:02:44.008961 >>> [routes.py] issue_token 2025-12-16 11:02:44.009092 >>> Auth.token: client_id=Olivos 2025-12-16 11:02:44.447981 >>> Auth.token: ok 2025-12-16 11:02:59.040928 >>> [routes.py] issue_token 2025-12-16 11:02:59.041077 >>> Auth.token: client_id=Olivos 2025-12-16 11:02:59.483910 >>> Auth.token: ok 2025-12-16 11:02:59.519711 >>> [routes.py] issue_token 2025-12-16 11:02:59.519876 >>> Auth.token: client_id=Olivos 2025-12-16 11:02:59.957959 >>> Auth.token: ok 2025-12-16 11:02:59.973547 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893779, 'jti': '80add3dd-bd81-411a-a7da-8d4abc9aec19', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893779, 'exp': 1765911779, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:05.266652 >>> [routes.py] issue_token 2025-12-16 11:03:05.266834 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:05.716742 >>> Auth.token: ok 2025-12-16 11:03:05.753561 >>> [routes.py] issue_token 2025-12-16 11:03:05.753707 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:06.194409 >>> Auth.token: ok 2025-12-16 11:03:06.210780 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893786, 'jti': 'f0d91ad9-018e-41a6-9108-16e74afb6e76', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893786, 'exp': 1765911786, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:14.174273 >>> [routes.py] issue_token 2025-12-16 11:03:14.174431 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:14.618282 >>> Auth.token: ok 2025-12-16 11:03:14.654597 >>> [routes.py] issue_token 2025-12-16 11:03:14.654755 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:15.095548 >>> Auth.token: ok 2025-12-16 11:03:15.114474 >>> [events.py] list_events 2025-12-16 11:03:15.114643 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893795, 'jti': 'f0d50048-31ce-481c-86e3-2a1af6037372', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893795, 'exp': 1765911795, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:15.243410 >>> hikvision.client fetch_events 2025-12-16 11:03:15.243630 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.245657 >>> [events.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:03:15.245965 >>> hikvision.client fetch_events 2025-12-16 11:03:15.246066 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.247545 >>> [events.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:03:15.248398 >>> hikvision.client fetch_events 2025-12-16 11:03:15.248503 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.249788 >>> [events.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:03:15.250098 >>> hikvision.client fetch_events 2025-12-16 11:03:15.250215 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.251469 >>> [events.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:03:15.251922 >>> hikvision.client fetch_events 2025-12-16 11:03:15.252037 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.253405 >>> [events.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:03:15.253749 >>> hikvision.client fetch_events 2025-12-16 11:03:15.253870 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.255139 >>> [events.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:03:15.255406 >>> hikvision.client fetch_events 2025-12-16 11:03:15.255497 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.257360 >>> [events.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:03:15.257683 >>> hikvision.client fetch_events 2025-12-16 11:03:15.257808 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.259142 >>> [events.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:03:15.259465 >>> hikvision.client fetch_events 2025-12-16 11:03:15.259562 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.260904 >>> [events.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:03:15.261232 >>> hikvision.client fetch_events 2025-12-16 11:03:15.261332 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.262593 >>> [events.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:03:15.263042 >>> hikvision.client fetch_events 2025-12-16 11:03:15.263147 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.264448 >>> [events.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:03:15.264940 >>> hikvision.client fetch_events 2025-12-16 11:03:15.265046 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:15.266341 >>> [events.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:03:16.094750 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.094936 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.094987 >>> normalized len: 0 2025-12-16 11:03:16.095098 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.095339 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.101257 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.101381 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.101429 >>> normalized len: 0 2025-12-16 11:03:16.101533 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.101737 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.111225 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.111347 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.111410 >>> normalized len: 0 2025-12-16 11:03:16.111499 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.122131 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.122333 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.122390 >>> normalized len: 0 2025-12-16 11:03:16.122487 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.127541 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.127649 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.127695 >>> normalized len: 0 2025-12-16 11:03:16.127802 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.128049 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.128139 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.128877 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.128970 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.129015 >>> normalized len: 0 2025-12-16 11:03:16.129238 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.130082 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.130233 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.130283 >>> normalized len: 0 2025-12-16 11:03:16.130359 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.135259 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.135351 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.135394 >>> normalized len: 0 2025-12-16 11:03:16.135467 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.140456 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.140569 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.140614 >>> normalized len: 0 2025-12-16 11:03:16.140693 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.143417 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.143513 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.143559 >>> normalized len: 0 2025-12-16 11:03:16.143658 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.150794 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:16.150906 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.150952 >>> normalized len: 0 2025-12-16 11:03:16.151028 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:16.213999 >>> Eventos crudos encontrados >>> 8 2025-12-16 11:03:16.214183 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:16.214257 >>> normalized len: 2 2025-12-16 11:03:16.214371 >>> hikvision.client fetch_events || total: 2 2025-12-16 11:03:16.214609 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214702 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214770 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214810 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214847 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214894 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214930 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.214965 >>> [events.py] hilos finalizados 2025-12-16 11:03:16.215005 >>> [TIMING] list_events threads total -> 0.972 s 2025-12-16 11:03:31.074524 >>> [routes.py] issue_token 2025-12-16 11:03:31.074662 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:31.517296 >>> Auth.token: ok 2025-12-16 11:03:31.552908 >>> [routes.py] issue_token 2025-12-16 11:03:31.553051 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:31.989403 >>> Auth.token: ok 2025-12-16 11:03:32.007690 >>> [events.py] list_events 2025-12-16 11:03:32.007868 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893811, 'jti': 'bdd38844-a2df-4bd0-a738-4636a4155301', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893811, 'exp': 1765911811, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:32.140654 >>> hikvision.client fetch_events 2025-12-16 11:03:32.140877 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.142610 >>> [events.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:03:32.142971 >>> hikvision.client fetch_events 2025-12-16 11:03:32.143086 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.144839 >>> [events.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:03:32.145374 >>> hikvision.client fetch_events 2025-12-16 11:03:32.145478 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.146753 >>> [events.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:03:32.146997 >>> hikvision.client fetch_events 2025-12-16 11:03:32.147164 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.148489 >>> [events.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:03:32.149877 >>> hikvision.client fetch_events 2025-12-16 11:03:32.149988 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.151269 >>> [events.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:03:32.151529 >>> hikvision.client fetch_events 2025-12-16 11:03:32.151653 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.153106 >>> [events.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:03:32.153737 >>> hikvision.client fetch_events 2025-12-16 11:03:32.153864 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.155121 >>> [events.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:03:32.156044 >>> hikvision.client fetch_events 2025-12-16 11:03:32.156152 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.157410 >>> [events.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:03:32.157952 >>> hikvision.client fetch_events 2025-12-16 11:03:32.158075 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.159405 >>> [events.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:03:32.159704 >>> hikvision.client fetch_events 2025-12-16 11:03:32.159825 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.161123 >>> [events.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:03:32.161381 >>> hikvision.client fetch_events 2025-12-16 11:03:32.161471 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.162713 >>> [events.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:03:32.163009 >>> hikvision.client fetch_events 2025-12-16 11:03:32.163117 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 11:03:32.164435 >>> [events.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:03:32.998128 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:32.998292 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:32.998343 >>> normalized len: 0 2025-12-16 11:03:32.998474 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.000802 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.000921 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.000968 >>> normalized len: 0 2025-12-16 11:03:33.001076 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.010035 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.010167 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.010218 >>> normalized len: 0 2025-12-16 11:03:33.010308 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.010490 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.013490 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.013620 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.013674 >>> normalized len: 0 2025-12-16 11:03:33.013787 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.013984 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.014066 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.022038 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.022157 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.022208 >>> normalized len: 0 2025-12-16 11:03:33.022292 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.023146 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.023241 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.023287 >>> normalized len: 0 2025-12-16 11:03:33.023364 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.026737 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.026838 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.026885 >>> normalized len: 0 2025-12-16 11:03:33.026976 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.030926 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.033794 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.033891 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.033938 >>> normalized len: 0 2025-12-16 11:03:33.034020 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.039647 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.039768 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.039824 >>> normalized len: 0 2025-12-16 11:03:33.039921 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.052410 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.052511 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.052557 >>> normalized len: 0 2025-12-16 11:03:33.052638 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.053415 >>> Eventos crudos encontrados >>> 0 2025-12-16 11:03:33.053510 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.053557 >>> normalized len: 0 2025-12-16 11:03:33.053636 >>> hikvision.client fetch_events || total: 0 2025-12-16 11:03:33.055145 >>> Eventos crudos encontrados >>> 8 2025-12-16 11:03:33.055249 >>> target_minors: [1, 75, 38] 2025-12-16 11:03:33.055316 >>> normalized len: 2 2025-12-16 11:03:33.055413 >>> hikvision.client fetch_events || total: 2 2025-12-16 11:03:33.055658 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055768 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055812 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055846 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055880 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055913 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055945 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.055978 >>> [events.py] hilos finalizados 2025-12-16 11:03:33.056013 >>> [TIMING] list_events threads total -> 0.916 s 2025-12-16 11:03:38.154602 >>> [routes.py] issue_token 2025-12-16 11:03:38.154752 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:38.593142 >>> Auth.token: ok 2025-12-16 11:03:38.630064 >>> [routes.py] issue_token 2025-12-16 11:03:38.630236 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:39.068408 >>> Auth.token: ok 2025-12-16 11:03:39.086323 >>> [persons.py] list_persons 2025-12-16 11:03:39.086512 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893819, 'jti': '3547f8c0-5865-40ac-a306-783b45736f1c', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893819, 'exp': 1765911819, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:39.222588 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:03:39.224815 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:03:39.226796 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:03:39.228757 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:03:39.230687 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:03:39.232918 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:03:39.234992 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:03:39.236714 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:03:39.238766 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:03:39.240563 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:03:39.242652 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:03:39.244663 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:03:39.244783 >>> [persons.py] hilos finalizados 2025-12-16 11:03:39.809316 >>> [routes.py] issue_token 2025-12-16 11:03:39.809449 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:40.129831 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.139575 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.245385 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.245560 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.245629 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250510 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250629 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250677 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250716 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250800 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250854 >>> [persons.py] hilos finalizados 2025-12-16 11:03:40.250899 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.031 s 2025-12-16 11:03:40.405394 >>> Auth.token: ok 2025-12-16 11:03:40.479521 >>> [routes.py] issue_token 2025-12-16 11:03:40.479656 >>> Auth.token: client_id=Olivos 2025-12-16 11:03:40.954404 >>> Auth.token: ok 2025-12-16 11:03:40.974351 >>> [persons.py] list_persons 2025-12-16 11:03:40.974509 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893820, 'jti': 'b77799bd-8c42-4655-abd9-205efae2f110', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893820, 'exp': 1765911820, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:03:41.107449 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:03:41.109593 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:03:41.111942 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:03:41.119276 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:03:41.121418 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:03:41.123919 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:03:41.125775 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:03:41.127775 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:03:41.130239 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:03:41.132020 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:03:41.133999 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:03:41.135906 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:03:41.135995 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.066296 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.066451 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.066497 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.142763 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.142950 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.149697 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.149915 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.149964 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.150002 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.150039 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.150072 >>> [persons.py] hilos finalizados 2025-12-16 11:03:42.150138 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.045 s 2025-12-16 11:05:02.016896 >>> [routes.py] issue_token 2025-12-16 11:05:02.017055 >>> Auth.token: client_id=Olivos 2025-12-16 11:05:02.491187 >>> Auth.token: ok 2025-12-16 11:05:02.541473 >>> [routes.py] issue_token 2025-12-16 11:05:02.541611 >>> Auth.token: client_id=Olivos 2025-12-16 11:05:02.692794 >>> [routes.py] issue_token 2025-12-16 11:05:02.692953 >>> Auth.token: client_id=Olivos 2025-12-16 11:05:03.158059 >>> Auth.token: ok 2025-12-16 11:05:03.216676 >>> [persons.py] list_persons 2025-12-16 11:05:03.216868 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765893903, 'jti': '0e81cada-1e20-4238-a112-467ce82498db', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765893903, 'exp': 1765911903, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:05:03.342731 >>> Auth.token: ok 2025-12-16 11:05:03.355500 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:05:03.357238 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:05:03.358762 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:05:03.360858 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:05:03.363193 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:05:03.369516 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:05:03.371293 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:05:03.372920 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:05:03.374968 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:05:03.376550 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:05:03.378502 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:05:03.380164 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:05:03.380275 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.263785 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.364758 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.364934 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.364988 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.495479 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.495642 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.814702 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.814911 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.814963 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.815005 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.815044 >>> [persons.py] hilos finalizados 2025-12-16 11:05:04.815088 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.462 s 2025-12-16 11:05:11.534598 >>> [routes.py] issue_token 2025-12-16 11:05:11.534729 >>> Auth.token: client_id=Olivos 2025-12-16 11:05:12.017637 >>> Auth.token: ok 2025-12-16 11:05:41.928342 >>> [routes.py] issue_token 2025-12-16 11:05:41.928489 >>> Auth.token: client_id=Olivos 2025-12-16 11:05:42.367692 >>> Auth.token: ok 2025-12-16 11:08:39.877792 >>> [routes.py] issue_token 2025-12-16 11:08:39.877955 >>> Auth.token: client_id=Olivos 2025-12-16 11:08:40.421162 >>> Auth.token: ok 2025-12-16 11:08:40.461697 >>> [routes.py] issue_token 2025-12-16 11:08:40.461856 >>> Auth.token: client_id=Olivos 2025-12-16 11:08:40.900928 >>> Auth.token: ok 2025-12-16 11:08:40.920536 >>> [persons.py] create_person 2025-12-16 11:08:40.920683 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765894120, 'jti': 'b0b0d784-8c6a-44f7-9747-94bf684a5ff1', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765894120, 'exp': 1765912120, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:08:41.050147 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:08:41.050282 >>> [persons.py] hilos finalizados 2025-12-16 11:08:41.939672 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 11:08:41.940075 >>> [TIMING] olivosportal1.dyndns.org:5020 search_user_by_employee_no -> 0.892 s 2025-12-16 11:08:42.881106 >>> [TIMING] olivosportal1.dyndns.org:5020 create_user -> 0.941 s 2025-12-16 11:08:43.746236 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '44763163', 'name': 'Rodrigo Llorente', 'userType': 'normal', 'sortByNamePosition': 0, 'sortByNameFlag': 'R', 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-01-01T00:00:00', 'endTime': '2035-01-01T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFP': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 11:08:43.746674 >>> Cargando imagen para el usuario 44763163 2025-12-16 11:08:43.747486 >>> tipo img_bytes antes de driver: 2025-12-16 11:08:43.747571 >>> len img_bytes: 60243 2025-12-16 11:08:45.083012 >>> [upload_face_via_fdlib] url=http://olivosportal1.dyndns.org:5020/ISAPI/Intelligent/FDLib/FaceDataRecord?format=json 2025-12-16 11:08:45.083207 >>> [upload_face_via_fdlib] status=200 2025-12-16 11:08:45.083790 >>> [upload_face_via_fdlib] status={ "statusCode": 1, "statusString": "OK", "subStatusCode": "ok", "FPID": "44763163" } 2025-12-16 11:08:45.083991 >>> [TIMING] olivosportal1.dyndns.org:5020 upload_face_via_fdlib -> 1.336 s 2025-12-16 11:08:45.961788 >>> [TIMING] olivosportal1.dyndns.org:5020 loop create_card -> 0.878 s 2025-12-16 11:08:45.962154 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 4.915 s 2025-12-16 11:08:53.354912 >>> [routes.py] issue_token 2025-12-16 11:08:53.355056 >>> Auth.token: client_id=Olivos 2025-12-16 11:08:53.792986 >>> Auth.token: ok 2025-12-16 11:08:53.827874 >>> [routes.py] issue_token 2025-12-16 11:08:53.828004 >>> Auth.token: client_id=Olivos 2025-12-16 11:08:54.259652 >>> Auth.token: ok 2025-12-16 11:08:54.277118 >>> [persons.py] list_persons 2025-12-16 11:08:54.277277 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765894134, 'jti': 'b1bd5ca6-e992-4e2a-9df5-8021f237a1b0', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765894134, 'exp': 1765912134, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:08:54.409627 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:08:54.411508 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:08:54.413345 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:08:54.415136 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:08:54.417360 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:08:54.419237 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:08:54.420634 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:08:54.422126 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:08:54.423708 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:08:54.425913 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:08:54.427403 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:08:54.428793 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:08:54.428874 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.443860 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.444046 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.444101 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.444144 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473175 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473320 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473370 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473413 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473450 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473486 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473523 >>> [persons.py] hilos finalizados 2025-12-16 11:08:55.473564 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.066 s 2025-12-16 11:09:07.886040 >>> [routes.py] issue_token 2025-12-16 11:09:07.886175 >>> Auth.token: client_id=Olivos 2025-12-16 11:09:08.320104 >>> Auth.token: ok 2025-12-16 11:11:31.591833 >>> [routes.py] issue_token 2025-12-16 11:11:31.592037 >>> Auth.token: client_id=Olivos 2025-12-16 11:11:32.074943 >>> Auth.token: ok 2025-12-16 11:11:32.112048 >>> [routes.py] issue_token 2025-12-16 11:11:32.112187 >>> Auth.token: client_id=Olivos 2025-12-16 11:11:32.553673 >>> Auth.token: ok 2025-12-16 11:11:32.572408 >>> resources.persons delete_person 2025-12-16 11:11:32.572604 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765894292, 'jti': 'ae38ec8b-8dee-4bc5-a364-0ab17a4e5ec7', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765894292, 'exp': 1765912292, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:11:32.701898 >>> resources.persons buscando persona en reader: P1. ENTRADA PROPIETARIOS 2025-12-16 11:11:33.587924 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '44763163', 'name': 'Rodrigo Llorente', 'userType': 'normal', 'sortByNamePosition': 0, 'sortByNameFlag': 'R', 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-01-01T00:00:00', 'endTime': '2035-01-01T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFP': 0, 'numOfFace': 1, 'PersonInfoExtends': [{'value': ''}], 'faceURL': 'http://olivosportal1.dyndns.org:5020/LOCALS/pic/enrlFace/0/0000000003.jpg@WEB000000000018'}]}} 2025-12-16 11:13:18.669401 >>> [routes.py] issue_token 2025-12-16 11:13:18.669562 >>> Auth.token: client_id=Olivos 2025-12-16 11:13:19.118158 >>> Auth.token: ok 2025-12-16 11:15:16.142160 >>> [routes.py] issue_token 2025-12-16 11:15:16.142337 >>> Auth.token: client_id=Olivos 2025-12-16 11:15:16.612127 >>> Auth.token: ok 2025-12-16 11:15:50.772345 >>> [routes.py] issue_token 2025-12-16 11:15:50.772502 >>> Auth.token: client_id=Olivos 2025-12-16 11:15:51.219888 >>> Auth.token: ok 2025-12-16 11:16:19.748320 >>> [routes.py] issue_token 2025-12-16 11:16:19.748628 >>> Auth.token: client_id=Olivos 2025-12-16 11:16:20.189966 >>> Auth.token: ok 2025-12-16 11:16:55.832553 >>> [routes.py] issue_token 2025-12-16 11:16:55.832706 >>> Auth.token: client_id=Olivos 2025-12-16 11:16:56.280225 >>> Auth.token: ok 2025-12-16 11:16:56.347394 >>> [routes.py] issue_token 2025-12-16 11:16:56.347525 >>> Auth.token: client_id=Olivos 2025-12-16 11:16:56.797874 >>> Auth.token: ok 2025-12-16 11:16:56.814189 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765894616, 'jti': '7b857334-2964-4993-89c8-e5b16df2742d', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765894616, 'exp': 1765912616, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:19:07.360705 >>> [routes.py] issue_token 2025-12-16 11:19:07.360901 >>> Auth.token: client_id=Olivos 2025-12-16 11:19:07.833508 >>> Auth.token: ok 2025-12-16 11:23:00.202490 >>> [routes.py] issue_token 2025-12-16 11:23:00.202756 >>> Auth.token: client_id=Olivos 2025-12-16 11:23:00.675526 >>> Auth.token: ok 2025-12-16 11:24:31.196941 >>> [routes.py] issue_token 2025-12-16 11:24:31.197129 >>> Auth.token: client_id=Olivos 2025-12-16 11:24:31.640399 >>> Auth.token: ok 2025-12-16 11:24:31.705117 >>> [routes.py] issue_token 2025-12-16 11:24:31.705270 >>> Auth.token: client_id=Olivos 2025-12-16 11:24:32.142652 >>> Auth.token: ok 2025-12-16 11:24:32.160607 >>> [persons.py] create_person 2025-12-16 11:24:32.160820 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765895072, 'jti': '9d5f484c-48e5-4bc6-a576-9e398605bf68', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765895072, 'exp': 1765913072, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:24:32.296563 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:24:32.298936 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:24:32.300598 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:24:32.302236 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:24:32.302331 >>> [persons.py] hilos finalizados 2025-12-16 11:24:33.310074 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 11:24:33.310284 >>> [TIMING] olivosportal2.dyndns.org:5020 search_user_by_employee_no -> 1.016 s 2025-12-16 11:24:34.305034 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 11:24:34.305247 >>> [TIMING] olivosportal2.dyndns.org:5021 search_user_by_employee_no -> 2.008 s 2025-12-16 11:24:34.831183 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 11:24:34.831424 >>> [TIMING] olivosportal2.dyndns.org:5023 search_user_by_employee_no -> 2.531 s 2025-12-16 11:24:35.289399 >>> [TIMING] olivosportal2.dyndns.org:5021 create_user -> 0.984 s 2025-12-16 11:24:35.418420 >>> [TIMING] olivosportal2.dyndns.org:5020 create_user -> 2.108 s 2025-12-16 11:24:37.178154 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '52535766', 'name': 'LAUTARO PETRE', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T11:24:00', 'endTime': '2026-01-02T11:24:00', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFP': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 11:24:37.178373 >>> Cargando imagen para el usuario 52535766 2025-12-16 11:24:37.178973 >>> tipo img_bytes antes de driver: 2025-12-16 11:24:37.179068 >>> len img_bytes: 24703 2025-12-16 11:24:37.249997 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 11:24:37.250235 >>> [TIMING] olivosportal2.dyndns.org:5022 search_user_by_employee_no -> 4.951 s 2025-12-16 11:24:38.216006 >>> [TIMING] olivosportal2.dyndns.org:5022 create_user -> 0.966 s 2025-12-16 11:24:39.247438 >>> [TIMING] olivosportal2.dyndns.org:5023 create_user -> 4.416 s 2025-12-16 11:24:39.926488 >>> [upload_face_via_fdlib] url=http://olivosportal2.dyndns.org:5020/ISAPI/Intelligent/FDLib/FaceDataRecord?format=json 2025-12-16 11:24:39.926666 >>> [upload_face_via_fdlib] status=200 2025-12-16 11:24:39.927237 >>> [upload_face_via_fdlib] status={ "statusCode": 1, "statusString": "OK", "subStatusCode": "ok", "FPID": "52535766" } 2025-12-16 11:24:39.927418 >>> [TIMING] olivosportal2.dyndns.org:5020 upload_face_via_fdlib -> 2.748 s 2025-12-16 11:24:40.214287 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '52535766', 'name': 'LAUTARO PETRE', 'userType': 'normal', 'sortByNamePosition': 0, 'sortByNameFlag': 'L', 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T11:24:00', 'endTime': '2026-01-02T11:24:00', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFP': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 11:24:40.214517 >>> Cargando imagen para el usuario 52535766 2025-12-16 11:24:40.214942 >>> tipo img_bytes antes de driver: 2025-12-16 11:24:40.215024 >>> len img_bytes: 24703 2025-12-16 11:24:40.991829 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '52535766', 'name': 'LAUTARO PETRE', 'userType': 'normal', 'sortByNamePosition': 0, 'sortByNameFlag': 'L', 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T11:24:00', 'endTime': '2026-01-02T11:24:00', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFP': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 11:24:40.992084 >>> Cargando imagen para el usuario 52535766 2025-12-16 11:24:40.992584 >>> tipo img_bytes antes de driver: 2025-12-16 11:24:40.992652 >>> len img_bytes: 24703 2025-12-16 11:24:42.422207 >>> [upload_face_via_fdlib] url=http://olivosportal2.dyndns.org:5022/ISAPI/Intelligent/FDLib/FaceDataRecord?format=json 2025-12-16 11:24:42.422403 >>> [upload_face_via_fdlib] status=200 2025-12-16 11:24:42.422626 >>> [upload_face_via_fdlib] status={ "statusCode": 1, "statusString": "OK", "subStatusCode": "ok", "FPID": "52535766" } 2025-12-16 11:24:42.422813 >>> [TIMING] olivosportal2.dyndns.org:5022 upload_face_via_fdlib -> 2.208 s 2025-12-16 11:24:43.355700 >>> [TIMING] olivosportal2.dyndns.org:5022 loop create_card -> 0.933 s 2025-12-16 11:24:47.640077 >>> [TIMING] olivosportal2.dyndns.org:5021 loop create_card -> 1.951 s 2025-12-16 11:24:49.940134 >>> [TIMING] olivosportal2.dyndns.org:5020 loop create_card -> 10.013 s 2025-12-16 11:24:49.940469 >>> [persons.py] hilos finalizados 2025-12-16 11:24:49.940577 >>> [persons.py] hilos finalizados 2025-12-16 11:24:49.940621 >>> [persons.py] hilos finalizados 2025-12-16 11:24:51.005402 >>> [upload_face_via_fdlib] error: timed out 2025-12-16 11:24:51.042915 >>> [upload_face_via_fdlib] trace: Traceback (most recent call last): File "/usr/local/lib/python3.6/site-packages/httpcore/_exceptions.py", line 8, in map_exceptions yield File "/usr/local/lib/python3.6/site-packages/httpcore/backends/sync.py", line 83, in connect_tcp address, timeout, source_address=source_address File "/usr/lib64/python3.6/socket.py", line 724, in create_connection raise err File "/usr/lib64/python3.6/socket.py", line 713, in create_connection sock.connect(sa) socket.timeout: timed out During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/local/lib/python3.6/site-packages/httpx/_transports/default.py", line 60, in map_httpcore_exceptions yield File "/usr/local/lib/python3.6/site-packages/httpx/_transports/default.py", line 218, in handle_request resp = self._pool.handle_request(req) File "/usr/local/lib/python3.6/site-packages/httpcore/_sync/connection_pool.py", line 253, in handle_request raise exc File "/usr/local/lib/python3.6/site-packages/httpcore/_sync/connection_pool.py", line 237, in handle_request response = connection.handle_request(request) File "/usr/local/lib/python3.6/site-packages/httpcore/_sync/connection.py", line 86, in handle_request raise exc File "/usr/local/lib/python3.6/site-packages/httpcore/_sync/connection.py", line 63, in handle_request stream = self._connect(request) File "/usr/local/lib/python3.6/site-packages/httpcore/_sync/connection.py", line 111, in _connect stream = self._network_backend.connect_tcp(**kwargs) File "/usr/local/lib/python3.6/site-packages/httpcore/backends/sync.py", line 83, in connect_tcp address, timeout, source_address=source_address File "/usr/lib64/python3.6/contextlib.py", line 99, in __exit__ self.gen.throw(type, value, traceback) File "/usr/local/lib/python3.6/site-packages/httpcore/_exceptions.py", line 12, in map_exceptions raise to_exc(exc) httpcore.ConnectTimeout: timed out The above exception was the direct cause of the following exception: Traceback (most recent call last): File "/var/www/html/APIs/hik/sensores/hikvision/client.py", line 755, in upload_face_via_fdlib r = client.post(url, files=files) File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 1129, in post extensions=extensions, File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 802, in request return self.send(request, auth=auth, follow_redirects=follow_redirects) File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 893, in send history=[], File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 920, in _send_handling_auth history=history, File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 954, in _send_handling_redirects response = self._send_single_request(request) File "/usr/local/lib/python3.6/site-packages/httpx/_client.py", line 990, in _send_single_request response = transport.handle_request(request) File "/usr/local/lib/python3.6/site-packages/httpx/_transports/default.py", line 218, in handle_request resp = self._pool.handle_request(req) File "/usr/lib64/python3.6/contextlib.py", line 99, in __exit__ self.gen.throw(type, value, traceback) File "/usr/local/lib/python3.6/site-packages/httpx/_transports/default.py", line 77, in map_httpcore_exceptions raise mapped_exc(message) from exc httpx.ConnectTimeout: timed out 2025-12-16 11:24:51.043082 >>> [TIMING] olivosportal2.dyndns.org:5023 upload_face_via_fdlib -> 10.050 s 2025-12-16 11:24:51.962365 >>> [TIMING] olivosportal2.dyndns.org:5023 loop create_card -> 0.919 s 2025-12-16 11:24:51.962772 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 19.669 s 2025-12-16 11:34:17.228671 >>> [routes.py] issue_token 2025-12-16 11:34:17.228845 >>> Auth.token: client_id=Olivos 2025-12-16 11:34:17.689616 >>> Auth.token: ok 2025-12-16 11:40:36.101456 >>> [routes.py] issue_token 2025-12-16 11:40:36.101621 >>> Auth.token: client_id=Olivos 2025-12-16 11:40:36.566352 >>> Auth.token: ok 2025-12-16 11:40:36.601994 >>> [routes.py] issue_token 2025-12-16 11:40:36.602127 >>> Auth.token: client_id=Olivos 2025-12-16 11:40:37.041893 >>> Auth.token: ok 2025-12-16 11:40:37.058373 >>> [persons.py] list_persons 2025-12-16 11:40:37.058519 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765896037, 'jti': '637718ac-50f1-49d4-8120-00886d7f1040', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765896037, 'exp': 1765914037, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:40:37.188426 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:40:37.190141 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:40:37.191839 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:40:37.193351 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:40:37.194852 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:40:37.196342 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:40:37.197867 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:40:37.208365 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:40:37.210371 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:40:37.212208 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:40:37.213985 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:40:37.215650 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:40:37.215737 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.095655 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.129618 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.193984 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.194166 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.265203 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.265879 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.265986 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.266029 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.266066 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.266101 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.266137 >>> [persons.py] hilos finalizados 2025-12-16 11:40:38.266176 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.080 s 2025-12-16 11:46:10.185604 >>> [routes.py] issue_token 2025-12-16 11:46:10.185777 >>> Auth.token: client_id=Olivos 2025-12-16 11:46:10.657637 >>> Auth.token: ok 2025-12-16 11:46:14.791574 >>> [routes.py] issue_token 2025-12-16 11:46:14.791717 >>> Auth.token: client_id=Olivos 2025-12-16 11:46:15.240622 >>> Auth.token: ok 2025-12-16 11:46:18.685708 >>> [routes.py] issue_token 2025-12-16 11:46:18.685887 >>> Auth.token: client_id=Olivos 2025-12-16 11:46:19.134118 >>> Auth.token: ok 2025-12-16 11:46:19.169740 >>> [routes.py] issue_token 2025-12-16 11:46:19.169875 >>> Auth.token: client_id=Olivos 2025-12-16 11:46:19.611818 >>> Auth.token: ok 2025-12-16 11:46:19.629506 >>> [persons.py] list_persons 2025-12-16 11:46:19.629696 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765896379, 'jti': 'ecd38788-1dbd-4971-ae2d-59cc9e956d96', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765896379, 'exp': 1765914379, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 11:46:19.768576 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 11:46:19.770352 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 11:46:19.772046 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 11:46:19.773602 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 11:46:19.775958 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 11:46:19.777555 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 11:46:19.779304 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 11:46:19.780757 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 11:46:19.782357 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 11:46:19.784537 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 11:46:19.786176 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 11:46:19.787713 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 11:46:19.787814 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.741275 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.755662 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.755893 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.755954 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.863506 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.863791 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.863855 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.863917 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.863976 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.864015 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.864052 >>> [persons.py] hilos finalizados 2025-12-16 11:46:20.864095 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.098 s 2025-12-16 13:03:29.021544 >>> [routes.py] issue_token 2025-12-16 13:03:29.021834 >>> Auth.token: client_id=Olivos 2025-12-16 13:03:29.488002 >>> Auth.token: ok 2025-12-16 13:03:29.524584 >>> [routes.py] issue_token 2025-12-16 13:03:29.524750 >>> Auth.token: client_id=Olivos 2025-12-16 13:03:29.970854 >>> Auth.token: ok 2025-12-16 13:03:29.990039 >>> [persons.py] list_persons 2025-12-16 13:03:29.990240 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765901009, 'jti': '8fd7eb31-35c1-450f-b5e7-1798bff7dea5', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765901009, 'exp': 1765919009, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 13:03:30.124464 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 13:03:30.126191 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 13:03:30.127825 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 13:03:30.129392 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 13:03:30.131201 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 13:03:30.132791 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 13:03:30.134438 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 13:03:30.156270 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 13:03:30.159051 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 13:03:30.161025 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 13:03:30.162810 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 13:03:30.164775 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 13:03:30.164875 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.094904 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.095088 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152379 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152538 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152587 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152627 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152665 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.152939 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.153007 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.153043 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.153079 >>> [persons.py] hilos finalizados 2025-12-16 13:03:31.155180 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.033 s 2025-12-16 13:29:14.769413 >>> [routes.py] issue_token 2025-12-16 13:29:14.769708 >>> Auth.token: client_id=Polo 2025-12-16 13:29:15.270918 >>> Auth.token: ok 2025-12-16 13:29:19.817447 >>> [routes.py] issue_token 2025-12-16 13:29:19.817842 >>> Auth.token: client_id=Polo 2025-12-16 13:29:20.262245 >>> Auth.token: ok 2025-12-16 13:29:25.772045 >>> [routes.py] issue_token 2025-12-16 13:29:25.772233 >>> Auth.token: client_id=Polo 2025-12-16 13:29:26.220274 >>> Auth.token: ok 2025-12-16 15:24:35.729852 >>> [routes.py] issue_token 2025-12-16 15:24:35.731054 >>> Auth.token: client_id=Olivos 2025-12-16 15:24:36.240012 >>> Auth.token: ok 2025-12-16 15:24:36.278169 >>> [routes.py] issue_token 2025-12-16 15:24:36.278322 >>> Auth.token: client_id=Olivos 2025-12-16 15:24:36.724549 >>> Auth.token: ok 2025-12-16 15:24:36.747585 >>> [events.py] list_events 2025-12-16 15:24:36.747865 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765909476, 'jti': 'eeefb5ce-03fc-4d54-a634-7cc90d0e424b', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765909476, 'exp': 1765927476, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 15:24:36.877406 >>> hikvision.client fetch_events 2025-12-16 15:24:36.877927 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.886451 >>> [events.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 15:24:36.887799 >>> hikvision.client fetch_events 2025-12-16 15:24:36.888260 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.890242 >>> [events.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 15:24:36.890868 >>> hikvision.client fetch_events 2025-12-16 15:24:36.891115 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.892714 >>> [events.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 15:24:36.893290 >>> hikvision.client fetch_events 2025-12-16 15:24:36.893407 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.895442 >>> [events.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 15:24:36.896029 >>> hikvision.client fetch_events 2025-12-16 15:24:36.896180 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.898091 >>> [events.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 15:24:36.898609 >>> hikvision.client fetch_events 2025-12-16 15:24:36.898837 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.901313 >>> [events.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 15:24:36.901962 >>> hikvision.client fetch_events 2025-12-16 15:24:36.902289 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.904389 >>> [events.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 15:24:36.905034 >>> hikvision.client fetch_events 2025-12-16 15:24:36.905248 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.907033 >>> [events.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 15:24:36.907740 >>> hikvision.client fetch_events 2025-12-16 15:24:36.907971 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.909573 >>> [events.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 15:24:36.910020 >>> hikvision.client fetch_events 2025-12-16 15:24:36.910212 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.911888 >>> [events.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 15:24:36.916514 >>> hikvision.client fetch_events 2025-12-16 15:24:36.916711 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.919021 >>> [events.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 15:24:36.919812 >>> hikvision.client fetch_events 2025-12-16 15:24:36.920057 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:24:36.922778 >>> [events.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 15:24:37.760177 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.760426 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.760487 >>> normalized len: 0 2025-12-16 15:24:37.760656 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.760930 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.778963 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.779156 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.779206 >>> normalized len: 0 2025-12-16 15:24:37.779314 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.780617 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.780764 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.780825 >>> normalized len: 0 2025-12-16 15:24:37.780935 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.786290 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.786447 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.786500 >>> normalized len: 0 2025-12-16 15:24:37.786797 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.789833 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.789983 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.790035 >>> normalized len: 0 2025-12-16 15:24:37.790172 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.791410 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.791543 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.791595 >>> normalized len: 0 2025-12-16 15:24:37.791693 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.792832 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.792942 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.792991 >>> normalized len: 0 2025-12-16 15:24:37.793081 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.794481 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.794635 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.794697 >>> normalized len: 0 2025-12-16 15:24:37.794832 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.795861 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.795964 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.796012 >>> normalized len: 0 2025-12-16 15:24:37.796112 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.796553 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.796641 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.796683 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.811789 >>> Eventos crudos encontrados >>> 0 2025-12-16 15:24:37.812018 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.812070 >>> normalized len: 0 2025-12-16 15:24:37.812195 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:24:37.827210 >>> Eventos crudos encontrados >>> 3 2025-12-16 15:24:37.827367 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.827445 >>> normalized len: 1 2025-12-16 15:24:37.827553 >>> hikvision.client fetch_events || total: 1 2025-12-16 15:24:37.852280 >>> Eventos crudos encontrados >>> 8 2025-12-16 15:24:37.852423 >>> target_minors: [1, 75, 38] 2025-12-16 15:24:37.852487 >>> normalized len: 2 2025-12-16 15:24:37.852600 >>> hikvision.client fetch_events || total: 2 2025-12-16 15:24:37.852892 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853011 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853053 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853093 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853131 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853167 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853360 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853399 >>> [events.py] hilos finalizados 2025-12-16 15:24:37.853440 >>> [TIMING] list_events threads total -> 0.977 s 2025-12-16 15:25:47.315413 >>> [routes.py] issue_token 2025-12-16 15:25:47.315986 >>> Auth.token: client_id=Olivos 2025-12-16 15:25:47.769385 >>> Auth.token: ok 2025-12-16 15:25:47.805246 >>> [routes.py] issue_token 2025-12-16 15:25:47.805383 >>> Auth.token: client_id=Olivos 2025-12-16 15:25:48.267994 >>> Auth.token: ok 2025-12-16 15:25:48.291203 >>> [persons.py] list_persons 2025-12-16 15:25:48.291625 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765909548, 'jti': 'f6dfd97f-ae76-4287-9c28-3c146573df67', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765909548, 'exp': 1765927548, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 15:25:48.427016 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 15:25:48.429102 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 15:25:48.457369 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 15:25:48.464984 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 15:25:48.468783 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 15:25:48.471040 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 15:25:48.473489 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 15:25:48.476000 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 15:25:48.478894 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 15:25:48.481473 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 15:25:48.483875 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 15:25:48.487156 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 15:25:48.487347 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.368771 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.432467 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.432796 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.432870 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474318 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474620 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474671 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474711 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474780 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474819 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474855 >>> [persons.py] hilos finalizados 2025-12-16 15:25:49.474898 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.055 s 2025-12-16 15:50:19.200921 >>> [routes.py] issue_token 2025-12-16 15:50:19.201279 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:19.676568 >>> Auth.token: ok 2025-12-16 15:50:21.477340 >>> [routes.py] issue_token 2025-12-16 15:50:21.478062 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:21.932838 >>> Auth.token: ok 2025-12-16 15:50:21.969033 >>> [routes.py] issue_token 2025-12-16 15:50:21.969175 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:22.418712 >>> Auth.token: ok 2025-12-16 15:50:22.445890 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911022, 'jti': 'faff0b29-6475-4c4b-a155-a5b03b2d5202', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911022, 'exp': 1765929022, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:50:42.496634 >>> [routes.py] issue_token 2025-12-16 15:50:42.496817 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:42.948855 >>> Auth.token: ok 2025-12-16 15:50:45.115855 >>> [routes.py] issue_token 2025-12-16 15:50:45.116004 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:45.582497 >>> Auth.token: ok 2025-12-16 15:50:45.619741 >>> [routes.py] issue_token 2025-12-16 15:50:45.619880 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:46.081292 >>> Auth.token: ok 2025-12-16 15:50:46.100320 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911046, 'jti': 'f127f816-4f7d-48d4-a53f-405eb7f458fd', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911046, 'exp': 1765929046, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:50:56.735066 >>> [routes.py] issue_token 2025-12-16 15:50:56.735208 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:57.175406 >>> Auth.token: ok 2025-12-16 15:50:57.215626 >>> [routes.py] issue_token 2025-12-16 15:50:57.215810 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:50:57.658945 >>> Auth.token: ok 2025-12-16 15:50:57.676604 >>> [events.py] list_events 2025-12-16 15:50:57.676763 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911057, 'jti': '263833d3-d6aa-49e9-b984-9e860d4b4ed7', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911057, 'exp': 1765929057, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:50:57.810048 >>> hikvision.client fetch_events 2025-12-16 15:50:57.810261 >>> hikvision.client fetch_events || url: http://santandergolf.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 15:50:57.812175 >>> [events.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:50:58.911022 >>> Eventos crudos encontrados >>> 23 2025-12-16 15:50:58.911341 >>> target_minors: [1, 75, 38] 2025-12-16 15:50:58.911459 >>> normalized len: 0 2025-12-16 15:50:58.911599 >>> hikvision.client fetch_events || total: 0 2025-12-16 15:50:58.911962 >>> [events.py] hilos finalizados 2025-12-16 15:50:58.912074 >>> [TIMING] list_events threads total -> 1.102 s 2025-12-16 15:51:12.105975 >>> [routes.py] issue_token 2025-12-16 15:51:12.106137 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:51:12.545385 >>> Auth.token: ok 2025-12-16 15:51:12.583549 >>> [routes.py] issue_token 2025-12-16 15:51:12.583703 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:51:13.047060 >>> Auth.token: ok 2025-12-16 15:51:13.065749 >>> [persons.py] list_persons 2025-12-16 15:51:13.065968 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911073, 'jti': '409c58f4-e458-4a21-9c1d-8def85476e3c', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911073, 'exp': 1765929073, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:51:13.198223 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:51:13.198356 >>> [persons.py] hilos finalizados 2025-12-16 15:51:14.096875 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.901 s 2025-12-16 15:52:17.844665 >>> [routes.py] issue_token 2025-12-16 15:52:17.844872 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:52:18.293460 >>> Auth.token: ok 2025-12-16 15:52:18.328649 >>> [routes.py] issue_token 2025-12-16 15:52:18.328834 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:52:18.778220 >>> Auth.token: ok 2025-12-16 15:52:18.797315 >>> [persons.py] list_persons 2025-12-16 15:52:18.797511 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911138, 'jti': '9a184eb8-fbff-4136-ad9c-6117182c33e4', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911138, 'exp': 1765929138, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:52:18.928115 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:52:18.928252 >>> [persons.py] hilos finalizados 2025-12-16 15:52:19.817179 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.891 s 2025-12-16 15:52:34.613797 >>> [routes.py] issue_token 2025-12-16 15:52:34.613936 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:52:35.079994 >>> Auth.token: ok 2025-12-16 15:53:11.616459 >>> [routes.py] issue_token 2025-12-16 15:53:11.616619 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:53:12.065902 >>> Auth.token: ok 2025-12-16 15:54:14.508355 >>> [routes.py] issue_token 2025-12-16 15:54:14.508550 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:54:14.960482 >>> Auth.token: ok 2025-12-16 15:54:15.043182 >>> [routes.py] issue_token 2025-12-16 15:54:15.043321 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:54:15.480201 >>> Auth.token: ok 2025-12-16 15:54:15.501594 >>> [persons.py] create_person 2025-12-16 15:54:15.501859 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911255, 'jti': 'be35d431-56be-447a-ba8a-85f45ddf6cb1', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911255, 'exp': 1765929255, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:54:15.632410 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:54:15.632743 >>> [persons.py] hilos finalizados 2025-12-16 15:54:16.564855 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 15:54:16.565092 >>> [TIMING] santandergolf.dyndns.org:5023 search_user_by_employee_no -> 0.936 s 2025-12-16 15:54:17.509078 >>> [TIMING] santandergolf.dyndns.org:5023 create_user -> 0.944 s 2025-12-16 15:54:18.375621 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': 'SCP1763', 'name': 'E. Berruti', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-01-01T00:00:00', 'endTime': '2035-01-01T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 15:54:18.375866 >>> Cargando imagen para el usuario SCP1763 2025-12-16 15:54:18.376428 >>> tipo img_bytes antes de driver: 2025-12-16 15:54:18.376556 >>> len img_bytes: 23904 2025-12-16 15:54:19.710375 >>> [upload_face_via_fdlib] url=http://santandergolf.dyndns.org:5023/ISAPI/Intelligent/FDLib/FaceDataRecord?format=json 2025-12-16 15:54:19.710551 >>> [upload_face_via_fdlib] status=200 2025-12-16 15:54:19.712374 >>> [upload_face_via_fdlib] status={ "statusCode": 1, "statusString": "OK", "subStatusCode": "ok", "FPID": "SCP1763" } 2025-12-16 15:54:19.712595 >>> [TIMING] santandergolf.dyndns.org:5023 upload_face_via_fdlib -> 1.336 s 2025-12-16 15:54:20.636852 >>> [TIMING] santandergolf.dyndns.org:5023 loop create_card -> 0.924 s 2025-12-16 15:54:20.637270 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 5.008 s 2025-12-16 15:56:23.115703 >>> [routes.py] issue_token 2025-12-16 15:56:23.115897 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:56:23.593149 >>> Auth.token: ok 2025-12-16 15:56:23.633467 >>> [routes.py] issue_token 2025-12-16 15:56:23.633623 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:56:24.062750 >>> Auth.token: ok 2025-12-16 15:56:24.080612 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911384, 'jti': '9306332a-1ac1-4175-9eff-34519a43a474', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911384, 'exp': 1765929384, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:56:27.844553 >>> [persons.py] modify_person 2025-12-16 15:56:27.844825 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911384, 'jti': '9306332a-1ac1-4175-9eff-34519a43a474', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911384, 'exp': 1765929384, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:56:27.844987 >>> [persons.py] body {'valid_to': '2025-12-17T15:56:00', 'gender': 'male', 'maxOpenDoorTime': 0, 'userType': 'normal', 'valid_from': '2025-01-01T00:00:00', 'readers': ['santandergolf.dyndns.org5023'], 'name': 'E. Berruti'} 2025-12-16 15:56:28.856226 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': 'SCP1763', 'name': 'E. Berruti', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-01-01T00:00:00', 'endTime': '2035-01-01T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 3, 'numOfFace': 1, 'PersonInfoExtends': [{'value': ''}], 'faceURL': 'http://santandergolf.dyndns.org:5023/LOCALS/pic/enrlFace/0/0000000003.jpg@WEB000000000069'}]}} 2025-12-16 15:56:52.217899 >>> [routes.py] issue_token 2025-12-16 15:56:52.218036 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:56:52.677827 >>> Auth.token: ok 2025-12-16 15:56:52.715631 >>> [routes.py] issue_token 2025-12-16 15:56:52.715816 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:56:53.151984 >>> Auth.token: ok 2025-12-16 15:56:53.169036 >>> [persons.py] list_persons 2025-12-16 15:56:53.169215 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911413, 'jti': '70be8a90-149c-45be-b70f-03e467ea36ac', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911413, 'exp': 1765929413, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:56:53.307937 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:56:53.308593 >>> [persons.py] hilos finalizados 2025-12-16 15:56:54.220419 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.915 s 2025-12-16 15:57:08.399014 >>> [routes.py] issue_token 2025-12-16 15:57:08.399165 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:57:08.842825 >>> Auth.token: ok 2025-12-16 15:57:17.285497 >>> [routes.py] issue_token 2025-12-16 15:57:17.285667 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:57:17.771899 >>> Auth.token: ok 2025-12-16 15:57:17.809281 >>> [routes.py] issue_token 2025-12-16 15:57:17.809458 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:57:18.251556 >>> Auth.token: ok 2025-12-16 15:57:18.269581 >>> resources.persons delete_person 2025-12-16 15:57:18.269802 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911438, 'jti': '5b42106f-4761-4075-b998-3121772d135a', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911438, 'exp': 1765929438, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:57:18.400902 >>> resources.persons buscando persona en reader: Lector Ingreso 2025-12-16 15:57:19.293430 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': 'SCP1763', 'name': 'E. Berruti', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-01-01T00:00:00', 'endTime': '2025-12-17T15:56:00', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 1, 'floorNumber': 1, 'localUIRight': False, 'gender': 'male', 'numOfCard': 3, 'numOfFace': 1, 'PersonInfoExtends': [{'value': ''}], 'faceURL': 'http://santandergolf.dyndns.org:5023/LOCALS/pic/enrlFace/0/0000000003.jpg@WEB000000000078'}]}} 2025-12-16 15:57:23.013063 >>> [routes.py] issue_token 2025-12-16 15:57:23.013197 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:57:23.472801 >>> Auth.token: ok 2025-12-16 15:57:23.510184 >>> [routes.py] issue_token 2025-12-16 15:57:23.510356 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:57:23.964607 >>> Auth.token: ok 2025-12-16 15:57:23.981996 >>> [persons.py] list_persons 2025-12-16 15:57:23.982190 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911443, 'jti': '6debdd65-de77-470f-9032-a1441644547d', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911443, 'exp': 1765929443, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:57:24.113988 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:57:24.114129 >>> [persons.py] hilos finalizados 2025-12-16 15:57:25.036047 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.924 s 2025-12-16 15:58:26.535118 >>> [routes.py] issue_token 2025-12-16 15:58:26.535323 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:58:26.986664 >>> Auth.token: ok 2025-12-16 15:58:30.127437 >>> [routes.py] issue_token 2025-12-16 15:58:30.127579 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:58:30.602577 >>> Auth.token: ok 2025-12-16 15:58:30.639076 >>> [routes.py] issue_token 2025-12-16 15:58:30.639211 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:58:31.079715 >>> Auth.token: ok 2025-12-16 15:58:31.096375 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911511, 'jti': '49e1189b-33d3-4147-ae6f-d6187d1a4e18', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911511, 'exp': 1765929511, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:58:32.133228 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '1', 'name': 'Iparkings Prueba', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-09-29T00:00:00', 'endTime': '2035-09-29T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 0, 'floorNumber': 0, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFace': 1, 'PersonInfoExtends': [{'value': ''}], 'faceURL': 'http://santandergolf.dyndns.org:5023/LOCALS/pic/enrlFace/0/0000000001.jpg@WEB000000000083'}]}} 2025-12-16 15:58:56.970973 >>> [routes.py] issue_token 2025-12-16 15:58:56.971132 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:58:57.419790 >>> Auth.token: ok 2025-12-16 15:58:57.458882 >>> [routes.py] issue_token 2025-12-16 15:58:57.459101 >>> Auth.token: client_id=SantanderGolf 2025-12-16 15:58:57.924408 >>> Auth.token: ok 2025-12-16 15:58:57.943880 >>> [persons.py] list_persons 2025-12-16 15:58:57.944093 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911537, 'jti': '204f821a-5a84-46ae-a5ea-7ee37d07ad54', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911537, 'exp': 1765929537, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 15:58:58.075914 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 15:58:58.076054 >>> [persons.py] hilos finalizados 2025-12-16 15:58:59.027812 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.954 s 2025-12-16 16:00:08.411558 >>> [routes.py] issue_token 2025-12-16 16:00:08.411699 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:00:08.858870 >>> Auth.token: ok 2025-12-16 16:00:17.320261 >>> [routes.py] issue_token 2025-12-16 16:00:17.320478 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:00:17.769066 >>> Auth.token: ok 2025-12-16 16:00:17.803432 >>> [routes.py] issue_token 2025-12-16 16:00:17.803566 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:00:18.255078 >>> Auth.token: ok 2025-12-16 16:00:18.276069 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911618, 'jti': '1e218fc1-a70f-4721-9f39-1b4ce3397323', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911618, 'exp': 1765929618, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:00:19.285420 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'NO MATCH', 'numOfMatches': 0, 'totalMatches': 0}} 2025-12-16 16:01:12.549746 >>> [routes.py] issue_token 2025-12-16 16:01:12.550044 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:01:13.023954 >>> Auth.token: ok 2025-12-16 16:01:13.059112 >>> [routes.py] issue_token 2025-12-16 16:01:13.059255 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:01:13.517204 >>> Auth.token: ok 2025-12-16 16:01:13.532967 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911673, 'jti': 'c5e528f8-663a-4a61-a0c2-739b06367227', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911673, 'exp': 1765929673, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:01:14.598368 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '1', 'name': 'Lector dactilar', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T00:00:00', 'endTime': '2035-12-16T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 0, 'floorNumber': 0, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 16:01:23.943270 >>> [routes.py] issue_token 2025-12-16 16:01:23.943437 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:01:24.396229 >>> Auth.token: ok 2025-12-16 16:01:24.442158 >>> [routes.py] issue_token 2025-12-16 16:01:24.442330 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:01:24.898277 >>> Auth.token: ok 2025-12-16 16:01:24.916105 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911684, 'jti': 'daea5332-9c19-4dff-9397-4ae078c2444d', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911684, 'exp': 1765929684, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:01:25.932319 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '1', 'name': 'Lector dactilar', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T00:00:00', 'endTime': '2035-12-16T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 0, 'floorNumber': 0, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 16:02:21.978240 >>> [routes.py] issue_token 2025-12-16 16:02:21.978599 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:02:22.409557 >>> Auth.token: ok 2025-12-16 16:02:22.444045 >>> [routes.py] issue_token 2025-12-16 16:02:22.444177 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:02:22.910610 >>> Auth.token: ok 2025-12-16 16:02:22.927850 >>> [persons.py] list_persons 2025-12-16 16:02:22.928033 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911742, 'jti': '1a785b03-5bd0-44af-bbd1-075f3dcf0706', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911742, 'exp': 1765929742, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:02:23.065771 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:02:23.065904 >>> [persons.py] hilos finalizados 2025-12-16 16:02:23.955774 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.892 s 2025-12-16 16:02:27.845799 >>> [routes.py] issue_token 2025-12-16 16:02:27.845954 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:02:28.297794 >>> Auth.token: ok 2025-12-16 16:02:28.332556 >>> [routes.py] issue_token 2025-12-16 16:02:28.332689 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:02:28.769987 >>> Auth.token: ok 2025-12-16 16:02:28.789431 >>> [persons.py] list_persons 2025-12-16 16:02:28.789660 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911748, 'jti': 'f76c7ca1-fe60-4593-8dae-c4be33024200', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911748, 'exp': 1765929748, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:02:28.924875 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:02:28.925014 >>> [persons.py] hilos finalizados 2025-12-16 16:02:29.836593 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.914 s 2025-12-16 16:03:02.960758 >>> [routes.py] issue_token 2025-12-16 16:03:02.960949 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:03:03.408502 >>> Auth.token: ok 2025-12-16 16:03:03.450203 >>> [routes.py] issue_token 2025-12-16 16:03:03.450387 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:03:03.908507 >>> Auth.token: ok 2025-12-16 16:03:03.928663 >>> [persons.py] list_persons 2025-12-16 16:03:03.928923 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911783, 'jti': 'f1244c02-e161-44c7-8071-54764bd73880', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911783, 'exp': 1765929783, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:03:04.063834 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:03:04.064004 >>> [persons.py] hilos finalizados 2025-12-16 16:03:04.976746 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.915 s 2025-12-16 16:04:30.917987 >>> [routes.py] issue_token 2025-12-16 16:04:30.918147 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:04:31.411413 >>> Auth.token: ok 2025-12-16 16:04:34.954180 >>> [routes.py] issue_token 2025-12-16 16:04:34.954303 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:04:35.407276 >>> Auth.token: ok 2025-12-16 16:04:35.442097 >>> [routes.py] issue_token 2025-12-16 16:04:35.442259 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:04:35.880590 >>> Auth.token: ok 2025-12-16 16:04:35.897426 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911875, 'jti': '29d2077b-bcf9-4281-9341-236b0d74ec23', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911875, 'exp': 1765929875, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:04:36.964534 >>> Usuario encontrado:{'UserInfoSearch': {'searchID': '1', 'responseStatusStrg': 'OK', 'numOfMatches': 1, 'totalMatches': 1, 'UserInfo': [{'employeeNo': '1', 'name': 'Lector dactilar', 'userType': 'normal', 'onlyVerify': False, 'closeDelayEnabled': False, 'Valid': {'enable': True, 'beginTime': '2025-12-16T00:00:00', 'endTime': '2035-12-16T23:59:59', 'timeType': 'local'}, 'belongGroup': '', 'password': '', 'doorRight': '1', 'RightPlan': [{'doorNo': 1, 'planTemplateNo': '1'}], 'maxOpenDoorTime': 0, 'openDoorTime': 0, 'roomNumber': 0, 'floorNumber': 0, 'localUIRight': False, 'gender': 'male', 'numOfCard': 0, 'numOfFace': 0, 'PersonInfoExtends': [{'value': ''}]}]}} 2025-12-16 16:06:11.729171 >>> [routes.py] issue_token 2025-12-16 16:06:11.729321 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:06:12.173070 >>> Auth.token: ok 2025-12-16 16:06:12.211676 >>> [routes.py] issue_token 2025-12-16 16:06:12.211893 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:06:12.649709 >>> Auth.token: ok 2025-12-16 16:06:12.667407 >>> [persons.py] list_persons 2025-12-16 16:06:12.667563 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911972, 'jti': 'a8c9c6dc-c2a1-4352-ab66-a2ce0e35eb5a', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911972, 'exp': 1765929972, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:06:12.799692 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:06:12.799841 >>> [persons.py] hilos finalizados 2025-12-16 16:06:13.747852 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.950 s 2025-12-16 16:06:18.749416 >>> [routes.py] issue_token 2025-12-16 16:06:18.749553 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:06:19.222803 >>> Auth.token: ok 2025-12-16 16:06:20.866968 >>> [routes.py] issue_token 2025-12-16 16:06:20.867123 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:06:21.318823 >>> Auth.token: ok 2025-12-16 16:06:21.356346 >>> [routes.py] issue_token 2025-12-16 16:06:21.356512 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:06:21.810787 >>> Auth.token: ok 2025-12-16 16:06:21.827514 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765911981, 'jti': '728c49e0-8806-422c-bf78-886331034fa0', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765911981, 'exp': 1765929981, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:12:18.659079 >>> [routes.py] issue_token 2025-12-16 16:12:18.659238 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:12:19.131485 >>> Auth.token: ok 2025-12-16 16:12:19.201500 >>> [routes.py] issue_token 2025-12-16 16:12:19.201689 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:12:19.654050 >>> Auth.token: ok 2025-12-16 16:12:19.673689 >>> [persons.py] list_persons 2025-12-16 16:12:19.673917 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912339, 'jti': '6cded94d-4b41-41a4-9f2c-cb78ca3bbea9', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912339, 'exp': 1765930339, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:12:19.804248 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:12:19.804399 >>> [persons.py] hilos finalizados 2025-12-16 16:12:20.711441 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.910 s 2025-12-16 16:13:08.501509 >>> [routes.py] issue_token 2025-12-16 16:13:08.501646 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:13:08.944226 >>> Auth.token: ok 2025-12-16 16:13:09.010012 >>> [routes.py] issue_token 2025-12-16 16:13:09.010178 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:13:09.472202 >>> Auth.token: ok 2025-12-16 16:13:09.488811 >>> [persons.py] list_persons 2025-12-16 16:13:09.488956 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912389, 'jti': 'f6657da9-5f42-4417-99c6-cc6a7f610ee8', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912389, 'exp': 1765930389, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:13:09.621836 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:13:09.622019 >>> [persons.py] hilos finalizados 2025-12-16 16:13:10.523944 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.905 s 2025-12-16 16:15:43.509731 >>> [routes.py] issue_token 2025-12-16 16:15:43.509940 >>> Auth.token: client_id=Olivos 2025-12-16 16:15:43.969453 >>> Auth.token: ok 2025-12-16 16:15:44.005037 >>> [routes.py] issue_token 2025-12-16 16:15:44.005179 >>> Auth.token: client_id=Olivos 2025-12-16 16:15:44.449917 >>> Auth.token: ok 2025-12-16 16:15:44.467285 >>> [persons.py] list_persons 2025-12-16 16:15:44.467437 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912544, 'jti': 'cf1eafb9-0e24-4945-a508-7728919450ad', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765912544, 'exp': 1765930544, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:15:44.602112 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:15:44.604329 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:15:44.606167 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:15:44.608000 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:15:44.609912 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:15:44.611934 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:15:44.613926 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:15:44.615810 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:15:44.617576 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:15:44.619706 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:15:44.622115 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:15:44.624285 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:15:44.624447 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.526619 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.643581 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.643812 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.643868 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750589 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750768 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750829 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750868 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750904 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750938 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.750972 >>> [persons.py] hilos finalizados 2025-12-16 16:15:45.751011 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.151 s 2025-12-16 16:16:00.051109 >>> [routes.py] issue_token 2025-12-16 16:16:00.051271 >>> Auth.token: client_id=Olivos 2025-12-16 16:16:00.512670 >>> Auth.token: ok 2025-12-16 16:17:15.946263 >>> [routes.py] issue_token 2025-12-16 16:17:15.946419 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:16.409581 >>> Auth.token: ok 2025-12-16 16:17:22.530802 >>> [routes.py] issue_token 2025-12-16 16:17:22.530988 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:22.986930 >>> Auth.token: ok 2025-12-16 16:17:23.025463 >>> [routes.py] issue_token 2025-12-16 16:17:23.025623 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:23.487824 >>> Auth.token: ok 2025-12-16 16:17:23.505691 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912643, 'jti': '2952402f-74b4-4dea-98d4-d451053dd9de', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912643, 'exp': 1765930643, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:17:31.003308 >>> [routes.py] issue_token 2025-12-16 16:17:31.003498 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:31.464240 >>> Auth.token: ok 2025-12-16 16:17:31.508034 >>> [routes.py] issue_token 2025-12-16 16:17:31.508225 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:31.958156 >>> Auth.token: ok 2025-12-16 16:17:31.978013 >>> [persons.py] list_persons 2025-12-16 16:17:31.978257 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912651, 'jti': '5e202140-baa0-487a-b7f8-60eacabd9079', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912651, 'exp': 1765930651, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:17:32.116980 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:17:32.117187 >>> [persons.py] hilos finalizados 2025-12-16 16:17:32.990343 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.876 s 2025-12-16 16:17:45.521523 >>> [routes.py] issue_token 2025-12-16 16:17:45.521679 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:45.998871 >>> Auth.token: ok 2025-12-16 16:17:46.044304 >>> [routes.py] issue_token 2025-12-16 16:17:46.044467 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:17:46.484323 >>> Auth.token: ok 2025-12-16 16:17:46.501744 >>> [events.py] list_events 2025-12-16 16:17:46.501891 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912666, 'jti': 'a8f73293-a333-4aa0-be3d-8e5a0db70d87', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912666, 'exp': 1765930666, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:17:46.629955 >>> hikvision.client fetch_events 2025-12-16 16:17:46.630174 >>> hikvision.client fetch_events || url: http://santandergolf.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:17:46.631883 >>> [events.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:17:47.850241 >>> Eventos crudos encontrados >>> 26 2025-12-16 16:17:47.850428 >>> target_minors: [1, 75, 38] 2025-12-16 16:17:47.850518 >>> normalized len: 0 2025-12-16 16:17:47.850615 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:17:47.850892 >>> [events.py] hilos finalizados 2025-12-16 16:17:47.850981 >>> [TIMING] list_events threads total -> 1.221 s 2025-12-16 16:18:21.345525 >>> [routes.py] issue_token 2025-12-16 16:18:21.345670 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:18:21.803451 >>> Auth.token: ok 2025-12-16 16:18:21.858871 >>> [routes.py] issue_token 2025-12-16 16:18:21.858999 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:18:22.314796 >>> Auth.token: ok 2025-12-16 16:18:22.335476 >>> [persons.py] list_persons 2025-12-16 16:18:22.335685 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912702, 'jti': '35acacec-f44f-40cc-a27f-a9a0797b867c', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912702, 'exp': 1765930702, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:18:22.465934 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:18:22.466074 >>> [persons.py] hilos finalizados 2025-12-16 16:18:23.353773 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.890 s 2025-12-16 16:18:39.014862 >>> [routes.py] issue_token 2025-12-16 16:18:39.015000 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:18:39.491220 >>> Auth.token: ok 2025-12-16 16:18:39.525878 >>> [routes.py] issue_token 2025-12-16 16:18:39.526036 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:18:39.985565 >>> Auth.token: ok 2025-12-16 16:18:40.005314 >>> [persons.py] list_persons 2025-12-16 16:18:40.005760 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912719, 'jti': 'e68267e3-ef80-43ec-8ee6-934b82be14ad', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912719, 'exp': 1765930719, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:18:40.135958 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:18:40.136094 >>> [persons.py] hilos finalizados 2025-12-16 16:18:41.014511 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.881 s 2025-12-16 16:18:47.121189 >>> [routes.py] issue_token 2025-12-16 16:18:47.121355 >>> Auth.token: client_id=Olivos 2025-12-16 16:18:47.568669 >>> Auth.token: ok 2025-12-16 16:18:47.606350 >>> [routes.py] issue_token 2025-12-16 16:18:47.606483 >>> Auth.token: client_id=Olivos 2025-12-16 16:18:48.053283 >>> Auth.token: ok 2025-12-16 16:18:48.072830 >>> [persons.py] list_persons 2025-12-16 16:18:48.073029 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912728, 'jti': '503a9b48-dc4c-42df-853f-8467421cb5f7', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765912728, 'exp': 1765930728, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:18:48.204770 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:18:48.207018 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:18:48.208997 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:18:48.210783 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:18:48.213321 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:18:48.215390 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:18:48.217969 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:18:48.220072 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:18:48.221946 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:18:48.224302 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:18:48.226291 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:18:48.228350 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:18:48.228464 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.155412 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.155620 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.277254 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.277420 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422541 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422758 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422816 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422860 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422898 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422937 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.422975 >>> [persons.py] hilos finalizados 2025-12-16 16:18:49.423020 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.221 s 2025-12-16 16:19:21.345482 >>> [routes.py] issue_token 2025-12-16 16:19:21.345680 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:19:21.806714 >>> Auth.token: ok 2025-12-16 16:19:21.843969 >>> [routes.py] issue_token 2025-12-16 16:19:21.844103 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:19:22.288031 >>> Auth.token: ok 2025-12-16 16:19:22.304944 >>> [persons.py] list_persons 2025-12-16 16:19:22.305151 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912762, 'jti': '391c3d53-4b21-4339-9cfb-99ee0993954a', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912762, 'exp': 1765930762, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:19:22.439433 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:19:22.439595 >>> [persons.py] hilos finalizados 2025-12-16 16:19:23.369067 >>> [routes.py] issue_token 2025-12-16 16:19:23.369221 >>> Auth.token: client_id=Olivos 2025-12-16 16:19:23.504827 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.068 s 2025-12-16 16:19:23.836857 >>> Auth.token: ok 2025-12-16 16:19:23.917306 >>> [routes.py] issue_token 2025-12-16 16:19:23.917493 >>> Auth.token: client_id=Olivos 2025-12-16 16:19:24.394833 >>> Auth.token: ok 2025-12-16 16:19:24.413856 >>> [persons.py] list_persons 2025-12-16 16:19:24.414010 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912764, 'jti': 'bde4ca06-f7ab-4df1-b02b-605c12bcd514', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765912764, 'exp': 1765930764, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:19:24.547861 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:19:24.550478 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:19:24.552559 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:19:24.554480 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:19:24.557344 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:19:24.559893 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:19:24.562310 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:19:24.564928 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:19:24.566767 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:19:24.568967 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:19:24.570851 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:19:24.573554 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:19:24.573660 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.470216 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.553844 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.554096 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.554152 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.554209 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.554252 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.609526 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.609689 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.609754 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.615883 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.616034 >>> [persons.py] hilos finalizados 2025-12-16 16:19:25.616097 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.071 s 2025-12-16 16:19:32.033502 >>> [routes.py] issue_token 2025-12-16 16:19:32.033794 >>> Auth.token: client_id=Olivos 2025-12-16 16:19:32.500848 >>> Auth.token: ok 2025-12-16 16:19:32.542645 >>> [routes.py] issue_token 2025-12-16 16:19:32.542829 >>> Auth.token: client_id=Olivos 2025-12-16 16:19:33.021810 >>> Auth.token: ok 2025-12-16 16:19:33.044090 >>> [persons.py] list_persons 2025-12-16 16:19:33.044323 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912773, 'jti': 'cd5a5dfd-e25b-4e4d-a118-ff7e0c06ec76', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765912773, 'exp': 1765930773, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:19:33.176250 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:19:33.179075 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:19:33.181426 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:19:33.183577 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:19:33.185595 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:19:33.187681 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:19:33.189581 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:19:33.191889 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:19:33.193678 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:19:33.196056 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:19:33.197818 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:19:33.199578 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:19:33.199654 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.178818 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.178982 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.179030 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.182140 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.182250 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232334 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232483 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232534 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232575 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232613 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232649 >>> [persons.py] hilos finalizados 2025-12-16 16:19:34.232690 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.059 s 2025-12-16 16:19:43.009015 >>> [routes.py] issue_token 2025-12-16 16:19:43.009188 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:19:43.500669 >>> Auth.token: ok 2025-12-16 16:19:43.537493 >>> [routes.py] issue_token 2025-12-16 16:19:43.537616 >>> Auth.token: client_id=SantanderGolf 2025-12-16 16:19:44.019649 >>> Auth.token: ok 2025-12-16 16:19:44.044115 >>> [persons.py] list_persons 2025-12-16 16:19:44.044358 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765912784, 'jti': '6a9fd392-a465-4a95-ac2f-ae4527ed3709', 'type': 'access', 'sub': 'SantanderGolf', 'nbf': 1765912784, 'exp': 1765930784, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: SantanderGolf 2025-12-16 16:19:44.177820 >>> [persons.py] lanzando hilo para lector: Lector Ingreso 2025-12-16 16:19:44.178118 >>> [persons.py] hilos finalizados 2025-12-16 16:19:45.064188 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 0.889 s 2025-12-16 16:24:02.723216 >>> [routes.py] issue_token 2025-12-16 16:24:02.723382 >>> Auth.token: client_id=Olivos 2025-12-16 16:24:03.195233 >>> Auth.token: ok 2025-12-16 16:24:03.229459 >>> [routes.py] issue_token 2025-12-16 16:24:03.229599 >>> Auth.token: client_id=Olivos 2025-12-16 16:24:03.678524 >>> Auth.token: ok 2025-12-16 16:24:03.699019 >>> [persons.py] list_persons 2025-12-16 16:24:03.699277 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765913043, 'jti': '4ba579cd-79ed-4ae4-a9c1-90da699d66b7', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765913043, 'exp': 1765931043, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:24:03.836172 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:24:03.838232 >>> [persons.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:24:03.839671 >>> [persons.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:24:03.841225 >>> [persons.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:24:03.843282 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:24:03.844849 >>> [persons.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:24:03.846282 >>> [persons.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:24:03.851852 >>> [persons.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:24:03.853288 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:24:03.854657 >>> [persons.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:24:03.857062 >>> [persons.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:24:03.858838 >>> [persons.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:24:03.858958 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.809232 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.809450 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.809515 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.809559 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.853814 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881130 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881322 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881375 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881419 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881458 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881533 >>> [persons.py] hilos finalizados 2025-12-16 16:24:04.881581 >>> [TIMING] Desde que se inician los hilos hasta la rspuesta final -> 1.047 s 2025-12-16 16:50:17.504210 >>> [routes.py] issue_token 2025-12-16 16:50:17.504433 >>> Auth.token: client_id=Olivos 2025-12-16 16:50:18.000795 >>> Auth.token: ok 2025-12-16 16:50:18.041228 >>> [routes.py] issue_token 2025-12-16 16:50:18.041391 >>> Auth.token: client_id=Olivos 2025-12-16 16:50:18.501303 >>> Auth.token: ok 2025-12-16 16:50:18.518994 >>> [events.py] list_events 2025-12-16 16:50:18.519148 >>> [decorators.py] get_tenant_id_from_jwt_identity, informacion del token >>> claims: {'fresh': False, 'iat': 1765914618, 'jti': 'cd85c5bb-1da4-4beb-b94f-8c49b609fafb', 'type': 'access', 'sub': 'Olivos', 'nbf': 1765914618, 'exp': 1765932618, 'scopes': ['users:read', 'users:write', 'events:read']} || tenant: Olivos 2025-12-16 16:50:18.650101 >>> hikvision.client fetch_events 2025-12-16 16:50:18.650322 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.652662 >>> [events.py] lanzando hilo para lector: P1. ENTRADA PROPIETARIOS 2025-12-16 16:50:18.653235 >>> hikvision.client fetch_events 2025-12-16 16:50:18.653368 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.655263 >>> [events.py] lanzando hilo para lector: P1. ENTRADA VISITAS 2025-12-16 16:50:18.655639 >>> hikvision.client fetch_events 2025-12-16 16:50:18.655799 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.657497 >>> [events.py] lanzando hilo para lector: P1. SALIDA PROPIETARIOS 2025-12-16 16:50:18.657977 >>> hikvision.client fetch_events 2025-12-16 16:50:18.658110 >>> hikvision.client fetch_events || url: http://olivosportal1.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.659671 >>> [events.py] lanzando hilo para lector: P1. SALIDA VISITAS 2025-12-16 16:50:18.660566 >>> hikvision.client fetch_events 2025-12-16 16:50:18.661062 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.662632 >>> [events.py] lanzando hilo para lector: P2. ENTRADA PROPIETARIOS 2025-12-16 16:50:18.663060 >>> hikvision.client fetch_events 2025-12-16 16:50:18.663199 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.664736 >>> [events.py] lanzando hilo para lector: P2. ENTRADA VISITAS 2025-12-16 16:50:18.665138 >>> hikvision.client fetch_events 2025-12-16 16:50:18.665246 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.666774 >>> [events.py] lanzando hilo para lector: P2. SALIDA PROPIETARIOS 2025-12-16 16:50:18.667316 >>> hikvision.client fetch_events 2025-12-16 16:50:18.667428 >>> hikvision.client fetch_events || url: http://olivosportal2.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.669414 >>> [events.py] lanzando hilo para lector: P2. SALIDA VISITAS 2025-12-16 16:50:18.676982 >>> hikvision.client fetch_events 2025-12-16 16:50:18.677209 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5020/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.679992 >>> [events.py] lanzando hilo para lector: P3. ENTRADA PROPIETARIOS 2025-12-16 16:50:18.680802 >>> hikvision.client fetch_events 2025-12-16 16:50:18.680963 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5021/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.683230 >>> [events.py] lanzando hilo para lector: P3. ENTRADA VISITAS 2025-12-16 16:50:18.687799 >>> hikvision.client fetch_events 2025-12-16 16:50:18.688098 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5022/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.690165 >>> [events.py] lanzando hilo para lector: P3. SALIDA PROPIETARIOS 2025-12-16 16:50:18.690678 >>> hikvision.client fetch_events 2025-12-16 16:50:18.690852 >>> hikvision.client fetch_events || url: http://olivosportal3.dyndns.org:5023/ISAPI/AccessControl/AcsEvent?format=json&security=1 || payload: {'AcsEventCond': {'searchID': '1', 'searchResultPosition': 0, 'maxResults': 100, 'major': 5, 'minor': 0, 'startTime': '2025-12-16T00:00:00-03:00', 'endTime': '2025-12-16T23:59:59-03:00', 'timeReverseOrder': True}} 2025-12-16 16:50:18.692612 >>> [events.py] lanzando hilo para lector: P3. SALIDA VISITAS 2025-12-16 16:50:19.528545 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.529153 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.529252 >>> normalized len: 0 2025-12-16 16:50:19.529425 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.554033 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.554247 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.554316 >>> normalized len: 0 2025-12-16 16:50:19.554441 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.554686 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.559226 >>> Eventos crudos encontrados >>> 1 2025-12-16 16:50:19.559432 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.559486 >>> normalized len: 0 2025-12-16 16:50:19.559630 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.560970 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.561154 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.561208 >>> normalized len: 0 2025-12-16 16:50:19.561363 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.561878 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.563641 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.563870 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.563924 >>> normalized len: 0 2025-12-16 16:50:19.564043 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.565281 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.565415 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.565464 >>> normalized len: 0 2025-12-16 16:50:19.565569 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.565973 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.566075 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.582970 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.583350 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.583404 >>> normalized len: 0 2025-12-16 16:50:19.583538 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.584946 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.585106 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.585155 >>> normalized len: 0 2025-12-16 16:50:19.585256 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.586501 >>> Eventos crudos encontrados >>> 6 2025-12-16 16:50:19.586636 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.586705 >>> normalized len: 2 2025-12-16 16:50:19.586856 >>> hikvision.client fetch_events || total: 2 2025-12-16 16:50:19.603176 >>> Eventos crudos encontrados >>> 0 2025-12-16 16:50:19.603372 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.603425 >>> normalized len: 0 2025-12-16 16:50:19.603554 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.627450 >>> Eventos crudos encontrados >>> 8 2025-12-16 16:50:19.627685 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.627796 >>> normalized len: 2 2025-12-16 16:50:19.627942 >>> hikvision.client fetch_events || total: 2 2025-12-16 16:50:19.628380 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.669425 >>> Eventos crudos encontrados >>> 27 2025-12-16 16:50:19.669616 >>> target_minors: [1, 75, 38] 2025-12-16 16:50:19.669706 >>> normalized len: 0 2025-12-16 16:50:19.670013 >>> hikvision.client fetch_events || total: 0 2025-12-16 16:50:19.670310 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670394 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670436 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670473 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670510 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670546 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670582 >>> [events.py] hilos finalizados 2025-12-16 16:50:19.670623 >>> [TIMING] list_events threads total -> 1.021 s