Backup takes too long

[Carlos CopekParticipant]

Hi,

I’m trying to finish backing up my site, I have no problems with other sites, but on this site I had to separate the uploads from the rest as I wasn’t able to finish a complete backup. But still it doesn’t finish. Here’s my log:

0000.000 (0) Opened log file at time: Wed, 04 Dec 2019 16:30:36 +0000 on https://cassagnegiftshop.com
0000.001 (0) UpdraftPlus WordPress backup plugin (https://updraftplus.com): 2.16.20.24 WP: 5.3 PHP: 7.2.25 (litespeed, Linux cloud105.pro-site.pt 3.10.0-962.3.2.lve1.5.24.9.el7.x86_64 #1 SMP Wed Feb 13 08:24:50 EST 2019 x86_64) MySQL: 5.7.28-cll-lve WPLANG: pt_PT Server: Apache safe_mode: 0 max_execution_time: 900 memory_limit: 256M (used: 81.7M | 84.5M) multisite: N openssl: OpenSSL 1.0.2k 26 Jan 2017 mcrypt: N LANG: ZipArchive::addFile: Y
0000.038 (0) Free space on disk containing Updraft’s temporary directory: 347661.5 MB
0000.040 (0) Tasks: Backup files: 1 (schedule: manual) Backup DB: 0 (schedule: manual)
0000.042 (0) Requesting semaphore lock (f) (apparently not via scheduler)
0000.043 (0) Semaphore (f, wpfk_options) was stuck, set lock time to 2019-12-04 16:30:36
0000.044 (0) Semaphore (f, wpfk_options) reset to 1
0000.045 (0) Set semaphore last lock (f) time to 2019-12-04 16:30:36
0000.045 (0) Semaphore lock (f) complete
0000.047 (0) Backup run: resumption=0, nonce=4f5e3c5dc4f8, file_nonce=4f5e3c5dc4f8 begun at=1575477036 (0s ago), job type=backup
0000.048 (0) Scheduling a resumption (1) after 300 seconds (1575477336) in case this run gets aborted
0000.057 (0) Checking if we have a zip executable available
0000.058 (0) Testing: /usr/bin/zip
0000.067 (0) Output: zip warning: binziptest/test.zip not found or empty
0000.068 (0) Output: adding: binziptest/subdir1/ (in=0) (out=0) (stored 0%)
0000.069 (0) Output: adding: binziptest/subdir1/subdir2/ (in=0) (out=0) (stored 0%)
0000.069 (0) Output: adding: binziptest/subdir1/subdir2/test.html (in=131) (out=107) (deflated 18%)
0000.070 (0) Output: total bytes=131, compressed=107 -> 18% savings
0000.081 (0) Output: adding: binziptest/subdir1/subdir2/test2.html (in=138) (out=113) (deflated 18%)
0000.082 (0) Output: total bytes=269, compressed=220 -> 18% savings
0000.089 (0) Working binary zip found: /usr/bin/zip
0000.090 (0) Zip engine: found/will use a binary zip: /usr/bin/zip
0000.091 (0) Creation of backups of directories: beginning
0000.092 (0) No backup of plugins: excluded by user’s options
0000.092 (0) No backup of themes: excluded by user’s options
0000.093 (0) Exclusion option setting (uploads): backup*,*backups,backwpup*,wp-clone,snapshots
0000.094 (0) Looking for candidates to backup in: /home/cassagnegiftshop/public_html/wp-content/uploads
0000.094 (0) finding files: 2019: adding to list (1)
0000.095 (0) finding files: woocommerce_uploads: adding to list (2)
0000.095 (0) finding files: wc-logs: adding to list (3)
0000.096 (0) finding files: woocommerce-placeholder.png: adding to list (4)
0000.096 (0) finding files: woocommerce-placeholder-150×150.png: adding to list (5)
0000.096 (0) finding files: woocommerce-placeholder-300×300.png: adding to list (6)
0000.097 (0) finding files: woocommerce-placeholder-768×768.png: adding to list (7)
0000.097 (0) finding files: woocommerce-placeholder-1024×1024.png: adding to list (8)
0000.098 (0) finding files: woocommerce-placeholder-500×640.png: adding to list (9)
0000.098 (0) Beginning creation of dump of uploads (split every: 40 MB)
0000.168 (0) Total entities for the zip file: 7 directories, 4009 files (0 skipped as non-modified), 294.2 MB
0000.171 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 100 files added (on-disk size: 0 KB)
0000.173 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 200 files added (on-disk size: 0 KB)
0000.175 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 300 files added (on-disk size: 0 KB)
0000.177 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 400 files added (on-disk size: 0 KB)
0000.178 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 25 MB added on this batch (25.8 MB, 4009 files batched, 463 (463) added so far); re-opening (prior size: 0 KB)
0000.348 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: size is now: 25.90 MB
0000.349 (0) A useful amount of data was added after this amount of zip processing: 0.9 s (normalised: 0.9 s, rate: 29668.7 KB/s)
0000.350 (0) Performance is good – will increase the amount of data we attempt to batch (time=0.89024996757507, normalised_time=0.86286238806528, max_time=0.34967303276062, data points known=1, old_max_bytes=26214400, new_max_bytes=41943040)
0000.352 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 500 files added (on-disk size: 26509.1 KB)
0000.354 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: 600 files added (on-disk size: 26509.1 KB)
0000.355 (0) Adding batch to zip file (UpdraftPlus_BinZip): possibly approaching split limit (13.2 MB, 223 (686) files added so far); last ratio: 1; re-opening (prior size: 26509.1 KB)
0000.484 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads.zip.tmp: size is now: 39.10 MB
0000.486 (0) Zip size is at/near split limit (39.1 MB / 40 MB) – bumping index (from: 0)
0001.045 (0) Created uploads zip (0) – 40036.3 KB in 0.4 s (114053.9 KB/s) (checksums: sha1: c37c3db31b7be6870110e5ff89d8518974ebeb0a, sha256: 29222609d2846b66707cd7353cb009bda8bc269dcc547872027b7c2803d2e37e)
0031.150 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 2.0 seconds have passed since the last write (0 MB, 1 (687) files added so far); re-opening (prior size: 0 KB)
0031.158 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: size is now: 0.00 MB
0031.160 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 700 files added (on-disk size: 7 KB)
0031.162 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 800 files added (on-disk size: 7 KB)
0031.164 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 900 files added (on-disk size: 7 KB)
0031.166 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 1000 files added (on-disk size: 7 KB)
0031.168 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 1100 files added (on-disk size: 7 KB)
0031.169 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 500 files added on this batch (25.4 MB, 4009 files batched, 501 (1188) added so far); re-opening (prior size: 7 KB)
0033.028 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: size is now: 25.50 MB
0033.097 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 1200 files added (on-disk size: 26152 KB)
0033.099 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: 1300 files added (on-disk size: 26152 KB)
0033.101 (0) Adding batch to zip file (UpdraftPlus_BinZip): possibly approaching split limit (13.4 MB, 199 (1387) files added so far); last ratio: 1; re-opening (prior size: 26152 KB)
0067.110 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads2.zip.tmp: size is now: 38.90 MB
0067.112 (0) Zip size is at/near split limit (38.9 MB / 40 MB) – bumping index (from: 1)
0069.091 (0) Created uploads zip (1) – 39883.8 KB in 66.1 s (602.9 KB/s) (checksums: sha1: bfa87977cd96e5ececcf56380fa9f8e09621044e, sha256: 0348cffd8a89ba90168f6d82291893a9ea7aab2d7073a1a4d6652a751c96f800)
0069.092 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1400 files added (on-disk size: 0 KB)
0069.094 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1500 files added (on-disk size: 0 KB)
0069.096 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1600 files added (on-disk size: 0 KB)
0069.098 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1700 files added (on-disk size: 0 KB)
0069.100 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1800 files added (on-disk size: 0 KB)
0069.101 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 500 files added on this batch (30.6 MB, 4009 files batched, 501 (1888) added so far); re-opening (prior size: 0 KB)
0100.413 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: size is now: 30.70 MB
0100.415 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 1900 files added (on-disk size: 31466.5 KB)
0100.417 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: 2000 files added (on-disk size: 31466.5 KB)
0100.418 (0) Adding batch to zip file (UpdraftPlus_BinZip): possibly approaching split limit (8.5 MB, 151 (2039) files added so far); last ratio: 1; re-opening (prior size: 31466.5 KB)
0125.995 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads3.zip.tmp: size is now: 39.20 MB
0125.997 (0) Zip size is at/near split limit (39.2 MB / 40 MB) – bumping index (from: 2)
0127.729 (0) Created uploads zip (2) – 40155.4 KB in 56.9 s (705.6 KB/s) (checksums: sha1: 72bda763600670bca7371bdf727eb375e115d06f, sha256: d58fdffaf3907a7893254ee560c246d2ebc96a5812a1d01d23a5e742446538e9)
0127.731 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: 2100 files added (on-disk size: 0 KB)
0127.733 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: 2200 files added (on-disk size: 0 KB)
0127.735 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: 2300 files added (on-disk size: 0 KB)
0127.737 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: 2400 files added (on-disk size: 0 KB)
0127.739 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: 2500 files added (on-disk size: 0 KB)
0127.740 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 40 MB added on this batch (40.1 MB, 4009 files batched, 474 (2513) added so far); re-opening (prior size: 0 KB)
0169.160 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads4.zip.tmp: size is now: 40.20 MB
0169.162 (0) A useful amount of data was added after this amount of zip processing: 43.7 s (normalised: 43.6 s, rate: 938.6 KB/s)
0169.163 (0) Zip size is at/near split limit (40.2 MB / 40 MB) – bumping index (from: 3)
0170.144 (0) Created uploads zip (3) – 41117.2 KB in 41.4 s (992.3 KB/s) (checksums: sha1: dd1bc4d7923e700cc49518cd3aab7aa9e089df11, sha256: 35a504175bac21740b3c33e64c916788643a83391c712873466adea196046fe3)
0170.146 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads5.zip.tmp: 2600 files added (on-disk size: 0 KB)
0170.148 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads5.zip.tmp: 2700 files added (on-disk size: 0 KB)
0170.150 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads5.zip.tmp: 2800 files added (on-disk size: 0 KB)
0170.196 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads5.zip.tmp: 2900 files added (on-disk size: 0 KB)
0170.198 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 40 MB added on this batch (40 MB, 4009 files batched, 422 (2935) added so far); re-opening (prior size: 0 KB)
0213.336 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads5.zip.tmp: size is now: 40.10 MB
0213.338 (0) A useful amount of data was added after this amount of zip processing: 44.9 s (normalised: 44.9 s, rate: 912.7 KB/s)
0213.339 (0) Zip size is at/near split limit (40.1 MB / 40 MB) – bumping index (from: 4)
0214.305 (0) Created uploads zip (4) – 41048.4 KB in 43.2 s (950.3 KB/s) (checksums: sha1: d65a2dc739318783162982220ca5f3214f880684, sha256: b6fc9a59c2207cc3263decc53530f87c2f484fc7b9da52adf1691035a1e95d3b)
0214.307 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads6.zip.tmp: 3000 files added (on-disk size: 0 KB)
0214.309 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads6.zip.tmp: 3100 files added (on-disk size: 0 KB)
0214.311 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads6.zip.tmp: 3200 files added (on-disk size: 0 KB)
0214.313 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads6.zip.tmp: 3300 files added (on-disk size: 0 KB)
0214.315 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 40 MB added on this batch (40.3 MB, 4009 files batched, 409 (3344) added so far); re-opening (prior size: 0 KB)
0255.657 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads6.zip.tmp: size is now: 40.40 MB
0255.659 (0) The scheduled resumption is within 45 seconds – will reschedule
0255.661 (0) Rescheduling resumption 1: moving to 345 seconds from now (1575477637)
0255.663 (0) To decrease the likelihood of overlaps, increasing resumption interval to: 300 + 45 = 345
0255.664 (0) A useful amount of data was added after this amount of zip processing: 43.2 s (normalised: 42.9 s, rate: 955.2 KB/s)
0255.664 (0) Performance is good – but we will not increase the amount of data we batch, as we are already at the present limit (time=43.204715967178, normalised_time=42.879566422899, max_time=255.66399312019, data points known=1, max_bytes=41943040)
0255.666 (0) Zip size is at/near split limit (40.4 MB / 40 MB) – bumping index (from: 5)
0257.226 (0) Created uploads zip (5) – 41348.4 KB in 41.4 s (999.7 KB/s) (checksums: sha1: 1477fe8408c07d554a2343f576db677100ec4e94, sha256: 2f0b284e935321b43a4da19b7c5e52569511f0f5d42cf9bfbb18ffd40d958833)
0257.228 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: 3400 files added (on-disk size: 0 KB)
0257.230 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: 3500 files added (on-disk size: 0 KB)
0257.232 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: 3600 files added (on-disk size: 0 KB)
0257.234 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: 3700 files added (on-disk size: 0 KB)
0257.236 (0) Zip: backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: 3800 files added (on-disk size: 0 KB)
0257.237 (0) Adding batch to zip file (UpdraftPlus_BinZip): over 500 files added on this batch (37.8 MB, 4009 files batched, 501 (3845) added so far); re-opening (prior size: 0 KB)
0297.659 (0) backup_2019-12-04-1630_Cassagne_4f5e3c5dc4f8-uploads7.zip.tmp: size is now: 37.90 MB
0297.662 (0) Adding batch to zip file (UpdraftPlus_BinZip): possibly approaching split limit (2.1 MB, 23 (3868) files added so far); last ratio: 1; re-opening (prior size: 38799.4 KB)

[Bryle CroduaModerator]

Hi,

Please see FAQ – https://updraftplus.com/faqs/how-much-resources-does-updraftplus-need/

Regards,
Bryle

[Author]

Posts