Re: [sympa-fr] Première demande de mot de passe plante

[David Verdin <adresse@cachée>]

Bonjour,

C'est plutôt le fichier xxx.stderr qui m'intéressait. Le fichier "sympa_dump" est créé par l'interface web de Sympa quand un paramètre fourni par l'utilisateur n'a pas le bon format.
Dans ton cas, c'est effectivement assez clair : la valeur de l'adresse email à abonner avait été positionnée dans le paramètre "previous_action". Je ne comprends pas pourquoi puisque sur ma propre version de Sympa 6.1.14, ça marche normalement.
Tu pourrais refaire une demande de mot de passe en ayant augmenté le niveau de logs de l'interface web, nous envoyer les logs et, par ailleurs, vérifier si le fichier dumpa_sympa.xx est créé systématiquement au moment de la demande.

Il est normal que tu n'aies par reçu de message pour ton mot de passe tant que tu n'as pas lancé le processus bulk. Les notifications de crash sont lancées sans passer par le bulk (d'où la mention "not using bulk") mais ce sont des exceptions.
si tu vas dans ta base de données, tu pourras voir des enregistrements dans les tables bulkmailer_table et bulkspool_table qui correspondent aux messages à envoyer. dès que tu auras lancé le bulk, ces messages seront expédiés.

Cordialement,

David Verdin

Le 02/10/12 23:51, Daniel B a écrit :

Bonjour David,

 

Merci pour tes conseils.

 

Dans /home/sympa/spool/tmp j'ai le fichier sympa_dump.xx qui contient ceci:

 

_action_
        'firstpasswd'
_email_
        ''
_previous_action_
        'adresse@cachée'
_previous_list_

 

Après l'avoir supprimé, j'ai pu lancer "sympa.pl -d" et cette fois-ci le daemon tient le coup dans le temps.

J'ai donc lancé la commande d'envoi de premier mot de passe. Les choses semblent s'être bien déroulées, mais je n'ai toujours pas reçu le premier e-mail contenant le mot de passe (la confirmation a été donnée sur la page web pourtant).

Voici la sortie de "sympa.pl -d" lorsque j'ai demandé le mot de passe:

 

[root@joshua bin]# ./sympa.pl -d
info Configuration file read, log level set using options : 2
debug2 List::db_connect() List::db_connect
debug2 SQLSource::connect() Connected to Database sympa
debug Conf::_load_auth() Conf::_load_auth(/home/sympa/default/auth.conf)
debug2 tools::cookie_changed() cookie is stable
debug Running server 4384 for sympa purpose
notice tools::write_pid() Previous process 4227 died suddenly ; notifying listmaster
debug2 List::send_notify_to_listmaster() List::send_notify_to_listmaster(crash,mydomain.com )
debug2 List::send_global_file() List::send_global_file(listmaster_notification, adresse@cachée)
debug2 List::get_user_db() List::get_user_db()
debug2 mail::mail_file() mail::mail_file(/home/sympa/default/mail_tt2/listmaster_notification.tt2, adresse@cachée, )
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang()
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang(en_US)
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang(en_US)
debug mail::sending() NOT USING BULK
notice Sympa 6.1.14 started
debug2 Language::SetLang() Language::SetLang(en)
debug2 List::init_list_cache() List::init_list_cache()
debug2 mail::reaper() Reaper unwaited pids : 4386
Open = 1

 

debug2 Language::SetLang() Language::SetLang(en)
debug2 List::init_list_cache() List::init_list_cache()
debug2 mail::reaper() Reaper unwaited pids :

 

Cette fois-ci le daemon ne plante plus après l'envoi du mot de passe, mais je n'ai toujours pas l'e-mail avec le mot de passe.

On peut voir une ligne qui dit "crash" ci-dessus, cela ne me semble pas normal.

 

Par contre je reçois toujours l'email suivant à la place lors de cette manip:

 

Previous process has died unexpectedly.
Date of crash:
Errors:

 

Puis, dans le log de sympa:

 

Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Scenario::request_action() rule true(),md5,do_it accepted
Oct  2 23:42:31 joshua wwsympa[4502]: info [robot mydomain.com] [session 54060338679064] [client adsl-11234.test.com] main::do_requestpasswd() do_requestpasswd(adresse@cachée)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 [robot mydomain.com] [session 54060338679064] [client adsl-
11234.test.com] main::is_ldap_user() is_ldap_user (adresse@cachée)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::get_filename() tools::get_filename(etc,,auth.conf,ed
enpics.com,)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::get_filename() get_filename : name: auth.conf ; dir
/auth.conf
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::get_filename() get_filename : name: auth.conf ; dir
/home/sympa/etc/mydomain.com/auth.conf
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::get_filename() get_filename : name: auth.conf ; dir
/home/sympa/etc/auth.conf
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::get_filename() get_filename : name: auth.conf ; dir
/home/sympa/default/auth.conf
Oct  2 23:42:31 joshua wwsympa[4502]: debug [robot mydomain.com] [session 54060338679064] [client adsl-1
1234.test.com] main::do_requestpasswd() do_requestpasswd: sending one tile ticket for adresse@cachée

Oct  2 23:42:31 joshua wwsympa[4502]: debug SympaSession::get_random() SympaSession::random
Oct  2 23:42:31 joshua wwsympa[4502]: info Auth::create_one_time_ticket() Auth::create_one_time_ticket(d
adresse@cachée,mydomain.com,choosepasswd,adsl-11234.test.com) value = 61373554363074
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 List::db_get_handler() List::db_get_handler
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 List::get_user_db() List::get_user_db(adresse@cachée)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 List::send_global_file() List::send_global_file(sendpasswd,
 adresse@cachée, mydomain.com)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::make_tt2_include_path() tools::make_tt2_include_path
(mydomain.com,mail_tt2,en_US,)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 tools::find_file() tools::find_file(sendpasswd.tt2,/home/sy
mpa/etc/mail_tt2/en_US:/home/sympa/etc/mail_tt2:/home/sympa/default/mail_tt2/en_US:/home/sympa/default/m
ail_tt2)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 mail::mail_file() mail::mail_file(/home/sympa/default/mail_
tt2/sendpasswd.tt2, adresse@cachée, )
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PushLang() Language::PushLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PopLang()
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en_US)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PushLang() Language::PushLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(%1 / your environment
)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(Someone, probably you
, requested to allocate or renew your password for your list server account %1. (This request came from
host %2).)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(You may ignore this r
equest or click on the following link in order to choose your password. )
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(Help on Sympa: %1%2)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PopLang()
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en_US)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PushLang() Language::PushLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Language::PopLang()
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(en_US)
Oct  2 23:42:31 joshua wwsympa[4502]: debug Bulk::store() Bulk::store(<msg>,<rcpts>,from = adresse@cachée,robot = mydomain.com,listname= ,priority_message = 1, delivery_date= 1349214151,verp = 0, merge = 0, dkim: d=  i=, last: )
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 List::db_get_handler() List::db_get_handler
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 [robot mydomain.com] [session 54060338679064] [client adsl-11234.test.com] main::check_param_out() check_param_out
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(%d %b %Y at %H:%M:%S)
Oct  2 23:42:31 joshua wwsympa[4502]: debug SympaSession::store()
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 List::db_get_handler() List::db_get_handler
Oct  2 23:42:31 joshua wwsympa[4502]: debug SympaSession::set_cookie() Session::set_cookie(localhost,session,secure= 1)
Oct  2 23:42:31 joshua wwsympa[4502]: debug2 Language::SetLang() Language::SetLang(ca_ES)
Oct  2 23:42:31 joshua wwsympa[4502]: debug3 Language::gettext() Language::gettext(_language_)

 

