Scénario #35468
Mis à jour par Joël Cuissinat il y a 10 mois
*EOLE* : _Pour étude, j'ai l'impression que cette demande englobe plusieurs problèmes, certains liés à "l'import AAF via Zéphir":http://eole.ac-dijon.fr/documentations/2.8/completes/HTML/ModuleScribe/co/41-synchro-AAF.html et d'autres pas forcément...
La première erreur ressemble à celle déjà signalée dans #34909
Les erreurs "commandes introuvables" pourraient être liées à des PATH manquants dans l'environnement d'exécution._ #34909_
Bonjour,
Tous les jours certains de nos serveurs Scribe se retrouvent bloqués au niveau de la synchronisation avec notre serveur zephir.
Pour les débloquer, j'efface le fichier /tmp/siteID.tar, redémarre le service z_stats et execute del_lock.
Il semblerait qu'un timeout est levée lors de la requete http pour la synchro zephir (cf extrait du fichier actions.log).
Est il possible d'augmenter le niveau de log/augmenter la valeur du timeout pour ces requetes ?
Voici les extraits des différents fichiers de log:
journalctl -u z_stats:
<pre>
juin 22 01:16:19 serveur01 sudo[471405]: uucp : TTY=unknown ; PWD=/var/spool/uucp/.Xqtdir ; USER=root ; COMMAND=/usr/share/zephir/scripts/import_aaf.zephir maj
juin 22 01:16:19 serveur01 sudo[471405]: pam_unix(sudo:session): session opened for user root by (uid=0)
juin 22 01:16:49 serveur01 sudo[471405]: pam_unix(sudo:session): session closed for user root
juin 22 01:17:04 serveur01 exim[471477]: 2023-06-22 01:17:04 1qC74S-001yeT-RT <= uucp@DOMAINE U=uucp P=local S=524
juin 22 01:17:04 serveur01 exim[471480]: 2023-06-22 01:17:04 1qC74S-001yeW-Tx <= uucp@DOMAINE U=uucp P=local S=635
juin 22 01:17:05 serveur01 exim[471483]: 2023-06-22 01:17:05 1qC74S-001yeW-Tx ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471479]: 2023-06-22 01:17:05 1qC74S-001yeT-RT ** zephir!root@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471501]: 2023-06-22 01:17:05 1qC74T-001yer-3l <= <> R=1qC74S-001yeT-RT U=Debian-exim P=local S=1835
juin 22 01:17:05 serveur01 exim[471502]: 2023-06-22 01:17:05 1qC74T-001yes-3m <= <> R=1qC74S-001yeW-Tx U=Debian-exim P=local S=1930
juin 22 01:17:05 serveur01 exim[471479]: 2023-06-22 01:17:05 1qC74S-001yeT-RT Completed
juin 22 01:17:05 serveur01 exim[471483]: 2023-06-22 01:17:05 1qC74S-001yeW-Tx Completed
juin 22 01:17:05 serveur01 exim[471519]: 2023-06-22 01:17:05 1qC74T-001yes-3m ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471519]: 2023-06-22 01:17:05 1qC74T-001yes-3m Frozen (delivery error message)
juin 22 01:17:05 serveur01 exim[471518]: 2023-06-22 01:17:05 1qC74T-001yer-3l ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471518]: 2023-06-22 01:17:05 1qC74T-001yer-3l Frozen (delivery error message)
juin 22 01:46:12 serveur01 zephiragents[2962]: 2023-06-22T01:46:12+0200 [-] /!\ archiving failed ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.utils._UnexpectedErrorOut>
juin 22 01:46:12 serveur01 zephiragents[2962]: ])
juin 22 01:46:12 serveur01 zephiragents[2962]: data: stats/
juin 22 01:46:12 serveur01 zephiragents[2962]: archive: /tmp/site16.tar
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] /!\ archiving failed ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.utils._UnexpectedErrorOutput'>: got stderr: b'tar >
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] ])
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] data: stats/
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] archive: /tmp/site16.tar
</pre>
Extrait de /var/log/uucp/Log:
<pre>
uucico zephir - (2023-06-22 01:16:12.28 471394) Calling system zephir (port SSH)
uucico zephir - (2023-06-22 01:16:12.77 471394) Login successful
uucico zephir - (2023-06-22 01:16:14.78 471394) Handshake successful (protocol 't')
uucico zephir root (2023-06-22 01:16:14.80 471394) Receiving /var/spool/uucppublic/import_0650017R.tar.gz (31250 bytes)
uucico zephir root (2023-06-22 01:16:14.82 471394) Receiving X.zephirO005R (67 bytes)
uucico zephir - (2023-06-22 01:16:14.83 471394) Call complete (2 seconds 31317 bytes 15658 bps)
uuxqt zephir root (2023-06-22 01:16:18.84 471396) Executing X.zephirO005R (zephir_client import_aaf maj)
uuxqt zephir root (2023-06-22 01:17:04.80 471396) ERROR: Execution: Exit status 1
uuxqt zephir root (2023-06-22 01:17:04.80 471396) Execution failed (X.zephirO005R)
</pre>
Fichier /var/log/zephir/actions.log
<pre>
Synchronisation des comptes utilisateurs AD...
error in actualise_cache: /usr/bin/actualise_cache - - /usr/bin/actualise_cache: ligne 5: service : commande introuvable
return code: 127
fichier importation_20230621_011700.txt copié dans :
/home/a/admin/perso/importation/importation_20230621_011700.txt
suppression du lock eoleimport
fichier import_<MYRNE>.tar.gz validé, copie pour import dans /var/lib/eole/aaf
Thu Jun 22 01:16:19 2023 : zephir_client import_aaf(maj)
--------------------------------------------------------
Traceback (most recent call last):
File "/usr/share/zephir/scripts/import_aaf.zephir", line 81, in <module>
update_fileliste()
File "/usr/share/zephir/scripts/import_aaf.zephir", line 51, in update_fileliste
code, liste_fic = convert(zephir_proxy.aaf.get_list(config.id_serveur))
File "/usr/lib/python3.8/xmlrpc/client.py", line 1109, in __call__
return self.__send(self.__name, args)
File "/usr/lib/python3/dist-packages/zephir/eolerpclib.py", line 95, in __request
response = self.__transport.request(
File "/usr/lib/python3.8/xmlrpc/client.py", line 1153, in request
return self.single_request(host, handler, request_body, verbose)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1165, in single_request
http_conn = self.send_request(host, handler, request_body, verbose)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1278, in send_request
self.send_content(connection, request_body)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1308, in send_content
connection.endheaders(request_body)
File "/usr/lib/python3.8/http/client.py", line 1251, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib/python3.8/http/client.py", line 1011, in _send_output
self.send(msg)
File "/usr/lib/python3.8/http/client.py", line 951, in send
self.connect()
File "/usr/lib/python3.8/http/client.py", line 1418, in connect
super().connect()
File "/usr/lib/python3.8/http/client.py", line 922, in connect
self.sock = self._create_connection(
File "/usr/lib/python3.8/socket.py", line 808, in create_connection
raise err
File "/usr/lib/python3.8/socket.py", line 796, in create_connection
sock.connect(sa)
socket.timeout: timed out
</pre>
La première erreur ressemble à celle déjà signalée dans #34909
Les erreurs "commandes introuvables" pourraient être liées à des PATH manquants dans l'environnement d'exécution._ #34909_
Bonjour,
Tous les jours certains de nos serveurs Scribe se retrouvent bloqués au niveau de la synchronisation avec notre serveur zephir.
Pour les débloquer, j'efface le fichier /tmp/siteID.tar, redémarre le service z_stats et execute del_lock.
Il semblerait qu'un timeout est levée lors de la requete http pour la synchro zephir (cf extrait du fichier actions.log).
Est il possible d'augmenter le niveau de log/augmenter la valeur du timeout pour ces requetes ?
Voici les extraits des différents fichiers de log:
journalctl -u z_stats:
<pre>
juin 22 01:16:19 serveur01 sudo[471405]: uucp : TTY=unknown ; PWD=/var/spool/uucp/.Xqtdir ; USER=root ; COMMAND=/usr/share/zephir/scripts/import_aaf.zephir maj
juin 22 01:16:19 serveur01 sudo[471405]: pam_unix(sudo:session): session opened for user root by (uid=0)
juin 22 01:16:49 serveur01 sudo[471405]: pam_unix(sudo:session): session closed for user root
juin 22 01:17:04 serveur01 exim[471477]: 2023-06-22 01:17:04 1qC74S-001yeT-RT <= uucp@DOMAINE U=uucp P=local S=524
juin 22 01:17:04 serveur01 exim[471480]: 2023-06-22 01:17:04 1qC74S-001yeW-Tx <= uucp@DOMAINE U=uucp P=local S=635
juin 22 01:17:05 serveur01 exim[471483]: 2023-06-22 01:17:05 1qC74S-001yeW-Tx ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471479]: 2023-06-22 01:17:05 1qC74S-001yeT-RT ** zephir!root@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471501]: 2023-06-22 01:17:05 1qC74T-001yer-3l <= <> R=1qC74S-001yeT-RT U=Debian-exim P=local S=1835
juin 22 01:17:05 serveur01 exim[471502]: 2023-06-22 01:17:05 1qC74T-001yes-3m <= <> R=1qC74S-001yeW-Tx U=Debian-exim P=local S=1930
juin 22 01:17:05 serveur01 exim[471479]: 2023-06-22 01:17:05 1qC74S-001yeT-RT Completed
juin 22 01:17:05 serveur01 exim[471483]: 2023-06-22 01:17:05 1qC74S-001yeW-Tx Completed
juin 22 01:17:05 serveur01 exim[471519]: 2023-06-22 01:17:05 1qC74T-001yes-3m ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471519]: 2023-06-22 01:17:05 1qC74T-001yes-3m Frozen (delivery error message)
juin 22 01:17:05 serveur01 exim[471518]: 2023-06-22 01:17:05 1qC74T-001yer-3l ** uucp@DOMAINE: Unrouteable address
juin 22 01:17:05 serveur01 exim[471518]: 2023-06-22 01:17:05 1qC74T-001yer-3l Frozen (delivery error message)
juin 22 01:46:12 serveur01 zephiragents[2962]: 2023-06-22T01:46:12+0200 [-] /!\ archiving failed ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.utils._UnexpectedErrorOut>
juin 22 01:46:12 serveur01 zephiragents[2962]: ])
juin 22 01:46:12 serveur01 zephiragents[2962]: data: stats/
juin 22 01:46:12 serveur01 zephiragents[2962]: archive: /tmp/site16.tar
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] /!\ archiving failed ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.utils._UnexpectedErrorOutput'>: got stderr: b'tar >
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] ])
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] data: stats/
juin 22 01:46:12 serveur01 zephiragents[2962]: [-] archive: /tmp/site16.tar
</pre>
Extrait de /var/log/uucp/Log:
<pre>
uucico zephir - (2023-06-22 01:16:12.28 471394) Calling system zephir (port SSH)
uucico zephir - (2023-06-22 01:16:12.77 471394) Login successful
uucico zephir - (2023-06-22 01:16:14.78 471394) Handshake successful (protocol 't')
uucico zephir root (2023-06-22 01:16:14.80 471394) Receiving /var/spool/uucppublic/import_0650017R.tar.gz (31250 bytes)
uucico zephir root (2023-06-22 01:16:14.82 471394) Receiving X.zephirO005R (67 bytes)
uucico zephir - (2023-06-22 01:16:14.83 471394) Call complete (2 seconds 31317 bytes 15658 bps)
uuxqt zephir root (2023-06-22 01:16:18.84 471396) Executing X.zephirO005R (zephir_client import_aaf maj)
uuxqt zephir root (2023-06-22 01:17:04.80 471396) ERROR: Execution: Exit status 1
uuxqt zephir root (2023-06-22 01:17:04.80 471396) Execution failed (X.zephirO005R)
</pre>
Fichier /var/log/zephir/actions.log
<pre>
Synchronisation des comptes utilisateurs AD...
error in actualise_cache: /usr/bin/actualise_cache - - /usr/bin/actualise_cache: ligne 5: service : commande introuvable
return code: 127
fichier importation_20230621_011700.txt copié dans :
/home/a/admin/perso/importation/importation_20230621_011700.txt
suppression du lock eoleimport
fichier import_<MYRNE>.tar.gz validé, copie pour import dans /var/lib/eole/aaf
Thu Jun 22 01:16:19 2023 : zephir_client import_aaf(maj)
--------------------------------------------------------
Traceback (most recent call last):
File "/usr/share/zephir/scripts/import_aaf.zephir", line 81, in <module>
update_fileliste()
File "/usr/share/zephir/scripts/import_aaf.zephir", line 51, in update_fileliste
code, liste_fic = convert(zephir_proxy.aaf.get_list(config.id_serveur))
File "/usr/lib/python3.8/xmlrpc/client.py", line 1109, in __call__
return self.__send(self.__name, args)
File "/usr/lib/python3/dist-packages/zephir/eolerpclib.py", line 95, in __request
response = self.__transport.request(
File "/usr/lib/python3.8/xmlrpc/client.py", line 1153, in request
return self.single_request(host, handler, request_body, verbose)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1165, in single_request
http_conn = self.send_request(host, handler, request_body, verbose)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1278, in send_request
self.send_content(connection, request_body)
File "/usr/lib/python3.8/xmlrpc/client.py", line 1308, in send_content
connection.endheaders(request_body)
File "/usr/lib/python3.8/http/client.py", line 1251, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib/python3.8/http/client.py", line 1011, in _send_output
self.send(msg)
File "/usr/lib/python3.8/http/client.py", line 951, in send
self.connect()
File "/usr/lib/python3.8/http/client.py", line 1418, in connect
super().connect()
File "/usr/lib/python3.8/http/client.py", line 922, in connect
self.sock = self._create_connection(
File "/usr/lib/python3.8/socket.py", line 808, in create_connection
raise err
File "/usr/lib/python3.8/socket.py", line 796, in create_connection
sock.connect(sa)
socket.timeout: timed out
</pre>