Page 1 sur 2

[RESOLU] L'agent WAPT se déconnecte

Publié : 15 juil. 2022 - 10:25
par alain17
Bonjour,

Je fais actuellement tourner un serveur WAPT Enterprise en version 2.2 tournant sous Ubuntu 20.04 LTS et je rencontre un problème avec mes clients sous Windows. En effet, certains fonctionnent parfaitement bien (restent connectés) et d'autres se déconnectent très rapidement du serveur (apparaissent déconnectés alors qu'on peut les pinguer). J'ai suivi le sujet sur l'antivirus et celui de cet utilisateur qui a des problèmes de déconnexion également.

J'ai exécuté la commande suivante sur un poste client qui se déconnecte, en tant qu'utilisateur non privilégié:

Code : Tout sélectionner

"c:\Program Files (x86)\wapt\runwaptservice.bat" -ldebug
Le résultat qui en est sorti est le suivant:

Code : Tout sélectionner

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']
Je constate qu'il y a de nombreuses erreurs "CRITICAL" dans le log, que l'agent éprouve des difficultés à appliquer la politique WUA et que les tâches planifiées semblent également ne pas être en bonne forme. Ce qui m'inquiète un peu, c'est que l'installation de ces clients de test date d'il y a vraiment peu (2 semaines max). Ai-je mal paramétré mon agent ? Je dois encore faire une mise à jour de celui-ci avant de déployer WAPT sur notre centaine de postes.

À priori, notre antivirus ne remonte pas de blocage d'utilitaire WAPT, je me demande donc ce qu'il peut bien arriver... auriez-vous une idée ? Tous les utilisateurs fonctionnent sans privilèges. J'ai tenté l'exécution de la commande de débug en admin, et ça passe sans problème.

D'avance merci pour vos idées.

Re: L'agent WAPT se déconnecte

Publié : 18 juil. 2022 - 15:59
par alain17
Bonjour,

En effectuant quelques recherches, j'ai compris que l'exécutable runwaptservice.bat devait toujours être lancé en administrateur, et que du coup rien ne clochait dans mon test sans privilèges administrateur.

Cela ne règle néanmoins pas le problème: certains postes ont leur agent qui plante régulièrement. Visiblement, il est possible de relancer WAPT via la commande:

Code : Tout sélectionner

wapt-get restart-waptservice
Y a-t-il un moyen d'automatiser cela, par exemple avec une tâche planifiée ? Je ne trouve pas la documentation de setuphelpers telle que mentionnée ici et qui pourrait m'aider.

Re: L'agent WAPT se déconnecte

Publié : 18 juil. 2022 - 18:37
par dcardon
Bonjour,

l'agent ne devrait pas planter comme cela.

Est ce que vous avez des messages dans l'observateur d'évènement par rapport à ce plantage? Est ce que vous avez des choses particulières dans c:\program files (x86)\wapt\log ?

Cordialement,

Denis

Re: L'agent WAPT se déconnecte

Publié : 12 août 2022 - 08:23
par alain17
Bonjour,

J'ai relevé les logs et le journal d'événements ce matin sur un poste affecté par ces déconnexions pour récupérer ce qui pouvait l'être. Dans les logs de WAPT, je trouve ceci:

Code : Tout sélectionner

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
À l'évidence, la connexion HTTPS ne semble pas se passer comme il faut, alors que le serveur est bien joignable, peut être résolu (nslookup) et pingué par la machine. Le serveur est bien fonctionnel et l'ordinateur présent sur le même réseau câblé (et même site) qu'un autre poste qui fonctionne et reste connecté. À toute fin utile, je précise que:
  • Ce comportement est observé aussi bien sur des postes utilisateurs que des postes avec la WAPT Console
  • Les certificats sont correctement déployés (je les vois dans l'onglet "Certificats" de chaque machine impactée
  • Une brève connexion semble se faire, car je vois que les postes se sont connectés au moins une fois le jour même
  • J'utilise un certificat SSL auto-signé, et je n'ai pas activé la vérification du certificat dans la configuration de l'agent
  • J'ai ajouté la configuration de l'agent dans les pièces jointes
Concernant les événements, j'ai pris quelques captures d'écran ci-jointes, mais ça traduit assez bien ce qu'on voit dans le log: il y a un démarrage, un crash à 07:19 et un redémarrage à 07:21.

Re: L'agent WAPT se déconnecte

Publié : 12 août 2022 - 09:28
par alain17
La configuration de l'agent n'a pas voulu s'uploader en édition sur le forum, donc je l'upload ici ;)

