Problème de courriel sortant

sadek · June 15, 2016, 4:27pm

Bonjour,

Nous avons mis en place un serveur de messagerie Bluemind, nous avons bient configuré le nom de domaine externe.
Au niveau du routeur nous avons bien redirigé les ports sur le serveur bluemind.

La reception depuis un serveurs externe ( exemple Gmail) vers notre serveurs fonctionne très bien, mais l’envoi des mails provenant de l’extérieur ne Fonctionne pas.

Pour l’info : On a bien ajouté tous les ports de la solution BlueMind dans notre Routeur.

Merci de nous aider d’avoir une solution.

nico.dumont · June 16, 2016, 9:47am

Bonjour,
Avez vous regardé dans les Log de bluemind et mail ? (/var/log/bm/core.log et /var/log/mail.err)
Est-ce que les mail ne sont pas tout simplement dans les spams ?

sadek · June 16, 2016, 11:11am

Bonjour,
Pour le Spam, on a déjà vérifié et on a rien trouvé.

Fichier mail.err

I 
Jun 13 13:15:48 mailbox cyrus/notify[1441]: recvfrom failed: Interrupted system call
Jun 13 13:15:48 mailbox cyrus/master[11186]: setrlimit: Unable to set file descriptors limit to -1: Operation not permitted
Jun 13 13:15:48 mailbox cyrus/master[11186]: retrying with 65536 (current max)
Jun 15 14:35:20 mailbox postfix[9222]: fatal: usage: postfix -c config_dir] -Dv] command
Jun 15 14:35:32 mailbox postfix[9260]: fatal: usage: postfix -c config_dir] -Dv] command
Jun 15 14:35:41 mailbox postfix/postfix-script[9270]: error: unknown command: ''
Jun 15 14:35:41 mailbox postfix/postfix-script[9271]: fatal: usage: postfix start (or stop, reload, abort, flush, check, status, set-permissions, upgrade-configuration)
Jun 15 14:35:43 mailbox postfix[9272]: fatal: usage: postfix -c config_dir] -Dv] command
Jun 15 14:41:00 mailbox postfix[10610]: fatal: myorigin parameter setting must not contain multiple values: mailbox.inovteam.loc, inovteam.loc
Jun 15 14:41:01 mailbox postfix[10612]: fatal: myorigin parameter setting must not contain multiple values: mailbox.inovteam.loc, inovteam.loc
Jun 15 15:35:01 mailbox postfix/postfix-script[23053]: fatal: cannot execute /usr/sbin/postconf!
Jun 15 15:35:10 mailbox postfix/postfix-script[23084]: fatal: cannot execute /usr/sbin/postconf!
Jun 16 01:00:57 mailbox postfix/postfix-script[17893]: fatal: cannot execute /usr/sbin/postconf!
Jun 16 09:31:45 mailbox postmulti[9172]: fatal: /etc/postfix/main.cf, line 48: missing '=' after attribute name: "relayhost [serveur67.heberjahiz.com]"
Jun 16 09:31:46 mailbox postmulti[9187]: fatal: /etc/postfix/main.cf, line 48: missing '=' after attribute name: "relayhost [serveur67.heberjahiz.com]"

Core-log

