Backup failures and (non) notifications
My (weekly) backups fail about 50% of the time.
From looking at my /backups folder I can see some didn't get uploaded, some didn't seem to complete compressing.
I get no notifications either way.
-
Here's the log from the server
There are 5 accounts to get backed up. 1 of them made it to AWS S3, the second never completed archiving, the other 3 ... no idea.
[root@vps cpbackup]# cat 1704010503.log
[2023-12-31 03:15:03 -0500] info [backup] Setting I/O priority to reduce system load: best-effort: prio 6
[2023-12-31 03:15:03 -0500] info [backup] Pruning metadata for backup at /backup/weekly/2023-12-31
[2023-12-31 03:15:03 -0500] info [backup] Creating metadata index for backup at /backup/weekly/2023-12-31
[2023-12-31 03:15:03 -0500] info [backup] Hard Linking available on "/backup"
[2023-12-31 03:15:03 -0500] info [backup] Running dir & file backup with target : /backup/weekly/2023-12-31/system
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from hard link targets
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: /var/cpanel/dnsadmin/sock: socket ignored
/bin/gtar: /var/cpanel/userhomes/cpanelconnecttrack/p0f.socket: socket ignored
/bin/gtar: Removing leading `/' from hard link targets
/bin/gtar: /var/cpanel/php-fpm/cpanelphpmyadmin/sock: socket ignored
/bin/gtar: /var/cpanel/php-fpm/therapy/sock: socket ignored
/bin/gtar: /var/cpanel/php-fpm/jimlongo/sock: socket ignored
/bin/gtar: /var/cpanel/php-fpm/wanless/sock: socket ignored
/bin/gtar: /var/cpanel/php-fpm/rdiv/sock: socket ignored
/bin/gtar: /var/cpanel/php-fpm/gregbechard/sock: socket ignored
/bin/gtar: /var/cpanel/sessions/cache: file changed as we read it
/bin/gtar returned a non-fatal error code, 1 (Some files differ).
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
/bin/gtar: Removing leading `/' from member names
[2023-12-31 03:16:45 -0500] info [backup] Queuing transport of file: /backup/weekly/2023-12-31/system_files.tar
[2023-12-31 03:16:46 -0500] info [backup] no_transport = 0 .. and queueid = TQ:TaskQueue:361
[2023-12-31 03:16:46 -0500] info [backup] leaving queue_backup_transport_item
[2023-12-31 03:16:46 -0500] info [backup] Queuing deletion of file: /backup/weekly/2023-12-31/system_files.tar
[2023-12-31 03:16:47 -0500] info [backup] no_transport = 0 .. and queueid = TQ:TaskQueue:362
[2023-12-31 03:16:47 -0500] info [backup] leaving queue_backup_transport_item
[2023-12-31 03:16:47 -0500] info [backup] Running account backup with target : /backup/weekly/2023-12-31/accounts
[2023-12-31 03:16:47 -0500] info [backup] checking backup for jimlongo
[2023-12-31 03:16:47 -0500] info [backup] Backups ARE enabled for jimlongo
[2023-12-31 03:16:47 -0500] info [backup] Calling pkgacct under cpuwatch to backup user “jimlongo”
[2023-12-31 03:16:47 -0500] pkgacct started.
[2023-12-31 03:16:47 -0500] pkgacct version 10 - user : jimlongo - tarball: 1 - target mysql : default - split: 0 - incremental: 0 - homedir: 1 - mailman: 1 - backup: 1 - archive version: 4 - running with uid 0
[2023-12-31 03:16:47 -0500] pkgacct using '/usr/local/cpanel/3rdparty/bin/pigz -6 --processes 1 --blocksize 4096 --rsyncable' to compress archives
[2023-12-31 03:16:47 -0500] pkgacct working dir : /backup/weekly/2023-12-31/accounts/jimlongo
[2023-12-31 03:16:47 -0500] Copying Reseller Config...[2023-12-31 03:16:47 -0500] Done
[2023-12-31 03:16:47 -0500] Copying Suspension Info (if needed)...[2023-12-31 03:16:47 -0500] Done
[2023-12-31 03:16:47 -0500] Copying Team Info (if needed)...[2023-12-31 03:16:47 -0500] Done
[2023-12-31 03:16:47 -0500] Copying installed SSL certificates and keys...[2023-12-31 03:16:47 -0500] Performing “ApacheTLS” component....
[2023-12-31 03:16:47 -0500] Completed “ApacheTLS” component.
[2023-12-31 03:16:47 -0500] Done
[2023-12-31 03:16:47 -0500] Copying DKIM keys....[2023-12-31 03:16:48 -0500] Done
[2023-12-31 03:16:48 -0500] Copying Bandwidth Data....[2023-12-31 03:16:48 -0500] Performing “Bandwidth” component....
Summary databases … done!
[2023-12-31 03:16:59 -0500] Completed “Bandwidth” component.
[2023-12-31 03:16:59 -0500] Done
[2023-12-31 03:16:59 -0500] Copying Dns Zones.......royalcanadianbaseballassociation.org......pernosakai.com......jimlongo.com......longobongo.com......thetorontopost.ca......swanseatennis.com......tennislessonsintoronto.com......janisellis.com......versteegdesigns.com......smalltalks.ca......jimjam.ca......allenbydaycare.com...[2023-12-31 03:16:59 -0500] Done
[2023-12-31 03:16:59 -0500] Copying Mail files....[2023-12-31 03:16:59 -0500] Performing “MailConfig” component....
[2023-12-31 03:16:59 -0500] Completed “MailConfig” component.
[2023-12-31 03:16:59 -0500] Done
[2023-12-31 03:16:59 -0500] Copying proftpd file....[2023-12-31 03:16:59 -0500] Done
[2023-12-31 03:16:59 -0500] Performing “Logs” component....
...log file sizes [47467541 byte(s)]......noise.jimlongo.com......allenby.jimlongo.com......tennislessonsintoronto.jimlongo.com-bytes_log......smalltalks.jimlongo.com......thetorontopost.jimlongo.com-bytes_log......swanseatennis.jimlongo.com-bytes_log......rcba.jimlongo.com......janisellis.jimlongo.com-bytes_log......swanseatennis.jimlongo.com......swanseatennis.jimlongo.com-ssl_log......jimlongo.com-bytes_log......longobongo.jimlongo.com-bytes_log......allenby.jimlongo.com-ssl_log......jimjam.jimlongo.com......thetorontopost.jimlongo.com......pernosakai.jimlongo.com......pernosakai.jimlongo.com-bytes_log......jimlongo-popbytes_log......jimjam.jimlongo.com-bytes_log......versteegdesigns.jimlongo.com-bytes_log......photos.janisellis.com-bytes_log......tennislessonsintoronto.jimlongo.com-ssl_log......photos.janisellis.com......longobongo.jimlongo.com......jimlongo-imapbytes_log......allenby.jimlongo.com-bytes_log......versteegdesigns.jimlongo.com......janisellis.jimlongo.com......longobongo.jimlongo.com-ssl_log......tennislessonsintoronto.jimlongo.com......noise.jimlongo.com-bytes_log......smalltalks.jimlongo.com-bytes_log......jimlongo.com......jimlongo.com-ssl_log......rcba.jimlongo.com-bytes_log...[2023-12-31 03:17:00 -0500] Completed “Logs” component.
[2023-12-31 03:17:00 -0500] Copy userdata...[2023-12-31 03:17:00 -0500] Done
[2023-12-31 03:17:00 -0500] Copy custom virtualhost templates...[2023-12-31 03:17:00 -0500] Done
[2023-12-31 03:17:00 -0500] Copying mailman lists and archives....Done copying mailman lists and archives.
[2023-12-31 03:17:00 -0500] Copying homedir.............
.........
.........
.........
.........
[2023-12-31 03:17:23 -0500] Done
[2023-12-31 03:17:23 -0500] Fixing up EA4 .htaccess blocks: /home/jimlongo/public_html/tennislessons/.htaccess /home/jimlongo/public_html/jimlongo/.htaccess /home/jimlongo/public_html/swansea/.htaccess /home/jimlongo/public_html/thetorontopost/.htaccess /home/jimlongo/public_html/rcba_forward/.htaccess /home/jimlongo/public_html/longobongo/.htaccess /home/jimlongo/public_html/jimjam/.htaccess /home/jimlongo/public_html/smalltalks/.htaccess /home/jimlongo/public_html/jimlongo/noise/.htaccess /home/jimlongo/public_html/versteegdesigns/.htaccess /home/jimlongo/public_html/allenby/.htaccess /home/jimlongo/public_html/janisellis/.htaccess /home/jimlongo/public_html/pernosakai/.htaccess Done.
[2023-12-31 03:17:23 -0500] Performing “Mysql” component....
Load watching suspended due to SIGUSR1
[2023-12-31 03:17:23 -0500] Determining mysql dbs...[2023-12-31 03:17:28 -0500] ...mysqldump version: 10.5.23...[2023-12-31 03:17:28 -0500] ...mysql version: 10.5...[2023-12-31 03:17:28 -0500] Saving mysql privs...[2023-12-31 03:17:28 -0500] Done
[2023-12-31 03:17:28 -0500] Saving mysql authentication information...[2023-12-31 03:17:28 -0500] Done
[2023-12-31 03:17:28 -0500] Storing MySQL databases...[2023-12-31 03:17:28 -0500] Storing database jimlongo_allenby
[2023-12-31 03:17:30 -0500] Storing database jimlongo_janisellis
[2023-12-31 03:17:30 -0500] Storing database jimlongo_jimlongo
[2023-12-31 03:17:31 -0500] Storing database jimlongo_kevanstaples
[2023-12-31 03:17:32 -0500] Storing database jimlongo_noise
[2023-12-31 03:17:33 -0500] Storing database jimlongo_pernosakai
[2023-12-31 03:17:34 -0500] Storing database jimlongo_postpro
[2023-12-31 03:17:35 -0500] Storing database jimlongo_smalltalk
[2023-12-31 03:17:36 -0500] Storing database jimlongo_swansea
[2023-12-31 03:17:40 -0500] Storing database jimlongo_tennislessons
[2023-12-31 03:17:41 -0500] Done
[2023-12-31 03:17:41 -0500] ...Done
[2023-12-31 03:17:41 -0500] ...Done
[2023-12-31 03:17:41 -0500] Completed “Mysql” component.
[2023-12-31 03:17:41 -0500] Performing “MysqlRemoteNotes” component....
Load watching resumed due to SIGUSR2
cpuwatch (Sun Dec 31 03:17:41 2023): System load is currently 3.56; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:18:12 2023): System load is currently 3.41, which is below the threshold of 3.50. Continuing …
[2023-12-31 03:18:12 -0500] Completed “MysqlRemoteNotes” component.
[2023-12-31 03:18:12 -0500] Performing “CpUserFile” component....
[2023-12-31 03:18:12 -0500] Completed “CpUserFile” component.
[2023-12-31 03:18:12 -0500] Performing “Cron” component....
[2023-12-31 03:18:12 -0500] Readable crontab file (/var/spool/cron/jimlongo) found; copying …
[2023-12-31 03:18:12 -0500] Completed “Cron” component.
[2023-12-31 03:18:12 -0500] Performing “Quota” component....
[2023-12-31 03:18:12 -0500] Completed “Quota” component.
[2023-12-31 03:18:12 -0500] Performing “Integration” component....
[2023-12-31 03:18:12 -0500] Completed “Integration” component.
[2023-12-31 03:18:12 -0500] Performing “AuthnLinks” component....
[2023-12-31 03:18:12 -0500] Completed “AuthnLinks” component.
[2023-12-31 03:18:12 -0500] Performing “APITokens” component....
[2023-12-31 03:18:12 -0500] Completed “APITokens” component.
[2023-12-31 03:18:12 -0500] Performing “DNSSEC” component....
[2023-12-31 03:18:12 -0500] Completed “DNSSEC” component.
[2023-12-31 03:18:12 -0500] Performing “Custom” component....
[2023-12-31 03:18:12 -0500] No custom components to perform.
[2023-12-31 03:18:12 -0500] Completed “Custom” component.
[2023-12-31 03:18:12 -0500] Performing “AutoSSL” component....
[2023-12-31 03:18:12 -0500] Completed “AutoSSL” component.
[2023-12-31 03:18:12 -0500] Storing Subdomains....
[2023-12-31 03:18:12 -0500] Done
[2023-12-31 03:18:12 -0500] Storing Parked Domains....
[2023-12-31 03:18:12 -0500] Done
[2023-12-31 03:18:12 -0500] Storing Addon Domains....
[2023-12-31 03:18:12 -0500] Performing “Password” component....
[2023-12-31 03:18:12 -0500] Completed “Password” component.
[2023-12-31 03:18:12 -0500] Performing “DigestShadow” component....
[2023-12-31 03:18:12 -0500] Completed “DigestShadow” component.
[2023-12-31 03:18:12 -0500] Copying shell.......[2023-12-31 03:18:12 -0500] Done
[2023-12-31 03:18:12 -0500] Performing “WebCalls” component....
[2023-12-31 03:18:12 -0500] Completed “WebCalls” component.
[2023-12-31 03:18:12 -0500] Performing “BrandCustomizations” component....
[2023-12-31 03:18:12 -0500] Completed “BrandCustomizations” component.
[2023-12-31 03:18:12 -0500] Performing “PublicContact” component....
[2023-12-31 03:18:12 -0500] Completed “PublicContact” component.
[2023-12-31 03:18:12 -0500] Performing “MailLimits” component....
[2023-12-31 03:18:12 -0500] Completed “MailLimits” component.
[2023-12-31 03:18:12 -0500] Performing “LinkedNodes” component....
[2023-12-31 03:18:12 -0500] Completed “LinkedNodes” component.
[2023-12-31 03:18:12 -0500] Creating Archive ....cpuwatch (Sun Dec 31 03:18:41 2023): System load is currently 3.52; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:19:12 2023): System load is currently 3.24, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 03:19:31 2023): System load is currently 3.90; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:20:02 2023): System load is currently 3.42, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 03:20:06 2023): System load is currently 3.54; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:20:37 2023): System load is currently 3.06, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 03:20:41 2023): System load is currently 3.70; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:21:31 2023): System load is currently 3.50, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 03:21:41 2023): System load is currently 3.59; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:22:21 2023): System load is currently 3.39, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 03:22:57 2023): System load is currently 3.87; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:23:28 2023): System load is currently 3.04, which is below the threshold of 3.50. Continuing …
..................................................
..................................................
[2023-12-31 03:28:07 -0500] Done
[2023-12-31 03:28:07 -0500] pkgacctfile is: /backup/weekly/2023-12-31/accounts/jimlongo.tar.gz
[2023-12-31 03:28:07 -0500]
[2023-12-31 03:28:07 -0500] size is: 2175145166
[2023-12-31 03:28:07 -0500]
[2023-12-31 03:28:07 -0500] homesize is: 4212772864
[2023-12-31 03:28:07 -0500]
[2023-12-31 03:28:07 -0500] homefiles is: 127360
[2023-12-31 03:28:07 -0500]
[2023-12-31 03:28:07 -0500] mysqlsize is: 130355477
[2023-12-31 03:28:07 -0500] pkgacct completed
[2023-12-31 03:28:08 -0500] info [backup] Successfully backed up account “jimlongo” to “/backup/weekly/2023-12-31/accounts”
[2023-12-31 03:28:08 -0500] info [backup] Adding metadata information for jimlongo to backup at /backup/weekly/2023-12-31
[2023-12-31 03:28:08 -0500] info [backup] Queuing weekly backup copy of “jimlongo” for transport of “/backup/weekly/2023-12-31/accounts/jimlongo.tar.gz” to “weekly/2023-12-31/accounts/jimlongo.tar.gz”
[2023-12-31 03:28:08 -0500] info [backup] This particular transport will be queued with keep_local = 0 , based on the need to copy weekly (1) and/or monthly () copies as well.
[2023-12-31 03:28:14 -0500] info [backup] Queuing transport of file: /backup/weekly/2023-12-31/accounts/jimlongo.tar.gz
[2023-12-31 03:28:14 -0500] info [backup] no_transport = 0 .. and queueid = TQ:TaskQueue:363
[2023-12-31 03:28:14 -0500] info [backup] leaving queue_backup_transport_item
[2023-12-31 03:28:14 -0500] info [backup] checking backup for rdiv
[2023-12-31 03:28:14 -0500] info [backup] Backups ARE enabled for rdiv
[2023-12-31 03:28:14 -0500] info [backup] Calling pkgacct under cpuwatch to backup user “rdiv”
[2023-12-31 03:28:14 -0500] pkgacct started.
[2023-12-31 03:28:14 -0500] pkgacct version 10 - user : rdiv - tarball: 1 - target mysql : default - split: 0 - incremental: 0 - homedir: 1 - mailman: 1 - backup: 1 - archive version: 4 - running with uid 0
[2023-12-31 03:28:14 -0500] pkgacct using '/usr/local/cpanel/3rdparty/bin/pigz -6 --processes 1 --blocksize 4096 --rsyncable' to compress archives
[2023-12-31 03:28:14 -0500] pkgacct working dir : /backup/weekly/2023-12-31/accounts/rdiv
[2023-12-31 03:28:14 -0500] Copying Reseller Config...[2023-12-31 03:28:14 -0500] Done
[2023-12-31 03:28:14 -0500] Copying Suspension Info (if needed)...[2023-12-31 03:28:14 -0500] Done
[2023-12-31 03:28:14 -0500] Copying Team Info (if needed)...[2023-12-31 03:28:14 -0500] Done
[2023-12-31 03:28:14 -0500] Copying installed SSL certificates and keys...[2023-12-31 03:28:14 -0500] Performing “ApacheTLS” component....
[2023-12-31 03:28:14 -0500] Completed “ApacheTLS” component.
[2023-12-31 03:28:14 -0500] Done
[2023-12-31 03:28:14 -0500] Copying DKIM keys....[2023-12-31 03:28:14 -0500] Done
[2023-12-31 03:28:14 -0500] Copying Bandwidth Data....[2023-12-31 03:28:14 -0500] Performing “Bandwidth” component....
Summary databases … done!
[2023-12-31 03:28:18 -0500] Completed “Bandwidth” component.
[2023-12-31 03:28:18 -0500] Done
[2023-12-31 03:28:18 -0500] Copying Dns Zones.......rdiv.com...[2023-12-31 03:28:18 -0500] Done
[2023-12-31 03:28:18 -0500] Copying Mail files....[2023-12-31 03:28:18 -0500] Performing “MailConfig” component....
[2023-12-31 03:28:18 -0500] Completed “MailConfig” component.
[2023-12-31 03:28:18 -0500] Done
[2023-12-31 03:28:18 -0500] Copying proftpd file....[2023-12-31 03:28:18 -0500] Done
[2023-12-31 03:28:18 -0500] Performing “Logs” component....
...log file sizes [23674032 byte(s)]......sounddog.rdiv.com-bytes_log......raystaples.rdiv.com-bytes_log......jankiewiet.rdiv.com......originals.rdiv.com......fit-and-fab.rdiv.com......dougqueen.rdiv.com-bytes_log......rdiv.com-bytes_log......kevanstaples.rdiv.com......rcba.rdiv.com......fit-and-fab.rdiv.com-bytes_log......thomaslongo.rdiv.com-bytes_log......jankiewiet.rdiv.com-bytes_log......rdiv.com......dougqueen.rdiv.com......raystaples.rdiv.com......sounddog.rdiv.com......rdiv-imapbytes_log......rcba.rdiv.com-bytes_log......thomaslongo.rdiv.com......originals.rdiv.com-bytes_log......kevanstaples.rdiv.com-bytes_log......rdiv.com-ssl_log...[2023-12-31 03:28:19 -0500] Completed “Logs” component.
[2023-12-31 03:28:19 -0500] Copy userdata...[2023-12-31 03:28:19 -0500] Done
[2023-12-31 03:28:19 -0500] Copy custom virtualhost templates...[2023-12-31 03:28:19 -0500] Done
[2023-12-31 03:28:19 -0500] Copying mailman lists and archives.......longo_rdiv.com.mbox...
...longo_rdiv.com...
...longo_rdiv.com...
Done copying mailman lists and archives.
[2023-12-31 03:28:19 -0500] Copying homedir.............
.........
[2023-12-31 03:28:27 -0500] Done
[2023-12-31 03:28:27 -0500] Fixing up EA4 .htaccess blocks: /home/rdiv/public_html/_peeps/rcba/.htaccess /home/rdiv/public_html/_peeps/dougqueen/.htaccess /home/rdiv/public_html/_peeps/originals/.htaccess /home/rdiv/public_html/_peeps/kevanstaples/.htaccess /home/rdiv/public_html/_peeps/thomaslongo/.htaccess /home/rdiv/public_html/_peeps/raystaples/.htaccess /home/rdiv/public_html/_peeps/fitandfab/.htaccess /home/rdiv/public_html/apps/sounddog/.htaccess /home/rdiv/public_html/_peeps/jankiewiet/.htaccess /home/rdiv/public_html/.htaccess Done.
[2023-12-31 03:28:27 -0500] Performing “Mysql” component....
[2023-12-31 03:28:27 -0500] Determining mysql dbs...Load watching suspended due to SIGUSR1
[2023-12-31 03:28:28 -0500] ...mysqldump version: 10.5.23...[2023-12-31 03:28:28 -0500] ...mysql version: 10.5...[2023-12-31 03:28:28 -0500] Saving mysql privs...[2023-12-31 03:28:28 -0500] Done
[2023-12-31 03:28:28 -0500] Saving mysql authentication information...[2023-12-31 03:28:28 -0500] Done
[2023-12-31 03:28:28 -0500] Storing MySQL databases...[2023-12-31 03:28:28 -0500] Storing database rdiv_dougqueen
[2023-12-31 03:28:28 -0500] Storing database rdiv_fitandfab
[2023-12-31 03:28:29 -0500] Storing database rdiv_raystaples
[2023-12-31 03:28:29 -0500] Storing database rdiv_thomaslongo
[2023-12-31 03:28:30 -0500] Storing database rdiv_website
[2023-12-31 03:28:30 -0500] Done
[2023-12-31 03:28:30 -0500] ...Done
[2023-12-31 03:28:30 -0500] ...Done
[2023-12-31 03:28:30 -0500] Completed “Mysql” component.
[2023-12-31 03:28:30 -0500] Performing “MysqlRemoteNotes” component....
Load watching resumed due to SIGUSR2
[2023-12-31 03:28:30 -0500] Completed “MysqlRemoteNotes” component.
[2023-12-31 03:28:30 -0500] Performing “CpUserFile” component....
[2023-12-31 03:28:30 -0500] Completed “CpUserFile” component.
[2023-12-31 03:28:30 -0500] Performing “Cron” component....
[2023-12-31 03:28:30 -0500] Readable crontab file (/var/spool/cron/rdiv) found; copying …
[2023-12-31 03:28:30 -0500] Completed “Cron” component.
[2023-12-31 03:28:30 -0500] Performing “Quota” component....
[2023-12-31 03:28:30 -0500] Completed “Quota” component.
[2023-12-31 03:28:30 -0500] Performing “Integration” component....
[2023-12-31 03:28:30 -0500] Completed “Integration” component.
[2023-12-31 03:28:30 -0500] Performing “AuthnLinks” component....
[2023-12-31 03:28:30 -0500] Completed “AuthnLinks” component.
[2023-12-31 03:28:30 -0500] Performing “APITokens” component....
[2023-12-31 03:28:30 -0500] Completed “APITokens” component.
[2023-12-31 03:28:30 -0500] Performing “DNSSEC” component....
[2023-12-31 03:28:30 -0500] Completed “DNSSEC” component.
[2023-12-31 03:28:30 -0500] Performing “Custom” component....
[2023-12-31 03:28:30 -0500] No custom components to perform.
[2023-12-31 03:28:30 -0500] Completed “Custom” component.
[2023-12-31 03:28:30 -0500] Performing “AutoSSL” component....
[2023-12-31 03:28:30 -0500] Completed “AutoSSL” component.
[2023-12-31 03:28:30 -0500] Storing Subdomains....
[2023-12-31 03:28:30 -0500] Done
[2023-12-31 03:28:30 -0500] Storing Parked Domains....
[2023-12-31 03:28:30 -0500] Done
[2023-12-31 03:28:30 -0500] Storing Addon Domains....
[2023-12-31 03:28:30 -0500] Performing “Password” component....
[2023-12-31 03:28:30 -0500] Completed “Password” component.
[2023-12-31 03:28:30 -0500] Performing “DigestShadow” component....
[2023-12-31 03:28:30 -0500] Completed “DigestShadow” component.
[2023-12-31 03:28:30 -0500] Copying shell.......[2023-12-31 03:28:30 -0500] Done
[2023-12-31 03:28:30 -0500] Performing “WebCalls” component....
[2023-12-31 03:28:30 -0500] Completed “WebCalls” component.
[2023-12-31 03:28:30 -0500] Performing “BrandCustomizations” component....
[2023-12-31 03:28:30 -0500] Completed “BrandCustomizations” component.
[2023-12-31 03:28:30 -0500] Performing “PublicContact” component....
[2023-12-31 03:28:30 -0500] Completed “PublicContact” component.
[2023-12-31 03:28:30 -0500] Performing “MailLimits” component....
[2023-12-31 03:28:30 -0500] Completed “MailLimits” component.
[2023-12-31 03:28:30 -0500] Performing “LinkedNodes” component....
[2023-12-31 03:28:30 -0500] Completed “LinkedNodes” component.
[2023-12-31 03:28:30 -0500] Creating Archive ......................................................cpuwatch (Sun Dec 31 03:31:17 2023): System load is currently 3.62; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:31:48 2023): System load is currently 3.38, which is below the threshold of 3.50. Continuing …
..............................
..................................................cpuwatch (Sun Dec 31 03:35:52 2023): System load is currently 3.69; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:36:23 2023): System load is currently 2.88, which is below the threshold of 3.50. Continuing …
..............................
....................cpuwatch (Sun Dec 31 03:38:46 2023): System load is currently 3.51; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:41:07 2023): System load is currently 3.45, which is below the threshold of 3.50. Continuing …
........................................cpuwatch (Sun Dec 31 03:43:01 2023): System load is currently 3.54; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:43:36 2023): System load is currently 3.40, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 03:43:56 2023): System load is currently 3.69; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:44:27 2023): System load is currently 3.10, which is below the threshold of 3.50. Continuing …
....................
cpuwatch (Sun Dec 31 03:45:17 2023): System load is currently 3.70; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:45:48 2023): System load is currently 3.13, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 03:46:07 2023): System load is currently 4.14; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:46:38 2023): System load is currently 3.43, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 03:46:42 2023): System load is currently 3.64; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:47:13 2023): System load is currently 2.74, which is below the threshold of 3.50. Continuing …
....................cpuwatch (Sun Dec 31 03:48:27 2023): System load is currently 3.88; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:48:58 2023): System load is currently 2.85, which is below the threshold of 3.50. Continuing …
..................................................
........................................cpuwatch (Sun Dec 31 03:53:32 2023): System load is currently 3.63; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:54:27 2023): System load is currently 3.32, which is below the threshold of 3.50. Continuing …
..............................
[2023-12-31 03:55:33 -0500] Done
[2023-12-31 03:55:33 -0500] pkgacctfile is: /backup/weekly/2023-12-31/accounts/rdiv.tar.gz
[2023-12-31 03:55:33 -0500]
[2023-12-31 03:55:33 -0500] size is: 5957493892
[2023-12-31 03:55:33 -0500]
[2023-12-31 03:55:33 -0500] homesize is: 9499021312
[2023-12-31 03:55:33 -0500]
[2023-12-31 03:55:33 -0500] homefiles is: 108756
[2023-12-31 03:55:33 -0500]
[2023-12-31 03:55:33 -0500] mysqlsize is: 12736896
[2023-12-31 03:55:33 -0500] pkgacct completed
[2023-12-31 03:55:33 -0500] info [backup] Successfully backed up account “rdiv” to “/backup/weekly/2023-12-31/accounts”
[2023-12-31 03:55:33 -0500] info [backup] Adding metadata information for rdiv to backup at /backup/weekly/2023-12-31
[2023-12-31 03:55:33 -0500] info [backup] Queuing weekly backup copy of “rdiv” for transport of “/backup/weekly/2023-12-31/accounts/rdiv.tar.gz” to “weekly/2023-12-31/accounts/rdiv.tar.gz”
[2023-12-31 03:55:33 -0500] info [backup] This particular transport will be queued with keep_local = 0 , based on the need to copy weekly (1) and/or monthly () copies as well.
[2023-12-31 03:55:52 -0500] info [backup] Queuing transport of file: /backup/weekly/2023-12-31/accounts/rdiv.tar.gz
[2023-12-31 03:55:52 -0500] info [backup] no_transport = 0 .. and queueid = TQ:TaskQueue:364
[2023-12-31 03:55:53 -0500] info [backup] leaving queue_backup_transport_item
[2023-12-31 03:55:53 -0500] info [backup] checking backup for wanless
[2023-12-31 03:55:53 -0500] info [backup] Backups ARE enabled for wanless
[2023-12-31 03:55:53 -0500] info [backup] Calling pkgacct under cpuwatch to backup user “wanless”
[2023-12-31 03:55:53 -0500] pkgacct started.
[2023-12-31 03:55:53 -0500] pkgacct version 10 - user : wanless - tarball: 1 - target mysql : default - split: 0 - incremental: 0 - homedir: 1 - mailman: 1 - backup: 1 - archive version: 4 - running with uid 0
[2023-12-31 03:55:53 -0500] pkgacct using '/usr/local/cpanel/3rdparty/bin/pigz -6 --processes 1 --blocksize 4096 --rsyncable' to compress archives
[2023-12-31 03:55:53 -0500] pkgacct working dir : /backup/weekly/2023-12-31/accounts/wanless
[2023-12-31 03:55:53 -0500] Copying Reseller Config...[2023-12-31 03:55:53 -0500] Done
[2023-12-31 03:55:53 -0500] Copying Suspension Info (if needed)...[2023-12-31 03:55:53 -0500] Done
[2023-12-31 03:55:53 -0500] Copying Team Info (if needed)...[2023-12-31 03:55:53 -0500] Done
[2023-12-31 03:55:53 -0500] Copying installed SSL certificates and keys...[2023-12-31 03:55:53 -0500] Performing “ApacheTLS” component....
[2023-12-31 03:55:53 -0500] Completed “ApacheTLS” component.
[2023-12-31 03:55:53 -0500] Done
[2023-12-31 03:55:53 -0500] Copying DKIM keys....[2023-12-31 03:55:53 -0500] Done
[2023-12-31 03:55:53 -0500] Copying Bandwidth Data....[2023-12-31 03:55:53 -0500] Performing “Bandwidth” component....
Summary databases … done!
[2023-12-31 03:56:01 -0500] Completed “Bandwidth” component.
[2023-12-31 03:56:01 -0500] Done
[2023-12-31 03:56:01 -0500] Copying Dns Zones.......wanlesstennis.com...[2023-12-31 03:56:01 -0500] Done
[2023-12-31 03:56:01 -0500] Copying Mail files....[2023-12-31 03:56:01 -0500] Performing “MailConfig” component....
[2023-12-31 03:56:01 -0500] Completed “MailConfig” component.
[2023-12-31 03:56:01 -0500] Done
[2023-12-31 03:56:01 -0500] Copying proftpd file....[2023-12-31 03:56:01 -0500] Done
[2023-12-31 03:56:01 -0500] Performing “Logs” component....
...log file sizes [617637445 byte(s)]......register.wanlesstennis.com............
...register.wanlesstennis.com-bytes_log......wanlesstennis.com-ssl_log......wanlesstennis.com......wanlesstennis.com-bytes_log......members.wanlesstennis.com-ssl_log......members.wanlesstennis.com-bytes_log......wanless-imapbytes_log......members.wanlesstennis.com......register.wanlesstennis.com-ssl_log...[2023-12-31 03:56:05 -0500] Completed “Logs” component.
[2023-12-31 03:56:05 -0500] Copy userdata...[2023-12-31 03:56:05 -0500] Done
[2023-12-31 03:56:05 -0500] Copy custom virtualhost templates...[2023-12-31 03:56:05 -0500] Done
[2023-12-31 03:56:05 -0500] Copying mailman lists and archives....Done copying mailman lists and archives.
[2023-12-31 03:56:05 -0500] Copying homedir.............
.........
[2023-12-31 03:56:15 -0500] Done
[2023-12-31 03:56:15 -0500] Fixing up EA4 .htaccess blocks: /home/wanless/public_html/forums/.htaccess /home/wanless/public_html/.htaccess /home/wanless/public_html/wanless_register/.htaccess Done.
[2023-12-31 03:56:15 -0500] Performing “Mysql” component....
Load watching suspended due to SIGUSR1
[2023-12-31 03:56:15 -0500] Determining mysql dbs...[2023-12-31 03:56:16 -0500] ...mysqldump version: 10.5.23...[2023-12-31 03:56:16 -0500] ...mysql version: 10.5...[2023-12-31 03:56:16 -0500] Saving mysql privs...[2023-12-31 03:56:16 -0500] Done
[2023-12-31 03:56:16 -0500] Saving mysql authentication information...[2023-12-31 03:56:16 -0500] Done
[2023-12-31 03:56:16 -0500] Storing MySQL databases...[2023-12-31 03:56:16 -0500] Storing database wanless_newz
[2023-12-31 03:56:19 -0500] Storing database wanless_phpBB
[2023-12-31 03:56:19 -0500] Storing database wanless_store
[2023-12-31 03:56:20 -0500] Storing database wanless_website
[2023-12-31 03:56:22 -0500] Done
[2023-12-31 03:56:22 -0500] ...Done
[2023-12-31 03:56:22 -0500] ...Done
[2023-12-31 03:56:22 -0500] Completed “Mysql” component.
[2023-12-31 03:56:22 -0500] Performing “MysqlRemoteNotes” component....
Load watching resumed due to SIGUSR2
cpuwatch (Sun Dec 31 03:56:22 2023): System load is currently 3.57; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:56:53 2023): System load is currently 2.69, which is below the threshold of 3.50. Continuing …
[2023-12-31 03:56:53 -0500] Completed “MysqlRemoteNotes” component.
[2023-12-31 03:56:53 -0500] Performing “CpUserFile” component....
[2023-12-31 03:56:53 -0500] Completed “CpUserFile” component.
[2023-12-31 03:56:53 -0500] Performing “Cron” component....
[2023-12-31 03:56:53 -0500] Readable crontab file (/var/spool/cron/wanless) found; copying …
[2023-12-31 03:56:53 -0500] Completed “Cron” component.
[2023-12-31 03:56:53 -0500] Performing “Quota” component....
[2023-12-31 03:56:53 -0500] Completed “Quota” component.
[2023-12-31 03:56:53 -0500] Performing “Integration” component....
[2023-12-31 03:56:53 -0500] Completed “Integration” component.
[2023-12-31 03:56:53 -0500] Performing “AuthnLinks” component....
[2023-12-31 03:56:53 -0500] Completed “AuthnLinks” component.
[2023-12-31 03:56:53 -0500] Performing “APITokens” component....
[2023-12-31 03:56:53 -0500] Completed “APITokens” component.
[2023-12-31 03:56:53 -0500] Performing “DNSSEC” component....
[2023-12-31 03:56:53 -0500] Completed “DNSSEC” component.
[2023-12-31 03:56:53 -0500] Performing “Custom” component....
[2023-12-31 03:56:53 -0500] No custom components to perform.
[2023-12-31 03:56:53 -0500] Completed “Custom” component.
[2023-12-31 03:56:53 -0500] Performing “AutoSSL” component....
[2023-12-31 03:56:53 -0500] Completed “AutoSSL” component.
[2023-12-31 03:56:53 -0500] Storing Subdomains....
[2023-12-31 03:56:53 -0500] Done
[2023-12-31 03:56:53 -0500] Storing Parked Domains....
[2023-12-31 03:56:53 -0500] Done
[2023-12-31 03:56:53 -0500] Storing Addon Domains....
[2023-12-31 03:56:53 -0500] Performing “Password” component....
[2023-12-31 03:56:53 -0500] Completed “Password” component.
[2023-12-31 03:56:53 -0500] Performing “DigestShadow” component....
[2023-12-31 03:56:53 -0500] Completed “DigestShadow” component.
[2023-12-31 03:56:53 -0500] Copying shell.......[2023-12-31 03:56:53 -0500] Done
[2023-12-31 03:56:53 -0500] Performing “WebCalls” component....
[2023-12-31 03:56:53 -0500] Completed “WebCalls” component.
[2023-12-31 03:56:53 -0500] Performing “BrandCustomizations” component....
[2023-12-31 03:56:53 -0500] Completed “BrandCustomizations” component.
[2023-12-31 03:56:53 -0500] Performing “PublicContact” component....
[2023-12-31 03:56:53 -0500] Completed “PublicContact” component.
[2023-12-31 03:56:53 -0500] Performing “MailLimits” component....
[2023-12-31 03:56:53 -0500] Completed “MailLimits” component.
[2023-12-31 03:56:53 -0500] Performing “LinkedNodes” component....
[2023-12-31 03:56:53 -0500] Completed “LinkedNodes” component.
[2023-12-31 03:56:53 -0500] Creating Archive ............................................cpuwatch (Sun Dec 31 03:59:12 2023): System load is currently 3.89; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 03:59:43 2023): System load is currently 3.26, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 04:00:01 2023): System load is currently 3.52; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:00:32 2023): System load is currently 2.94, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 04:01:22 2023): System load is currently 3.53; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:01:53 2023): System load is currently 2.83, which is below the threshold of 3.50. Continuing …
....................
..........cpuwatch (Sun Dec 31 04:03:07 2023): System load is currently 3.52; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:03:38 2023): System load is currently 2.59, which is below the threshold of 3.50. Continuing …
..............................cpuwatch (Sun Dec 31 04:05:07 2023): System load is currently 3.62; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:05:38 2023): System load is currently 2.90, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 04:06:07 2023): System load is currently 3.59; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:06:38 2023): System load is currently 2.80, which is below the threshold of 3.50. Continuing …
..............................
..........cpuwatch (Sun Dec 31 04:08:37 2023): System load is currently 3.59; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:09:08 2023): System load is currently 3.27, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 04:09:17 2023): System load is currently 3.63; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:09:48 2023): System load is currently 3.15, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 04:10:02 2023): System load is currently 3.92; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:10:33 2023): System load is currently 3.30, which is below the threshold of 3.50. Continuing …
....................cpuwatch (Sun Dec 31 04:11:12 2023): System load is currently 4.39; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:11:52 2023): System load is currently 3.41, which is below the threshold of 3.50. Continuing …
..................................................
..............................cpuwatch (Sun Dec 31 04:15:47 2023): System load is currently 3.54; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:16:18 2023): System load is currently 3.27, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 04:16:22 2023): System load is currently 3.64; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:16:53 2023): System load is currently 3.28, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 04:17:02 2023): System load is currently 4.10; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:17:33 2023): System load is currently 3.37, which is below the threshold of 3.50. Continuing …
..........cpuwatch (Sun Dec 31 04:18:02 2023): System load is currently 3.77; waiting for it to go down below 3.50 to continue …
cpuwatch (Sun Dec 31 04:18:33 2023): System load is currently 3.50, which is below the threshold of 3.50. Continuing …
cpuwatch (Sun Dec 31 04:18:42 2023): System load is currently 4.14; waiting for it to go down below 3.50 to continue …0 -
Hey there! It seems your server load is reaching a threshold that is too high for the backup to process. If you know this isn't the case and have plenty of resources, you can adjust this value in WHM >> Tweak Settings to resolve this issue:
https://support.cpanel.net/hc/en-us/articles/360049877314-Prevent-slow-backups-due-to-high-load
0 -
Thanks, increased that and got through the backup last night.
However I still don't receive any backup notification. Checked the mail logs there is nothing sent around 4:17
The log ends with the lines
[2024-01-02 04:17:16 -0500] info [backup] leaving queue_backup_transport_item
[2024-01-02 04:17:16 -0500] info [backup] Completed at Tue Jan 2 04:17:16 2024
[2024-01-02 04:17:16 -0500] info [backup] Final state is Backup::Success (0)
[2024-01-02 04:17:16 -0500] info [backup] Sent Backup::Success notification.0 -
That looks good to me, so not receiving a notification could be a separate issue. Usually I would expect an email to have the subject of "[hostname] The backup process completed." Do you see anything in the mail logs with this command that could be the notification being sent?
grep -i backup /var/log/exim_mainlog0 -
No there is nothing in the logs like that.
0 -
Inside WHM >> Contact Manager, is the "Backup Successful" option set to a priority that will receive email alerts? If so, this is one of those "it should just work" type of things. The last line of the log does indicate that it's trying to send the notification, so it's odd that you don't see it in the mail log.
Is there a backup in the mail queue maybe?
I'm just trying to think of alternate reasons why the message wouldn't exist.
0 -
Thanks, that looks like it. I've reviewed this and changed it. I'll see on the next backup.
0 -
Hopefully that does the trick!
0
Please sign in to leave a comment.
Comments
8 comments