Backup is taking forever.

Tagged: back up

This topic has 1 reply, 2 voices, and was last updated 6 years, 3 months ago by Bryle Crodua.

Viewing 2 posts - 1 through 2 (of 2 total)

Author

Posts
August 24, 2018 at 4:35 pm #301221

james_mcmahon
Participant

This is not a particularily big site but the backup seems to be taking an incredibly long time – is there an issue?

Here is the logfile

Thanks in anticipation

0000.000 (0) Opened log file at time: Fri, 24 Aug 2018 13:39:52 +0000 on https://mcmahonoconnor.ie/wp
0000.002 (0) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 1.14.13 WP: 4.6.12 PHP: 5.6.37 (cgi-fcgi, Linux lh917.dnsireland.com 3.10.0-714.10.2.lve1.5.17.1.el7.x86_64 #1 SMP Tue May 22 10:39:25 EDT 2018 x86_64) MySQL: 5.6.40 WPLANG: en_US Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 7.5M | 9.3M) multisite: N openssl: OpenSSL 1.0.2o 27 Mar 2018 mcrypt: Y LANG: ZipArchive::addFile: Y
0000.004 (0) Free space on disk containing Updraft’s temporary directory: 341637.1 MB
0000.007 (0) Tasks: Backup files: 1 (schedule: manual) Backup DB: 1 (schedule: manual)
0000.019 (0) Requesting semaphore lock (fd) (apparently not via scheduler)
0000.022 (0) Semaphore (fd, wpir_options) was stuck, set lock time to 2018-08-24 13:39:52
0000.024 (0) Semaphore (fd, wpir_options) reset to 1
0000.026 (0) Set semaphore last lock (fd) time to 2018-08-24 13:39:52
0000.028 (0) Semaphore lock (fd) complete
0000.035 (0) Backup run: resumption=0, nonce=3ad7986d905b, begun at=1535117992 (0s ago), job type=backup
0000.038 (0) Scheduling a resumption (1) after 300 seconds (1535118292) in case this run gets aborted
0000.056 (0) Checking if we have a zip executable available
0000.058 (0) Testing: /usr/bin/zip
0000.060 (0) PHP event: code E_WARNING: escapeshellarg() has been disabled for security reasons (line 1600, wp-content/plugins/updraftplus/class-updraftplus.php)
0000.062 (0) PHP event: code E_WARNING: popen() has been disabled for security reasons (line 1605, wp-content/plugins/updraftplus/class-updraftplus.php)
0000.063 (0) Error: popen failed
0000.066 (0) Testing: /bin/zip
0000.067 (0) PHP event: code E_WARNING: escapeshellarg() has been disabled for security reasons (line 1600, wp-content/plugins/updraftplus/class-updraftplus.php)
0000.069 (0) PHP event: code E_WARNING: popen() has been disabled for security reasons (line 1605, wp-content/plugins/updraftplus/class-updraftplus.php)
0000.071 (0) Error: popen failed
0000.075 (0) Creation of backups of directories: beginning
0000.080 (0) Beginning creation of dump of plugins (split every: 400 MB)
0000.169 (0) Total entities for the zip file: 467 directories, 4259 files (0 skipped as non-modified), 48 MB
0000.180 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 100 files added (on-disk size: 0 KB)
0000.188 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 200 files added (on-disk size: 0 KB)
0000.197 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 300 files added (on-disk size: 0 KB)
0000.206 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 400 files added (on-disk size: 0 KB)
0000.216 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 500 files added (on-disk size: 0 KB)
0000.218 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (7.4 MB, 4259 files batched, 501 (501) added so far); re-opening (prior size: 0 KB)
0010.841 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 600 files added (on-disk size: 2953.2 KB)
0010.897 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 700 files added (on-disk size: 2953.2 KB)
0010.914 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 800 files added (on-disk size: 2953.2 KB)
0010.952 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 900 files added (on-disk size: 2953.2 KB)
0010.977 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1000 files added (on-disk size: 2953.2 KB)
0010.982 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (18.8 MB, 4259 files batched, 501 (1002) added so far); re-opening (prior size: 2953.2 KB)
0035.675 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1100 files added (on-disk size: 8298.7 KB)
0039.935 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 2.0 seconds have passed since the last write (1.8 MB, 99 (1101) files added so far); re-opening (prior size: 8298.7 KB)
0050.596 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1200 files added (on-disk size: 8917.4 KB)
0050.632 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1300 files added (on-disk size: 8917.4 KB)
0050.659 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1400 files added (on-disk size: 8917.4 KB)
0050.698 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1500 files added (on-disk size: 8917.4 KB)
0050.731 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1600 files added (on-disk size: 8917.4 KB)
0050.738 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (1.1 MB, 4259 files batched, 501 (1602) added so far); re-opening (prior size: 8917.4 KB)
0063.137 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1700 files added (on-disk size: 9441.3 KB)
0063.161 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1800 files added (on-disk size: 9441.3 KB)
0063.178 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 1900 files added (on-disk size: 9441.3 KB)
0063.196 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2000 files added (on-disk size: 9441.3 KB)
0063.219 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2100 files added (on-disk size: 9441.3 KB)
0063.224 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (8.2 MB, 4259 files batched, 501 (2103) added so far); re-opening (prior size: 9441.3 KB)
0078.247 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2200 files added (on-disk size: 11323.3 KB)
0082.715 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 2.0 seconds have passed since the last write (0.7 MB, 98 (2201) files added so far); re-opening (prior size: 11323.3 KB)
0095.869 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2300 files added (on-disk size: 11835.3 KB)
0096.098 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2400 files added (on-disk size: 11835.3 KB)
0096.154 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2500 files added (on-disk size: 11835.3 KB)
0096.212 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2600 files added (on-disk size: 11835.3 KB)
0096.248 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2700 files added (on-disk size: 11835.3 KB)
0096.261 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (5.6 MB, 4259 files batched, 501 (2702) added so far); re-opening (prior size: 11835.3 KB)
0120.236 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2800 files added (on-disk size: 15672.9 KB)
0120.295 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 2900 files added (on-disk size: 15672.9 KB)
0120.357 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3000 files added (on-disk size: 15672.9 KB)
0120.421 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3100 files added (on-disk size: 15672.9 KB)
0120.489 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3200 files added (on-disk size: 15672.9 KB)
0120.497 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (1.3 MB, 4259 files batched, 501 (3203) added so far); re-opening (prior size: 15672.9 KB)
0136.684 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3300 files added (on-disk size: 16471.4 KB)
0139.278 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3400 files added (on-disk size: 16471.4 KB)
0139.335 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3500 files added (on-disk size: 16471.4 KB)
0139.373 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3600 files added (on-disk size: 16471.4 KB)
0139.427 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3700 files added (on-disk size: 16471.4 KB)
0139.434 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (1.5 MB, 4259 files batched, 501 (3704) added so far); re-opening (prior size: 16471.4 KB)
0160.475 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3800 files added (on-disk size: 17353.5 KB)
0160.498 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 3900 files added (on-disk size: 17353.5 KB)
0160.523 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 4000 files added (on-disk size: 17353.5 KB)
0160.546 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 4100 files added (on-disk size: 17353.5 KB)
0160.569 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip.tmp: 4200 files added (on-disk size: 17353.5 KB)
0160.571 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (1.3 MB, 4259 files batched, 501 (4205) added so far); re-opening (prior size: 17353.5 KB)
0200.526 (0) Created plugins zip (0) – 18222.1 KB in 200.4 s (90.9 KB/s) (sha1: 152be63f1ff886170678a4ebf277b541b78be5ae, sha256: d23c1a13197623e7e915883d26f0ef47ca7fb82ddacdc0f757c2da6d3017a95e)
0200.536 (0) Beginning creation of dump of themes (split every: 400 MB)
0200.562 (0) Total entities for the zip file: 54 directories, 515 files (0 skipped as non-modified), 13 MB
0200.569 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip.tmp: 100 files added (on-disk size: 0 KB)
0200.582 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip.tmp: 200 files added (on-disk size: 0 KB)
0200.601 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip.tmp: 300 files added (on-disk size: 0 KB)
0200.628 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip.tmp: 400 files added (on-disk size: 0 KB)
0200.661 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip.tmp: 500 files added (on-disk size: 0 KB)
0200.670 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 500 files added on this batch (12.4 MB, 515 files batched, 501 (501) added so far); re-opening (prior size: 0 KB)
0232.241 (0) Created themes zip (0) – 9286.6 KB in 31.7 s (292.9 KB/s) (sha1: 7cbacaf62eb15d4514b14ca5c5abe5c23201df7f, sha256: 5ebe2687f63a888aafdb0d00cff92539dafa42c01eb56b3920b547f37c3a3deb)
0232.246 (0) Exclusion option setting (uploads): wp-clone,snapshots
0232.247 (0) Looking for candidates to backup in: /home/mcmahono/public_html/wp/wp-content/uploads
0232.249 (0) finding files: 2016: adding to list (1)
0232.251 (0) finding files: revslider: adding to list (2)
0232.253 (0) finding files: 2013: adding to list (3)
0232.254 (0) finding files: 2015: adding to list (4)
0232.256 (0) finding files: 2017: adding to list (5)
0232.258 (0) finding files: 2018: adding to list (6)
0232.259 (0) finding files: 2014: adding to list (7)
0232.261 (0) Beginning creation of dump of uploads (split every: 400 MB)
0232.495 (0) Total entities for the zip file: 208 directories, 14585 files (0 skipped as non-modified), 2425.1 MB
0232.502 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 100 files added (on-disk size: 0 KB)
0232.507 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.1 MB, 14585 files batched, 168 (168) added so far); re-opening (prior size: 0 KB)
0287.509 (0) The time we have been running (287.5) is approaching the resumption interval (300) – increasing resumption interval to 318
0287.518 (0) The scheduled resumption is within 45 seconds – will reschedule
0287.525 (0) Rescheduling resumption 1: moving to 363 seconds from now (1535118643)
0287.537 (0) To decrease the likelihood of overlaps, increasing resumption interval to: 318 + 45 = 363
0287.542 (0) A useful amount of data was added after this amount of zip processing: 56.1 s (normalised: 55.9 s, rate: 457.8 KB/s)
0287.555 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 200 files added (on-disk size: 25334 KB)
0287.582 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 300 files added (on-disk size: 25334 KB)
0287.592 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.5 MB, 14585 files batched, 203 (371) added so far); re-opening (prior size: 25334 KB)
0365.162 (0) The time we have been running (365.1) is approaching the resumption interval (363) – increasing resumption interval to 396
0366.172 (0) A useful amount of data was added after this amount of zip processing: 78.7 s (normalised: 77.3 s, rate: 331.4 KB/s)
0366.200 (0) The time we have been running (366.2) is approaching the resumption interval (396) – increasing resumption interval to 397
0366.206 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 400 files added (on-disk size: 50778.8 KB)
0366.214 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 115 (486) added so far); re-opening (prior size: 50778.8 KB)
0468.192 (0) The time we have been running (468.2) is approaching the resumption interval (397) – increasing resumption interval to 499
0468.509 (0) A useful amount of data was added after this amount of zip processing: 103 s (normalised: 102.9 s, rate: 248.8 KB/s)
0468.515 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 500 files added (on-disk size: 76217.1 KB)
0468.525 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 600 files added (on-disk size: 76217.1 KB)
0468.530 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.2 MB, 14585 files batched, 159 (645) added so far); re-opening (prior size: 76217.1 KB)
0597.310 (0) The time we have been running (597.3) is approaching the resumption interval (499) – increasing resumption interval to 628
0597.313 (0) A useful amount of data was added after this amount of zip processing: 128.8 s (normalised: 127.6 s, rate: 200.6 KB/s)
0597.323 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 700 files added (on-disk size: 101802.2 KB)
0597.333 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 800 files added (on-disk size: 101802.2 KB)
0597.344 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 900 files added (on-disk size: 101802.2 KB)
0597.346 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 262 (907) added so far); re-opening (prior size: 101802.2 KB)
0678.469 (1) Opened log file at time: Fri, 24 Aug 2018 13:51:10 +0000 on https://mcmahonoconnor.ie/wp
0679.759 (1) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 1.14.13 WP: 4.6.12 PHP: 5.6.37 (cgi-fcgi, Linux lh917.dnsireland.com 3.10.0-714.10.2.lve1.5.17.1.el7.x86_64 #1 SMP Tue May 22 10:39:25 EDT 2018 x86_64) MySQL: 5.6.40 WPLANG: en_US Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 6.6M | 7.3M) multisite: N openssl: OpenSSL 1.0.2o 27 Mar 2018 mcrypt: Y LANG: ZipArchive::addFile: Y
0679.765 (1) Free space on disk containing Updraft’s temporary directory: 340969.5 MB
0681.755 (1) Backup run: resumption=1, nonce=3ad7986d905b, begun at=1535117992 (682s ago), job type=backup, previous check-in=597.3s
0681.763 (1) Scheduling a resumption (2) after 628 seconds (1535119302) in case this run gets aborted
0681.805 (1) Checking if we have a zip executable available
0681.813 (1) Creation of backups of directories: had begun; will resume
0683.762 (1) Beginning creation of dump of plugins (split every: 400 MB)
0683.765 (1) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip: this file has already been created (age: 484 s)
0683.777 (1) Beginning creation of dump of themes (split every: 400 MB)
0683.779 (1) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip: this file has already been created (age: 452 s)
0685.765 (1) Exclusion option setting (uploads): wp-clone,snapshots
0685.772 (1) Looking for candidates to backup in: /home/mcmahono/public_html/wp/wp-content/uploads
0685.775 (1) finding files: 2016: adding to list (1)
0685.780 (1) finding files: revslider: adding to list (2)
0685.785 (1) finding files: 2013: adding to list (3)
0687.755 (1) finding files: 2015: adding to list (4)
0687.761 (1) finding files: 2017: adding to list (5)
0687.763 (1) finding files: 2018: adding to list (6)
0687.764 (1) finding files: 2014: adding to list (7)
0687.769 (1) Beginning creation of dump of uploads (split every: 400 MB)
0687.773 (1) File exists (/home/mcmahono/public_html/wp/wp-content/updraft/backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp), but was apparently not modified within the last 30 seconds, so we assume that any previous run has now terminated (time_mod=1535118589, time_now=1535118680, diff=91)
0687.780 (1) Terminate: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp.S8zZBE exists with activity within the last 30 seconds (time_mod=1535118680, time_now=1535118680, diff=0, size=92608KB). This likely means that another UpdraftPlus run is at work; so we will exit.
0687.784 (1) Rescheduling resumption 2: moving to 600 seconds from now (1535119280)
0687.798 (1) To decrease the likelihood of overlaps, increasing resumption interval to: 628 + 120 = 748
0755.177 (0) The time we have been running (755.1) is approaching the resumption interval (628) – increasing resumption interval to 786
0755.203 (0) A useful amount of data was added after this amount of zip processing: 158.7 s (normalised: 158.6 s, rate: 161.5 KB/s)
0755.335 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1000 files added (on-disk size: 127215.5 KB)
0755.414 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1100 files added (on-disk size: 127215.5 KB)
0755.425 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (27.5 MB, 14585 files batched, 259 (1166) added so far); re-opening (prior size: 127215.5 KB)
0937.626 (0) The time we have been running (937.6) is approaching the resumption interval (786) – increasing resumption interval to 968
0937.649 (0) A useful amount of data was added after this amount of zip processing: 183.2 s (normalised: 166.6 s, rate: 153.7 KB/s)
0937.714 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1200 files added (on-disk size: 155074.7 KB)
0937.733 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1300 files added (on-disk size: 155074.7 KB)
0937.741 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.2 MB, 14585 files batched, 162 (1328) added so far); re-opening (prior size: 155074.7 KB)
1157.343 (0) The time we have been running (1157.3) is approaching the resumption interval (968) – increasing resumption interval to 1188
1157.349 (0) A useful amount of data was added after this amount of zip processing: 219.9 s (normalised: 218.5 s, rate: 117.2 KB/s)
1157.375 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1400 files added (on-disk size: 180584.6 KB)
1157.383 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.1 MB, 14585 files batched, 97 (1425) added so far); re-opening (prior size: 180584.6 KB)
1292.706 (2) Opened log file at time: Fri, 24 Aug 2018 14:01:25 +0000 on https://mcmahonoconnor.ie/wp
1294.164 (2) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 1.14.13 WP: 4.6.12 PHP: 5.6.37 (cgi-fcgi, Linux lh917.dnsireland.com 3.10.0-714.10.2.lve1.5.17.1.el7.x86_64 #1 SMP Tue May 22 10:39:25 EDT 2018 x86_64) MySQL: 5.6.40 WPLANG: en_US Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 6.6M | 7.3M) multisite: N openssl: OpenSSL 1.0.2o 27 Mar 2018 mcrypt: Y LANG: ZipArchive::addFile: Y
1296.167 (2) Free space on disk containing Updraft’s temporary directory: 340520.7 MB
1298.171 (2) Backup run: resumption=2, nonce=3ad7986d905b, begun at=1535117992 (1298s ago), job type=backup
1298.176 (2) Scheduling a resumption (3) after 1188 seconds (1535120478) in case this run gets aborted
1299.970 (2) Checking if we have a zip executable available
1299.972 (2) Creation of backups of directories: had begun; will resume
1302.062 (2) No check-in was detected on the previous run – as a result, we are reducing the batch amount (old=26214400, new=20971520)
1302.069 (2) Beginning creation of dump of plugins (split every: 400 MB)
1304.063 (2) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip: this file has already been created (age: 1104 s)
1304.072 (2) Beginning creation of dump of themes (split every: 400 MB)
1306.059 (2) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip: this file has already been created (age: 1074 s)
1306.065 (2) Exclusion option setting (uploads): wp-clone,snapshots
1306.067 (2) Looking for candidates to backup in: /home/mcmahono/public_html/wp/wp-content/uploads
1306.068 (2) finding files: 2016: adding to list (1)
1306.070 (2) finding files: revslider: adding to list (2)
1308.063 (2) finding files: 2013: adding to list (3)
1308.065 (2) finding files: 2015: adding to list (4)
1308.066 (2) finding files: 2017: adding to list (5)
1308.068 (2) finding files: 2018: adding to list (6)
1310.059 (2) finding files: 2014: adding to list (7)
1310.060 (2) Beginning creation of dump of uploads (split every: 400 MB)
1310.065 (2) File exists (/home/mcmahono/public_html/wp/wp-content/updraft/backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp), but was apparently not modified within the last 30 seconds, so we assume that any previous run has now terminated (time_mod=1535119149, time_now=1535119302, diff=153)
1310.069 (2) Terminate: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp.I7Z511 exists with activity within the last 30 seconds (time_mod=1535119302, time_now=1535119302, diff=0, size=157108KB). This likely means that another UpdraftPlus run is at work; so we will exit.
1312.065 (2) Rescheduling resumption 3: moving to 1308 seconds from now (1535120612)
1312.069 (2) To decrease the likelihood of overlaps, increasing resumption interval to: 1188 + 120 = 1308
1384.049 (0) The time we have been running (1384) is approaching the resumption interval (1188) – increasing resumption interval to 1415
1385.020 (0) A useful amount of data was added after this amount of zip processing: 228.5 s (normalised: 228.1 s, rate: 112.3 KB/s)
1385.026 (0) The time we have been running (1385) is approaching the resumption interval (1415) – increasing resumption interval to 1416
1385.042 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1500 files added (on-disk size: 205992.4 KB)
1385.057 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1600 files added (on-disk size: 205992.4 KB)
1385.067 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.7 MB, 14585 files batched, 240 (1665) added so far); re-opening (prior size: 205992.4 KB)
1642.685 (0) The time we have been running (1642.7) is approaching the resumption interval (1416) – increasing resumption interval to 1673
1642.689 (0) A useful amount of data was added after this amount of zip processing: 258.2 s (normalised: 251.2 s, rate: 101.9 KB/s)
1642.703 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1700 files added (on-disk size: 231933.4 KB)
1642.717 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1800 files added (on-disk size: 231933.4 KB)
1642.726 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26 MB, 14585 files batched, 192 (1857) added so far); re-opening (prior size: 231933.4 KB)
1924.314 (0) The time we have been running (1924.3) is approaching the resumption interval (1673) – increasing resumption interval to 1955
1924.330 (0) A useful amount of data was added after this amount of zip processing: 281.8 s (normalised: 270.7 s, rate: 94.6 KB/s)
1924.344 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 1900 files added (on-disk size: 258299.4 KB)
1924.355 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.1 MB, 14585 files batched, 124 (1981) added so far); re-opening (prior size: 258299.4 KB)
2234.139 (0) The time we have been running (2234.1) is approaching the resumption interval (1955) – increasing resumption interval to 2265
2234.165 (0) A useful amount of data was added after this amount of zip processing: 310.7 s (normalised: 309.1 s, rate: 82.8 KB/s)
2234.288 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2000 files added (on-disk size: 283639.2 KB)
2234.378 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 112 (2093) added so far); re-opening (prior size: 283639.2 KB)
2560.772 (0) The time we have been running (2560.8) is approaching the resumption interval (2265) – increasing resumption interval to 2591
2562.113 (0) A useful amount of data was added after this amount of zip processing: 328.6 s (normalised: 328.5 s, rate: 77.9 KB/s)
2562.119 (0) The time we have been running (2562.1) is approaching the resumption interval (2591) – increasing resumption interval to 2593
2562.129 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2100 files added (on-disk size: 309109.8 KB)
2562.143 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2200 files added (on-disk size: 309109.8 KB)
2562.151 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.3 MB, 14585 files batched, 157 (2250) added so far); re-opening (prior size: 309109.8 KB)
2919.540 (3) Opened log file at time: Fri, 24 Aug 2018 14:28:32 +0000 on https://mcmahonoconnor.ie/wp
2919.567 (0) The time we have been running (2919.5) is approaching the resumption interval (2593) – increasing resumption interval to 2950
2920.005 (3) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 1.14.13 WP: 4.6.12 PHP: 5.6.37 (cgi-fcgi, Linux lh917.dnsireland.com 3.10.0-714.10.2.lve1.5.17.1.el7.x86_64 #1 SMP Tue May 22 10:39:25 EDT 2018 x86_64) MySQL: 5.6.40 WPLANG: en_US Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 6.6M | 7.3M) multisite: N openssl: OpenSSL 1.0.2o 27 Mar 2018 mcrypt: Y LANG: ZipArchive::addFile: Y
2920.007 (3) Free space on disk containing Updraft’s temporary directory: 339151.2 MB
2920.012 (0) A useful amount of data was added after this amount of zip processing: 358.5 s (normalised: 340.5 s, rate: 75.2 KB/s)
2920.012 (3) Backup run: resumption=3, nonce=3ad7986d905b, begun at=1535117992 (2920s ago), job type=backup
2920.015 (3) Scheduling a resumption (4) after 2593 seconds (1535123505) in case this run gets aborted
2920.035 (3) Checking if we have a zip executable available
2920.037 (3) Creation of backups of directories: had begun; will resume
2920.038 (0) The time we have been running (2920) is approaching the resumption interval (2950) – increasing resumption interval to 2951
2920.043 (3) Beginning creation of dump of plugins (split every: 400 MB)
2920.045 (3) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip: this file has already been created (age: 2720 s)
2920.051 (3) Beginning creation of dump of themes (split every: 400 MB)
2920.052 (3) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip: this file has already been created (age: 2688 s)
2920.059 (3) Exclusion option setting (uploads): wp-clone,snapshots
2920.060 (3) Looking for candidates to backup in: /home/mcmahono/public_html/wp/wp-content/uploads
2920.062 (3) finding files: 2016: adding to list (1)
2920.066 (3) finding files: revslider: adding to list (2)
2920.067 (3) finding files: 2013: adding to list (3)
2920.069 (3) finding files: 2015: adding to list (4)
2920.070 (3) finding files: 2017: adding to list (5)
2920.073 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2300 files added (on-disk size: 335884.6 KB)
2920.075 (3) finding files: 2018: adding to list (6)
2920.076 (3) finding files: 2014: adding to list (7)
2920.078 (3) Beginning creation of dump of uploads (split every: 400 MB)
2920.084 (3) Terminate: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp exists with activity within the last 30 seconds (time_mod=1535120912, time_now=1535120912, diff=0, size=335884.6KB). This likely means that another UpdraftPlus run is at work; so we will exit.
2920.087 (3) Rescheduling resumption 4: moving to 2713 seconds from now (1535123625)
2920.095 (3) To decrease the likelihood of overlaps, increasing resumption interval to: 2593 + 120 = 2713
2920.117 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.1 MB, 14585 files batched, 144 (2394) added so far); re-opening (prior size: 335884.6 KB)
3310.459 (0) The time we have been running (3310.4) is approaching the resumption interval (2951) – increasing resumption interval to 3341
3310.487 (0) A useful amount of data was added after this amount of zip processing: 391 s (normalised: 374.8 s, rate: 68.3 KB/s)
3310.592 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2400 files added (on-disk size: 362405.3 KB)
3310.701 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2500 files added (on-disk size: 362405.3 KB)
3310.765 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2600 files added (on-disk size: 362405.3 KB)
3310.818 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2700 files added (on-disk size: 362405.3 KB)
3310.828 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (31 MB, 14585 files batched, 316 (2710) added so far); re-opening (prior size: 362405.3 KB)
3727.775 (0) The time we have been running (3727.8) is approaching the resumption interval (3341) – increasing resumption interval to 3758
3727.786 (0) A useful amount of data was added after this amount of zip processing: 417.3 s (normalised: 336.3 s, rate: 76.1 KB/s)
3727.810 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads.zip.tmp: 2800 files added (on-disk size: 393814.5 KB)
3727.815 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): possibly approaching split limit (20.6 MB, 108 (2818) files added so far); last ratio: 0.9888; re-opening (prior size: 393814.5 KB)
4155.613 (0) The time we have been running (4155.6) is approaching the resumption interval (3758) – increasing resumption interval to 4186
4155.616 (0) Zip size is at/near split limit (405 MB / 400 MB) – bumping index (from: 0)
4160.930 (0) The time we have been running (4160.9) is approaching the resumption interval (4186) – increasing resumption interval to 4191
4160.933 (0) Created uploads zip (0) – 414685.9 KB in 3923.4 s (105.7 KB/s) (checksums: sha1: dfdcd929a8bddd0e3dadfcc81fcd06cc74358735, sha256: 9212bb7c17f31a5e9a91d374606911b8ceb143e512c6f5dd31ac613e48408ee9)
4160.936 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 2.0 seconds have passed since the last write (0 MB, 1 (2819) files added so far); re-opening (prior size: 0 KB)
4160.946 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (28.5 MB, 14585 files batched, 79 (2898) added so far); re-opening (prior size: 2.7 KB)
4219.357 (0) The time we have been running (4219.4) is approaching the resumption interval (4191) – increasing resumption interval to 4250
4219.372 (0) A useful amount of data was added after this amount of zip processing: 58.9 s (normalised: 51.6 s, rate: 496 KB/s)
4219.376 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 2900 files added (on-disk size: 28942.4 KB)
4219.381 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (30.3 MB, 14585 files batched, 81 (2979) added so far); re-opening (prior size: 28942.4 KB)
4309.364 (0) The time we have been running (4309.4) is approaching the resumption interval (4250) – increasing resumption interval to 4340
4309.463 (0) A useful amount of data was added after this amount of zip processing: 91 s (normalised: 75.1 s, rate: 340.8 KB/s)
4309.468 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3000 files added (on-disk size: 59611.7 KB)
4309.475 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3100 files added (on-disk size: 59611.7 KB)
4309.476 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (27.3 MB, 14585 files batched, 124 (3103) added so far); re-opening (prior size: 59611.7 KB)
4425.276 (0) The time we have been running (4425.3) is approaching the resumption interval (4340) – increasing resumption interval to 4456
4425.348 (0) A useful amount of data was added after this amount of zip processing: 116.9 s (normalised: 107 s, rate: 239.3 KB/s)
4425.357 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (30.1 MB, 14585 files batched, 93 (3196) added so far); re-opening (prior size: 87338.5 KB)
4570.772 (0) The time we have been running (4570.8) is approaching the resumption interval (4456) – increasing resumption interval to 4601
4570.789 (0) A useful amount of data was added after this amount of zip processing: 146.3 s (normalised: 121.4 s, rate: 210.9 KB/s)
4570.793 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3200 files added (on-disk size: 117485.1 KB)
4570.801 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3300 files added (on-disk size: 117485.1 KB)
4570.805 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.6 MB, 14585 files batched, 139 (3335) added so far); re-opening (prior size: 117485.1 KB)
4738.121 (0) The time we have been running (4738.1) is approaching the resumption interval (4601) – increasing resumption interval to 4769
4738.176 (0) A useful amount of data was added after this amount of zip processing: 167.7 s (normalised: 164 s, rate: 156.1 KB/s)
4738.187 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3400 files added (on-disk size: 143255.2 KB)
4738.196 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3500 files added (on-disk size: 143255.2 KB)
4738.198 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (27 MB, 14585 files batched, 176 (3511) added so far); re-opening (prior size: 143255.2 KB)
4932.474 (0) The time we have been running (4932.5) is approaching the resumption interval (4769) – increasing resumption interval to 4963
4934.066 (0) A useful amount of data was added after this amount of zip processing: 196.6 s (normalised: 181.7 s, rate: 140.9 KB/s)
4934.072 (0) The time we have been running (4934.1) is approaching the resumption interval (4963) – increasing resumption interval to 4965
4934.085 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3600 files added (on-disk size: 170414.3 KB)
4934.090 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.6 MB, 14585 files batched, 138 (3649) added so far); re-opening (prior size: 170414.3 KB)
5154.849 (0) The time we have been running (5154.8) is approaching the resumption interval (4965) – increasing resumption interval to 5185
5154.878 (0) A useful amount of data was added after this amount of zip processing: 221.4 s (normalised: 215.8 s, rate: 118.6 KB/s)
5154.888 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3700 files added (on-disk size: 196302.3 KB)
5154.897 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.2 MB, 14585 files batched, 143 (3792) added so far); re-opening (prior size: 196302.3 KB)
5400.884 (0) The time we have been running (5400.9) is approaching the resumption interval (5185) – increasing resumption interval to 5431
5402.368 (0) A useful amount of data was added after this amount of zip processing: 247.9 s (normalised: 236.5 s, rate: 108.2 KB/s)
5402.374 (0) The time we have been running (5402.4) is approaching the resumption interval (5431) – increasing resumption interval to 5433
5402.381 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3800 files added (on-disk size: 222533.3 KB)
5402.391 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.3 MB, 14585 files batched, 95 (3887) added so far); re-opening (prior size: 222533.3 KB)
5675.091 (0) The time we have been running (5675.1) is approaching the resumption interval (5433) – increasing resumption interval to 5706
5675.167 (0) A useful amount of data was added after this amount of zip processing: 273.7 s (normalised: 260.3 s, rate: 98.4 KB/s)
5675.175 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 3900 files added (on-disk size: 249156.6 KB)
5675.187 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4000 files added (on-disk size: 249156.6 KB)
5675.193 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.3 MB, 14585 files batched, 159 (4046) added so far); re-opening (prior size: 249156.6 KB)
5973.281 (0) The time we have been running (5973.3) is approaching the resumption interval (5706) – increasing resumption interval to 6004
5973.322 (0) A useful amount of data was added after this amount of zip processing: 298.8 s (normalised: 283.6 s, rate: 90.3 KB/s)
5973.335 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4100 files added (on-disk size: 275909.3 KB)
5973.345 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (27.6 MB, 14585 files batched, 138 (4184) added so far); re-opening (prior size: 275909.3 KB)
6297.835 (0) The time we have been running (6297.8) is approaching the resumption interval (6004) – increasing resumption interval to 6328
6298.523 (0) A useful amount of data was added after this amount of zip processing: 326 s (normalised: 295.4 s, rate: 86.7 KB/s)
6298.529 (0) The time we have been running (6298.5) is approaching the resumption interval (6328) – increasing resumption interval to 6329
6298.538 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4200 files added (on-disk size: 303774.5 KB)
6298.549 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4300 files added (on-disk size: 303774.5 KB)
6298.556 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 172 (4356) added so far); re-opening (prior size: 303774.5 KB)
6648.225 (0) The time we have been running (6648.2) is approaching the resumption interval (6329) – increasing resumption interval to 6679
6648.228 (0) A useful amount of data was added after this amount of zip processing: 349.7 s (normalised: 349.4 s, rate: 73.3 KB/s)
6648.241 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4400 files added (on-disk size: 329171.5 KB)
6648.253 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.4 MB, 14585 files batched, 130 (4486) added so far); re-opening (prior size: 329171.5 KB)
7023.727 (0) The time we have been running (7023.7) is approaching the resumption interval (6679) – increasing resumption interval to 7054
7023.790 (0) A useful amount of data was added after this amount of zip processing: 376.3 s (normalised: 356.7 s, rate: 71.8 KB/s)
7023.799 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4500 files added (on-disk size: 356050.1 KB)
7023.808 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (32.5 MB, 14585 files batched, 89 (4575) added so far); re-opening (prior size: 356050.1 KB)
7213.532 (4) Opened log file at time: Fri, 24 Aug 2018 15:40:06 +0000 on https://mcmahonoconnor.ie/wp
7215.420 (4) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 1.14.13 WP: 4.6.12 PHP: 5.6.37 (cgi-fcgi, Linux lh917.dnsireland.com 3.10.0-714.10.2.lve1.5.17.1.el7.x86_64 #1 SMP Tue May 22 10:39:25 EDT 2018 x86_64) MySQL: 5.6.40 WPLANG: en_US Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 6.6M | 7.3M) multisite: N openssl: OpenSSL 1.0.2o 27 Mar 2018 mcrypt: Y LANG: ZipArchive::addFile: Y
7217.413 (4) Free space on disk containing Updraft’s temporary directory: 341242.9 MB
7217.416 (4) Backup run: resumption=4, nonce=3ad7986d905b, begun at=1535117992 (7217s ago), job type=backup
7217.419 (4) Scheduling a resumption (5) after 7054 seconds (1535132263) in case this run gets aborted
7219.574 (4) Checking if we have a zip executable available
7221.620 (4) Creation of backups of directories: had begun; will resume
7223.626 (4) Beginning creation of dump of plugins (split every: 400 MB)
7225.624 (4) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-plugins.zip: this file has already been created (age: 7026 s)
7225.628 (4) Beginning creation of dump of themes (split every: 400 MB)
7225.630 (4) backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-themes.zip: this file has already been created (age: 6994 s)
7227.628 (4) Exclusion option setting (uploads): wp-clone,snapshots
7227.633 (4) Looking for candidates to backup in: /home/mcmahono/public_html/wp/wp-content/uploads
7227.635 (4) finding files: 2016: adding to list (1)
7227.638 (4) finding files: revslider: adding to list (2)
7229.623 (4) finding files: 2013: adding to list (3)
7229.624 (4) finding files: 2015: adding to list (4)
7229.626 (4) finding files: 2017: adding to list (5)
7231.623 (4) finding files: 2018: adding to list (6)
7231.624 (4) finding files: 2014: adding to list (7)
7231.626 (4) Beginning creation of dump of uploads (split every: 400 MB)
7233.618 (4) File exists (/home/mcmahono/public_html/wp/wp-content/updraft/backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp), but was apparently not modified within the last 30 seconds, so we assume that any previous run has now terminated (time_mod=1535125016, time_now=1535125224, diff=208)
7233.625 (4) Terminate: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp.9dIJ1J exists with activity within the last 30 seconds (time_mod=1535125226, time_now=1535125224, diff=-2, size=215088KB). This likely means that another UpdraftPlus run is at work; so we will exit.
7233.628 (4) Rescheduling resumption 5: moving to 7174 seconds from now (1535132400)
7235.624 (4) To decrease the likelihood of overlaps, increasing resumption interval to: 7054 + 120 = 7174
7436.377 (0) The time we have been running (7436.4) is approaching the resumption interval (7054) – increasing resumption interval to 7467
7437.656 (0) A useful amount of data was added after this amount of zip processing: 414.2 s (normalised: 319.1 s, rate: 80.2 KB/s)
7437.662 (0) The time we have been running (7437.7) is approaching the resumption interval (7467) – increasing resumption interval to 7468
7437.673 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads2.zip.tmp: 4600 files added (on-disk size: 388959.7 KB)
7437.678 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): possibly approaching split limit (24.2 MB, 57 (4632) files added so far); last ratio: 0.9904; re-opening (prior size: 388959.7 KB)
7867.894 (0) The time we have been running (7867.9) is approaching the resumption interval (7468) – increasing resumption interval to 7898
7867.898 (0) Zip size is at/near split limit (403.8 MB / 400 MB) – bumping index (from: 1)
7873.980 (0) The time we have been running (7874) is approaching the resumption interval (7898) – increasing resumption interval to 7904
7873.984 (0) Created uploads zip (1) – 413524.5 KB in 3707 s (111.6 KB/s) (checksums: sha1: 3936748f855f1a9155fb79958b96d7064fb468cf, sha256: 2a49b02768a9d802e9e4f00a55e4aa24ea6e78f4e4c793d3773bef61af181be6)
7873.987 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 2.0 seconds have passed since the last write (0 MB, 1 (4633) files added so far); re-opening (prior size: 0 KB)
7874.003 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 4700 files added (on-disk size: 5.5 KB)
7874.008 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 4800 files added (on-disk size: 5.5 KB)
7874.011 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.4 MB, 14585 files batched, 188 (4821) added so far); re-opening (prior size: 5.5 KB)
7928.824 (0) The time we have been running (7928.8) is approaching the resumption interval (7904) – increasing resumption interval to 7959
7928.889 (0) A useful amount of data was added after this amount of zip processing: 55.4 s (normalised: 52.6 s, rate: 487.1 KB/s)
7928.897 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 4900 files added (on-disk size: 26782.4 KB)
7928.904 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (27.9 MB, 14585 files batched, 157 (4978) added so far); re-opening (prior size: 26782.4 KB)
8011.324 (0) The time we have been running (8011.3) is approaching the resumption interval (7959) – increasing resumption interval to 8042
8012.514 (0) A useful amount of data was added after this amount of zip processing: 84 s (normalised: 75.2 s, rate: 340.5 KB/s)
8012.521 (0) The time we have been running (8012.5) is approaching the resumption interval (8042) – increasing resumption interval to 8043
8012.526 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5000 files added (on-disk size: 55097.1 KB)
8012.534 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5100 files added (on-disk size: 55097.1 KB)
8012.541 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (26.8 MB, 14585 files batched, 188 (5166) added so far); re-opening (prior size: 55097.1 KB)
8122.278 (0) The time we have been running (8122.3) is approaching the resumption interval (8043) – increasing resumption interval to 8153
8122.294 (0) A useful amount of data was added after this amount of zip processing: 109.8 s (normalised: 102.3 s, rate: 250.3 KB/s)
8122.301 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5200 files added (on-disk size: 82123.7 KB)
8122.311 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5300 files added (on-disk size: 82123.7 KB)
8122.319 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.8 MB, 14585 files batched, 220 (5386) added so far); re-opening (prior size: 82123.7 KB)
8255.340 (0) The time we have been running (8255.3) is approaching the resumption interval (8153) – increasing resumption interval to 8286
8255.343 (0) A useful amount of data was added after this amount of zip processing: 133.9 s (normalised: 129.8 s, rate: 197.2 KB/s)
8255.349 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5400 files added (on-disk size: 108040.5 KB)
8255.358 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5500 files added (on-disk size: 108040.5 KB)
8255.365 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 182 (5568) added so far); re-opening (prior size: 108040.5 KB)
8411.115 (0) The time we have been running (8411.1) is approaching the resumption interval (8286) – increasing resumption interval to 8442
8411.958 (0) A useful amount of data was added after this amount of zip processing: 157.5 s (normalised: 157.4 s, rate: 162.7 KB/s)
8411.967 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5600 files added (on-disk size: 133451.1 KB)
8411.977 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5700 files added (on-disk size: 133451.1 KB)
8411.980 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (31.1 MB, 14585 files batched, 145 (5713) added so far); re-opening (prior size: 133451.1 KB)
8606.929 (0) The time we have been running (8606.9) is approaching the resumption interval (8442) – increasing resumption interval to 8637
8607.119 (0) A useful amount of data was added after this amount of zip processing: 195.6 s (normalised: 157.1 s, rate: 162.9 KB/s)
8607.124 (0) The time we have been running (8607.1) is approaching the resumption interval (8637) – increasing resumption interval to 8638
8607.136 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (28.8 MB, 14585 files batched, 66 (5779) added so far); re-opening (prior size: 165099.6 KB)
8828.583 (0) The time we have been running (8828.6) is approaching the resumption interval (8638) – increasing resumption interval to 8859
8828.641 (0) A useful amount of data was added after this amount of zip processing: 222.2 s (normalised: 193 s, rate: 132.7 KB/s)
8828.650 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5800 files added (on-disk size: 194359.4 KB)
8828.656 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (28.2 MB, 14585 files batched, 73 (5852) added so far); re-opening (prior size: 194359.4 KB)
9079.902 (0) The time we have been running (9079.9) is approaching the resumption interval (8859) – increasing resumption interval to 9110
9079.933 (0) A useful amount of data was added after this amount of zip processing: 251.4 s (normalised: 223 s, rate: 114.8 KB/s)
9079.944 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.6 MB, 14585 files batched, 47 (5899) added so far); re-opening (prior size: 222937.7 KB)
9349.562 (0) The time we have been running (9349.6) is approaching the resumption interval (9110) – increasing resumption interval to 9380
9349.609 (0) A useful amount of data was added after this amount of zip processing: 270.1 s (normalised: 263.6 s, rate: 97.1 KB/s)
9349.617 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 5900 files added (on-disk size: 248991.8 KB)
9349.628 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 6000 files added (on-disk size: 248991.8 KB)
9349.638 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (28.3 MB, 14585 files batched, 185 (6084) added so far); re-opening (prior size: 248991.8 KB)
9651.579 (0) The time we have been running (9651.6) is approaching the resumption interval (9380) – increasing resumption interval to 9682
9651.606 (0) A useful amount of data was added after this amount of zip processing: 302.1 s (normalised: 267.2 s, rate: 95.8 KB/s)
9651.616 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 6100 files added (on-disk size: 277712.6 KB)
9651.629 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 6200 files added (on-disk size: 277712.6 KB)
9651.640 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25 MB, 14585 files batched, 195 (6279) added so far); re-opening (prior size: 277712.6 KB)
10041.646 (0) The time we have been running (10041.6) is approaching the resumption interval (9682) – increasing resumption interval to 10072
10041.650 (0) A useful amount of data was added after this amount of zip processing: 390.2 s (normalised: 389.6 s, rate: 65.7 KB/s)
10041.659 (0) Zip: backup_2018-08-24-1339_McMahon_O039Connor_3ad7986d905b-uploads3.zip.tmp: 6300 files added (on-disk size: 303111.7 KB)
10041.664 (0) Adding batch to zip file (UpdraftPlus_ZipArchive): over 25 MB added on this batch (25.9 MB, 14585 files batched, 54 (6333) added so far); re-opening (prior size: 303111.7 KB)

August 25, 2018 at 4:10 pm #301379

Bryle Crodua
Moderator

Hi,

It shows that the backup process is timed out or killed off.

Please ask your hosts/server admin to investigate their PHP error logs. These logs should contain more information on the exact issue that is causing the backup process to halt.

Kind Regards,
Bryle
Author

Posts

Viewing 2 posts - 1 through 2 (of 2 total)

The topic ‘Backup is taking forever.’ is closed to new replies.