2016-06-16 10:08:00,878 [pool-5-thread-4] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:08:00,878 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75120secs ago.
2016-06-16 10:08:00,879 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:08:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29364 (start: Thu Jun 16 10:08:00 GMT 2016)
2016-06-16 10:08:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:08:00,882 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:08:00,883 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:08:00,883 [pool-5-thread-2] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 68700secs ago.
2016-06-16 10:08:00,883 [pool-5-thread-2] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:08:00,884 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071680865
2016-06-16 10:08:00,884 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071680865] progress is now 100%.
2016-06-16 10:08:00,887 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:08:00,888 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:08:00,888 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75120secs ago.
2016-06-16 10:08:00,888 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68640secs ago.
2016-06-16 10:08:00,888 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:08:00,888 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:08:00,895 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071680871] finished and recorded: SUCCESS, duration: 6ms.
2016-06-16 10:08:00,895 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071680829] finished and recorded: SUCCESS, duration: 43ms.
2016-06-16 10:08:06,895 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071680865
2016-06-16 10:08:06,896 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071680865...
2016-06-16 10:08:06,896 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:08:06,897 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:08:06,898 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29365 (start: Thu Jun 16 10:08:00 GMT 2016)
2016-06-16 10:08:06,898 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:08:06,936 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071680865] finished and recorded: SUCCESS, duration: 19ms.
2016-06-16 10:08:42,944 [vert.x-worker-thread-10] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:08:42,945 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:08:42,974 [vert.x-worker-thread-16] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:08:42,975 [vert.x-eventloop-thread-1] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:08:42,978 [vert.x-eventloop-thread-1] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:09:00,828 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:09:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:09:00,834 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:09:00,835 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,837 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:09:00,841 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:09:00,842 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,842 [pool-5-thread-4] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:09:00,847 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:09:00,848 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,848 [pool-5-thread-1] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:09:00,852 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:09:00,853 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,854 [pool-5-thread-3] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:09:00,854 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071740829
2016-06-16 10:09:00,854 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071740829] progress is now 100%.
2016-06-16 10:09:00,854 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071740829
2016-06-16 10:09:00,854 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:09:00,855 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071740829...
2016-06-16 10:09:00,856 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29366 (start: Thu Jun 16 10:09:00 GMT 2016)
2016-06-16 10:09:00,856 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:09:00,858 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:09:00,859 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,859 [pool-5-thread-4] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:09:00,864 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:09:00,865 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:09:00,865 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071740829] finished and recorded: SUCCESS, duration: 25ms.
2016-06-16 10:09:00,869 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:09:00,870 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:09:00,876 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:09:00,876 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466071740870
2016-06-16 10:09:00,876 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071740870] progress is now 100%.
2016-06-16 10:09:00,876 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466071740870
2016-06-16 10:09:00,877 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466071740870...
2016-06-16 10:09:00,878 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:09:00,878 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75180secs ago.
2016-06-16 10:09:00,878 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:09:00,878 [pool-5-thread-4] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 68700secs ago.
2016-06-16 10:09:00,878 [pool-5-thread-4] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:09:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29367 (start: Thu Jun 16 10:09:00 GMT 2016)
2016-06-16 10:09:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:09:00,880 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071740865
2016-06-16 10:09:00,880 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071740865] progress is now 100%.
2016-06-16 10:09:00,883 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:09:00,884 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:09:00,884 [pool-5-thread-3] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 68760secs ago.
2016-06-16 10:09:00,884 [pool-5-thread-3] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:09:00,888 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:09:00,889 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:09:00,889 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68700secs ago.
2016-06-16 10:09:00,889 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:09:00,889 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75180secs ago.
2016-06-16 10:09:00,889 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:09:00,890 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071740870] finished and recorded: SUCCESS, duration: 6ms.
2016-06-16 10:09:06,866 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:09:06,866 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071740865
2016-06-16 10:09:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071740865...
2016-06-16 10:09:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29368 (start: Thu Jun 16 10:09:00 GMT 2016)
2016-06-16 10:09:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:09:06,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071740865] finished and recorded: SUCCESS, duration: 15ms.
2016-06-16 10:09:06,891 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:09:20,345 [vert.x-worker-thread-18] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:09:20,345 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:09:20,372 [vert.x-eventloop-thread-0] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 3ms.
2016-06-16 10:10:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:10:00,830 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:10:00,836 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:10:00,837 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,837 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:10:00,842 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:10:00,843 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,843 [pool-5-thread-4] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:10:00,847 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:10:00,849 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,849 [pool-5-thread-2] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:10:00,850 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071800830
2016-06-16 10:10:00,850 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071800830] progress is now 100%.
2016-06-16 10:10:00,851 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071800830
2016-06-16 10:10:00,852 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:10:00,852 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071800830...
2016-06-16 10:10:00,853 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:10:00,854 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29369 (start: Thu Jun 16 10:10:00 GMT 2016)
2016-06-16 10:10:00,854 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:10:00,855 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,855 [pool-5-thread-3] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:10:00,860 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:10:00,861 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,861 [pool-5-thread-4] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:10:00,865 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:10:00,866 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:10:00,871 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071800830] finished and recorded: SUCCESS, duration: 20ms.
2016-06-16 10:10:00,871 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:10:00,872 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:10:00,877 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:10:00,877 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466071800872
2016-06-16 10:10:00,878 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071800872] progress is now 100%.
2016-06-16 10:10:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466071800872
2016-06-16 10:10:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466071800872...
2016-06-16 10:10:00,878 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:10:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75240secs ago.
2016-06-16 10:10:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:10:00,879 [pool-5-thread-4] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 68760secs ago.
2016-06-16 10:10:00,879 [pool-5-thread-4] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:10:00,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29370 (start: Thu Jun 16 10:10:00 GMT 2016)
2016-06-16 10:10:00,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:10:00,883 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071800866
2016-06-16 10:10:00,883 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071800866] progress is now 100%.
2016-06-16 10:10:00,884 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:10:00,885 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:10:00,885 [pool-5-thread-1] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 68820secs ago.
2016-06-16 10:10:00,885 [pool-5-thread-1] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:10:00,889 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:10:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:10:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75240secs ago.
2016-06-16 10:10:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:10:00,891 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68760secs ago.
2016-06-16 10:10:00,891 [pool-5-thread-4] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:10:00,896 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071800872] finished and recorded: SUCCESS, duration: 6ms.
2016-06-16 10:10:06,871 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:10:06,872 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071800866
2016-06-16 10:10:06,872 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071800866...
2016-06-16 10:10:06,874 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29371 (start: Thu Jun 16 10:10:00 GMT 2016)
2016-06-16 10:10:06,874 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:10:06,885 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071800866] finished and recorded: SUCCESS, duration: 17ms.
2016-06-16 10:10:06,896 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:10:43,012 [vert.x-worker-thread-14] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:10:43,013 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:10:43,039 [vert.x-worker-thread-15] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:10:43,040 [vert.x-eventloop-thread-3] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:10:43,043 [vert.x-eventloop-thread-3] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:10:43,053 [vert.x-worker-thread-11] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ysnp
2016-06-16 10:10:43,054 [vert.x-eventloop-thread-2] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 0ms.
2016-06-16 10:11:00,828 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:11:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:11:00,834 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:11:00,835 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,836 [pool-5-thread-1] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:11:00,841 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:11:00,842 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,842 [pool-5-thread-3] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:11:00,846 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:11:00,848 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,848 [pool-5-thread-4] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:11:00,851 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071860829
2016-06-16 10:11:00,851 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071860829] progress is now 100%.
2016-06-16 10:11:00,851 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071860829
2016-06-16 10:11:00,851 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071860829...
2016-06-16 10:11:00,851 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:11:00,853 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:11:00,853 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29372 (start: Thu Jun 16 10:11:00 GMT 2016)
2016-06-16 10:11:00,853 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:11:00,854 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,854 [pool-5-thread-1] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:11:00,859 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:11:00,860 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,860 [pool-5-thread-3] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:11:00,864 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071860829] finished and recorded: SUCCESS, duration: 22ms.
2016-06-16 10:11:00,865 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:11:00,866 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:11:00,870 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:11:00,871 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:11:00,876 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:11:00,879 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:11:00,879 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466071860871
2016-06-16 10:11:00,879 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071860871] progress is now 100%.
2016-06-16 10:11:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466071860871
2016-06-16 10:11:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 68820secs ago.
2016-06-16 10:11:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:11:00,879 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75300secs ago.
2016-06-16 10:11:00,879 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:11:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466071860871...
2016-06-16 10:11:00,881 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29373 (start: Thu Jun 16 10:11:00 GMT 2016)
2016-06-16 10:11:00,881 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:11:00,884 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:11:00,884 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071860866
2016-06-16 10:11:00,884 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071860866] progress is now 100%.
2016-06-16 10:11:00,885 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:11:00,885 [pool-5-thread-2] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 68880secs ago.
2016-06-16 10:11:00,885 [pool-5-thread-2] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:11:00,889 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:11:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:11:00,890 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68820secs ago.
2016-06-16 10:11:00,890 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:11:00,890 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75300secs ago.
2016-06-16 10:11:00,890 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:11:00,897 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071860871] finished and recorded: SUCCESS, duration: 8ms.
2016-06-16 10:11:06,865 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:11:06,865 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071860866
2016-06-16 10:11:06,865 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071860866...
2016-06-16 10:11:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29374 (start: Thu Jun 16 10:11:00 GMT 2016)
2016-06-16 10:11:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:11:06,879 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071860866] finished and recorded: SUCCESS, duration: 18ms.
2016-06-16 10:11:06,898 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:11:50,393 [vert.x-worker-thread-4] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:11:50,394 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:11:50,420 [vert.x-eventloop-thread-7] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 3ms.
2016-06-16 10:12:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:12:00,831 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:12:00,836 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:12:00,838 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,838 [pool-5-thread-2] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:12:00,844 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:12:00,845 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,845 [pool-5-thread-1] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:12:00,850 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:12:00,851 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,851 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:12:00,854 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071920831
2016-06-16 10:12:00,854 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071920831] progress is now 100%.
2016-06-16 10:12:00,854 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071920831
2016-06-16 10:12:00,855 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071920831...
2016-06-16 10:12:00,855 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:12:00,856 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:12:00,856 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,857 [pool-5-thread-2] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:12:00,857 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29375 (start: Thu Jun 16 10:12:00 GMT 2016)
2016-06-16 10:12:00,857 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:12:00,861 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:12:00,862 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,862 [pool-5-thread-1] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:12:00,867 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:12:00,868 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:12:00,872 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:12:00,873 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:12:00,874 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071920831] finished and recorded: SUCCESS, duration: 23ms.
2016-06-16 10:12:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466071920873
2016-06-16 10:12:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071920873] progress is now 100%.
2016-06-16 10:12:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466071920873
2016-06-16 10:12:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466071920873...
2016-06-16 10:12:00,879 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:12:00,880 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:12:00,880 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75360secs ago.
2016-06-16 10:12:00,880 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:12:00,880 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 68880secs ago.
2016-06-16 10:12:00,880 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:12:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29376 (start: Thu Jun 16 10:12:00 GMT 2016)
2016-06-16 10:12:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:12:00,884 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:12:00,885 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:12:00,885 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 68940secs ago.
2016-06-16 10:12:00,885 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:12:00,888 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071920868
2016-06-16 10:12:00,888 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071920868] progress is now 100%.
2016-06-16 10:12:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:12:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:12:00,891 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75360secs ago.
2016-06-16 10:12:00,891 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68880secs ago.
2016-06-16 10:12:00,891 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:12:00,891 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:12:00,900 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071920873] finished and recorded: SUCCESS, duration: 5ms.
2016-06-16 10:12:06,875 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:12:06,875 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071920868
2016-06-16 10:12:06,876 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071920868...
2016-06-16 10:12:06,878 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29377 (start: Thu Jun 16 10:12:00 GMT 2016)
2016-06-16 10:12:06,878 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:12:06,889 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071920868] finished and recorded: SUCCESS, duration: 20ms.
2016-06-16 10:12:06,900 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:12:42,893 [vert.x-worker-thread-1] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:12:42,894 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:12:42,925 [vert.x-worker-thread-2] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:12:42,926 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:12:42,930 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:13:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:13:00,830 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:13:00,835 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:13:00,836 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,837 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:13:00,841 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:13:00,842 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,842 [pool-5-thread-1] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:13:00,846 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:13:00,847 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,848 [pool-5-thread-2] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:13:00,852 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:13:00,853 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071980830
2016-06-16 10:13:00,853 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071980830] progress is now 100%.
2016-06-16 10:13:00,853 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071980830
2016-06-16 10:13:00,853 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,854 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071980830...
2016-06-16 10:13:00,854 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:13:00,854 [pool-5-thread-3] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:13:00,855 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29378 (start: Thu Jun 16 10:13:00 GMT 2016)
2016-06-16 10:13:00,855 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:13:00,858 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:13:00,859 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,860 [pool-5-thread-1] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:13:00,864 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:13:00,865 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:13:00,866 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466071980830] finished and recorded: SUCCESS, duration: 23ms.
2016-06-16 10:13:00,870 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:13:00,871 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:13:00,875 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466071980871
2016-06-16 10:13:00,875 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071980871] progress is now 100%.
2016-06-16 10:13:00,875 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466071980871
2016-06-16 10:13:00,876 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466071980871...
2016-06-16 10:13:00,877 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:13:00,877 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29379 (start: Thu Jun 16 10:13:00 GMT 2016)
2016-06-16 10:13:00,877 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:13:00,878 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466071980865
2016-06-16 10:13:00,878 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071980865] progress is now 100%.
2016-06-16 10:13:00,878 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:13:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75420secs ago.
2016-06-16 10:13:00,879 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:13:00,880 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 68940secs ago.
2016-06-16 10:13:00,880 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:13:00,884 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:13:00,885 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:13:00,885 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 69000secs ago.
2016-06-16 10:13:00,885 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:13:00,889 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:13:00,890 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466071980871] finished and recorded: SUCCESS, duration: 4ms.
2016-06-16 10:13:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:13:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 68940secs ago.
2016-06-16 10:13:00,891 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75420secs ago.
2016-06-16 10:13:00,891 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:13:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:13:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:13:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466071980865
2016-06-16 10:13:06,867 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466071980865...
2016-06-16 10:13:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29380 (start: Thu Jun 16 10:13:00 GMT 2016)
2016-06-16 10:13:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:13:06,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466071980865] finished and recorded: SUCCESS, duration: 13ms.
2016-06-16 10:13:06,891 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:13:07,493 [vert.x-worker-thread-15] net.bluemind.core.UserManagement INFO - Accepting token as password for admin0@global.virt in bm-xmpp
2016-06-16 10:13:07,494 [vert.x-eventloop-thread-1] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:13:37,289 [vert.x-worker-thread-8] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:13:37,289 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:13:37,319 [vert.x-worker-thread-11] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:37,320 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:37,324 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:13:37,411 [vert.x-eventloop-thread-0] net.bluemind.core.server.vertx.XmlBufferHandler INFO - identity/get in 21ms.
2016-06-16 10:13:37,415 [vert.x-worker-thread-10] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:37,416 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:37,419 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:13:37,699 [vert.x-eventloop-thread-3] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 4ms.
2016-06-16 10:13:39,258 [vert.x-worker-thread-17] net.bluemind.core.contact.ContactHome INFO - [ykasdi@inovteam.com] ElasticSearch: '(k*)'
2016-06-16 10:13:39,264 [vert.x-worker-thread-17] net.bluemind.core.contact.ContactHome INFO - ElasticSearch time spent for 3 results: 6ms.
2016-06-16 10:13:39,272 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - book/searchContact in 24ms.
2016-06-16 10:13:39,277 [vert.x-worker-thread-5] net.bluemind.core.distributionlist.DistributionListBindingImpl INFO - [ykasdi@inovteam.com] DistributionList : find()
2016-06-16 10:13:39,288 [vert.x-eventloop-thread-1] net.bluemind.core.server.vertx.XmlBufferHandler INFO - distributionlist/find in 11ms.
2016-06-16 10:13:47,070 [vert.x-eventloop-thread-0] net.bluemind.core.server.vertx.XmlBufferHandler INFO - identity/get in 19ms.
2016-06-16 10:13:47,182 [vert.x-eventloop-thread-3] net.bluemind.core.server.vertx.XmlBufferHandler INFO - book/getFolderFromId in 3ms.
2016-06-16 10:13:47,196 [vert.x-worker-thread-1] net.bluemind.core.contact.ContactHome INFO - [ykasdi@inovteam.com] ElasticSearch: '-is:archive  (email:kasdi.yassir@gmail.com)'
2016-06-16 10:13:47,204 [vert.x-worker-thread-1] net.bluemind.core.contact.ContactHome INFO - ElasticSearch time spent for 1 results: 7ms.
2016-06-16 10:13:47,211 [vert.x-eventloop-thread-2] net.bluemind.core.server.vertx.XmlBufferHandler INFO - book/advancedSearchContact in 25ms.
2016-06-16 10:13:47,216 [vert.x-worker-thread-0] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:47,217 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:47,220 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:13:48,074 [vert.x-worker-thread-13] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:48,075 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:48,079 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:13:48,396 [vert.x-eventloop-thread-7] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 4ms.
2016-06-16 10:13:48,576 [vert.x-worker-thread-15] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:48,577 [vert.x-worker-thread-8] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:13:48,577 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:48,578 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:13:48,582 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 2ms.
2016-06-16 10:13:48,583 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:14:00,829 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:14:00,831 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:14:00,836 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:14:00,837 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,837 [pool-5-thread-4] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:14:00,842 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:14:00,844 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,844 [pool-5-thread-2] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:14:00,849 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:14:00,850 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,850 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:14:00,855 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:14:00,856 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,856 [pool-5-thread-4] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:14:00,860 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:14:00,861 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,861 [pool-5-thread-2] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:14:00,866 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:14:00,867 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:14:00,873 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:14:00,874 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:14:00,874 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072040831
2016-06-16 10:14:00,874 [pool-5-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072040831] progress is now 100%.
2016-06-16 10:14:00,874 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072040831
2016-06-16 10:14:00,875 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072040831...
2016-06-16 10:14:00,875 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:14:00,876 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29381 (start: Thu Jun 16 10:14:00 GMT 2016)
2016-06-16 10:14:00,876 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:14:00,879 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466072040874
2016-06-16 10:14:00,879 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072040874] progress is now 100%.
2016-06-16 10:14:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466072040874
2016-06-16 10:14:00,881 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:14:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466072040874...
2016-06-16 10:14:00,882 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:14:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75480secs ago.
2016-06-16 10:14:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:14:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 69000secs ago.
2016-06-16 10:14:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:14:00,883 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29382 (start: Thu Jun 16 10:14:00 GMT 2016)
2016-06-16 10:14:00,883 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:14:00,886 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466072040867
2016-06-16 10:14:00,886 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072040867] progress is now 100%.
2016-06-16 10:14:00,888 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:14:00,889 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:14:00,889 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 69060secs ago.
2016-06-16 10:14:00,889 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:14:00,893 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:14:00,894 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:14:00,895 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 69000secs ago.
2016-06-16 10:14:00,895 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:14:00,895 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75480secs ago.
2016-06-16 10:14:00,895 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:14:00,898 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072040874] finished and recorded: SUCCESS, duration: 5ms.
2016-06-16 10:14:00,898 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072040831] finished and recorded: SUCCESS, duration: 43ms.
2016-06-16 10:14:06,898 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466072040867
2016-06-16 10:14:06,899 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466072040867...
2016-06-16 10:14:06,899 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:14:06,899 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:14:06,900 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29383 (start: Thu Jun 16 10:14:00 GMT 2016)
2016-06-16 10:14:06,900 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:14:06,914 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072040867] finished and recorded: SUCCESS, duration: 19ms.
2016-06-16 10:14:20,344 [vert.x-worker-thread-7] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:14:20,345 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:14:20,372 [vert.x-eventloop-thread-1] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 4ms.
2016-06-16 10:15:00,831 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:15:00,832 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:15:00,837 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:15:00,838 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,839 [pool-5-thread-4] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:15:00,843 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:15:00,844 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,844 [pool-5-thread-1] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:15:00,849 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:15:00,850 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,850 [pool-5-thread-2] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:15:00,854 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:15:00,855 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,856 [pool-5-thread-4] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:15:00,856 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072100832
2016-06-16 10:15:00,856 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072100832] progress is now 100%.
2016-06-16 10:15:00,856 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072100832
2016-06-16 10:15:00,857 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072100832...
2016-06-16 10:15:00,857 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:15:00,858 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29384 (start: Thu Jun 16 10:15:00 GMT 2016)
2016-06-16 10:15:00,858 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:15:00,861 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:15:00,862 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,862 [pool-5-thread-1] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:15:00,867 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:15:00,868 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072100832] finished and recorded: SUCCESS, duration: 24ms.
2016-06-16 10:15:00,868 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:15:00,873 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:15:00,874 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:15:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466072100874
2016-06-16 10:15:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072100874] progress is now 100%.
2016-06-16 10:15:00,878 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466072100874
2016-06-16 10:15:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466072100874...
2016-06-16 10:15:00,879 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:15:00,880 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:15:00,880 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29385 (start: Thu Jun 16 10:15:00 GMT 2016)
2016-06-16 10:15:00,880 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:15:00,880 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75540secs ago.
2016-06-16 10:15:00,880 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:15:00,880 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 69060secs ago.
2016-06-16 10:15:00,881 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:15:00,881 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466072100868
2016-06-16 10:15:00,881 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072100868] progress is now 100%.
2016-06-16 10:15:00,885 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:15:00,886 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:15:00,886 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 69120secs ago.
2016-06-16 10:15:00,886 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:15:00,890 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:15:00,891 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:15:00,891 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 69060secs ago.
2016-06-16 10:15:00,891 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:15:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75540secs ago.
2016-06-16 10:15:00,891 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:15:00,893 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072100874] finished and recorded: SUCCESS, duration: 4ms.
2016-06-16 10:15:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:15:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466072100868
2016-06-16 10:15:06,869 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466072100868...
2016-06-16 10:15:06,871 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29386 (start: Thu Jun 16 10:15:00 GMT 2016)
2016-06-16 10:15:06,871 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:15:06,882 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072100868] finished and recorded: SUCCESS, duration: 13ms.
2016-06-16 10:15:06,894 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:15:48,472 [vert.x-worker-thread-0] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:15:48,473 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:15:48,499 [vert.x-worker-thread-12] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in ips
2016-06-16 10:15:48,500 [vert.x-eventloop-thread-0] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/doLogin in 1ms.
2016-06-16 10:15:48,503 [vert.x-eventloop-thread-0] net.bluemind.core.server.vertx.XmlBufferHandler INFO - setting/getSettings in 1ms.
2016-06-16 10:16:00,831 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:16:00,833 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:16:00,838 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:16:00,839 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,840 [pool-5-thread-4] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:16:00,845 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:16:00,846 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,846 [pool-5-thread-1] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:16:00,851 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:16:00,852 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,852 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:16:00,857 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:16:00,858 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,858 [pool-5-thread-4] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:16:00,863 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:16:00,864 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,864 [pool-5-thread-1] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:16:00,868 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:16:00,869 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:16:00,873 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:16:00,875 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:16:00,877 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072160833
2016-06-16 10:16:00,877 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072160833] progress is now 100%.
2016-06-16 10:16:00,877 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072160833
2016-06-16 10:16:00,877 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072160833...
2016-06-16 10:16:00,879 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466072160875
2016-06-16 10:16:00,879 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072160875] progress is now 100%.
2016-06-16 10:16:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29387 (start: Thu Jun 16 10:16:00 GMT 2016)
2016-06-16 10:16:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:16:00,880 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:16:00,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:16:00,880 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466072160875
2016-06-16 10:16:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466072160875...
2016-06-16 10:16:00,881 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:16:00,882 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75600secs ago.
2016-06-16 10:16:00,882 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:16:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 69120secs ago.
2016-06-16 10:16:00,882 [pool-5-thread-2] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:16:00,882 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29388 (start: Thu Jun 16 10:16:00 GMT 2016)
2016-06-16 10:16:00,882 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:16:00,886 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:16:00,887 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:16:00,887 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 69180secs ago.
2016-06-16 10:16:00,887 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:16:00,890 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466072160869
2016-06-16 10:16:00,890 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072160869] progress is now 100%.
2016-06-16 10:16:00,892 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:16:00,892 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:16:00,893 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75600secs ago.
2016-06-16 10:16:00,893 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:16:00,893 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 69120secs ago.
2016-06-16 10:16:00,893 [pool-5-thread-2] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:16:00,902 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072160875] finished and recorded: SUCCESS, duration: 4ms.
2016-06-16 10:16:00,902 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072160833] finished and recorded: SUCCESS, duration: 44ms.
2016-06-16 10:16:06,902 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466072160869
2016-06-16 10:16:06,903 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466072160869...
2016-06-16 10:16:06,903 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:16:06,903 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:16:06,904 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29389 (start: Thu Jun 16 10:16:00 GMT 2016)
2016-06-16 10:16:06,904 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:16:06,918 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072160869] finished and recorded: SUCCESS, duration: 21ms.
2016-06-16 10:16:50,338 [vert.x-worker-thread-11] net.bluemind.core.UserManagement INFO - Accepting token as password for ykasdi@inovteam.com in bm-hps-ping
2016-06-16 10:16:50,339 [vert.x-eventloop-thread-6] net.bluemind.core.server.vertx.XmlBufferHandler INFO - login/validate in 1ms.
2016-06-16 10:16:50,366 [vert.x-eventloop-thread-3] net.bluemind.core.server.vertx.XmlBufferHandler INFO - calendar/getPendingEventCount in 4ms.
2016-06-16 10:17:00,831 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:17:00,832 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:17:00,837 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolIndexJob
2016-06-16 10:17:00,838 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,839 [pool-5-thread-3] net.bluemind.job.mailindex.MailspoolIndexJob INFO - Not planned.
2016-06-16 10:17:00,843 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.contactindex.ContactIndexJob
2016-06-16 10:17:00,844 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,845 [pool-5-thread-1] net.bluemind.job.contactindex.ContactIndexJob INFO - Not planned.
2016-06-16 10:17:00,849 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.MailspoolResyncIndexJob
2016-06-16 10:17:00,850 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,850 [pool-5-thread-2] net.bluemind.job.mailindex.MailspoolResyncIndexJob INFO - Not planned.
2016-06-16 10:17:00,855 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.calendarindex.CalendarIndexJob
2016-06-16 10:17:00,856 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,856 [pool-5-thread-3] net.bluemind.job.calendarindex.CalendarIndexJob INFO - Not planned.
2016-06-16 10:17:00,861 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.job.mailindex.ArchiveSpoolIndexJob
2016-06-16 10:17:00,862 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,862 [pool-5-thread-1] net.bluemind.job.mailindex.ArchiveSpoolIndexJob INFO - Not planned.
2016-06-16 10:17:00,866 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId Vacation
2016-06-16 10:17:00,867 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:17:00,871 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId EventAlert
2016-06-16 10:17:00,873 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:17:00,878 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing EventAlert-global.virt-1466072220873
2016-06-16 10:17:00,878 [pool-5-thread-3] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072220873] progress is now 100%.
2016-06-16 10:17:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of EventAlert-global.virt-1466072220873
2016-06-16 10:17:00,878 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.archive.core.ArchiveJob
2016-06-16 10:17:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072220832
2016-06-16 10:17:00,878 [pool-5-thread-4] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072220832] progress is now 100%.
2016-06-16 10:17:00,878 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for EventAlert-global.virt-1466072220873...
2016-06-16 10:17:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for EventAlert
2016-06-16 10:17:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072220832
2016-06-16 10:17:00,879 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072220832...
2016-06-16 10:17:00,880 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 2 jobs from database.
2016-06-16 10:17:00,881 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob@global.virt updated with last_run set to id 29390 (start: Thu Jun 16 10:17:00 GMT 2016)
2016-06-16 10:17:00,881 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 7 entries...
2016-06-16 10:17:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - run plan for EventAlert@global.virt updated with last_run set to id 29391 (start: Thu Jun 16 10:17:00 GMT 2016)
2016-06-16 10:17:00,881 [pool-4-thread-1] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:17:00,882 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 75660secs ago.
2016-06-16 10:17:00,882 [pool-5-thread-1] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:17:00,882 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - not forced, last run was 69180secs ago.
2016-06-16 10:17:00,882 [pool-5-thread-3] net.bluemind.archive.core.ArchiveJob INFO - less than one day ago, skipping execution.
2016-06-16 10:17:00,886 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.dataprotect.core.DataProtectJob
2016-06-16 10:17:00,887 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 1 jobs from database.
2016-06-16 10:17:00,887 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - not planned, last run was 69240secs ago.
2016-06-16 10:17:00,887 [pool-5-thread-4] net.bluemind.dataprotect.core.DataProtectJob INFO - less than one day ago, skipping execution.
2016-06-16 10:17:00,889 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - Finishing Vacation-global.virt-1466072220867
2016-06-16 10:17:00,889 [pool-5-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072220867] progress is now 100%.
2016-06-16 10:17:00,892 [Timer-3] net.bluemind.core.jobs.impl.JobBindingImpl INFO - getJobFromId net.bluemind.core.jobs.quota.QuotaGatheringJob
2016-06-16 10:17:00,893 [Timer-3] net.bluemind.core.jobs.impl.JobHome INFO - Loaded 0 jobs from database.
2016-06-16 10:17:00,893 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 69180secs ago.
2016-06-16 10:17:00,893 [pool-5-thread-3] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:17:00,893 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - not forced, last run was 75660secs ago.
2016-06-16 10:17:00,893 [pool-5-thread-1] net.bluemind.core.jobs.quota.QuotaGatheringJob INFO - less than one day ago, skipping execution.
2016-06-16 10:17:00,903 [pool-4-thread-1] net.bluemind.core.jobs.impl.Scheduler INFO - [EventAlert-global.virt-1466072220873] finished and recorded: SUCCESS, duration: 5ms.
2016-06-16 10:17:00,903 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob-global.virt-1466072220832] finished and recorded: SUCCESS, duration: 46ms.
2016-06-16 10:17:06,903 [pool-4-thread-2] net.bluemind.core.jobs.impl.ExecutionRecorder INFO - recording execution of Vacation-global.virt-1466072220867
2016-06-16 10:17:06,903 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - recording execution for Vacation-global.virt-1466072220867...
2016-06-16 10:17:06,903 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for net.bluemind.core.jobs.cleanup.JobExecutionsCleanJob
2016-06-16 10:17:06,904 [pool-4-thread-1] net.bluemind.core.jobs.impl.SendReport INFO - No report sent for Vacation
2016-06-16 10:17:06,905 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - run plan for Vacation@global.virt updated with last_run set to id 29392 (start: Thu Jun 16 10:17:00 GMT 2016)
2016-06-16 10:17:06,905 [pool-4-thread-2] net.bluemind.core.jobs.impl.JobHome INFO - saving 3 entries...
2016-06-16 10:17:06,917 [pool-4-thread-2] net.bluemind.core.jobs.impl.Scheduler INFO - [Vacation-global.virt-1466072220867] finished and recorded: SUCCESS, duration: 22ms.

