• The Horde webmail has been deprecated. Its complete removal is scheduled for April 2025. For details and recommended actions, see the Feature and Deprecation Plan.
  • We’re working on enhancing the Monitoring feature in Plesk, and we could really use your expertise! If you’re open to sharing your experiences with server and website monitoring or providing feedback, we’d love to have a one-hour online meeting with you.

pleskrestore sets modification dates to current date

IsmetP

New Pleskian
Hello!

Our Plesk is 11.09 #31. Our OS Debian Squeeze.

Pleskrestore (the command line tool) changes the modification dates of all the restored files to the actual date time!!! The TAR-archives are correct. We cannot use the migration manager, because this server is a fallback server if the main server crashes.

What can we do? We have hundreds of domains.

Isi
 
Last edited:
Further Details

Thank you for your quick reply. Here are further details.

Plesk Panel 11.0.9 (upgraded from 10.4.4), Microupdate #31, OS Debian 6.0.6, Server: Intel Xeon E3-1245, Quad-Core, 16GB RAM, 3 TB HD, Softraid, enough free disk space (~90% free)

1. Make a backup with plesk: subcription>control panel>websites & domains>backup manager>Back up
- Add prefix to backup name: "test"
- Store backup in: "Server repository"
- Back up: "Domain configuration and content>all configuration and content"
2. in command line (ssh): /usr/local/psa/bin/pleskrestore --restore test_...xml -level clients

After restoring the backupfile all of the files (in httpdocs, private, sessions, statistics) have lost their date! But if you look inside the tar file you can see that the files have their right date.

We tried this on a second server (same Plesk version), with same result.