et à la fin du fichier:
Oct  2 23:42:34 joshua sympa[4492]: debug2 Language::SetLang() Language::SetLang(en)
Oct  2 23:42:34 joshua sympa[4492]: debug2 List::init_list_cache() List::init_list_cache()
Oct  2 23:42:34 joshua sympa[4492]: debug2 mail::reaper() Reaper unwaited pids : #012Open = 0

 

 

As-tu une idée?

 

Cordialement,

Daniel

 

 

----- Original Message -----

From: David Verdin

To: adresse@cachée

Sent: Tuesday, October 02, 2012 10:02 AM

Subject: Re: [sympa-fr] Première demande de mot de passe plante

Bonjour,

Là, le processus ne plante pas. Le problème c'est que l'on ne voit pas non plus passer ta demande de mot de passe. Soit tu ne l'as pas envoyée, soit les spools ne sont pas correctement configurés : Sympa ne chercherait pas à parcourir le bon répertoire. Mais là, il n'y a pas de raison qu'il plante.

La deuxième ligne de tes logs, c'est l'envoi de la notification du dernier plantage de Sympa.

Un autre moyen de débugger, c'est de lancer sympa.pl sans l'option "-d" et de repérer le pid du processus. Ensuite, une fois qu'il a planté, tu vas chercher dans le spool tmp (par défaut ça doit être le répertoire /var/spool/sympa/tmp) le fichier qui s'appelle "<pid>.stderr" où "<pid>" est le pid du processus Sympa qui vient de planter.

Ce fichier contient l'erreur standard émise par le processus. En général, un plantage a de bonne chances d'être dû à quelque chose de suffisamment inattendu pour déclencher une impression dans l'erreur standard.