nico.dumont · June 16, 2016, 11:26am

L’installation a été effectuer sur une config vierge ?
Avez vous modifié /etc/postfix/main.cf manuellement ?
il y a visiblement une erreur dans ce fichier pourriez vous poster sont contenu ?

sadek · June 16, 2016, 11:46am

Oui, on a installé la solution sur une config vierges.
Effectivement, notre responsable réseau a essayé de régler ce souci et il a toucher ce fichier manuellement.

Le contenu de fichier Main.cf

smtpd_banner = $myhostname ESMTP $mail_name (BlueMind)
biff = no

append_dot_mydomain = no

# Uncomment the next line to generate "delayed mail" warnings
#delay_warning_time = 4h

myhostname = mailbox.inovteam.loc


# Liste des bases d'alias consultées par l'agent de livraison 'local'
alias_maps = hash:/etc/aliases
# Listes des base d'alias mise à jour par 'newaliases'
alias_database = hash:/etc/aliases
local_recipient_maps = $alias_maps

mydestination = localhost, $myhostname
mynetworks = 127.0.0.0/8, 192.168.1.0/24
message_size_limit = 10485760
mailbox_size_limit = 10485760

virtual_transport = error:mailbox does not exist
virtual_mailbox_domains = hash:/etc/postfix/virtual_domains
virtual_mailbox_maps = hash:/etc/postfix/virtual_mailbox
virtual_alias_maps = hash:/etc/postfix/virtual_alias
transport_maps = hash:/etc/postfix/transport, hash:/etc/postfix/master_relay_transport