migration.log
------------
[12:07:20|INFO:23809:p.log] pmm-ras started : /opt/psa/admin/bin/pmm-ras --get-dump-info --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-file-specification=test02_domainxyz.de_info_1212181057.xml --check-sign --session-path=/opt/psa/PMM/logs
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/' initialising...
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Initialized
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Get backup info from test02_domainxyz.de_info_1212181057.xml
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Get initial backup info from dir .discovered/test02_domainxyz.de_info_1212181057
[12:07:20|INFO:23809:p.log] Get backup params from listing of .discovered/test02_domainxyz.de_info_1212181057
[12:07:20|INFO:23809:p.log] Read properties from xml test02_domainxyz.de_info_1212181057.xml
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Validate backup test02_domainxyz.de_info_1212181057.xml
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Validate backup (common phase) test02_domainxyz.de_info_1212181057.xml
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Get items 'status' for discovered 'test02_domainxyz.de_info_1212181057' at path
[12:07:20|INFO:23809:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Get info from .discovered/test02_domainxyz.de_info_1212181057/status_OK
[12:07:20|INFO:23809:p.log] pmm-ras finished. Exit code: 0
[12:07:20|INFO:23811:p.log] pmm-ras started : /opt/psa/admin/bin/pmm-ras --convert-local-dump --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-specification=test02_domainxyz.de_info_1212181057.xml --session-path=/opt/psa/PMM/logs
[12:07:20|INFO:23811:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/' initialising...
[12:07:20|INFO:23811:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Initialized
[12:07:20|INFO:23811:p.log] Repository '/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/': Convert local backup to current Panel version test02_domainxyz.de_info_1212181057.xml
[12:07:20|INFO:23811:p.log] Executing utility: /opt/psa/bin/pre10-backup-convert --can-convert -source /home/backups/plesk/dumps/clients/aost/domains/domainxyz.de//test02_domainxyz.de_info_1212181057.xml
2012-12-18T12:07:20+01:00 INFO (6): backup_Converter_Panel10::_canConvertCommand started from /home/backups/plesk/dumps/clients/aost/domains/domainxyz.de//test02_domainxyz.de_info_1212181057.xml
2012-12-18T12:07:20+01:00 INFO (6): Dump version is 11.0.9
2012-12-18T12:07:20+01:00 INFO (6): backup_Converter_Panel10::_canConvertCommand finished
[12:07:20|INFO:23811:p.log] The utility succesfully executed.
 
Last edited:
pmmcli.log

pmmcli.log
----------
23808: 2012-12-18 12:07:20,129 DEBUG --> <pmmcli.CheckDumpAction object at 0x267a0d0>
23808: 2012-12-18 12:07:20,129 INFO stdin: <dump-specification><dumps-storage-credentials storage-type="local"><root-dir>/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de</root-dir><file-name/></dumps-storage-credentials><name-of-info-xml-file>test02_domainxyz.de_info_1212181057.xml</name-of-info-xml-file></dump-specification>
23808: 2012-12-18 12:07:20,131 INFO Packet succesfully validated.
23808: 2012-12-18 12:07:20,132 DEBUG <pmmcli.ActionRunner object at 0x267a090>: doActivity
23808: 2012-12-18 12:07:20,133 INFO Executing <subprocess[23809] '/opt/psa/admin/bin/pmm-ras --get-dump-info --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-file-specification=test02_domainxyz.de_info_1212181057.xml --check-sign --session-path=/opt/psa/PMM/logs'>
23808: 2012-12-18 12:07:20,145 INFO Execution of <subprocess[23809] '/opt/psa/admin/bin/pmm-ras --get-dump-info --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-file-specification=test02_domainxyz.de_info_1212181057.xml --check-sign --session-path=/opt/psa/PMM/logs'> finished successfully.
23808: 2012-12-18 12:07:20,145 DEBUG <pmmcli.CheckDumpAction object at 0x267a0d0>: response
23808: 2012-12-18 12:07:20,147 INFO Outgoing packet:
<?xml version="1.0" encoding="UTF-8"?>
<response>
<errcode>0</errcode>
<data>
<check-dump-result>
<dump-status dump-status="OK">
</dump-status>
</check-dump-result>
</data>
</response>

23810: 2012-12-18 12:07:20,215 DEBUG --> <pmmcli.RestoreAction object at 0xf810d0>
23810: 2012-12-18 12:07:20,215 INFO stdin: <restore-task-description owner-guid="a28b696f-ae41-4e71-8ff2-8239b12bff48" owner-type="server"><source><dump-specification><dumps-storage-credentials storage-type="local"><root-dir>/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de</root-dir><file-name/><backup-password>[NO_PASSWORD_bf0335c6-c8b5-43b7-9ca4-a5692c58e5c4]</backup-password></dumps-storage-credentials><name-of-info-xml-file>test02_domainxyz.de_info_1212181057.xml</name-of-info-xml-file></dump-specification></source><objects><selected><node name="domain" children-processing-type="copy"/><node name="dump-info" children-processing-type="copy"/></selected></objects><ignore-errors><ignore-error type="sign"/></ignore-errors><misc suspend="false"/></restore-task-description>
23810: 2012-12-18 12:07:20,217 INFO Packet succesfully validated.
23810: 2012-12-18 12:07:20,218 DEBUG <pmmcli.ActionRunner object at 0xf81090>: doActivity
23810: 2012-12-18 12:07:20,220 INFO Executing <subprocess[23811] '/opt/psa/admin/bin/pmm-ras --convert-local-dump --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-specification=test02_domainxyz.de_info_1212181057.xml --session-path=/opt/psa/PMM/logs'>
23810: 2012-12-18 12:07:20,408 INFO Execution of <subprocess[23811] '/opt/psa/admin/bin/pmm-ras --convert-local-dump --dump-storage=/home/backups/plesk/dumps/clients/aost/domains/domainxyz.de/ --dump-specification=test02_domainxyz.de_info_1212181057.xml --session-path=/opt/psa/PMM/logs'> finished successfully.
23810: 2012-12-18 12:07:20,409 INFO Create restore session 20121218120720219 started
23810: 2012-12-18 12:07:20,410 INFO Initialized restore session 20121218120720219
23810: 2012-12-18 12:07:20,427 INFO Create restore session 20121218120720219 done
23810: 2012-12-18 12:07:20,428 DEBUG Acquired session mutex: MainThread
23810: 2012-12-18 12:07:20,428 DEBUG detecting running pmmcli daemon...
23810: 2012-12-18 12:07:20,440 DEBUG starting pmmcli daemon...
23810: 2012-12-18 12:07:20,441 DEBUG Executing asynchronously [23816] process
23810: 2012-12-18 12:07:20,442 DEBUG Released session mutex: MainThread
23810: 2012-12-18 12:07:20,442 DEBUG Acquired session mutex: MainThread
23810: 2012-12-18 12:07:20,449 DEBUG Released session mutex: MainThread
23810: 2012-12-18 12:07:20,449 DEBUG Acquired session mutex: MainThread
23810: 2012-12-18 12:07:20,450 DEBUG Released session mutex: MainThread
23810: 2012-12-18 12:07:20,450 DEBUG Acquired session mutex: MainThread
23810: 2012-12-18 12:07:20,451 DEBUG Released session mutex: MainThread
23810: 2012-12-18 12:07:20,451 DEBUG Prepare to call sign checker
23810: 2012-12-18 12:07:20,453 INFO Executing <subprocess[23817] '/opt/psa/admin/sbin/backup_sign verify /opt/psa/PMM/rsessions/20121218120720219/info.xml'>
23810: 2012-12-18 12:07:20,456 INFO Execution of <subprocess[23817] '/opt/psa/admin/sbin/backup_sign verify /opt/psa/PMM/rsessions/20121218120720219/info.xml'> finished successfully.
23810: 2012-12-18 12:07:20,460 DEBUG Prepare to call backup_encrypt
23810: 2012-12-18 12:07:20,461 DEBUG decryptBackup
23810: 2012-12-18 12:07:20,462 INFO Executing <subprocess[23818] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/api-cli/backup_encrypt.php --encrypt-by-plesk -single-file /opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp'>
23810: 2012-12-18 12:07:20,625 INFO Execution of <subprocess[23818] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/api-cli/backup_encrypt.php --encrypt-by-plesk -single-file /opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp'> finished successfully.
23810: 2012-12-18 12:07:20,626 DEBUG Prepare to call guids fixer
23810: 2012-12-18 12:07:20,628 INFO Executing <subprocess[23821] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Conflicts/Runner.php --fix-guids --restore-specification=/opt/psa/PMM/rsessions/20121218120720219/restore.xml --restore-specification-out=/opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp --session-path=/opt/psa/PMM/rsessions/20121218120720219'>
23810: 2012-12-18 12:07:20,803 INFO Subprocess raised ExecuteException: Subprocess <subprocess[23821] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Conflicts/Runner.php --fix-guids --restore-specification=/opt/psa/PMM/rsessions/20121218120720219/restore.xml --restore-specification-out=/opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp --session-path=/opt/psa/PMM/rsessions/20121218120720219'> was finished with exit code 254
== STDOUT ====================

== STDERR ====================

23810: 2012-12-18 12:07:20,806 INFO Executing <subprocess[23824] '/usr/bin/perl /opt/psa/admin/bin/plesk_agent_manager server -c --migration-mode --session-path=/opt/psa/PMM/rsessions/20121218120720219'>
23810: 2012-12-18 12:07:27,914 INFO Execution of <subprocess[23824] '/usr/bin/perl /opt/psa/admin/bin/plesk_agent_manager server -c --migration-mode --session-path=/opt/psa/PMM/rsessions/20121218120720219'> finished successfully.
23810: 2012-12-18 12:07:27,916 INFO Executing <subprocess[24195] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Transformations/TransformationRunner.php --transform-dump -restore-specification /opt/psa/PMM/rsessions/20121218120720219/restore.xml -restore-specification-out /opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp -session-path /opt/psa/PMM/rsessions/20121218120720219'>
23810: 2012-12-18 12:07:28,074 INFO Execution of <subprocess[24195] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Transformations/TransformationRunner.php --transform-dump -restore-specification /opt/psa/PMM/rsessions/20121218120720219/restore.xml -restore-specification-out /opt/psa/PMM/rsessions/20121218120720219/restore.xml.tmp -session-path /opt/psa/PMM/rsessions/20121218120720219'> finished successfully.
23810: 2012-12-18 12:07:28,105 DEBUG Prepare to detect conflicts
23810: 2012-12-18 12:07:28,107 INFO Executing <subprocess[24198] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Conflicts/Runner.php --detect-conflicts --plesk-dump=/opt/psa/PMM/rsessions/20121218120720219/dump.xml --owner-guid=a28b696f-ae41-4e71-8ff2-8239b12bff48 --restore-specification=/opt/psa/PMM/rsessions/20121218120720219/restore.xml --conflicts-description-out=/opt/psa/PMM/rsessions/20121218120720219/conflict_description --session-path=/opt/psa/PMM/rsessions/20121218120720219 --log=conflict-detect.log'>
23810: 2012-12-18 12:07:29,401 INFO Execution of <subprocess[24198] '/opt/psa/bin/sw-engine-pleskrun /opt/psa/admin/plib/backup/Conflicts/Runner.php --detect-conflicts --plesk-dump=/opt/psa/PMM/rsessions/20121218120720219/dump.xml --owner-guid=a28b696f-ae41-4e71-8ff2-8239b12bff48 --restore-specification=/opt/psa/PMM/rsessions/20121218120720219/restore.xml --conflicts-description-out=/opt/psa/PMM/rsessions/20121218120720219/conflict_description --session-path=/opt/psa/PMM/rsessions/20121218120720219 --log=conflict-detect.log'> finished successfully.
23810: 2012-12-18 12:07:29,417 DEBUG <pmmcli.RestoreAction object at 0xf810d0>: response
23810: 2012-12-18 12:07:29,422 INFO Outgoing packet:
<?xml version="1.0" encoding="UTF-8"?>
<response>

cut ... too many characters

......
 
Thank you for detailed report. I have forwarded it to developers from Plesk Service Team (request #126141 for your reference). I will keep this thread updated with any results of investigation.
 
Hello Igor!

Is the bug in Parallels bugfix pipeline? Or do you know, when will the bugfix be released?

Isi
 
Same in newest PP-Version 11.5.30!

All restored files have the actual system date/time and not the original date/time stored in backup-tar!
 
Back
Top