[RESUELTO] El agente WAPT se desconecta

alain17 · 15 de julio de 2022 - 10:25

Buen día,

Actualmente estoy ejecutando un servidor WAPT Enterprise versión 2.2 en Ubuntu 20.04 LTS y tengo un problema con mis clientes Windows. Algunos funcionan perfectamente (permanecen conectados), mientras que otros se desconectan del servidor muy rápido (aparecen desconectados aunque se les pueda hacer ping). Seguí las instrucciones tema sobre antivirus y el de Este usuario que está experimentando problemas de desconexión también.

Ejecuté el siguiente comando en una máquina cliente que se desconecta, como usuario sin privilegios:

Código: Seleccionar todo

"c:\Program Files (x86)\wapt\runwaptservice.bat" -ldebug

El resultado que surgió fue el siguiente:

Código: Seleccionar todo

2022-07-15 09:19:57,091 [waptcore MainThread 16644] DEBUG Thread 16644 is connecting to wapt db
2022-07-15 09:19:57,094 [waptcore MainThread 16644] DEBUG DB Start transaction
2022-07-15 09:19:57,094 [waptcore MainThread 16644] DEBUG DB commit
2022-07-15 09:19:57,127 [waptservice MainThread 16644] INFO Setting hiberboot_enabled to 0
2022-07-15 09:19:57,129 [waptcore MainThread 16644] DEBUG Thread 16644 is connecting to wapt db
2022-07-15 09:19:57,129 [waptcore MainThread 16644] DEBUG DB Start transaction
2022-07-15 09:19:57,130 [waptcore MainThread 16644] DEBUG DB commit
Disabling Windows auto update service, using WaptWUA instead
2022-07-15 09:19:57,159 [waptwua MainThread 16644] CRITICAL Unable to set waptwua policies : __enter__
2022-07-15 09:19:57,159 [wapttasks MainThread 16644] INFO Service Configuration: {'config_filename': 'c:\\Program Files (x86)\\wapt\\wapt-get.ini', 'waptservice_user': None, 'waptservice_password': None, 'MAX_HISTORY': 30, 'waptservice_port': 8088, 'dbpath': 'c:\\Program Files (x86)\\wapt\\db\\waptdb.sqlite', 'loglevel': 'debug', 'log_directory': 'c:\\Program Files (x86)\\wapt\\log', 'waptserver': <WaptServer https://waptserver.domaine.local>, 'hiberboot_enabled': 0, 'max_gpo_script_wait': 180, 'pre_shutdown_timeout': 180, 'log_to_windows_events': False, 'allow_user_service_restart': False, 'signature_clockskew': 21600, 'notify_user': False, 'waptservice_admin_filter': False, 'enable_remote_repo': False, 'local_repo_path': 'c:\\Program Files (x86)\\wapt\\repository', 'local_repo_sync_task_period': '2h', 'local_repo_time_for_sync_start': None, 'local_repo_time_for_sync_end': None, 'local_repo_limit_bandwidth': None, 'wol_port': '7,9', 'wol_relay': False, 'service_auth_type': 'system', 'verify_cert_ldap': False, 'download_after_update_with_waptupdate_task_period': True, 'forced_installs_task_period': '2m', 'reconfig_on_network_change': False, 'loglevel_waptcore': None, 'loglevel_waptservice': None, 'loglevel_waptws': None, 'loglevel_waptdb': None, 'loglevel_websocket': None, 'loglevel_waitress': None, 'loglevel_wapttasks': None}
2022-07-15 09:19:57,159 [wapttasks MainThread 16644] INFO Starting task queue
2022-07-15 09:19:57,160 [wapttasks MainThread 16644] INFO Tasks queue running
2022-07-15 09:19:57,160 [wapttasks WaptTaskManager 7028] INFO Wapt tasks management initialized with c:\Program Files (x86)\wapt\wapt-get.ini configuration
2022-07-15 09:19:57,161 [wapttasks MainThread 16644] INFO Starting waitress waptservice on port 8088
2022-07-15 09:19:57,162 [waptservice SocketIOClient 20008] INFO No password set for local waptservice, using local computer security
2022-07-15 09:19:57,163 [waptcore WaptTaskManager 7028] DEBUG Thread 7028 is connecting to wapt db
2022-07-15 09:19:57,165 [waptcore SocketIOClient 20008] DEBUG Thread 20008 is connecting to wapt db
2022-07-15 09:19:57,165 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:19:57,165 [waptcore WaptTaskManager 7028] DEBUG DB commit
2022-07-15 09:19:57,166 [waptcore SocketIOClient 20008] DEBUG DB Start transaction
2022-07-15 09:19:57,167 [waptcore SocketIOClient 20008] DEBUG DB commit
2022-07-15 09:19:57,168 [waitress MainThread 16644] INFO Serving on http://127.0.0.1:8088
2022-07-15 09:19:57,249 [wapttasks SocketIOClient 20008] INFO Starting socketio on "https://waptserver.domaine.local:443" Thread id 20008
2022-07-15 09:19:57,249 [waptws SocketIOClient 20008] DEBUG Certificate checking : False
2022-07-15 09:19:57,250 [waptcore WaptTaskManager 7028] DEBUG Host certificate c:\Program Files (x86)\wapt\private\4C4C4544-0035-4710-804A-B3C04F434233.crt not found, not using it for auth on repo global
2022-07-15 09:19:57,252 [waptcore WaptTaskManager 7028] DEBUG Host certificate c:\Program Files (x86)\wapt\private\4C4C4544-0035-4710-804A-B3C04F434233.crt not found, not using it for auth on repo wapt
2022-07-15 09:19:57,252 [waptcore WaptTaskManager 7028] INFO Main repository: https://waptserver.domaine.local/wapt
2022-07-15 09:19:57,253 [waptcore WaptTaskManager 7028] DEBUG Host certificate c:\Program Files (x86)\wapt\private\4C4C4544-0035-4710-804A-B3C04F434233.crt not found, not using it for auth on repo wapt-host
2022-07-15 09:19:57,254 [wapttasks WaptTaskManager 7028] INFO Core Configuration: {'wapt_base_dir': 'c:\\Program Files (x86)\\wapt', 'waptserver': <WaptServer https://waptserver.domaine.local>, 'config_filename': 'c:\\Program Files (x86)\\wapt\\wapt-get.ini', 'proxies': {'http': '', 'https': ''}, 'repositories': [<WaptRepo https://waptserver.domaine.local/wapt>, <WaptHostRepo https://waptserver.domaine.local/wapt-host for host_id 4C4C4544-0035-4710-804A-B3C04F434233 >], 'personal_certificate_path': '', 'public_certs_dir': 'c:\\Program Files (x86)\\wapt\\ssl', 'package_cache_dir': 'c:\\Program Files (x86)\\wapt\\cache', 'dbpath': 'c:\\Program Files (x86)\\wapt\\db\\waptdb.sqlite', 'use_http_proxy_for_repo': False, 'use_http_proxy_for_server': False, 'limit_bandwidth': None, 'locales': ['fr'], 'custom_tags': [], 'packages_whitelist': None, 'packages_blacklist': None, 'maturities': ['PROD'], 'host_uuid': '4C4C4544-0035-4710-804A-B3C04F434233', 'use_fqdn_as_uuid': False, 'use_hostpackages': True, 'use_ad_groups': False, 'use_repo_rules': False, 'host_profiles': [], 'host_organizational_unit_dn': 'OU=WAPT Test,OU=Ordinateurs,DC=Domaine,DC=local', 'host_ad_site': None, 'waptaudit_task_period': '2h', 'hiberboot_enabled': '0', 'max_gpo_script_wait': 180.0, 'pre_shutdown_timeout': 180.0, 'uninstallkey_timeout': 120, 'check_certificates_validity': True, 'token_lifetime': 86400}
2022-07-15 09:19:57,254 [wapttasks WaptTaskManager 7028] INFO Wapt tasks queue started
2022-07-15 09:19:57,850 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 1.3s before retrying
2022-07-15 09:19:59,426 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 2.2750000000000004s before retrying
2022-07-15 09:20:02,026 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 3.9812500000000006s before retrying
2022-07-15 09:20:06,093 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 6.967187500000001s before retrying
2022-07-15 09:20:07,320 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:07,426 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "GET /licences.json HTTP/1.1" 200 7952
2022-07-15 09:20:07,428 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:07,428 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:07,432 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:07,435 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:07,435 [waptcore WaptTaskManager 7028] DEBUG Remove unknown repositories from packages table and params ("wapt","wapt-host")
2022-07-15 09:20:07,436 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt to avoid unecessary update
2022-07-15 09:20:07,436 [waptcore WaptTaskManager 7028] DEBUG Checking availability of https://waptserver.domaine.local/wapt/Packages
2022-07-15 09:20:07,437 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:07,532 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt/Packages HTTP/1.1" 200 0
2022-07-15 09:20:07,533 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt has not been updated (last update 2022-07-11T07:09:54), skipping update
2022-07-15 09:20:07,533 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt-host to avoid unecessary update
2022-07-15 09:20:07,534 [waptcore WaptTaskManager 7028] DEBUG Checking availability of wapt-host
2022-07-15 09:20:07,534 [waptcore WaptTaskManager 7028] DEBUG Trying to get  host package for 4C4C4544-0035-4710-804A-B3C04F434233 at https://waptserver.domaine.local/wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt
2022-07-15 09:20:07,535 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:07,624 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt HTTP/1.1" 200 0
2022-07-15 09:20:07,625 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt-host has not been updated (last update 2022-07-08T09:23:28), skipping update
2022-07-15 09:20:07,626 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:07,626 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:07,626 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 4567, in _update_repos_list\n    self.write_param(\'host_capabilities_fingerprint\', new_capa)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 8018, in write_param\n    self.waptdb.set_param(name, value)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:07,627 [wapttasks WaptTaskManager 7028] CRITICAL Error for update in check_scheduled_tasks: attempt to write a readonly database
2022-07-15 09:20:07,627 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:07,628 [waptcore WaptTaskManager 7028] DEBUG DB commit
2022-07-15 09:20:13,222 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 12.192578125000002s before retrying
2022-07-15 09:20:17,637 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:17,725 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "GET /licences.json HTTP/1.1" 200 7952
2022-07-15 09:20:17,726 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:17,727 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:17,727 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:17,729 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:17,730 [waptcore WaptTaskManager 7028] DEBUG Remove unknown repositories from packages table and params ("wapt","wapt-host")
2022-07-15 09:20:17,730 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt to avoid unecessary update
2022-07-15 09:20:17,730 [waptcore WaptTaskManager 7028] DEBUG Checking availability of https://waptserver.domaine.local/wapt/Packages
2022-07-15 09:20:17,731 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:17,821 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt/Packages HTTP/1.1" 200 0
2022-07-15 09:20:17,822 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt has not been updated (last update 2022-07-11T07:09:54), skipping update
2022-07-15 09:20:17,823 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt-host to avoid unecessary update
2022-07-15 09:20:17,826 [waptcore WaptTaskManager 7028] DEBUG Checking availability of wapt-host
2022-07-15 09:20:17,826 [waptcore WaptTaskManager 7028] DEBUG Trying to get  host package for 4C4C4544-0035-4710-804A-B3C04F434233 at https://waptserver.domaine.local/wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt
2022-07-15 09:20:17,826 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:17,895 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt HTTP/1.1" 200 0
2022-07-15 09:20:17,896 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt-host has not been updated (last update 2022-07-08T09:23:28), skipping update
2022-07-15 09:20:17,897 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:17,897 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:17,898 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 4567, in _update_repos_list\n    self.write_param(\'host_capabilities_fingerprint\', new_capa)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 8018, in write_param\n    self.waptdb.set_param(name, value)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:17,898 [wapttasks WaptTaskManager 7028] CRITICAL Error for update in check_scheduled_tasks: attempt to write a readonly database
2022-07-15 09:20:17,898 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:17,898 [waptcore WaptTaskManager 7028] DEBUG DB commit
2022-07-15 09:20:23,435 [wapttasks MainThread 16644] INFO Waptservice stopped
2022-07-15 09:20:25,848 [waptws SocketIOClient 20008] WARNING Exception PermissionError(13, 'Permission denied'), waiting 21.337011718750006s before retrying
2022-07-15 09:20:27,919 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:27,994 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "GET /licences.json HTTP/1.1" 200 7952
2022-07-15 09:20:27,998 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:27,999 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:28,000 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:28,011 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:28,012 [waptcore WaptTaskManager 7028] DEBUG Remove unknown repositories from packages table and params ("wapt","wapt-host")
2022-07-15 09:20:28,013 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt to avoid unecessary update
2022-07-15 09:20:28,014 [waptcore WaptTaskManager 7028] DEBUG Checking availability of https://waptserver.domaine.local/wapt/Packages
2022-07-15 09:20:28,015 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:28,085 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt/Packages HTTP/1.1" 200 0
2022-07-15 09:20:28,086 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt has not been updated (last update 2022-07-11T07:09:54), skipping update
2022-07-15 09:20:28,087 [waptcore WaptTaskManager 7028] DEBUG Check last-modified header for wapt-host to avoid unecessary update
2022-07-15 09:20:28,087 [waptcore WaptTaskManager 7028] DEBUG Checking availability of wapt-host
2022-07-15 09:20:28,087 [waptcore WaptTaskManager 7028] DEBUG Trying to get  host package for 4C4C4544-0035-4710-804A-B3C04F434233 at https://waptserver.domaine.local/wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt
2022-07-15 09:20:28,088 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:28,156 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "HEAD /wapt-host/4C4C4544-0035-4710-804A-B3C04F434233.wapt HTTP/1.1" 200 0
2022-07-15 09:20:28,157 [waptcore WaptTaskManager 7028] INFO Index from https://waptserver.domaine.local/wapt-host has not been updated (last update 2022-07-08T09:23:28), skipping update
2022-07-15 09:20:28,158 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:28,158 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:28,158 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 4567, in _update_repos_list\n    self.write_param(\'host_capabilities_fingerprint\', new_capa)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 8018, in write_param\n    self.waptdb.set_param(name, value)\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']
2022-07-15 09:20:28,159 [wapttasks WaptTaskManager 7028] CRITICAL Error for update in check_scheduled_tasks: attempt to write a readonly database
2022-07-15 09:20:28,159 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:28,159 [waptcore WaptTaskManager 7028] DEBUG DB commit
2022-07-15 09:20:38,177 [urllib3.connectionpool WaptTaskManager 7028] DEBUG Starting new HTTPS connection (1): waptserver.domaine.local:443
2022-07-15 09:20:38,250 [urllib3.connectionpool WaptTaskManager 7028] DEBUG https://waptserver.domaine.local:443 "GET /licences.json HTTP/1.1" 200 7952
2022-07-15 09:20:38,251 [waptcore WaptTaskManager 7028] DEBUG DB Start transaction
2022-07-15 09:20:38,252 [waptcore WaptTaskManager 7028] DEBUG DB rollback
2022-07-15 09:20:38,252 [waptcore WaptTaskManager 7028] DEBUG Error at DB exit attempt to write a readonly database, rollbacking
['  File "c:\\Program Files (x86)\\wapt\\common.py", line 347, in set_param\n    self.execute(\'insert or replace into wapt_params(name,value,create_date,ptype) values (?,?,?,?)\', (name, value, datetime2isodate(), ptype))\n', '  File "c:\\Program Files (x86)\\wapt\\common.py", line 397, in execute\n    return self.db.execute(query, args)\n']

He detectado numerosos errores "CRITICOS" en el registro, que el agente tiene problemas para aplicar la política WUA y que las tareas programadas también parecen funcionar mal. Lo que me preocupa un poco es que estos clientes de prueba se instalaron hace muy poco (hace un máximo de dos semanas). ¿He configurado mal mi agente? Aún necesito actualizarlo antes de implementar WAPT en nuestras aproximadamente cien estaciones de trabajo.

Nuestro antivirus no reporta ningún bloqueo de la utilidad WAPT, así que me pregunto qué podría estar pasando... ¿Tienen alguna idea? Todos los usuarios están ejecutando sin privilegios. Intenté ejecutar el comando de depuración como administrador y funcionó sin problemas.

Gracias de antemano por tus ideas.

alain17 · 18 de julio de 2022 - 15:59

Buen día,

Después de investigar un poco, entendí que el ejecutable runwaptservice.bat siempre debe ejecutarse como administrador y que, por lo tanto, no había nada malo en mi prueba sin privilegios de administrador.

Sin embargo, esto no soluciona el problema: algunas estaciones de trabajo sufren fallos frecuentes en su agente. Al parecer, es posible reiniciar WAPT con el comando:

Código: Seleccionar todo

wapt-get restart-waptservice

¿Hay alguna forma de automatizar esto, por ejemplo, con una tarea programada? No encuentro la documentación de setuphelpers como se menciona aquí y quien me podría ayudar.

18 de julio de 2022 - 18:37

Hola,

el agente no debería fallar de esa manera.

¿Aparece algún mensaje en el Visor de eventos relacionado con este fallo? ¿Ve algo inusual en c:\program files (x86)\wapt\log?

Saludos,

Denis

alain17 · 12 de agosto de 2022 - 08:23

Buen día,

Esta mañana revisé los registros y el registro de eventos de una máquina afectada por estas desconexiones para recuperar lo que pude. En los registros de WAPT, encontré lo siguiente:

Código: Seleccionar todo

Disabling Windows auto update service, using WaptWUA instead
2022-08-12 07:19:32,315 [wapttasks MainThread 7640] INFO Service Configuration: {'config_filename': 'C:\\Program Files (x86)\\wapt\\wapt-get.ini', 'waptservice_user': None, 'waptservice_password': None, 'MAX_HISTORY': 30, 'waptservice_port': 8088, 'dbpath': 'C:\\Program Files (x86)\\wapt\\db\\waptdb.sqlite', 'loglevel': 'warning', 'log_directory': 'C:\\Program Files (x86)\\wapt\\log', 'waptserver': <WaptServer https://waptserver.domaine.local>, 'hiberboot_enabled': 0, 'max_gpo_script_wait': 180, 'pre_shutdown_timeout': 180, 'log_to_windows_events': False, 'allow_user_service_restart': False, 'signature_clockskew': 21600, 'notify_user': False, 'waptservice_admin_filter': False, 'enable_remote_repo': False, 'local_repo_path': 'C:\\Program Files (x86)\\wapt\\repository', 'local_repo_sync_task_period': '2h', 'local_repo_time_for_sync_start': None, 'local_repo_time_for_sync_end': None, 'local_repo_limit_bandwidth': None, 'wol_port': '7,9', 'wol_relay': False, 'service_auth_type': 'system', 'verify_cert_ldap': False, 'download_after_update_with_waptupdate_task_period': True, 'forced_installs_task_period': '2m', 'reconfig_on_network_change': False, 'loglevel_waptcore': None, 'loglevel_waptservice': None, 'loglevel_waptws': None, 'loglevel_waptdb': None, 'loglevel_websocket': None, 'loglevel_waitress': None, 'loglevel_wapttasks': None}
2022-08-12 07:19:32,316 [wapttasks MainThread 7640] INFO Starting task queue
2022-08-12 07:19:32,317 [wapttasks MainThread 7640] INFO Tasks queue running
2022-08-12 07:19:32,317 [wapttasks WaptTaskManager 6372] INFO Wapt tasks management initialized with C:\Program Files (x86)\wapt\wapt-get.ini configuration
2022-08-12 07:19:32,319 [wapttasks MainThread 7640] INFO Starting waitress waptservice on port 8088
2022-08-12 07:19:32,421 [wapttasks SocketIOClient 6556] INFO Starting socketio on "https://waptserver.domaine.local:443" Thread id 6556
2022-08-12 07:19:32,466 [wapttasks WaptTaskManager 6372] INFO Core Configuration: {'wapt_base_dir': 'C:\\Program Files (x86)\\wapt', 'waptserver': <WaptServer https://waptserver.domaine.local>, 'config_filename': 'C:\\Program Files (x86)\\wapt\\wapt-get.ini', 'proxies': {'http': '', 'https': ''}, 'repositories': [<WaptRepo https://waptserver.domaine.local/wapt>, <WaptHostRepo https://waptserver.domaine.local/wapt-host for host_id 4C4C4544-0035-4710-804A-B3C04F434233 >], 'personal_certificate_path': '', 'public_certs_dir': 'C:\\Program Files (x86)\\wapt\\ssl', 'package_cache_dir': 'C:\\Program Files (x86)\\wapt\\cache', 'dbpath': 'C:\\Program Files (x86)\\wapt\\db\\waptdb.sqlite', 'use_http_proxy_for_repo': False, 'use_http_proxy_for_server': False, 'limit_bandwidth': None, 'locales': ['fr'], 'custom_tags': [], 'packages_whitelist': None, 'packages_blacklist': None, 'maturities': ['PROD'], 'host_uuid': '4C4C4544-0035-4710-804A-B3C04F434233', 'use_fqdn_as_uuid': False, 'use_hostpackages': True, 'use_ad_groups': False, 'use_repo_rules': False, 'host_profiles': [], 'host_organizational_unit_dn': 'OU=WAPT Test,OU=Ordinateurs,DC=Domaine,DC=local', 'host_ad_site': None, 'waptaudit_task_period': '2h', 'hiberboot_enabled': '0', 'max_gpo_script_wait': 180.0, 'pre_shutdown_timeout': 180.0, 'uninstallkey_timeout': 120, 'check_certificates_validity': True, 'token_lifetime': 86400}
2022-08-12 07:19:32,466 [wapttasks WaptTaskManager 6372] INFO Wapt tasks queue started
2022-08-12 07:19:32,523 [waptws SocketIOClient 6556] WARNING Exception ConnectionError(MaxRetryError("HTTPSConnectionPool(host='waptserver.domaine.local', port=443): Max retries exceeded with url: /get_websocket_auth_token (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x079AEEF8>: Failed to establish a new connection: [Errno 11001] getaddrinfo failed'))")), waiting 2.6s before retrying
2022-08-12 07:19:35,272 [wapttasks SocketIOClient 6556] INFO Socketio connection params have changed. Socketio needs reconnect
2022-08-12 07:19:35,273 [wapttasks SocketIOClient 6556] INFO Creating socketio client: https://waptserver.domaine.local:443 client auth cert: ('C:\\Program Files (x86)\\wapt\\private\\4C4C4544-0035-4710-804A-B3C04F434233.crt', 'C:\\Program Files (x86)\\wapt\\private\\4C4C4544-0035-4710-804A-B3C04F434233.pem') proxies: None verify_cert: False
2022-08-12 07:19:35,273 [wapttasks SocketIOClient 6556] INFO Connecting Socketio to https://waptserver.domaine.local:443
2022-08-12 07:19:35,342 [wapttasks SocketIOClient 6556] INFO WS read loop for 120s
2022-08-12 07:19:42,847 [wapttasks WaptTaskManager 6372] INFO Add task Mise à jour de la liste des paquets disponibles to queue
2022-08-12 07:19:42,849 [wapttasks WaptTaskManager 6372] INFO Add task Audit de 8 packages (tâche #-1) to queue
2022-08-12 07:19:42,849 [wapttasks WaptTaskManager 6372] INFO Add task Informer le serveur du statut de cette machine to queue
2022-08-12 07:19:42,856 [wapttasks WaptTaskManager 6372] INFO Running task Mise à jour de la liste des paquets disponibles created by SCHEDULER
Get packages index from [<WaptRepo https://waptserver.domaine.local/wapt>, <WaptHostRepo https://waptserver.domaine.local/wapt-host for host_id 4C4C4544-0035-4710-804A-B3C04F434233 >]
2022-08-12 07:19:44,070 [wapttasks WaptTaskManager 6372] INFO update_server_status successful (data size 62647)
2022-08-12 07:19:44,098 [wapttasks WaptTaskManager 6372] INFO Running task Audit de 8 packages (tâche #2) created by SCHEDULER
Auditing pla-waptwua
Auditing pla-vcredist2015-2022
Auditing DC=Domaine=local
OK: No setup.py
Auditing pla-vcredist
Auditing pla-pyscripter4
 OK: Uninstall Key PyScripter_is1 in Windows Registry.
Auditing 4C4C4544-0035-4710-804A-B3C04F434233
OK: No setup.py
Auditing pla-fork
Auditing pla-waptupgrade
The installed version of the WAPT agent and the version of the package are corresponding.
2022-08-12 07:19:44,728 [wapttasks WaptTaskManager 6372] INFO Running task Informer le serveur du statut de cette machine created by SCHEDULER
2022-08-12 07:19:45,466 [wapttasks WaptTaskManager 6372] INFO update_server_status successful (data size 15541)
Done.
2022-08-12 07:20:42,297 [wapttasks waitress-0 5136] INFO Add task Mise à jour de la liste des paquets disponibles to queue
2022-08-12 07:20:42,297 [wapttasks WaptTaskManager 6372] INFO Running task Mise à jour de la liste des paquets disponibles created by None
Get packages index from [<WaptRepo https://waptserver.domaine.local/wapt>, <WaptHostRepo https://waptserver.domaine.local/wapt-host for host_id 4C4C4544-0035-4710-804A-B3C04F434233 >]
2022-08-12 07:21:19,375 [waptws SocketIOClient 6556] WARNING Exception ConnectionError(MaxRetryError("HTTPSConnectionPool(host='waptserver.domaine.local', port=443): Max retries exceeded with url: /get_websocket_auth_token (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x08490D18>: Failed to establish a new connection: [Errno 11001] getaddrinfo failed'))")), waiting 5.0s before retrying
2022-08-12 07:21:24,508 [wapttasks SocketIOClient 6556] INFO Socketio connection params have changed. Socketio needs reconnect
2022-08-12 07:21:24,509 [wapttasks SocketIOClient 6556] INFO Connecting Socketio to https://waptserver.domaine.local:443
2022-08-12 07:21:24,558 [wapttasks SocketIOClient 6556] INFO WS read loop for 120s
2022-08-12 07:23:25,518 [wapttasks SocketIOClient 6556] INFO WS read loop for 120s
2022-08-12 07:25:26,489 [wapttasks SocketIOClient 6556] INFO WS read loop for 120s
2022-08-12 07:27:27,489 [wapttasks SocketIOClient 6556] INFO WS read loop for 120s

Claramente, la conexión HTTPS no funciona correctamente, aunque el servidor es accesible, se puede resolver (nslookup) y la máquina puede hacer ping. El servidor funciona y la computadora está en la misma red cableada (e incluso en el mismo sitio) que otra máquina que funciona y permanece conectada. Para que conste, debo mencionar que:

Este comportamiento se observa tanto en las estaciones de trabajo de usuario como en las estaciones de trabajo con la consola WAPT
Los certificados se implementan correctamente (puedo verlos en la pestaña "Certificados" de cada máquina afectada)
Parece establecerse una breve conexión, ya que veo que las estaciones de trabajo se han conectado al menos una vez ese mismo día
Estoy usando un certificado SSL autofirmado y no he habilitado la verificación del certificado en la configuración del agente
He agregado la configuración del agente a los archivos adjuntos

Respecto a los acontecimientos, he tomado algunas capturas de pantalla adjuntas, pero traduce bastante bien lo que vemos en el log: hay un inicio, un bloqueo a las 07:19 y un reinicio a las 07:21.

alain17 · 12 de agosto de 2022 - 09:28

La configuración del agente no se pudo cargar para editarla en el foro, así que la estoy cargando aquí

12 de agosto de 2022 - 15:17

Código: Seleccionar todo

2022-08-12 07:21:19,375 [waptws SocketIOClient 6556] WARNING Exception ConnectionError(MaxRetryError("HTTPSConnectionPool(host='waptserver.domaine.local', port=443): Max retries exceeded with url: /get_websocket_auth_token (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x08490D18>: Failed to establish a new connection: [Errno 11001] getaddrinfo failed'))")), waiting 5.0s before retrying

Código: Seleccionar todo

getaddrinfo failed

Qué extraño, parece un problema de DNS. ¿Podrías tener dos servidores DNS conectados a las máquinas, y uno de ellos no puede resolver la dirección del servidor WAPT?

De lo contrario, aparentemente podría provenir de una variable http_proxy local establecida en la máquina

https://stackoverflow-com.translate.goo ... r_pto=wapp

alain17 · 15 de agosto de 2022 - 09:32

Buen día

sfonteneau escribió: ↑12 de agosto de 2022 - 15:17
Código: Seleccionar todo
2022-08-12 07:21:19,375 [waptws SocketIOClient 6556] WARNING Exception ConnectionError(MaxRetryError("HTTPSConnectionPool(host='waptserver.domaine.local', port=443): Max retries exceeded with url: /get_websocket_auth_token (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x08490D18>: Failed to establish a new connection: [Errno 11001] getaddrinfo failed'))")), waiting 5.0s before retrying
Código: Seleccionar todo
getaddrinfo failed
Qué extraño, parece un problema de DNS. ¿Podrías tener dos servidores DNS conectados a las máquinas, y uno de ellos no puede resolver la dirección del servidor WAPT?

Eso también me parece extraño. Usamos dos controladores de dominio (réplicas) que también actúan como servidores DNS (sus direcciones IP aparecen correctamente en ipconfig). Ejecuté los siguientes comandos para comprobar la resolución de nombres en ambos servidores y obtengo la misma respuesta (correcta):

Código: Seleccionar todo

nslookup waptserver.domaine.local dc01.domaine.local
nslookup waptserver.domaine.local dc02.domaine.local

sfonteneau escribió: ↑12 de agosto de 2022 - 15:17 De lo contrario, aparentemente podría provenir de una variable http_proxy configurada localmente en la máquina.

Lo comprobé y no tengo esa variable de entorno en mis máquinas, y no usamos un proxy. Curiosamente, esta mañana aparecieron más máquinas conectadas, pero no la mía. Aproveché para hacer una prueba en Python y parece que funciona correctamente.

: wapt_addrinfo.png (11,98 KB) Visto 7529 veces

Dicho esto, tengo una pista interesante: mi ordenador aparece como "desconectado" al cambiar de la red cableada a la red wifi de la empresa. Se ha observado un comportamiento similar con otros portátiles. Repliqué mis pruebas de NSLOOKUP y Python en ambas redes y los resultados son idénticos. Cuando el ordenador vuelve a la red cableada, la conexión se restablece.

Por alguna razón que no logro comprender, WAPT parece tener problemas para cambiar de una red cableada a una inalámbrica. ¿Has observado este comportamiento también?

17 de agosto de 2022 - 10:20

En la configuración de red, a nivel de DNS, ¿no hay ninguna opción de respaldo a 8.8.8.8, por ejemplo?

Ya sea Wi-Fi o cable, no debería haber problema; simplemente estamos restableciendo la conexión.

La línea `/get_websocket_auth_token` contacta al servidor para volver a autenticarse para el WebSocket,

pero ahí es donde aparentemente tenemos un problema de DNS.

alain17 · 19 de agosto de 2022 - 11:33

sfonteneau escribió: ↑17 de agosto de 2022 - 10:20 En la configuración de su red, a nivel de DNS, ¿no hay una opción de respaldo a 8.8.8.8, por ejemplo?

Tengo un servidor DNS externo como respaldo, pero no para las direcciones ".local", que se resuelven internamente. Dicho esto, migré a la versión 2.2.2 esta semana, y la implementación de los nuevos agentes parece haber aportado mayor estabilidad. Esto podría deberse a alguna de las muchas correcciones de esta versión. Estaré atento y abriré un nuevo hilo si es necesario.

Gracias por su seguimiento

19 de agosto de 2022 - 12:11

alain17 escribió: ↑19 de agosto de 2022 - 11:33 Tengo una alternativa en un DNS externo, pero no para direcciones en ".local", que se resuelven internamente.

En general, recurrir a un DNS externo no es una buena idea (y no solo para Wapt)

De hecho, si por alguna razón el servidor DNS que resuelve .local no responde, la solicitud se remitirá al servidor DNS externo si responde. (Y el servidor DNS externo responderá, no lo sé, y Windows lo almacenará en caché)

Este problema ya se ha encontrado en soporte aquí; eliminar el DNS externo resuelve los problemas.