Re: L'agent WAPT se déconnecte

Publié : 12 août 2022 - 15:17
par sfonteneau

Code : Tout sélectionner

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

Code : Tout sélectionner

getaddrinfo failed
Étrange on dirait pourtant un problème dns , vous n'auriez pas deux dns pousser sur les machines dont un qui n'est pas capable de résoudre l’adresse du serveur wapt ?

sinon visiblement ça pourrai venir d'une variable http_proxy set localement sur le poste ?

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

Re: L'agent WAPT se déconnecte

Publié : 15 août 2022 - 09:32
par alain17
Bonjour
sfonteneau a écrit : 12 août 2022 - 15:17

Code : Tout sélectionner

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

Code : Tout sélectionner

getaddrinfo failed
Étrange on dirait pourtant un problème dns , vous n'auriez pas deux dns pousser sur les machines dont un qui n'est pas capable de résoudre l’adresse du serveur wapt ?
C'est également ce qui me semble étrange. Nous utilisons deux contrôleurs de domaine (réplicats) qui agissent également comme DNS (leur IP est bien listé dans un ipconfig). J'ai effectué les commandes suivantes pour vérifier la résolution du nom sur les deux serveurs et j'obtiens la même réponse (qui est correcte):

Code : Tout sélectionner

nslookup waptserver.domaine.local dc01.domaine.local
nslookup waptserver.domaine.local dc02.domaine.local
sfonteneau a écrit : 12 août 2022 - 15:17 sinon visiblement ça pourrai venir d'une variable http_proxy set localement sur le poste ?
J'ai vérifié, je n'ai pas de telle variable d'environnement sur mes postes, et nous n'utilisons pas de proxy. Étrangement ce matin davantage de postes apparaissent connecté, mais pas le mien. J'ai pu en profiter pour effectuer un test en Python et ça a l'air de fonctionner correctement.
wapt_addrinfo.png
wapt_addrinfo.png (11.98 Kio) Consulté 1551 fois
Cela dit, j'ai une piste intéressante: mon poste passe en "disconnected" lorsque je passe du réseau câblé au réseau WiFi de l'entreprise. Un comportement similaire a pu être reproduit avec d'autres ordinateurs portables. J'ai répliqué mes tests NSLOOKUP et Python sur les deux réseaux et les résultats sont identiques. Lorsque le poste revient sur réseau câblé, la connexion est rétablie.

Pour une raison que je ne parviens pas à comprendre, cela semble poser un problème à WAPT de passer d'un réseau filaire à du sans fil. Est-ce que vous avez pu observer ce comportement également ?

Re: L'agent WAPT se déconnecte

Publié : 17 août 2022 - 10:20
par sfonteneau
Dans vos conf réseau au niveau dns pas de fallback sur 8.8.8.8 par exemple ?

wifi ou cable normalement ça devrait pas poser problème on réenclanche juste une connexion,

la ligne donc : /get_websocket_auth_token contacte le serveur pour se réauthentifier pour la websocket

mais c'est là qu'on a un problème de dns visiblement

Re: L'agent WAPT se déconnecte

Publié : 19 août 2022 - 11:33
par alain17
sfonteneau a écrit : 17 août 2022 - 10:20 Dans vos conf réseau au niveau dns pas de fallback sur 8.8.8.8 par exemple ?
J'ai bien un fallback sur un DNS externe, mais par pour les adresses en ".local", qui sont résolues en interne. Cela dit, j'ai fait cette semaine la migration vers la version 2.2.2 et le déploiement des nouveaux agents semble apporter davantage de stabilité. C'est peut-être grâce à un des nombreux fix de cette version. Je vais garder l'oeil ouvert et j'ouvrirai un nouveau sujet le cas échéant.

Merci pour votre suivi

Re: L'agent WAPT se déconnecte

Publié : 19 août 2022 - 12:11
par sfonteneau
alain17 a écrit : 19 août 2022 - 11:33 J'ai bien un fallback sur un DNS externe, mais par pour les adresses en ".local", qui sont résolues en interne.
Globalement un fallback sur un dns externe n'est pas une bonne idée (et pas que pour wapt)

En effet si pour une raison x ou y le dns qui résoud le.local ne répond pas la requests va basculer sur le DNS externe si il répond. et le dns externe va répondre je ne connais pas et windows va faire du cache)

Problème déjà rencontrer au support ici, supprimer le dns externe résous les problèmes.