2013-01-04 14:24:10,215 n.b.c.j.i.JobBindingImpl INFO - start BackupFullJob
2013-01-04 14:24:10,215 n.b.c.j.JobRegistry INFO - User admin0 triggered run of job BackupFullJob
2013-01-04 14:24:10,223 n.b.c.j.i.JobBindingImpl INFO - getJobFromId BackupFullJob
2013-01-04 14:24:10,224 n.b.c.j.i.JobHome INFO - Loaded 1 jobs from database.
2013-01-04 14:24:10,225 n.b.c.s.SyncServlet INFO - handler responded to backupfull/backup in 10ms.
2013-01-04 14:24:10,229 n.b.n.c.SchExecTask INFO - Run cmd mkdir -p /var/backups/bluemind
2013-01-04 14:24:10,280 n.b.n.c.SchExecTask INFO - Run cmd mkdir -p /var/backups/bluemind/backupFull
2013-01-04 14:24:10,331 n.b.s.b.f.t.BackupFullStore INFO - Backup datas stored on: mail (91.121.216.32), into: /var/backups/bluemind/backupFull
2013-01-04 14:24:10,331 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 5%.
2013-01-04 14:24:10,378 n.b.s.b.f.b.DoBackupFull INFO - Getting BM core configuration files from host: mail
2013-01-04 14:24:10,378 n.b.n.c.SChNodeClient INFO - Opening stream on /etc/bm/bm.ini…
2013-01-04 14:24:10,380 n.b.n.c.ScpReader INFO - Streaming bm.ini size: 136…
2013-01-04 14:24:10,381 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@3fdd6860
2013-01-04 14:24:10,445 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 20%.
2013-01-04 14:24:10,447 n.b.s.b.f.b.DoBackupFull INFO - Dumping database from host: mail
2013-01-04 14:24:10,447 n.b.s.b.f.t.BackupFullDatabaseHelper INFO - Dumping database: bj, to: /tmp/bmDatabase_-mail.dump
2013-01-04 14:24:10,447 n.b.n.c.SchExecTask INFO - Run noout /usr/share/bm-core/backupBMDatabase.sh bj /tmp/bmDatabase-mail.dump
2013-01-04 14:24:11,179 n.b.n.c.SChNodeClient INFO - Opening stream on /tmp/bmDatabase-mail.dump…
2013-01-04 14:24:11,181 n.b.n.c.ScpReader INFO - Streaming bmDatabase-mail.dump size: 1315665…
2013-01-04 14:24:11,571 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@5e5d9f0e
2013-01-04 14:24:11,597 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@5e5d9f0e
2013-01-04 14:24:11,638 n.b.s.b.f.t.BackupFullDatabaseHelper INFO - Removing: /tmp/bmDatabase-mail.dump
2013-01-04 14:24:11,638 n.b.n.c.SchExecTask INFO - Run cmd rm -f /tmp/bmDatabase-mail.dump
2013-01-04 14:24:11,690 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 30%.
2013-01-04 14:24:11,693 n.b.s.b.f.b.DoBackupFull INFO - Backuping documents from host: mail
2013-01-04 14:24:11,693 n.b.s.b.f.t.BackupFullDocumentsHelper INFO - Backuping documents /tmp/bmDocs-mail.tar.gz2
2013-01-04 14:24:11,693 n.b.n.c.SchExecTask INFO - Run noout /usr/share/bm-core/backupBMDocs.sh /tmp/bmDocs-mail.tar.gz2
2013-01-04 14:24:11,866 n.b.n.c.SChNodeClient INFO - Opening stream on /tmp/bmDocs-mail.tar.gz2…
2013-01-04 14:24:11,868 n.b.n.c.ScpReader INFO - Streaming bmDocs-mail.tar.gz2 size: 0…
2013-01-04 14:24:12,354 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@6e0a62ff
2013-01-04 14:24:12,355 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@6e0a62ff
2013-01-04 14:24:12,385 n.b.c.s.SyncServlet INFO - handler responded to calendar/doSync in 4ms.
2013-01-04 14:24:12,397 n.b.s.b.f.t.BackupFullDocumentsHelper INFO - Removing: /tmp/bmDocs-mail.tar.gz2
2013-01-04 14:24:12,397 n.b.n.c.SchExecTask INFO - Run cmd rm -f /tmp/bmDocs-mail.tar.gz2
2013-01-04 14:24:12,458 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 50%.
2013-01-04 14:24:12,461 n.b.s.b.f.b.DoBackupFull INFO - Backuping cyrus host: net.bluemind.core.api.system.Host@1
2013-01-04 14:24:12,461 n.b.s.b.f.t.BackupFullCyrusHelper INFO - Backuping all cyrus lib datas to: /tmp/cyrusLib-mail.tar.bz2
2013-01-04 14:24:12,461 n.b.n.c.SchExecTask INFO - Run noout /usr/share/bm-cyrus/backupCyrus.sh lib /tmp/cyrusLib-mail.tar.bz2
2013-01-04 14:24:12,542 n.b.n.c.SChNodeClient INFO - Opening stream on /tmp/cyrusLib-mail.tar.bz2…
2013-01-04 14:24:12,544 n.b.n.c.ScpReader INFO - Streaming cyrusLib-mail.tar.bz2 size: 0…
2013-01-04 14:24:12,906 n.b.n.c.SchExecTask INFO - Run cmd mkdir -p /var/backups/bluemind/backupFull/mail
2013-01-04 14:24:12,959 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@38fc0f12
2013-01-04 14:24:12,961 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@38fc0f12
2013-01-04 14:24:13,001 n.b.s.b.f.t.BackupFullCyrusHelper INFO - Removing: /tmp/cyrusLib-mail.tar.bz2
2013-01-04 14:24:13,002 n.b.n.c.SchExecTask INFO - Run cmd rm -f /tmp/cyrusLib-mail.tar.bz2
2013-01-04 14:24:13,053 n.b.s.b.f.t.BackupFullCyrusHelper INFO - Backuping all cyrus spool datas to: /tmp/cyrusSpool-mail.tar.bz2
2013-01-04 14:24:13,053 n.b.n.c.SchExecTask INFO - Run noout /usr/share/bm-cyrus/backupCyrus.sh spool /tmp/cyrusSpool-mail.tar.bz2
2013-01-04 14:24:13,236 n.b.n.c.SChNodeClient INFO - Opening stream on /tmp/cyrusSpool-mail.tar.bz2…
2013-01-04 14:24:13,238 n.b.n.c.ScpReader INFO - Streaming cyrusSpool-mail.tar.bz2 size: 0…
2013-01-04 14:24:13,491 n.b.n.c.SchExecTask INFO - Run cmd mkdir -p /var/backups/bluemind/backupFull/mail
2013-01-04 14:24:13,544 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@4ed82b4a
2013-01-04 14:24:13,545 n.b.n.c.RemoteStreamWrapper INFO - closing…(remaining 0) net.bluemind.node.client.RemoteStreamWrapper@4ed82b4a
2013-01-04 14:24:13,586 n.b.s.b.f.t.BackupFullCyrusHelper INFO - Removing: /tmp/cyrusSpool-mail.tar.bz2
2013-01-04 14:24:13,587 n.b.n.c.SchExecTask INFO - Run cmd rm -f /tmp/cyrusSpool-_mail.tar.bz2
2013-01-04 14:24:13,638 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 100%.
2013-01-04 14:24:13,638 n.b.s.b.f.b.DoBackupFull INFO - Full backup success !
2013-01-04 14:24:13,639 n.b.n.c.SchListFiles INFO - Run listfiles /usr/bin/bm-post-full-backup.sh
2013-01-04 14:24:13,644 n.b.n.c.ResponseHelper$1 ERROR - Premature end of file.
2013-01-04 14:24:13,644 n.b.n.c.SchListFiles INFO - No files found in: /usr/bin/bm-post-full-backup.sh
2013-01-04 14:24:13,685 n.b.c.j.i.Scheduler WARN - [BackupFullJob-global.virt-1357309450224] [en] => Missing post-backup script (/usr/bin/bm-post-full-backup.sh)
2013-01-04 14:24:13,685 n.b.c.j.i.Scheduler WARN - [BackupFullJob-global.virt-1357309450224] [fr] => Script post-backup manquant (/usr/bin/bm-post-full-backup.sh)
2013-01-04 14:24:13,685 n.b.c.j.i.Scheduler INFO - Finishing BackupFullJob-global.virt-1357309450224
2013-01-04 14:24:13,685 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] progress is now 100%.
2013-01-04 14:24:13,686 n.b.c.j.i.ExecutionRecorder INFO - recording execution of BackupFullJob-global.virt-1357309450224
2013-01-04 14:24:13,686 n.b.c.j.i.JobHome INFO - recording execution for BackupFullJob-global.virt-1357309450224…
2013-01-04 14:24:13,688 n.b.c.j.i.JobHome INFO - run plan for BackupFullJob@global.virt updated with last_run set to id 48128 (start: Fri Jan 04 14:24:10 GMT 2013)
2013-01-04 14:24:13,688 n.b.c.j.i.JobHome INFO - saving 20 entries…
2013-01-04 14:24:13,721 n.b.c.j.i.Scheduler INFO - [BackupFullJob-global.virt-1357309450224] finished and recorded: SUCCESS, duration: 3461ms.