recipient_delimiter = +

# SMTP/TLS
smtp_tls_security_level = may
smtp_tls_mandatory_protocols = !SSLv2,!SSLv3

smtpd_tls_security_level=may
smtpd_tls_cert_file=/etc/ssl/certs/bm_cert.pem
smtpd_tls_key_file=/etc/ssl/certs/bm_cert.pem
smtpd_tls_CAfile=/var/lib/bm-ca/cacert.pem
smtpd_tls_mandatory_protocols=!SSLv2,!SSLv3

# SMTP authentication
smtpd_sasl_auth_enable=yes
broken_sasl_auth_clients=yes
smtpd_sasl_security_options=noanonymous
smtpd_recipient_restrictions=permit_sasl_authenticated,permit_mynetworks,reject_unauth_destination
smtpd_sasl_authenticated_header=yes

relayhost =[serveur67.heberjahiz.com]
inet_protocols = ipv4

nico.dumont · June 16, 2016, 12:06pm

Il a déjà corriger des chose depuis ce matin je vois.

pouvez vous regarder dans /var/log/mail.info

Je vois que vous utilisé un serveur relay pour l’envoi des mail, avez vous accès au log de ce serveur ?

sadek · June 16, 2016, 1:57pm

le fichier : /var/log/mail.info introuvable.