Donc tu peux nous envoyer le contenu de ce fichier (sachant qu'en général, seule la dernière ligne est utile) et on pourra sans doute t'aider.

Cordialement,

David

Le 18/09/12 18:04, Daniel B a écrit :

Bonjour David,

 

J'ai lancé la commande comme tu l'as demandé.

Le résultat est le suivant:

 

debug2 List::get_user_db() List::get_user_db(adresse@cachée)
debug2 mail::mail_file() mail::mail_file(/home/sympa/default/mail_tt2/listmaster_notification.tt2, adresse@cachée, )
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang()
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang(en_US)
debug Language::PushLang() Language::PushLang(en)
debug2 Language::SetLang() Language::SetLang(en)
debug Language::PopLang()
debug2 Language::SetLang() Language::SetLang(en_US)
debug mail::sending() NOT USING BULK
notice Sympa 6.1.14 started
debug2 Language::SetLang() Language::SetLang(en)
debug2 List::init_list_cache() List::init_list_cache()
debug2 mail::reaper() Reaper unwaited pids : 12705
Open = 1

 

debug2 Language::SetLang() Language::SetLang(en)
debug2 List::init_list_cache() List::init_list_cache()
debug2 mail::reaper() Reaper unwaited pids :
Open = 0

 

debug2 Language::SetLang() Language::SetLang(en)
...

 

Le dernier paragraphe est répété indéfiniment.

Lorsque je lance "sympa.pl" sans l'option "-d", j'arrive à voir le processus apparaître dans ps pendant environ 2 secondes, puis il disparaît.

 

Pour Marc-Alexandre, concernant les logs j'ai mis la ligne suivante dans rsyslog.conf de mon serveur:

 

# Sympa mailing list logs
local1.*                                                /var/log/sympa

 

Je ne sais pas si c'est juste.

 

Cordialement,

Daniel

 

 

 

----- Original Message -----

From: David Verdin

To: adresse@cachée

Sent: Tuesday, September 18, 2012 9:36 AM

Subject: Re: [sympa-fr] Première demande de mot de passe plante

Bonjour,

Les logs indiquent que les démons démarrent mais ils doivent planter après.
Pour débugger, tu peux lancer "sympa.pl -d". On saura exactement pourquoi il plante.

Cordialement,

David

Le 17/09/12 20:18, Daniel B a écrit :

Bonjour David,

 

Merci pour ces indications.

 

Malheureusement je n'arrive pas à fair ces tests car maintenant c'est encore pire (je n'ai rien changé depuis):

Lorsque je lance le service sympa, il indique que tout est lancé correctement.

Dans les logs (/var/log/messages) j'ai ceci:

 

Sep 17 20:17:01 joshua sympa[2865]: info Configuration file read, default log level 4
Sep 17 20:17:01 joshua sympa[2865]: info Server started for all, pid 2867
Sep 17 20:17:02 joshua bulk[2871]: info Configuration file read, default log level 4
Sep 17 20:17:02 joshua bulk[2871]: info Starting bulk master daemon, pid 2873

Il n'y a pas d'erreur, mais si je fais "service sympa status" il me répond ceci:

 

Status of Sympa subsystem:
Status file for subsystem found.
sympa.pl is stopped
bulk.pl is stopped
archived.pl is stopped
bounced.pl is stopped
task_manager.pl is stopped

Donc le serveur ne s'est pas vraiment lancé.

Avec ps aux, le résultat est le même, pas de processus sympa qui tourne.

 

Une idée de ce qui se passe?

 

Cordialement,
Daniel

 

 

 

----- Original Message -----

From: David Verdin

To: adresse@cachée

Sent: Tuesday, September 04, 2012 9:17 AM

Subject: Re: [sympa-fr] Première demande de mot de passe plante

Normalement, quand le processus wwsympa.fcgi plante, tu dois voir une erreur 500 dans le navigateur. Si ce n'est pas le cas, c'est que ce n'est pas lui qui plante, mais sans doute le bulk.pl, chargé d'expédier le message.
Pour avoir un peu plus d'infos sur la raison du plantage, tu pourrais augmenter le niveau de logs :
  - passe log_level dans wwsympa.conf à la valeur 2
  - lance bulk.pl en mode debug (c'est à dire avec l'option "-d")

Ensuite, retente un envoi de mot de passe initial et fais-nous suivre les logs qui sont produits.

Cordialement,

David

Le 31/08/12 19:24, Daniel B a écrit :

Bonjour,

 

Je suis en train d'installer sympa 6.1.14 sur mon serveur CentOS 6 et après l'installation qui semble être en ordre (service tourne correctement, pas d'erreur dans les log files lorsque je lance le service, etc..), je n'arrive pas à recevoir le premier mot de passe pour le listmaster depuis l'interface web (first login).

Lorsque je le demande, la page web me dit que le mot de passe a été correctement envoyé mais en réalité je reçois un autre message de la part de mailer-request à la place qui est le suivant:

 

Previous process crashed

 

Previous process has died unexpectedly.
Date of crash:
Errors:

 

Check log file for further details.

 

Effectivement, le service sympa a planté et je dois le relancer à la main.

Ceci se produit à chaque fois que j'essaie d'obtenir ce premier mot de passe pour le listmaster.

Je n'ai pas d'autre log qui explique mieux ce qui se passe et /var/log/maillog n'affiche aucune autre indication autre que de dire que l'e-mail pour le listmaster a été correctement envoyé (probablement le message de l'erreur).

 

Que puis-je faire?

 

Merci d'avance pour une quelconque aide car je suis franchement bloqué là et il me semble que je suis tout près du but...

 

Salutations cordiales,

Daniel

 

 

Attachment: smime.p7s
Description: Signature cryptographique S/MIME