On a l’accès de serveur relay via Cpanel et on a pas trouvé le fichier .log

Je veux juste savoir si on peut changer le port d’envoi des email, je pense que la solution BlueMind utilise le port 25 n’est ce pas ?

pour l’information, ci-dessous le contenu de fichier mail.log :

Jun 16 12:17:24 mailbox postfix/smtp[17808]: connect to serveur67.heberjahiz.com[159.253.148.204]:25: Connection timed out
Jun 16 12:17:24 mailbox postfix/smtp[17808]: 56D62CA16B7: to=kasdi.yassir@gmail.com, relay=none, delay=30, delays=0.09/0.01/30/0, dsn=4.4.1, status=deferred (connect to serveur67.heberjahiz.com[159.253.148.204]:25: Connection timed out)

nico.dumont · June 17, 2016, 7:43am

Effectivement votre serveur relay ne répond pas.
Donc soit il y a un problème avec celui-ci soit le port 25 et bloqué.
Pour utiliser un autre port il suffit de modifier le paramètre relayhost dans le fichier main.cf

relayhost = [serveur67.heberjahiz.com]:PORT

sadek · June 17, 2016, 10:44am

Merci bien pour votre réponse.
Mais on a déjà essayé avec cette solution mais sans aucun résultat.

sadek · June 17, 2016, 11:30am

Y a des solution pour detecter la source de problème ?

nico.dumont · June 17, 2016, 12:03pm

Je viens de tester votre serveur relay il répond bien.
Il faudrait vérifier si vous y avez bien accès depuis votre serveur
D’abord tester le ping

ping serveur67.heberjahiz.com

puis si ok tester de ce connecter en telenet

telnet serveur67.heberjahiz.com PORT

Si sa ne marche pas, vous n’avez pas accès au serveur relay → voir firewall

sadek · June 17, 2016, 12:25pm

ping serveur67.heberjahiz.com

PING serveur67.heberjahiz.com (159.253.148.204): 56 data bytes
64 bytes from 159.253.148.204: icmp_seq=0 ttl=47 time=179.089 ms
64 bytes from 159.253.148.204: icmp_seq=1 ttl=47 time=100.474 ms
64 bytes from 159.253.148.204: icmp_seq=2 ttl=47 time=105.903 ms

telnet serveur67.heberjahiz.com 465

Trying 159.253.148.204...
Connected to serveur67.heberjahiz.com.

nico.dumont · June 17, 2016, 1:49pm

Vous êtes sur de votre port 465 ? c’est pas courant.
essayer peut-être sur le port 587.

sadek · June 17, 2016, 2:09pm

Avec l’utilisation de port 587 on a reçu un mail d’erreur lors d’envoi d’un email.

Undelivered Mail Returned to Sender

nico.dumont · June 17, 2016, 3:13pm

Quelle est le contenu complet du message reçu ?
Pouvez vous regarder a nouveaux dans les log /var/log/mail.info

sadek · June 17, 2016, 3:17pm

Le contenu d’email reçu :

This is the mail system at host mailbox.inovteam.loc.

I’m sorry to have to inform you that your message could not
be delivered to one or more recipients. It’s attached below.

For further assistance, please send mail to postmaster.

If you do so, please include this problem report. You can
delete your own text from the attached returned message.
               The mail system
sadek.contact@gmail.com: host serveur62.heberjahiz.com[159.253.148.194] said:
550 SMTP AUTH is required for message submission on port 587 (in reply to
RCPT TO command)
Reporting-MTA: dns; mailbox.inovteam.loc
X-Postfix-Queue-ID: 30114CA1777
X-Postfix-Sender: rfc822; hassan@inovteam.com
Arrival-Date: Fri, 17 Jun 2016 14:36:51 +0000 (WET)

Final-Recipient: rfc822; sadek.contact@gmail.com
Original-Recipient: rfc822;sadek.contact@gmail.com
Action: failed
Status: 5.0.0
Remote-MTA: dns; serveur62.heberjahiz.com
Diagnostic-Code: smtp; 550 SMTP AUTH is required for message submission on port
587

J’ai pas trouvé le fichier : /var/log/mail.info

nico.dumont · June 17, 2016, 3:26pm

vous devez vous authentifier sur votre serveur relay
avez vous un user/password
il explique bien la procédure pour configurer le user password dans postfix ici : http://mhawthorne.net/posts/postfix-configuring-gmail-as-relay.html

sadek · June 18, 2016, 10:48am

OK, merci,
Je vais essayer cette solution et je reviens vers vous.

Toony · June 20, 2016, 7:12am

Généralement l’envoi sur le relais se fait par le port 25. Les port 465 et 587 sont des ports utilisés pour l’envoi de mail par les clients, ils nécessitent:
[list=*]
]SSL pour le 465, TLS pour le 587/]
]de s’authentifier/]
[/list]

D’autre part, la directive relayhost doit être gérée depuis la console d’administration.

sadek · June 20, 2016, 1:20pm

[quote=nico.dumont]vous devez vous authentifier sur votre serveur relay
avez vous un user/password
il explique bien la procédure pour configurer le user password dans postfix ici : http://mhawthorne.net/posts/postfix-configuring-gmail-as-relay.html[/quote]

On a suivi ce tuto mais sans aucun resultat.