Cron scheduling

Summary
I am not having any luck using a cron expression in DEFAULT_BACKUP_BEGIN. I was trying to use 0 5,17 * * *  and I tired * 5 * * * both of which just cause the backup to start immediately when the container is started. If I go back to just using HHMM everything works.
Steps to reproduce
Put a valid cron value into the DEFAULT_BACKUP_BEGIN environment variable
What is the expected correct behavior?
cron schedule should be implements
Relevant logs and/or screenshots
seq: invalid floating point argument: ‘#Generating’
Try 'seq --help' for more information.
/assets/functions/10-db-backup: line 1957: [: : integer expression expected
/assets/functions/10-db-backup: line 1961: [: : integer expression expected
date: invalid date ‘2023-00-12T00:00:00’
date: invalid date ‘@’
seq: invalid floating point argument: ‘#Generating’
Try 'seq --help' for more information.
/assets/functions/10-db-backup: line 1957: [: : integer expression expected
/assets/functions/10-db-backup: line 1961: [: : integer expression expected
date: invalid date ‘2023-00-12T00:00:00’
date: invalid date ‘@’
                                                                       ,---.
,--------.,--.                 ,--.            ,---.    ,--. ,--------.|   |
'--.  .--'`--',--.--. ,---.  ,-|  |     ,---. /  .-'    |  | '--.  .--'|  .'
   |  |   ,--.|  .--'| .-. :' .-. |    | .-. ||  `-,    |  |    |  |   |  |
   |  |   |  ||  |   \   --.\ `-' |    ' '-' '|  .-'    |  |.--.|  |   `--'
   `--'   `--'`--'    `----' `---'      `---' `--'      `--''--'`--'   .--.
                                                                       '--'
Image:  tiredofit/db-backup | Version  4.0.12 Type 'image_changelog' for details
Repository/Documentation: https://github.com/tiredofit/docker-db-backup/

If this image provides you value  - Consider sponsoring my work for continued
development, timely updates, and feature requests. Commercial support available.

                    More Info:  https://www.tiredofit.ca

2023-11-12.16:31:24 [NOTICE] ** [scheduling] Container configured for scheduled tasks with 'cron'
2023-11-12.16:31:25 [STARTING] ** [scheduling] [1] Starting cron
2023-11-12.16:31:26 [INFO] ** [01-mariadb__ALL] Next Backup at
2023-11-12.16:31:26 [NOTICE] ** [01-mariadb__ALL] Executing pre backup custom script : '/assets/scripts/mariadb/pre/mariadb-prescript.sh'
OK2023-11-12.16:31:26 [NOTICE] ** [01-mariadb__ALL] Dumping MySQL/MariaDB database: 'authelia' and compressing with 'gzip'

Environment

Image version / tag:  4.0.12
Host OS: unraid

Any logs | docker-compose.yml

Possible fixes

If you add DEBUG_TIMER=TRUE to your environment variable there should be some more output that I can try to parse through?

I have a more detailed log for you @tiredofit:
                                                                       ,---.
,--------.,--.                 ,--.            ,---.    ,--. ,--------.|   |
'--.  .--'`--',--.--. ,---.  ,-|  |     ,---. /  .-'    |  | '--.  .--'|  .'
   |  |   ,--.|  .--'| .-. :' .-. |    | .-. ||  `-,    |  |    |  |   |  |
   |  |   |  ||  |   \   --.\ `-' |    ' '-' '|  .-'    |  |.--.|  |   `--'
   `--'   `--'`--'    `----' `---'      `---' `--'      `--''--'`--'   .--.
                                                                       '--'
Image:  tiredofit/db-backup | Version  4.0.18 Type 'image_changelog' for details
Repository/Documentation: https://github.com/tiredofit/docker-db-backup/

If this image provides you value  - Consider sponsoring my work for continued
development, timely updates, and feature requests. Commercial support available.

                    More Info:  https://www.tiredofit.ca

2023-11-20.10:47:31 [NOTICE] ** [timezone] Timezone: Setting to 'Etc/UTC' from 'Etc/GMT'
2023-11-20.10:47:32 [NOTICE] ** [scheduling] Container configured for scheduled tasks with 'cron'
2023-11-20.10:47:32 [NOTICE] ** [messaging] Container configured to route mail via SMTP to 'postfix-relay'
2023-11-20.10:47:33 [STARTING] ** [scheduling] [1] Starting cron
/assets/functions/10-db-backup: line 1903: [: : integer expression expected
seq: invalid floating point argument: ‘#Generating’
Try 'seq --help' for more information.
/assets/functions/10-db-backup: line 1964: [: : integer expression expected
/assets/functions/10-db-backup: line 1968: [: : integer expression expected
date: invalid date ‘2023-00-26T00:00:00’
date: invalid date ‘@’
2023-11-20.10:47:35 [INFO] ** [01-gse-database__gse] Next Backup at
2023-11-20.10:47:35 [NOTICE] ** [01-gse-database__gse] Executing pre backup custom script : '/assets/scripts/pre/00_clean_flyway_history.sh'
2023-11-20.10:47:35 [NOTICE] ** [01-gse-database__gse] Dumping MySQL/MariaDB database: 'gse' and compressing with 'gzip'
mysqldump: Error: 'Access denied; you need (at least one of) the PROCESS privilege(s) for this operation' when trying to dump tablespaces
2023-11-20.10:47:51 [INFO] ** [01-gse-database__gse] DB Backup of 'mysql_gse_gse-database_20231120-104735.sql.gz' completed successfully
2023-11-20.10:47:51 [NOTICE] ** [01-gse-database__gse] Generating SHA1 sum for 'mysql_gse_gse-database_20231120-104735.sql.gz'
2023-11-20.10:47:52 [NOTICE] ** [01-gse-database__gse] Backup of 'mysql_gse_gse-database_20231120-104735.sql.gz' created with the size of 335600144 bytes
2023-11-20.10:47:52 [NOTICE] ** [01-gse-database__gse] Executing post backup custom script : '/assets/scripts/post/00_upload_dump.sh'
Compressing database backups into single archive...
tar: removing leading '/' from member names
backup/latest-mysql_all_gse-database

The CRON value I used was 0 0 * * *. Reverting back to the absolute format (0000) works as intended.

Thanks for the output - 4.0.19 will resolve this for you. As also referenced in #289 step values ie */5 are not functioning, but the value you used will work just fine.
Let me know if this starts working again..

@tiredofit I'm still having this issue with version 4.0.20 and this cron
DB02_BACKUP_BEGIN="0 * * * *"
The issue is:

backup start immediately after the container start
backup start immediately after the previous backup and keeps looping like that to infinite

@tiredofit I'm still having this issue with version 4.0.20 and this cron
DB02_BACKUP_BEGIN="0 * * * *"
The issue is:

backup start immediately after the container start
backup start immediately after the previous backup and keeps looping like that to infinite

I observed the exact same issue in 4.0.22, although I used my CRON from before (0 0 * * *). Here's a detailed log:
2023-11-27T08:41:43.274503458Z + output_off
2023-11-27T08:41:43.274541989Z + '[' true = true ']'
2023-11-27T08:41:43.274546050Z + set +x
2023-11-27T08:41:43.294568030Z                                                                        ,---.
2023-11-27T08:41:43.294590016Z ,--------.,--.                 ,--.            ,---.    ,--. ,--------.|   |
2023-11-27T08:41:43.294593680Z '--.  .--'`--',--.--. ,---.  ,-|  |     ,---. /  .-'    |  | '--.  .--'|  .'
2023-11-27T08:41:43.294596203Z    |  |   ,--.|  .--'| .-. :' .-. |    | .-. ||  `-,    |  |    |  |   |  |
2023-11-27T08:41:43.294598239Z    |  |   |  ||  |   \   --.\ `-' |    ' '-' '|  .-'    |  |.--.|  |   `--'
2023-11-27T08:41:43.294600783Z    `--'   `--'`--'    `----' `---'      `---' `--'      `--''--'`--'   .--.
2023-11-27T08:41:43.294603154Z                                                                        '--'
2023-11-27T08:41:43.294605173Z Image:  tiredofit/db-backup | Version  4.0.22 Type 'image_changelog' for details
2023-11-27T08:41:43.294607468Z Repository/Documentation: https://github.com/tiredofit/docker-db-backup/
2023-11-27T08:41:43.294609508Z
2023-11-27T08:41:43.296656312Z If this image provides you value  - Consider sponsoring my work for continued
2023-11-27T08:41:43.296676690Z development, timely updates, and feature requests. Commercial support available.
2023-11-27T08:41:43.296680314Z
2023-11-27T08:41:43.296682469Z                     More Info:  https://www.tiredofit.ca
2023-11-27T08:41:43.296864916Z
2023-11-27T08:41:43.316291564Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/00-startup ** [container-init] Creating Logrotate Entry for /var/log/container//container.log
2023-11-27T08:41:43.341411121Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/00-startup ** [container-init] Cold Container startup detected - Proceeding to initialize services normally
2023-11-27T08:41:43.367006046Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/00-startup ** [container-init] Adding shortcuts to .bashrc
2023-11-27T08:41:43.397072641Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/00-startup ** [container-init] Adding 'changelog' command to .bashrc
2023-11-27T08:41:43.454307152Z + output_off
2023-11-27T08:41:43.454330823Z + '[' true = true ']'
2023-11-27T08:41:43.454333946Z + set +x
2023-11-27T08:41:43.469438441Z 2023-11-27.08:41:43 [NOTICE] /etc/cont-init.d/01-timezone ** [timezone] Timezone: Setting to 'Etc/UTC' from 'Etc/GMT'
2023-11-27T08:41:43.515573104Z + output_off
2023-11-27T08:41:43.515596754Z + '[' true = true ']'
2023-11-27T08:41:43.515600326Z + set +x
2023-11-27T08:41:43.525227672Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/02-permissions ** [permissions] Enabling permissions features
2023-11-27T08:41:43.592267650Z + output_off
2023-11-27T08:41:43.592289025Z + '[' true = true ']'
2023-11-27T08:41:43.592302815Z + set +x
2023-11-27T08:41:43.608852912Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/03-monitoring ** [container] Container: Getting defaults for '03-monitoring'
2023-11-27T08:41:43.651554263Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/03-monitoring ** [container] Container: No functions available for '03-monitoring'
2023-11-27T08:41:43.698848543Z + output_off
2023-11-27T08:41:43.698875772Z + '[' true = true ']'
2023-11-27T08:41:43.698881523Z + set +x
2023-11-27T08:41:43.715534713Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/04-scheduling ** [container] Container: Getting defaults for '04-scheduling'
2023-11-27T08:41:43.746886849Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/04-scheduling ** [container] Container: No functions available for '04-scheduling'
2023-11-27T08:41:43.771643545Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/04-scheduling ** [scheduling] Creating Logrotate Entry for /var/log/cron//cron.log
2023-11-27T08:41:43.852677863Z 2023-11-27.08:41:43 [NOTICE] /etc/cont-init.d/04-scheduling ** [scheduling] Container configured for scheduled tasks with 'cron'
2023-11-27T08:41:43.884735005Z + output_off
2023-11-27T08:41:43.884752664Z + '[' true = true ']'
2023-11-27T08:41:43.884755389Z + set +x
2023-11-27T08:41:43.893208720Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/00-container
2023-11-27T08:41:43.917706259Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/02-permissions
2023-11-27T08:41:43.941947296Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/03-monitoring
2023-11-27T08:41:43.982215892Z 2023-11-27.08:41:43 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/04-scheduling
2023-11-27T08:41:44.015335001Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/05-logging
2023-11-27T08:41:44.048956503Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/06-messaging
2023-11-27T08:41:44.078539146Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/07-firewall
2023-11-27T08:41:44.109844173Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting defaults for /assets/defaults/10-db-backup
2023-11-27T08:41:44.143477869Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [container] Container: Getting functions for /assets/functions/10-db-backup
2023-11-27T08:41:44.184913593Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/05-logging ** [logging] Enabling log rotation
2023-11-27T08:41:44.260964223Z + output_off
2023-11-27T08:41:44.261102932Z + '[' true = true ']'
2023-11-27T08:41:44.261110537Z + set +x
2023-11-27T08:41:44.275302255Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/06-messaging ** [container] Container: Getting defaults for '06-messaging'
2023-11-27T08:41:44.299893467Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/06-messaging ** [container] Container: No functions available for '06-messaging'
2023-11-27T08:41:44.325640746Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/06-messaging ** [messaging] Converting Variable Name SMTP_TLS value to 'Off'
2023-11-27T08:41:44.348014993Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/06-messaging ** [messaging] Converting Variable Name SMTP_STARTTLS value to 'Off'
2023-11-27T08:41:44.370335769Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/06-messaging ** [messaging] Converting Variable Name SMTP_TLSCERTCHECK value to 'Off'
2023-11-27T08:41:44.387400587Z 2023-11-27.08:41:44 [NOTICE] /etc/cont-init.d/06-messaging ** [messaging] Container configured to route mail via SMTP to 'postfix-relay'
2023-11-27T08:41:44.427008304Z + output_off
2023-11-27T08:41:44.427044119Z + '[' true = true ']'
2023-11-27T08:41:44.427047364Z + set +x
2023-11-27T08:41:44.439272935Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/00-container
2023-11-27T08:41:44.467890991Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/02-permissions
2023-11-27T08:41:44.489660493Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/03-monitoring
2023-11-27T08:41:44.516322817Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/04-scheduling
2023-11-27T08:41:44.539210608Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/05-logging
2023-11-27T08:41:44.564691026Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/06-messaging
2023-11-27T08:41:44.588937276Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/07-firewall
2023-11-27T08:41:44.613569703Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting defaults for /assets/defaults/10-db-backup
2023-11-27T08:41:44.639788324Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/07-firewall ** [container] Container: Getting functions for /assets/functions/10-db-backup
2023-11-27T08:41:44.700257766Z + prepare_service single
2023-11-27T08:41:44.700275988Z + '[' -n single ']'
2023-11-27T08:41:44.700278343Z + case "$(dirname "$0")" in
2023-11-27T08:41:44.700712057Z ++ dirname /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.702336432Z + set -a
2023-11-27T08:41:44.702349504Z + get_defaults single
2023-11-27T08:41:44.702352145Z + '[' -n single ']'
2023-11-27T08:41:44.702353883Z + case "${1,,}" in
2023-11-27T08:41:44.702360271Z + case "$(dirname "$0")" in
2023-11-27T08:41:44.702835377Z ++ dirname /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.704415475Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.705656595Z + '[' -f /assets/defaults/10-db-backup ']'
2023-11-27T08:41:44.706088137Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.707252582Z + print_debug 'Container: Getting defaults for '\''10-db-backup'\'''
2023-11-27T08:41:44.707260460Z + output_off
2023-11-27T08:41:44.707262426Z + '[' true = true ']'
2023-11-27T08:41:44.707264365Z + set +x
2023-11-27T08:41:44.714280613Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [container] Container: Getting defaults for '10-db-backup'
2023-11-27T08:41:44.722232915Z + case "$(basename "$0")" in
2023-11-27T08:41:44.722438673Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.723834365Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.725041015Z + source /assets/defaults/10-db-backup
2023-11-27T08:41:44.725050345Z ++ BACKUP_JOB_CONCURRENCY=1
2023-11-27T08:41:44.725052839Z ++ DBBACKUP_USER=dbbackup
2023-11-27T08:41:44.725054486Z ++ DBBACKUP_GROUP=dbbackup
2023-11-27T08:41:44.725056396Z ++ DEFAULT_BACKUP_BEGIN='0 0 * * *'
2023-11-27T08:41:44.725058471Z ++ DEFAULT_BACKUP_INTERVAL=1440
2023-11-27T08:41:44.725060389Z ++ DEFAULT_BACKUP_INTERVAL=1440
2023-11-27T08:41:44.725155780Z ++ DEFAULT_BACKUP_LOCATION=FILESYSTEM
2023-11-27T08:41:44.725164463Z ++ DEFAULT_BLOBXFER_REMOTE_PATH=/docker-db-backup
2023-11-27T08:41:44.725167030Z ++ DEFAULT_CHECKSUM=SHA1
2023-11-27T08:41:44.725169075Z ++ DEFAULT_COMPRESSION=GZ
2023-11-27T08:41:44.725171205Z ++ DEFAULT_COMPRESSION_LEVEL=3
2023-11-27T08:41:44.725172913Z ++ DEFAULT_CREATE_LATEST_SYMLINK=false
2023-11-27T08:41:44.725174519Z ++ DEFAULT_ENABLE_PARALLEL_COMPRESSION=TRUE
2023-11-27T08:41:44.725176410Z ++ DEFAULT_ENCRYPT=FALSE
2023-11-27T08:41:44.725212214Z ++ DEFAULT_FILESYSTEM_PATH=/backup
2023-11-27T08:41:44.725217834Z ++ DEFAULT_FILESYSTEM_PATH_PERMISSION=700
2023-11-27T08:41:44.725346702Z ++ DEFAULT_FILESYSTEM_PERMISSION=600
2023-11-27T08:41:44.725355979Z ++ DEFAULT_FILESYSTEM_ARCHIVE_PATH=/backup/archive/
2023-11-27T08:41:44.725358612Z ++ DEFAULT_LOG_LEVEL=notice
2023-11-27T08:41:44.725368646Z ++ DEFAULT_MYSQL_ENABLE_TLS=FALSE
2023-11-27T08:41:44.725370901Z ++ DEFAULT_MYSQL_EVENTS=TRUE
2023-11-27T08:41:44.725372610Z ++ DEFAULT_MYSQL_MAX_ALLOWED_PACKET=512M
2023-11-27T08:41:44.725374299Z ++ DEFAULT_MYSQL_SINGLE_TRANSACTION=TRUE
2023-11-27T08:41:44.725375867Z ++ DEFAULT_MYSQL_STORED_PROCEDURES=TRUE
2023-11-27T08:41:44.725517741Z ++ DEFAULT_MYSQL_TLS_CA_FILE=/etc/ssl/cert.pem
2023-11-27T08:41:44.725527291Z ++ DEFAULT_MYSQL_TLS_VERIFY=FALSE
2023-11-27T08:41:44.725529540Z ++ DEFAULT_MYSQL_TLS_VERSION=TLSv1.1,TLSv1.2,TLSv1.3
2023-11-27T08:41:44.725531308Z ++ DEFAULT_MSSQL_MODE=database
2023-11-27T08:41:44.725879149Z +++ nproc
2023-11-27T08:41:44.727198941Z ++ DEFAULT_PARALLEL_COMPRESSION_THREADS=12
2023-11-27T08:41:44.727207110Z ++ DEFAULT_RESOURCE_OPTIMIZED=FALSE
2023-11-27T08:41:44.727209830Z ++ DEFAULT_S3_CERT_SKIP_VERIFY=TRUE
2023-11-27T08:41:44.727211496Z ++ DEFAULT_S3_PROTOCOL=https
2023-11-27T08:41:44.727213390Z ++ DEFAULT_SCRIPT_LOCATION_PRE=/assets/scripts/pre/
2023-11-27T08:41:44.727214979Z ++ DEFAULT_SCRIPT_LOCATION_POST=/assets/scripts/post/
2023-11-27T08:41:44.727243857Z ++ DEFAULT_SIZE_VALUE=bytes
2023-11-27T08:41:44.727256714Z ++ DEFAULT_SKIP_AVAILABILITY_CHECK=FALSE
2023-11-27T08:41:44.727379168Z ++ DEFAULT_SPLIT_DB=TRUE
2023-11-27T08:41:44.727385810Z ++ LOG_PATH=/logs
2023-11-27T08:41:44.727388192Z ++ MANUAL_RUN_FOREVER=TRUE
2023-11-27T08:41:44.727389749Z ++ MODE=AUTO
2023-11-27T08:41:44.727391587Z ++ TEMP_PATH=/tmp/backups
2023-11-27T08:41:44.727393176Z ++ '[' -n '' ']'
2023-11-27T08:41:44.727571576Z + get_functions single
2023-11-27T08:41:44.727578303Z + '[' -n single ']'
2023-11-27T08:41:44.727580286Z + case "${1,,}" in
2023-11-27T08:41:44.727581985Z + case "$(dirname "$0")" in
2023-11-27T08:41:44.728054501Z ++ dirname /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.729542095Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.730907430Z + '[' -f /assets/functions/10-db-backup ']'
2023-11-27T08:41:44.731392636Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.732661771Z + print_debug 'Container: Getting functions for '\''10-db-backup'\'''
2023-11-27T08:41:44.732669143Z + output_off
2023-11-27T08:41:44.732671036Z + '[' true = true ']'
2023-11-27T08:41:44.732672786Z + set +x
2023-11-27T08:41:44.739725080Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [container] Container: Getting functions for '10-db-backup'
2023-11-27T08:41:44.748564557Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.749789999Z + source /assets/functions/10-db-backup
2023-11-27T08:41:44.757960587Z + set +a
2023-11-27T08:41:44.757970581Z + prepare_service 03-monitoring
2023-11-27T08:41:44.757973414Z + '[' -n 03-monitoring ']'
2023-11-27T08:41:44.757975465Z + case "$(dirname "$0")" in
2023-11-27T08:41:44.761054463Z ++ dirname /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.762610987Z + set -a
2023-11-27T08:41:44.762621394Z + get_defaults 03-monitoring
2023-11-27T08:41:44.762623813Z + '[' -n 03-monitoring ']'
2023-11-27T08:41:44.762625625Z + case "${1,,}" in
2023-11-27T08:41:44.763732410Z ++ echo 03-monitoring
2023-11-27T08:41:44.763848043Z ++ tr , '\n'
2023-11-27T08:41:44.765440621Z + defaults=03-monitoring
2023-11-27T08:41:44.765448939Z + for d in $defaults
2023-11-27T08:41:44.765451191Z + '[' -f /assets/defaults/03-monitoring ']'
2023-11-27T08:41:44.765453140Z + print_debug 'Container: Getting defaults for 03-monitoring'
2023-11-27T08:41:44.765455158Z + output_off
2023-11-27T08:41:44.765460650Z + '[' true = true ']'
2023-11-27T08:41:44.765462473Z + set +x
2023-11-27T08:41:44.774496431Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [container] Container: Getting defaults for 03-monitoring
2023-11-27T08:41:44.785856683Z + case "${d}" in
2023-11-27T08:41:44.785870921Z + output_off
2023-11-27T08:41:44.785873615Z + '[' true = true ']'
2023-11-27T08:41:44.785875316Z + set +x
2023-11-27T08:41:44.794528887Z + get_functions 03-monitoring
2023-11-27T08:41:44.794547022Z + '[' -n 03-monitoring ']'
2023-11-27T08:41:44.794549695Z + case "${1,,}" in
2023-11-27T08:41:44.795622108Z ++ echo 03-monitoring
2023-11-27T08:41:44.795629901Z ++ tr , '\n'
2023-11-27T08:41:44.797349012Z + functions=03-monitoring
2023-11-27T08:41:44.797361266Z + for f in $functions
2023-11-27T08:41:44.797363691Z + '[' -f /assets/functions/03-monitoring ']'
2023-11-27T08:41:44.797365495Z + print_debug 'Container: No functions available for '\''03-monitoring'\'''
2023-11-27T08:41:44.797367635Z + output_off
2023-11-27T08:41:44.797446338Z + '[' true = true ']'
2023-11-27T08:41:44.797455057Z + set +x
2023-11-27T08:41:44.806930230Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [container] Container: No functions available for '03-monitoring'
2023-11-27T08:41:44.818323101Z + set +a
2023-11-27T08:41:44.818339257Z + PROCESS_NAME=db-backup
2023-11-27T08:41:44.818341957Z + output_off
2023-11-27T08:41:44.818343737Z + '[' true = true ']'
2023-11-27T08:41:44.818346194Z + set +x
2023-11-27T08:41:44.827200023Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [db-backup] Running in Auto / Default Mode - Letting Image control scheduling
2023-11-27T08:41:44.838251106Z + output_on
2023-11-27T08:41:44.838266051Z + '[' true = true ']'
2023-11-27T08:41:44.838269002Z + case "$(basename "$0")" in
2023-11-27T08:41:44.838548404Z ++ basename /etc/cont-init.d/10-db-backup
2023-11-27T08:41:44.840054782Z + set -x
2023-11-27T08:41:44.840066671Z + var_true ''
2023-11-27T08:41:44.840070412Z + '[' '' = true ']'
2023-11-27T08:41:44.840238116Z + '[' '' = yes ']'
2023-11-27T08:41:44.840339366Z + db_backup_container_init
2023-11-27T08:41:44.840344735Z + rm -rf /tmp/.container/db-backup-backups
2023-11-27T08:41:44.841824088Z + echo '0 0 * * * /usr/sbin/logrotate_dbbackup >/dev/null 2>&1'
2023-11-27T08:41:44.841834013Z + touch /tmp/.container/db-backup-backups
2023-11-27T08:41:44.843251009Z + create_schedulers backup
2023-11-27T08:41:44.843259714Z + var_true ''
2023-11-27T08:41:44.843262510Z + '[' '' = true ']'
2023-11-27T08:41:44.843264428Z + '[' '' = yes ']'
2023-11-27T08:41:44.843448849Z + case "${1}" in
2023-11-27T08:41:44.843455874Z + backup
2023-11-27T08:41:44.843955328Z ++ set -o posix
2023-11-27T08:41:44.844319737Z ++ set
2023-11-27T08:41:44.844328561Z ++ grep -Pc '^(DB[0-9]._HOST=|.*MONGO_CUSTOM_URI=)'
2023-11-27T08:41:44.845463072Z + local backup_instances=1
2023-11-27T08:41:44.845473523Z + print_debug '[create_schedulers] Found '\''1'\'' DB_HOST instances'
2023-11-27T08:41:44.845477281Z + output_off
2023-11-27T08:41:44.845479706Z + '[' true = true ']'
2023-11-27T08:41:44.845481601Z + set +x
2023-11-27T08:41:44.854229853Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [db-backup] [create_schedulers] Found '1' DB_HOST instances
2023-11-27T08:41:44.864830218Z + '[' -n '' ']'
2023-11-27T08:41:44.864848325Z + (( instance = 01 ))
2023-11-27T08:41:44.864851098Z + (( instance <= backup_instances ))
2023-11-27T08:41:44.865370963Z ++ printf %02d 1
2023-11-27T08:41:44.865616160Z + instance=01
2023-11-27T08:41:44.865622689Z + cp -R /assets/dbbackup/template-dbbackup /etc/services.available/dbbackup-01
2023-11-27T08:41:44.867378186Z + sed -i 's|{{BACKUP_NUMBER}}|01|g' /etc/services.available/dbbackup-01/run
2023-11-27T08:41:44.869156508Z + '[' auto = manual ']'
2023-11-27T08:41:44.869165218Z + cat
2023-11-27T08:41:44.870733732Z + chmod +x /usr/bin/backup01-now
2023-11-27T08:41:44.872185946Z + '[' 01 = 01 ']'
2023-11-27T08:41:44.872196302Z + touch /usr/bin/backup-now
2023-11-27T08:41:44.873661666Z + chmod +x /usr/bin/backup-now
2023-11-27T08:41:44.875203540Z + cat
2023-11-27T08:41:44.877185552Z ++ echo '01 +1'
2023-11-27T08:41:44.877195412Z ++ bc
2023-11-27T08:41:44.878347721Z + instance=2
2023-11-27T08:41:44.878355907Z + (( 1 ))
2023-11-27T08:41:44.878358064Z + (( instance <= backup_instances ))
2023-11-27T08:41:44.878360865Z + var_true ''
2023-11-27T08:41:44.878363274Z + '[' '' = true ']'
2023-11-27T08:41:44.878467999Z + '[' '' = yes ']'
2023-11-27T08:41:44.878476621Z + create_zabbix dbbackup4
2023-11-27T08:41:44.878556250Z + '[' -n dbbackup4 ']'
2023-11-27T08:41:44.878561831Z + '[' -n '' ']'
2023-11-27T08:41:44.878564062Z + autoregister=dbbackup4
2023-11-27T08:41:44.878565972Z + print_debug 'Adding Zabbix Auto Register configuration for '\''dbbackup4'\'''
2023-11-27T08:41:44.878679837Z + output_off
2023-11-27T08:41:44.878685714Z + '[' true = true ']'
2023-11-27T08:41:44.878687607Z + set +x
2023-11-27T08:41:44.888247314Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/10-db-backup ** [db-backup] Adding Zabbix Auto Register configuration for 'dbbackup4'
2023-11-27T08:41:44.899240109Z + var_true false
2023-11-27T08:41:44.899257714Z + '[' false = true ']'
2023-11-27T08:41:44.899268704Z + '[' false = yes ']'
2023-11-27T08:41:44.899271882Z + liftoff
2023-11-27T08:41:44.899276771Z + output_off
2023-11-27T08:41:44.899279245Z + '[' true = true ']'
2023-11-27T08:41:44.899281117Z + set +x
2023-11-27T08:41:44.928518954Z + output_off
2023-11-27T08:41:44.928533691Z + '[' true = true ']'
2023-11-27T08:41:44.928536159Z + set +x
2023-11-27T08:41:44.975802347Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/99-container ** [container] Skipping '03-monitoring' service for startup routines
2023-11-27T08:41:44.991777749Z 2023-11-27.08:41:44 [DEBUG] /etc/cont-init.d/99-container ** [container] Getting ready to start '04-scheduling' service
2023-11-27T08:41:45.008743262Z 2023-11-27.08:41:45 [DEBUG] /etc/cont-init.d/99-container ** [container] Skipping '05-logging' service for startup routines
2023-11-27T08:41:45.024995542Z 2023-11-27.08:41:45 [DEBUG] /etc/cont-init.d/99-container ** [container] Skipping '07-firewall' service for startup routines
2023-11-27T08:41:45.040220904Z 2023-11-27.08:41:45 [DEBUG] /etc/cont-init.d/99-container ** [container] No Initialization Script Found - Getting ready to start 'dbbackup-01' service
2023-11-27T08:41:45.081261119Z + PROCESS_NAME=db-backup01-scheduler
2023-11-27T08:41:45.081283401Z + check_container_initialized
2023-11-27T08:41:45.081294772Z + + print_debug PROCESS_NAME=scheduling
2023-11-27T08:41:45.081297143Z 'Checking to see if container initialization scripts have completed'
2023-11-27T08:41:45.081298801Z + output_off
2023-11-27T08:41:45.081300656Z + output_off
2023-11-27T08:41:45.081302256Z + '[' true = + true '[' ']'true
2023-11-27T08:41:45.081304137Z = true ']'
2023-11-27T08:41:45.081305626Z + set + set +x
2023-11-27T08:41:45.081307194Z +x
2023-11-27T08:41:45.088336164Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/dbbackup-01/run ** [db-backup01-scheduler] Checking to see if container initialization scripts have completed
2023-11-27T08:41:45.089878596Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/00-container
2023-11-27T08:41:45.096298487Z + output_off
2023-11-27T08:41:45.096318620Z + '[' true = true ']'
2023-11-27T08:41:45.096328012Z + set +x
2023-11-27T08:41:45.098062663Z + check_service_initialized init 10-db-backup
2023-11-27T08:41:45.098073440Z + print_debug 'Checking to see if service has initialized'
2023-11-27T08:41:45.098076012Z + output_off
2023-11-27T08:41:45.098078142Z + '[' true = true ']'
2023-11-27T08:41:45.098080112Z + set +x
2023-11-27T08:41:45.104864484Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/dbbackup-01/run ** [db-backup01-scheduler] Checking to see if service has initialized
2023-11-27T08:41:45.113067362Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/02-permissions
2023-11-27T08:41:45.113235016Z + output_off
2023-11-27T08:41:45.113255116Z + '[' true = true ']'
2023-11-27T08:41:45.113260079Z + set +x
2023-11-27T08:41:45.115179758Z + source /assets/functions/10-db-backup
2023-11-27T08:41:45.124382432Z + source /assets/defaults/10-db-backup
2023-11-27T08:41:45.124404844Z ++ BACKUP_JOB_CONCURRENCY=1
2023-11-27T08:41:45.124410663Z ++ DBBACKUP_USER=dbbackup
2023-11-27T08:41:45.124432126Z ++ DBBACKUP_GROUP=dbbackup
2023-11-27T08:41:45.124442665Z ++ DEFAULT_BACKUP_BEGIN='0 0 * * *'
2023-11-27T08:41:45.124445614Z ++ DEFAULT_BACKUP_INTERVAL=1440
2023-11-27T08:41:45.124447758Z ++ DEFAULT_BACKUP_INTERVAL=1440
2023-11-27T08:41:45.124449619Z ++ DEFAULT_BACKUP_LOCATION=FILESYSTEM
2023-11-27T08:41:45.124451630Z ++ DEFAULT_BLOBXFER_REMOTE_PATH=/docker-db-backup
2023-11-27T08:41:45.124453522Z ++ DEFAULT_CHECKSUM=SHA1
2023-11-27T08:41:45.124455041Z ++ DEFAULT_COMPRESSION=GZ
2023-11-27T08:41:45.124456488Z ++ DEFAULT_COMPRESSION_LEVEL=3
2023-11-27T08:41:45.124458326Z ++ DEFAULT_CREATE_LATEST_SYMLINK=false
2023-11-27T08:41:45.124663528Z ++ DEFAULT_ENABLE_PARALLEL_COMPRESSION=TRUE
2023-11-27T08:41:45.124670926Z ++ DEFAULT_ENCRYPT=FALSE
2023-11-27T08:41:45.124673201Z ++ DEFAULT_FILESYSTEM_PATH=/backup
2023-11-27T08:41:45.124674794Z ++ DEFAULT_FILESYSTEM_PATH_PERMISSION=700
2023-11-27T08:41:45.124676677Z ++ DEFAULT_FILESYSTEM_PERMISSION=600
2023-11-27T08:41:45.124678255Z ++ DEFAULT_FILESYSTEM_ARCHIVE_PATH=/backup/archive/
2023-11-27T08:41:45.124679898Z ++ DEFAULT_LOG_LEVEL=notice
2023-11-27T08:41:45.124681428Z ++ DEFAULT_MYSQL_ENABLE_TLS=FALSE
2023-11-27T08:41:45.124683031Z ++ DEFAULT_MYSQL_EVENTS=TRUE
2023-11-27T08:41:45.124684574Z ++ DEFAULT_MYSQL_MAX_ALLOWED_PACKET=512M
2023-11-27T08:41:45.124794645Z ++ DEFAULT_MYSQL_SINGLE_TRANSACTION=TRUE
2023-11-27T08:41:45.124815064Z ++ DEFAULT_MYSQL_STORED_PROCEDURES=TRUE
2023-11-27T08:41:45.124816917Z ++ DEFAULT_MYSQL_TLS_CA_FILE=/etc/ssl/cert.pem
2023-11-27T08:41:45.124839776Z ++ DEFAULT_MYSQL_TLS_VERIFY=FALSE
2023-11-27T08:41:45.124841438Z ++ DEFAULT_MYSQL_TLS_VERSION=TLSv1.1,TLSv1.2,TLSv1.3
2023-11-27T08:41:45.124843108Z ++ DEFAULT_MSSQL_MODE=database
2023-11-27T08:41:45.125429825Z +++ nproc
2023-11-27T08:41:45.127036462Z ++ DEFAULT_PARALLEL_COMPRESSION_THREADS=12
2023-11-27T08:41:45.127044744Z ++ DEFAULT_RESOURCE_OPTIMIZED=FALSE
2023-11-27T08:41:45.127046657Z ++ DEFAULT_S3_CERT_SKIP_VERIFY=TRUE
2023-11-27T08:41:45.127048171Z ++ DEFAULT_S3_PROTOCOL=https
2023-11-27T08:41:45.127049845Z ++ DEFAULT_SCRIPT_LOCATION_PRE=/assets/scripts/pre/
2023-11-27T08:41:45.127051752Z ++ DEFAULT_SCRIPT_LOCATION_POST=/assets/scripts/post/
2023-11-27T08:41:45.127053344Z ++ DEFAULT_SIZE_VALUE=bytes
2023-11-27T08:41:45.127289636Z ++ DEFAULT_SKIP_AVAILABILITY_CHECK=FALSE
2023-11-27T08:41:45.127324176Z ++ DEFAULT_SPLIT_DB=TRUE
2023-11-27T08:41:45.127327427Z ++ LOG_PATH=/logs
2023-11-27T08:41:45.127330536Z ++ MANUAL_RUN_FOREVER=TRUE
2023-11-27T08:41:45.127333330Z ++ MODE=AUTO
2023-11-27T08:41:45.127335805Z ++ TEMP_PATH=/tmp/backups
2023-11-27T08:41:45.127338834Z ++ '[' -n '' ']'
2023-11-27T08:41:45.127579155Z + bootstrap_variables backup_init 01
2023-11-27T08:41:45.127892033Z + var_true ''
2023-11-27T08:41:45.127901072Z + '[' '' = true ']'
2023-11-27T08:41:45.127904819Z + '[' '' = yes ']'
2023-11-27T08:41:45.128499865Z + case "${1}" in
2023-11-27T08:41:45.128510455Z + backup_init 01
2023-11-27T08:41:45.128794743Z + backup_instance_number=01
2023-11-27T08:41:45.129272465Z ++ mktemp
2023-11-27T08:41:45.130890192Z + backup_instance_vars=/tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.131015158Z + set -o posix
2023-11-27T08:41:45.131367497Z + set
2023-11-27T08:41:45.131507465Z + grep -oE '^backup_job_.*='
2023-11-27T08:41:45.131805536Z + grep -oE '.*='
2023-11-27T08:41:45.131814484Z + sed /--/d
2023-11-27T08:41:45.132558760Z + read -r backup_instance_var
2023-11-27T08:41:45.132879830Z + transform_file_var DEFAULT_AUTH DEFAULT_TYPE DEFAULT_HOST DEFAULT_PORT DEFAULT_NAME DEFAULT_NAME_EXCLUDE DEFAULT_USER DEFAULT_PASS DEFAULT_ENCRYPT_PASSPHRASE DEFAULT_ENCRYPT_PUBLIC_KEY DEFAULT_ENCRYPT_PRIVATE_KEY DEFAULT_MONGO_CUSTOM_URI DEFAULT_MYSQL_TLS_CA_FILE DEFAULT_MYSQL_TLS_CERT_FILE DEFAULT_MYSQL_TLS_KEY_FILE DEFAULT_S3_BUCKET DEFAULT_S3_KEY_ID DEFAULT_S3_KEY_SECRET DEFAULT_S3_PATH DEFAULT_S3_REGION DEFAULT_S3_HOST DEFAULT_S3_PROTOCOL DEFAULT_S3_EXTRA_OPTS DEFAULT_S3_CERT_CA_FILE DEFAULT_BLOBXFER_STORAGE_ACCOUNT DEFAULT_BLOBXFER_STORAGE_ACCOUNT_KEY DEFAULT_BLOBXFER_REMOTE_PATH DB01_AUTH DB01_TYPE DB01_HOST DB01_PORT DB01_NAME DB01_NAME_EXCLUDE DB01_USER DB01_PASS DB01_ENCRYPT_PASSPHRASE DB01_ENCRYPT_PUBLIC_KEY DB01_ENCRYPT_PRIVATE_KEY DB01_MONGO_CUSTOM_URI DB01_MYSQL_TLS_CA_FILE DB01_MYSQL_TLS_CERT_FILE DB01_MYSQL_TLS_KEY_FILE DB01_S3_BUCKET DB01_S3_KEY_ID DB01_S3_KEY_SECRET DB01_S3_PATH DB01_S3_REGION DB01_S3_HOST DB01_S3_PROTOCOL DB01_S3_EXTRA_OPTS DB01_S3_CERT_CA_FILE DB01_BLOBXFER_STORAGE_ACCOUNT DB01_BLOBXFER_STORAGE_ACCOUNT_KEY DB01_BLOBXFER_REMOTE_PATH BLOBXFER_STORAGE_ACCOUNT BLOBXFER_STORAGE_KEY DB_HOST DB_NAME DB_PORT DB_USER DB_PASS MONGO_CUSTOM_URI DB_AUTH S3_BUCKET S3_KEY_ID S3_KEY_SECRET S3_PATH S3_REGION S3_HOST S3_PROTOCOL S3_EXTRA_OPTS
2023-11-27T08:41:45.132891343Z + local variables
2023-11-27T08:41:45.133599535Z ++ echo DEFAULT_AUTH DEFAULT_TYPE DEFAULT_HOST DEFAULT_PORT DEFAULT_NAME DEFAULT_NAME_EXCLUDE DEFAULT_USER DEFAULT_PASS DEFAULT_ENCRYPT_PASSPHRASE DEFAULT_ENCRYPT_PUBLIC_KEY DEFAULT_ENCRYPT_PRIVATE_KEY DEFAULT_MONGO_CUSTOM_URI DEFAULT_MYSQL_TLS_CA_FILE DEFAULT_MYSQL_TLS_CERT_FILE DEFAULT_MYSQL_TLS_KEY_FILE DEFAULT_S3_BUCKET DEFAULT_S3_KEY_ID DEFAULT_S3_KEY_SECRET DEFAULT_S3_PATH DEFAULT_S3_REGION DEFAULT_S3_HOST DEFAULT_S3_PROTOCOL DEFAULT_S3_EXTRA_OPTS DEFAULT_S3_CERT_CA_FILE DEFAULT_BLOBXFER_STORAGE_ACCOUNT ++ DEFAULT_BLOBXFER_STORAGE_ACCOUNT_KEY DEFAULT_BLOBXFER_REMOTE_PATH DB01_AUTH tr DB01_TYPE ' ' DB01_HOST DB01_PORT '\n'DB01_NAME
2023-11-27T08:41:45.133632010Z DB01_NAME_EXCLUDE DB01_USER DB01_PASS DB01_ENCRYPT_PASSPHRASE DB01_ENCRYPT_PUBLIC_KEY DB01_ENCRYPT_PRIVATE_KEY DB01_MONGO_CUSTOM_URI DB01_MYSQL_TLS_CA_FILE DB01_MYSQL_TLS_CERT_FILE DB01_MYSQL_TLS_KEY_FILE DB01_S3_BUCKET DB01_S3_KEY_ID DB01_S3_KEY_SECRET DB01_S3_PATH DB01_S3_REGION DB01_S3_HOST DB01_S3_PROTOCOL DB01_S3_EXTRA_OPTS DB01_S3_CERT_CA_FILE DB01_BLOBXFER_STORAGE_ACCOUNT DB01_BLOBXFER_STORAGE_ACCOUNT_KEY DB01_BLOBXFER_REMOTE_PATH BLOBXFER_STORAGE_ACCOUNT BLOBXFER_STORAGE_KEY DB_HOST DB_NAME DB_PORT DB_USER DB_PASS MONGO_CUSTOM_URI DB_AUTH S3_BUCKET S3_KEY_ID S3_KEY_SECRET S3_PATH S3_REGION S3_HOST S3_PROTOCOL S3_EXTRA_OPTS
2023-11-27T08:41:45.135122486Z + variables='DEFAULT_AUTH
2023-11-27T08:41:45.135133838Z DEFAULT_TYPE
2023-11-27T08:41:45.135136258Z DEFAULT_HOST
2023-11-27T08:41:45.135138143Z DEFAULT_PORT
2023-11-27T08:41:45.135139710Z DEFAULT_NAME
2023-11-27T08:41:45.135141727Z DEFAULT_NAME_EXCLUDE
2023-11-27T08:41:45.135143583Z DEFAULT_USER
2023-11-27T08:41:45.135145305Z DEFAULT_PASS
2023-11-27T08:41:45.135152925Z DEFAULT_ENCRYPT_PASSPHRASE
2023-11-27T08:41:45.135154696Z DEFAULT_ENCRYPT_PUBLIC_KEY
2023-11-27T08:41:45.135156502Z DEFAULT_ENCRYPT_PRIVATE_KEY
2023-11-27T08:41:45.135158296Z DEFAULT_MONGO_CUSTOM_URI
2023-11-27T08:41:45.135159845Z DEFAULT_MYSQL_TLS_CA_FILE
2023-11-27T08:41:45.135161694Z DEFAULT_MYSQL_TLS_CERT_FILE
2023-11-27T08:41:45.135163230Z DEFAULT_MYSQL_TLS_KEY_FILE
2023-11-27T08:41:45.135164731Z DEFAULT_S3_BUCKET
2023-11-27T08:41:45.135166600Z DEFAULT_S3_KEY_ID
2023-11-27T08:41:45.135168191Z DEFAULT_S3_KEY_SECRET
2023-11-27T08:41:45.135169733Z DEFAULT_S3_PATH
2023-11-27T08:41:45.135171573Z DEFAULT_S3_REGION
2023-11-27T08:41:45.135173083Z DEFAULT_S3_HOST
2023-11-27T08:41:45.135174900Z DEFAULT_S3_PROTOCOL
2023-11-27T08:41:45.135176718Z DEFAULT_S3_EXTRA_OPTS
2023-11-27T08:41:45.135178256Z DEFAULT_S3_CERT_CA_FILE
2023-11-27T08:41:45.135179831Z DEFAULT_BLOBXFER_STORAGE_ACCOUNT
2023-11-27T08:41:45.135181608Z DEFAULT_BLOBXFER_STORAGE_ACCOUNT_KEY
2023-11-27T08:41:45.135183158Z DEFAULT_BLOBXFER_REMOTE_PATH
2023-11-27T08:41:45.135184704Z DB01_AUTH
2023-11-27T08:41:45.135186478Z DB01_TYPE
2023-11-27T08:41:45.135188088Z DB01_HOST
2023-11-27T08:41:45.135189586Z DB01_PORT
2023-11-27T08:41:45.135191123Z DB01_NAME
2023-11-27T08:41:45.135192657Z DB01_NAME_EXCLUDE
2023-11-27T08:41:45.135194463Z DB01_USER
2023-11-27T08:41:45.135195960Z DB01_PASS
2023-11-27T08:41:45.135197468Z DB01_ENCRYPT_PASSPHRASE
2023-11-27T08:41:45.135199263Z DB01_ENCRYPT_PUBLIC_KEY
2023-11-27T08:41:45.135201135Z DB01_ENCRYPT_PRIVATE_KEY
2023-11-27T08:41:45.135202926Z DB01_MONGO_CUSTOM_URI
2023-11-27T08:41:45.135204471Z DB01_MYSQL_TLS_CA_FILE
2023-11-27T08:41:45.135206258Z DB01_MYSQL_TLS_CERT_FILE
2023-11-27T08:41:45.135208050Z DB01_MYSQL_TLS_KEY_FILE
2023-11-27T08:41:45.135209600Z DB01_S3_BUCKET
2023-11-27T08:41:45.135211778Z DB01_S3_KEY_ID
2023-11-27T08:41:45.135214445Z DB01_S3_KEY_SECRET
2023-11-27T08:41:45.135217054Z DB01_S3_PATH
2023-11-27T08:41:45.135219414Z DB01_S3_REGION
2023-11-27T08:41:45.135221407Z DB01_S3_HOST
2023-11-27T08:41:45.135223223Z DB01_S3_PROTOCOL
2023-11-27T08:41:45.135225008Z DB01_S3_EXTRA_OPTS
2023-11-27T08:41:45.135226542Z DB01_S3_CERT_CA_FILE
2023-11-27T08:41:45.135228046Z DB01_BLOBXFER_STORAGE_ACCOUNT
2023-11-27T08:41:45.135229599Z DB01_BLOBXFER_STORAGE_ACCOUNT_KEY
2023-11-27T08:41:45.135234400Z DB01_BLOBXFER_REMOTE_PATH
2023-11-27T08:41:45.135237273Z BLOBXFER_STORAGE_ACCOUNT
2023-11-27T08:41:45.135239928Z BLOBXFER_STORAGE_KEY
2023-11-27T08:41:45.135241614Z DB_HOST
2023-11-27T08:41:45.135243134Z DB_NAME
2023-11-27T08:41:45.135244593Z DB_PORT
2023-11-27T08:41:45.135246073Z DB_USER
2023-11-27T08:41:45.135248115Z DB_PASS
2023-11-27T08:41:45.135250524Z MONGO_CUSTOM_URI
2023-11-27T08:41:45.135252995Z DB_AUTH
2023-11-27T08:41:45.135255096Z S3_BUCKET
2023-11-27T08:41:45.135256633Z S3_KEY_ID
2023-11-27T08:41:45.135258415Z S3_KEY_SECRET
2023-11-27T08:41:45.135260197Z S3_PATH
2023-11-27T08:41:45.135261678Z S3_REGION
2023-11-27T08:41:45.135263240Z S3_HOST
2023-11-27T08:41:45.135265114Z S3_PROTOCOL
2023-11-27T08:41:45.135266641Z S3_EXTRA_OPTS'
2023-11-27T08:41:45.135268414Z + for variable in $variables
2023-11-27T08:41:45.135269963Z + '[' -v DEFAULT_AUTH_FILE ']'
2023-11-27T08:41:45.135271477Z + for variable in $variables
2023-11-27T08:41:45.135273217Z + '[' -v DEFAULT_TYPE_FILE ']'
2023-11-27T08:41:45.135274674Z + for variable in $variables
2023-11-27T08:41:45.135276211Z + '[' -v DEFAULT_HOST_FILE ']'
2023-11-27T08:41:45.135278669Z + for variable in $variables
2023-11-27T08:41:45.135280522Z + '[' -v DEFAULT_PORT_FILE ']'
2023-11-27T08:41:45.135282248Z + for variable in $variables
2023-11-27T08:41:45.135283986Z + '[' -v DEFAULT_NAME_FILE ']'
2023-11-27T08:41:45.135285452Z + for variable in $variables
2023-11-27T08:41:45.135286988Z + '[' -v DEFAULT_NAME_EXCLUDE_FILE ']'
2023-11-27T08:41:45.135288528Z + for variable in $variables
2023-11-27T08:41:45.135290608Z + '[' -v DEFAULT_USER_FILE ']'
2023-11-27T08:41:45.135292239Z + for variable in $variables
2023-11-27T08:41:45.135294056Z + '[' -v DEFAULT_PASS_FILE ']'
2023-11-27T08:41:45.135295768Z + for variable in $variables
2023-11-27T08:41:45.135297510Z + '[' -v DEFAULT_ENCRYPT_PASSPHRASE_FILE ']'
2023-11-27T08:41:45.135299064Z + for variable in $variables
2023-11-27T08:41:45.135300829Z + '[' -v DEFAULT_ENCRYPT_PUBLIC_KEY_FILE ']'
2023-11-27T08:41:45.135302337Z + for variable in $variables
2023-11-27T08:41:45.135460035Z + '[' -v DEFAULT_ENCRYPT_PRIVATE_KEY_FILE ']'
2023-11-27T08:41:45.135467701Z + for variable in $variables
2023-11-27T08:41:45.135469894Z + '[' -v DEFAULT_MONGO_CUSTOM_URI_FILE ']'
2023-11-27T08:41:45.135471447Z + for variable in $variables
2023-11-27T08:41:45.135472983Z + '[' -v DEFAULT_MYSQL_TLS_CA_FILE_FILE ']'
2023-11-27T08:41:45.135479620Z + for variable in $variables
2023-11-27T08:41:45.135481458Z + '[' -v DEFAULT_MYSQL_TLS_CERT_FILE_FILE ']'
2023-11-27T08:41:45.135483319Z + for variable in $variables
2023-11-27T08:41:45.135485131Z + '[' -v DEFAULT_MYSQL_TLS_KEY_FILE_FILE ']'
2023-11-27T08:41:45.135486663Z + for variable in $variables
2023-11-27T08:41:45.135488309Z + '[' -v DEFAULT_S3_BUCKET_FILE ']'
2023-11-27T08:41:45.135490136Z + for variable in $variables
2023-11-27T08:41:45.135491890Z + '[' -v DEFAULT_S3_KEY_ID_FILE ']'
2023-11-27T08:41:45.135493393Z + for variable in $variables
2023-11-27T08:41:45.135494935Z + '[' -v DEFAULT_S3_KEY_SECRET_FILE ']'
2023-11-27T08:41:45.135496796Z + for variable in $variables
2023-11-27T08:41:45.135585960Z + '[' -v DEFAULT_S3_PATH_FILE ']'
2023-11-27T08:41:45.135594828Z + for variable in $variables
2023-11-27T08:41:45.135597342Z + '[' -v DEFAULT_S3_REGION_FILE ']'
2023-11-27T08:41:45.135599346Z + for variable in $variables
2023-11-27T08:41:45.135600971Z + '[' -v DEFAULT_S3_HOST_FILE ']'
2023-11-27T08:41:45.135602508Z + for variable in $variables
2023-11-27T08:41:45.135603991Z + '[' -v DEFAULT_S3_PROTOCOL_FILE ']'
2023-11-27T08:41:45.135605907Z + for variable in $variables
2023-11-27T08:41:45.135770296Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/03-monitoring
2023-11-27T08:41:45.135774710Z + '[' -v DEFAULT_S3_EXTRA_OPTS_FILE ']'
2023-11-27T08:41:45.135786987Z + for variable in $variables
2023-11-27T08:41:45.135789680Z + '[' -v DEFAULT_S3_CERT_CA_FILE_FILE ']'
2023-11-27T08:41:45.135791653Z + for variable in $variables
2023-11-27T08:41:45.135793510Z + '[' -v DEFAULT_BLOBXFER_STORAGE_ACCOUNT_FILE ']'
2023-11-27T08:41:45.135795366Z + for variable in $variables
2023-11-27T08:41:45.135797010Z + '[' -v DEFAULT_BLOBXFER_STORAGE_ACCOUNT_KEY_FILE ']'
2023-11-27T08:41:45.135798861Z + for variable in $variables
2023-11-27T08:41:45.135800363Z + '[' -v DEFAULT_BLOBXFER_REMOTE_PATH_FILE ']'
2023-11-27T08:41:45.135802400Z + for variable in $variables
2023-11-27T08:41:45.135804341Z + '[' -v DB01_AUTH_FILE ']'
2023-11-27T08:41:45.135806136Z + for variable in $variables
2023-11-27T08:41:45.135807872Z + '[' -v DB01_TYPE_FILE ']'
2023-11-27T08:41:45.135809365Z + for variable in $variables
2023-11-27T08:41:45.135810854Z + '[' -v DB01_HOST_FILE ']'
2023-11-27T08:41:45.135812346Z + for variable in $variables
2023-11-27T08:41:45.135814161Z + '[' -v DB01_PORT_FILE ']'
2023-11-27T08:41:45.135815682Z + for variable in $variables
2023-11-27T08:41:45.136053695Z + '[' -v DB01_NAME_FILE ']'
2023-11-27T08:41:45.136061082Z + for variable in $variables
2023-11-27T08:41:45.136062920Z + '[' -v DB01_NAME_EXCLUDE_FILE ']'
2023-11-27T08:41:45.136064623Z + for variable in $variables
2023-11-27T08:41:45.136066167Z + '[' -v DB01_USER_FILE ']'
2023-11-27T08:41:45.136067999Z + for variable in $variables
2023-11-27T08:41:45.136069805Z + '[' -v DB01_PASS_FILE ']'
2023-11-27T08:41:45.136071330Z + for variable in $variables
2023-11-27T08:41:45.136073151Z + '[' -v DB01_ENCRYPT_PASSPHRASE_FILE ']'
2023-11-27T08:41:45.136075016Z + for variable in $variables
2023-11-27T08:41:45.136156819Z + '[' -v DB01_ENCRYPT_PUBLIC_KEY_FILE ']'
2023-11-27T08:41:45.136164001Z + for variable in $variables
2023-11-27T08:41:45.136166247Z + '[' -v DB01_ENCRYPT_PRIVATE_KEY_FILE ']'
2023-11-27T08:41:45.136167794Z + for variable in $variables
2023-11-27T08:41:45.136169304Z + '[' -v DB01_MONGO_CUSTOM_URI_FILE ']'
2023-11-27T08:41:45.136271875Z + for variable in $variables
2023-11-27T08:41:45.136280465Z + '[' -v DB01_MYSQL_TLS_CA_FILE_FILE ']'
2023-11-27T08:41:45.136283096Z + for variable in $variables
2023-11-27T08:41:45.136284901Z + '[' -v DB01_MYSQL_TLS_CERT_FILE_FILE ']'
2023-11-27T08:41:45.136286849Z + for variable in $variables
2023-11-27T08:41:45.136288679Z + '[' -v DB01_MYSQL_TLS_KEY_FILE_FILE ']'
2023-11-27T08:41:45.136290540Z + for variable in $variables
2023-11-27T08:41:45.136400518Z + '[' -v DB01_S3_BUCKET_FILE ']'
2023-11-27T08:41:45.136407329Z + for variable in $variables
2023-11-27T08:41:45.136409506Z + '[' -v DB01_S3_KEY_ID_FILE ']'
2023-11-27T08:41:45.136411383Z + for variable in $variables
2023-11-27T08:41:45.136412960Z + '[' -v DB01_S3_KEY_SECRET_FILE ']'
2023-11-27T08:41:45.136414579Z + for variable in $variables
2023-11-27T08:41:45.136416138Z + '[' -v DB01_S3_PATH_FILE ']'
2023-11-27T08:41:45.136418043Z + for variable in $variables
2023-11-27T08:41:45.136419840Z + '[' -v DB01_S3_REGION_FILE ']'
2023-11-27T08:41:45.136421409Z + for variable in $variables
2023-11-27T08:41:45.136423019Z + '[' -v DB01_S3_HOST_FILE ']'
2023-11-27T08:41:45.136424644Z + for variable in $variables
2023-11-27T08:41:45.136428402Z + '[' -v DB01_S3_PROTOCOL_FILE ']'
2023-11-27T08:41:45.136430368Z + for variable in $variables
2023-11-27T08:41:45.136432228Z + '[' -v DB01_S3_EXTRA_OPTS_FILE ']'
2023-11-27T08:41:45.136573629Z + for variable in $variables
2023-11-27T08:41:45.136581605Z + '[' -v DB01_S3_CERT_CA_FILE_FILE ']'
2023-11-27T08:41:45.136591130Z + for variable in $variables
2023-11-27T08:41:45.136599264Z + '[' -v DB01_BLOBXFER_STORAGE_ACCOUNT_FILE ']'
2023-11-27T08:41:45.136601229Z + for variable in $variables
2023-11-27T08:41:45.136603129Z + '[' -v DB01_BLOBXFER_STORAGE_ACCOUNT_KEY_FILE ']'
2023-11-27T08:41:45.136604725Z + for variable in $variables
2023-11-27T08:41:45.136606294Z + '[' -v DB01_BLOBXFER_REMOTE_PATH_FILE ']'
2023-11-27T08:41:45.136607896Z + for variable in $variables
2023-11-27T08:41:45.136693431Z + '[' -v BLOBXFER_STORAGE_ACCOUNT_FILE ']'
2023-11-27T08:41:45.136700842Z + for variable in $variables
2023-11-27T08:41:45.136703096Z + '[' -v BLOBXFER_STORAGE_KEY_FILE ']'
2023-11-27T08:41:45.136704640Z + for variable in $variables
2023-11-27T08:41:45.136706177Z + '[' -v DB_HOST_FILE ']'
2023-11-27T08:41:45.136708013Z + for variable in $variables
2023-11-27T08:41:45.136709758Z + '[' -v DB_NAME_FILE ']'
2023-11-27T08:41:45.136711267Z + for variable in $variables
2023-11-27T08:41:45.136712874Z + '[' -v DB_PORT_FILE ']'
2023-11-27T08:41:45.136815087Z + for variable in $variables
2023-11-27T08:41:45.136822173Z + '[' -v DB_USER_FILE ']'
2023-11-27T08:41:45.136824072Z + for variable in $variables
2023-11-27T08:41:45.136827661Z + '[' -v DB_PASS_FILE ']'
2023-11-27T08:41:45.136829508Z + for variable in $variables
2023-11-27T08:41:45.136996265Z + '[' -v MONGO_CUSTOM_URI_FILE ']'
2023-11-27T08:41:45.137007733Z + for variable in $variables
2023-11-27T08:41:45.137010335Z + '[' -v DB_AUTH_FILE ']'
2023-11-27T08:41:45.137011917Z + for variable in $variables
2023-11-27T08:41:45.137013417Z + '[' -v S3_BUCKET_FILE ']'
2023-11-27T08:41:45.137015210Z + for variable in $variables
2023-11-27T08:41:45.137016739Z + '[' -v S3_KEY_ID_FILE ']'
2023-11-27T08:41:45.137018230Z + for variable in $variables
2023-11-27T08:41:45.137019806Z + '[' -v S3_KEY_SECRET_FILE ']'
2023-11-27T08:41:45.137021681Z + for variable in $variables
2023-11-27T08:41:45.137136598Z + '[' -v S3_PATH_FILE ']'
2023-11-27T08:41:45.137144430Z + for variable in $variables
2023-11-27T08:41:45.137146781Z + '[' -v S3_REGION_FILE ']'
2023-11-27T08:41:45.137148886Z + for variable in $variables
2023-11-27T08:41:45.137150743Z + '[' -v S3_HOST_FILE ']'
2023-11-27T08:41:45.137152413Z + for variable in $variables
2023-11-27T08:41:45.137153988Z + '[' -v S3_PROTOCOL_FILE ']'
2023-11-27T08:41:45.137155872Z + for variable in $variables
2023-11-27T08:41:45.137157370Z + '[' -v S3_EXTRA_OPTS_FILE ']'
2023-11-27T08:41:45.137158931Z + unset file_variable
2023-11-27T08:41:45.137160532Z + unset variables
2023-11-27T08:41:45.137258031Z + set -o posix
2023-11-27T08:41:45.137634723Z + set
2023-11-27T08:41:45.137722616Z + grep -E '^DB01_|^DEFAULT_|^DB_|^ARCHIVE|^BACKUP_|^BLOBXFER_|^CHECKSUM|^COMPRESSION|^CREATE_|^ENABLE_|^EXTRA_|^GZ_|^INFLUX_|^MYSQL_|^MONGO_|^PARALLEL|^PRE_|^POST_|^S3|^SKIP|^SPLIT'
2023-11-27T08:41:45.139522891Z + '[' -n '' ']'
2023-11-27T08:41:45.139530918Z + '[' -n '' ']'
2023-11-27T08:41:45.139533109Z + '[' -n '' ']'
2023-11-27T08:41:45.139534777Z + '[' -n '' ']'
2023-11-27T08:41:45.139536682Z + '[' -n '' ']'
2023-11-27T08:41:45.139538233Z + '[' -n '' ']'
2023-11-27T08:41:45.139540049Z + grep -qo '.*_PASS='\''.*'\''' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.140537360Z + grep -qo 'MONGO_CUSTOM_URI='\''.*'\''' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.141391017Z + transform_backup_instance_variable 01 ARCHIVE_TIME backup_job_archive_time
2023-11-27T08:41:45.141400561Z + grep -q '^DB01_ARCHIVE_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.142313182Z + grep -q '^DB_ARCHIVE_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.142974126Z + grep -q '^ARCHIVE_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.143792180Z + grep -q '^DEFAULT_ARCHIVE_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.144623547Z + transform_backup_instance_variable 01 AUTH backup_job_db_auth
2023-11-27T08:41:45.144632751Z + grep -q '^DB01_AUTH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.145503354Z + grep -q '^DB_AUTH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.146311242Z + grep -q '^AUTH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.147041181Z + grep -q '^DEFAULT_AUTH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.147809602Z + transform_backup_instance_variable 01 BACKUP_BEGIN backup_job_backup_begin
2023-11-27T08:41:45.147816776Z + grep -q '^DB01_BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.148689875Z + grep -q '^DB_BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.149516462Z + grep -q '^BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.150394811Z + grep -q '^DEFAULT_BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.152017974Z ++ grep '^DEFAULT_BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.152038224Z ++ cut -d = -f2
2023-11-27T08:41:45.153830941Z + '[' ''\''0 0 * * *'\''' '!=' unset ']'
2023-11-27T08:41:45.154453723Z ++ grep '^DEFAULT_BACKUP_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.154464755Z ++ cut -d = -f2-
2023-11-27T08:41:45.155978594Z + export 'backup_job_backup_begin='\''0 0 * * *'\'''
2023-11-27T08:41:45.155988526Z + backup_job_backup_begin=''\''0 0 * * *'\'''
2023-11-27T08:41:45.155991194Z + transform_backup_instance_variable 01 BACKUP_INTERVAL backup_job_backup_interval
2023-11-27T08:41:45.156082588Z + grep -q '^DB01_BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.157066126Z + grep -q '^DB_BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.157817822Z + grep -q '^BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.158682910Z + grep -q '^DEFAULT_BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.160113457Z ++ grep '^DEFAULT_BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.160124188Z ++ cut -d = -f2
2023-11-27T08:41:45.161653711Z + '[' 1440 '!=' unset ']'
2023-11-27T08:41:45.161669786Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/04-scheduling
2023-11-27T08:41:45.162328089Z ++ grep '^DEFAULT_BACKUP_INTERVAL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.162437335Z ++ cut -d = -f2-
2023-11-27T08:41:45.163882440Z + export backup_job_backup_interval=1440
2023-11-27T08:41:45.163893690Z + backup_job_backup_interval=1440
2023-11-27T08:41:45.163895947Z + transform_backup_instance_variable 01 BACKUP_GLOBALS backup_job_backup_pgsql_globals
2023-11-27T08:41:45.163898080Z + grep -q '^DB01_BACKUP_GLOBALS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.164849425Z + grep -q '^DB_BACKUP_GLOBALS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.165776745Z + grep -q '^BACKUP_GLOBALS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.166587825Z + grep -q '^DEFAULT_BACKUP_GLOBALS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.167548551Z + transform_backup_instance_variable 01 BACKUP_LOCATION backup_job_backup_location
2023-11-27T08:41:45.167558221Z + grep -q '^DB01_BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.168382704Z + grep -q '^DB_BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.169220943Z + grep -q '^BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.169954685Z + grep -q '^DEFAULT_BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.171338146Z ++ grep '^DEFAULT_BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.171352487Z ++ cut -d = -f2
2023-11-27T08:41:45.172804351Z + '[' FILESYSTEM '!=' unset ']'
2023-11-27T08:41:45.173516767Z ++ grep '^DEFAULT_BACKUP_LOCATION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.173530394Z ++ cut -d = -f2-
2023-11-27T08:41:45.175316698Z + export backup_job_backup_location=FILESYSTEM
2023-11-27T08:41:45.175327757Z + backup_job_backup_location=FILESYSTEM
2023-11-27T08:41:45.175330218Z + transform_backup_instance_variable 01 BLACKOUT_BEGIN backup_job_snapshot_blackout_start
2023-11-27T08:41:45.175332451Z + grep -q '^DB01_BLACKOUT_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.176282620Z + grep -q '^DB_BLACKOUT_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.177101534Z + grep -q '^BLACKOUT_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.177885144Z + grep -q '^DEFAULT_BLACKOUT_BEGIN=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.178909514Z + transform_backup_instance_variable 01 BLACKOUT_END backup_job_snapshot_blackout_finish
2023-11-27T08:41:45.178920302Z + grep -q '^DB01_BLACKOUT_END=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.179896768Z + grep -q '^DB_BLACKOUT_END=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.180871296Z + grep -q '^BLACKOUT_END=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.181783319Z + grep -q '^DEFAULT_BLACKOUT_END=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.182711399Z + transform_backup_instance_variable 01 BLOBXFER_REMOTE_PATH backup_job_blobxfer_remote_path
2023-11-27T08:41:45.182720555Z + grep -q '^DB01_BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.183677499Z + grep -q '^DB_BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.184230756Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/05-logging
2023-11-27T08:41:45.184778126Z + grep -q '^BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.185640478Z + grep -q '^DEFAULT_BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.187134747Z ++ grep '^DEFAULT_BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.187149423Z ++ cut -d = -f2
2023-11-27T08:41:45.188640950Z + '[' /docker-db-backup '!=' unset ']'
2023-11-27T08:41:45.189349976Z ++ grep '^DEFAULT_BLOBXFER_REMOTE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.189359580Z ++ cut -d = -f2-
2023-11-27T08:41:45.190803351Z + export backup_job_blobxfer_remote_path=/docker-db-backup
2023-11-27T08:41:45.190812313Z + backup_job_blobxfer_remote_path=/docker-db-backup
2023-11-27T08:41:45.190814928Z + transform_backup_instance_variable 01 BLOBXFER_STORAGE_ACCOUNT backup_job_blobxfer_storage_account
2023-11-27T08:41:45.190817110Z + grep -q '^DB01_BLOBXFER_STORAGE_ACCOUNT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.191892299Z + grep -q '^DB_BLOBXFER_STORAGE_ACCOUNT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.192700218Z + grep -q '^BLOBXFER_STORAGE_ACCOUNT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.193623558Z + grep -q '^DEFAULT_BLOBXFER_STORAGE_ACCOUNT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.194563531Z + transform_backup_instance_variable 01 BLOBXFER_STORAGE_KEY backup_job_blobxfer_storage_key
2023-11-27T08:41:45.194572363Z + grep -q '^DB01_BLOBXFER_STORAGE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.195485473Z + grep -q '^DB_BLOBXFER_STORAGE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.196429178Z + grep -q '^BLOBXFER_STORAGE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.197351453Z + grep -q '^DEFAULT_BLOBXFER_STORAGE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.198313638Z + transform_backup_instance_variable 01 CHECKSUM backup_job_checksum
2023-11-27T08:41:45.198329007Z + grep -q '^DB01_CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.199309692Z + grep -q '^DB_CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.200321159Z + grep -q '^CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.201141216Z + grep -q '^DEFAULT_CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.202656401Z ++ grep '^DEFAULT_CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.202942397Z ++ cut -d = -f2
2023-11-27T08:41:45.204893888Z + '[' SHA1 '!=' unset ']'
2023-11-27T08:41:45.205514218Z ++ grep '^DEFAULT_CHECKSUM=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.205524016Z ++ cut -d = -f2-
2023-11-27T08:41:45.206984420Z + export backup_job_checksum=SHA1
2023-11-27T08:41:45.206994648Z + backup_job_checksum=SHA1
2023-11-27T08:41:45.206997291Z + transform_backup_instance_variable 01 CLEANUP_TIME backup_job_cleanup_time
2023-11-27T08:41:45.206999260Z + grep -q '^DB01_CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.208188655Z + grep -q '^DB_CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.208978132Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/06-messaging
2023-11-27T08:41:45.208988981Z + grep -q '^CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.209811898Z + grep -q '^DEFAULT_CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.211378684Z ++ grep '^DEFAULT_CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.211388651Z ++ cut -d = -f2
2023-11-27T08:41:45.213138918Z + '[' 10080 '!=' unset ']'
2023-11-27T08:41:45.213814720Z ++ grep '^DEFAULT_CLEANUP_TIME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.213824813Z ++ cut -d = -f2-
2023-11-27T08:41:45.215613393Z + export backup_job_cleanup_time=10080
2023-11-27T08:41:45.215632816Z + backup_job_cleanup_time=10080
2023-11-27T08:41:45.215637433Z + transform_backup_instance_variable 01 COMPRESSION backup_job_compression
2023-11-27T08:41:45.215645587Z + grep -q '^DB01_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.216686742Z + grep -q '^DB_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.217578349Z + grep -q '^COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.218463799Z + grep -q '^DEFAULT_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.219838197Z ++ grep '^DEFAULT_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.219847639Z ++ cut -d = -f2
2023-11-27T08:41:45.221497660Z + '[' GZ '!=' unset ']'
2023-11-27T08:41:45.222264249Z ++ grep '^DEFAULT_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.222281010Z ++ cut -d = -f2-
2023-11-27T08:41:45.223635894Z + export backup_job_compression=GZ
2023-11-27T08:41:45.223646101Z + backup_job_compression=GZ
2023-11-27T08:41:45.223648737Z + transform_backup_instance_variable 01 COMPRESSION_LEVEL backup_job_compression_level
2023-11-27T08:41:45.223652017Z + grep -q '^DB01_COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.224667546Z + grep -q '^DB_COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.225570846Z + grep -q '^COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.226435266Z + grep -q '^DEFAULT_COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.227779565Z ++ grep '^DEFAULT_COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.227789097Z ++ cut -d = -f2
2023-11-27T08:41:45.229490955Z + '[' 3 '!=' unset ']'
2023-11-27T08:41:45.230364252Z ++ grep '^DEFAULT_COMPRESSION_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.230380320Z ++ cut -d = -f2-
2023-11-27T08:41:45.231583114Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/07-firewall
2023-11-27T08:41:45.232028703Z + export backup_job_compression_level=3
2023-11-27T08:41:45.232040710Z + backup_job_compression_level=3
2023-11-27T08:41:45.232043339Z + transform_backup_instance_variable 01 CREATE_LATEST_SYMLINK backup_job_create_latest_symlink
2023-11-27T08:41:45.232045281Z + grep -q '^DB01_CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.233100819Z + grep -q '^DB_CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.233937187Z + grep -q '^CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.234874633Z + grep -q '^DEFAULT_CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.236354480Z ++ grep '^DEFAULT_CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.236372584Z ++ cut -d = -f2
2023-11-27T08:41:45.237885922Z + '[' false '!=' unset ']'
2023-11-27T08:41:45.238559089Z ++ grep '^DEFAULT_CREATE_LATEST_SYMLINK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.238568608Z ++ cut -d = -f2-
2023-11-27T08:41:45.240148246Z + export backup_job_create_latest_symlink=false
2023-11-27T08:41:45.240157716Z + backup_job_create_latest_symlink=false
2023-11-27T08:41:45.240160304Z + transform_backup_instance_variable 01 ENABLE_PARALLEL_COMPRESSION backup_job_parallel_compression
2023-11-27T08:41:45.240162213Z + grep -q '^DB01_ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.241193814Z + grep -q '^DB_ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.241963079Z + grep -q '^ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.242872597Z + grep -q '^DEFAULT_ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.244153637Z ++ grep '^DEFAULT_ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.244163388Z ++ cut -d = -f2
2023-11-27T08:41:45.245951688Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.246791880Z ++ grep '^DEFAULT_ENABLE_PARALLEL_COMPRESSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.246811927Z ++ cut -d = -f2-
2023-11-27T08:41:45.248568102Z + export backup_job_parallel_compression=TRUE
2023-11-27T08:41:45.248579158Z + backup_job_parallel_compression=TRUE
2023-11-27T08:41:45.248584684Z + transform_backup_instance_variable 01 ENCRYPT backup_job_encrypt
2023-11-27T08:41:45.248586650Z + grep -q '^DB01_ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.249606646Z + grep -q '^DB_ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.250529740Z + grep -q '^ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.251401053Z + grep -q '^DEFAULT_ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.252811510Z ++ grep '^DEFAULT_ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.252821122Z ++ cut -d = -f2
2023-11-27T08:41:45.254120916Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Container: Getting defaults for /assets/defaults/10-db-backup
2023-11-27T08:41:45.254484158Z + '[' FALSE '!=' unset ']'
2023-11-27T08:41:45.255238873Z ++ grep '^DEFAULT_ENCRYPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.255251152Z ++ cut -d = -f2-
2023-11-27T08:41:45.256637518Z + export backup_job_encrypt=FALSE
2023-11-27T08:41:45.256647704Z + backup_job_encrypt=FALSE
2023-11-27T08:41:45.256649979Z + transform_backup_instance_variable 01 ENCRYPT_PASSPHRASE backup_job_encrypt_passphrase
2023-11-27T08:41:45.256652192Z + grep -q '^DB01_ENCRYPT_PASSPHRASE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.257740973Z + grep -q '^DB_ENCRYPT_PASSPHRASE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.258754110Z + grep -q '^ENCRYPT_PASSPHRASE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.259553390Z + grep -q '^DEFAULT_ENCRYPT_PASSPHRASE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.260389107Z + transform_backup_instance_variable 01 ENCRYPT_PRIVATE_KEY backup_job_encrypt_private_key
2023-11-27T08:41:45.260398587Z + grep -q '^DB01_ENCRYPT_PRIVATE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.261436662Z + grep -q '^DB_ENCRYPT_PRIVATE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.262334748Z + grep -q '^ENCRYPT_PRIVATE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.263045501Z + grep -q '^DEFAULT_ENCRYPT_PRIVATE_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.263872109Z + transform_backup_instance_variable 01 ENCRYPT_PUBLIC_KEY backup_job_encrypt_public_key
2023-11-27T08:41:45.263881589Z + grep -q '^DB01_ENCRYPT_PUBLIC_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.264802166Z + grep -q '^DB_ENCRYPT_PUBLIC_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.265688249Z + grep -q '^ENCRYPT_PUBLIC_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.266553286Z + grep -q '^DEFAULT_ENCRYPT_PUBLIC_KEY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.267395150Z + transform_backup_instance_variable 01 EXTRA_DUMP_OPTS backup_job_extra_dump_opts
2023-11-27T08:41:45.267404583Z + grep -q '^DB01_EXTRA_DUMP_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.268292396Z + grep -q '^DB_EXTRA_DUMP_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.269288908Z + grep -q '^EXTRA_DUMP_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.270184847Z + grep -q '^DEFAULT_EXTRA_DUMP_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.271067978Z + transform_backup_instance_variable 01 EXTRA_ENUMERATION_OPTS backup_job_extra_enumeration_opts
2023-11-27T08:41:45.271077281Z + grep -q '^DB01_EXTRA_ENUMERATION_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.271916069Z + grep -q '^DB_EXTRA_ENUMERATION_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.272764512Z + grep -q '^EXTRA_ENUMERATION_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.273722279Z + grep -q '^DEFAULT_EXTRA_ENUMERATION_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.274658947Z + transform_backup_instance_variable 01 EXTRA_OPTS backup_job_extra_opts
2023-11-27T08:41:45.274668946Z + grep -q '^DB01_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.275607157Z + grep -q '^DB_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.275851574Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Checking to see if container initialization scripts have completed
2023-11-27T08:41:45.276445569Z + grep -q '^EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.277307257Z + grep -q '^DEFAULT_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.278227082Z + transform_backup_instance_variable 01 FILESYSTEM_ARCHIVE_PATH backup_job_filesystem_archive_path
2023-11-27T08:41:45.278237219Z + grep -q '^DB01_FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.279277740Z + grep -q '^DB_FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.280435105Z + grep -q '^FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.281318017Z + grep -q '^DEFAULT_FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.282810873Z ++ grep '^DEFAULT_FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.282820851Z ++ cut -d = -f2
2023-11-27T08:41:45.284313540Z + '[' /backup/archive/ '!=' unset ']'
2023-11-27T08:41:45.285090469Z ++ grep '^DEFAULT_FILESYSTEM_ARCHIVE_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.285098974Z ++ cut -d = -f2-
2023-11-27T08:41:45.286469241Z + export backup_job_filesystem_archive_path=/backup/archive/
2023-11-27T08:41:45.286478667Z + backup_job_filesystem_archive_path=/backup/archive/
2023-11-27T08:41:45.286481254Z + transform_backup_instance_variable 01 FILESYSTEM_PATH backup_job_filesystem_path
2023-11-27T08:41:45.286483667Z + grep -q '^DB01_FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.287551482Z + grep -q '^DB_FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.288556333Z + grep -q '^FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.289422961Z + grep -q '^DEFAULT_FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.290849388Z ++ grep '^DEFAULT_FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.290867031Z ++ cut -d = -f2
2023-11-27T08:41:45.292427874Z + '[' /backup '!=' unset ']'
2023-11-27T08:41:45.292970665Z ++ grep '^DEFAULT_FILESYSTEM_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.293018014Z ++ cut -d = -f2-
2023-11-27T08:41:45.293454609Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Checking to see if service has initialized
2023-11-27T08:41:45.294562159Z + export backup_job_filesystem_path=/backup
2023-11-27T08:41:45.294585372Z + backup_job_filesystem_path=/backup
2023-11-27T08:41:45.294588402Z + transform_backup_instance_variable 01 FILESYSTEM_PATH_PERMISSION backup_job_filesystem_path_permission
2023-11-27T08:41:45.294590359Z + grep -q '^DB01_FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.295685722Z + grep -q '^DB_FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.296651704Z + grep -q '^FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.297515150Z + grep -q '^DEFAULT_FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.298982045Z ++ grep '^DEFAULT_FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.299123401Z ++ cut -d = -f2
2023-11-27T08:41:45.300675026Z + '[' 700 '!=' unset ']'
2023-11-27T08:41:45.301496927Z ++ grep '^DEFAULT_FILESYSTEM_PATH_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.301522808Z ++ cut -d = -f2-
2023-11-27T08:41:45.303140613Z + export backup_job_filesystem_path_permission=700
2023-11-27T08:41:45.303153434Z + backup_job_filesystem_path_permission=700
2023-11-27T08:41:45.303155917Z + transform_backup_instance_variable 01 FILESYSTEM_PERMISSION backup_job_filesystem_permission
2023-11-27T08:41:45.303233150Z + grep -q '^DB01_FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.304338156Z + grep -q '^DB_FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.305215631Z + grep -q '^FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.306079817Z + grep -q '^DEFAULT_FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.307464718Z ++ grep '^DEFAULT_FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.307475586Z ++ cut -d = -f2
2023-11-27T08:41:45.308928574Z + '[' 600 '!=' unset ']'
2023-11-27T08:41:45.309619875Z ++ grep '^DEFAULT_FILESYSTEM_PERMISSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.309629990Z ++ cut -d = -f2-
2023-11-27T08:41:45.311130425Z + export backup_job_filesystem_permission=600
2023-11-27T08:41:45.311140339Z + backup_job_filesystem_permission=600
2023-11-27T08:41:45.311143158Z + transform_backup_instance_variable 01 GZ_RSYNCABLE backup_job_gz_rsyncable
2023-11-27T08:41:45.311145087Z + grep -q '^DB01_GZ_RSYNCABLE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.312458013Z + grep -q '^DB_GZ_RSYNCABLE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.313719564Z + grep -q '^GZ_RSYNCABLE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.314705734Z + grep -q '^DEFAULT_GZ_RSYNCABLE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.314724880Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] [logrotate] Setting Logrotate retention days after all services have finished initializing
2023-11-27T08:41:45.315533465Z + transform_backup_instance_variable 01 HOST backup_job_db_host
2023-11-27T08:41:45.315543322Z + grep -q '^DB01_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.316941232Z ++ grep '^DB01_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.316950677Z ++ cut -d = -f2
2023-11-27T08:41:45.318481340Z + '[' gse-database '!=' unset ']'
2023-11-27T08:41:45.319076738Z ++ grep '^DB01_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.319333700Z ++ cut -d = -f2-
2023-11-27T08:41:45.320677305Z + export backup_job_db_host=gse-database
2023-11-27T08:41:45.320693774Z + backup_job_db_host=gse-database
2023-11-27T08:41:45.320701316Z + transform_backup_instance_variable 01 INFLUX_VERSION backup_job_influx_version
2023-11-27T08:41:45.320735966Z + grep -q '^DB01_INFLUX_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.321843990Z + grep -q '^DB_INFLUX_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.322774186Z + grep -q '^INFLUX_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.323640736Z + grep -q '^DEFAULT_INFLUX_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.324589058Z + transform_backup_instance_variable 01 LOG_LEVEL backup_job_log_level
2023-11-27T08:41:45.324597085Z + grep -q '^DB01_LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.325474221Z + grep -q '^DB_LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.326416675Z + grep -q '^LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.327315649Z + grep -q '^DEFAULT_LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.328911400Z ++ grep '^DEFAULT_LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.328931675Z ++ cut -d = -f2
2023-11-27T08:41:45.330597981Z + '[' notice '!=' unset ']'
2023-11-27T08:41:45.331323447Z ++ grep '^DEFAULT_LOG_LEVEL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.331334354Z ++ cut -d = -f2-
2023-11-27T08:41:45.332977945Z + export backup_job_log_level=notice
2023-11-27T08:41:45.332991361Z + backup_job_log_level=notice
2023-11-27T08:41:45.332996459Z + transform_backup_instance_variable 01 MONGO_CUSTOM_URI backup_job_mongo_custom_uri
2023-11-27T08:41:45.333000811Z + grep -q '^DB01_MONGO_CUSTOM_URI=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.333019632Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] [logrotate] Moving files from /assets/logrotate to /etc/logrotate.d
2023-11-27T08:41:45.334279993Z + grep -q '^DB_MONGO_CUSTOM_URI=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.335271966Z + grep -q '^MONGO_CUSTOM_URI=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.336105460Z + grep -q '^DEFAULT_MONGO_CUSTOM_URI=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.336962351Z + transform_backup_instance_variable 01 MYSQL_ENABLE_TLS backup_job_mysql_enable_tls
2023-11-27T08:41:45.336970757Z + grep -q '^DB01_MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.337828221Z + grep -q '^DB_MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.338647901Z + grep -q '^MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.339473413Z + grep -q '^DEFAULT_MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.340783556Z ++ grep '^DEFAULT_MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.340792948Z ++ cut -d = -f2
2023-11-27T08:41:45.342389337Z + '[' FALSE '!=' unset ']'
2023-11-27T08:41:45.342924703Z ++ grep '^DEFAULT_MYSQL_ENABLE_TLS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.342933340Z ++ cut -d = -f2-
2023-11-27T08:41:45.344594483Z + export backup_job_mysql_enable_tls=FALSE
2023-11-27T08:41:45.344607199Z + backup_job_mysql_enable_tls=FALSE
2023-11-27T08:41:45.344611790Z + transform_backup_instance_variable 01 MYSQL_EVENTS backup_job_mysql_events
2023-11-27T08:41:45.344615371Z + grep -q '^DB01_MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.345910350Z + grep -q '^DB_MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.346919079Z + grep -q '^MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.347690345Z + grep -q '^DEFAULT_MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.349136560Z ++ grep '^DEFAULT_MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.349274409Z ++ cut -d = -f2
2023-11-27T08:41:45.350723932Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.351362123Z ++ grep '^DEFAULT_MYSQL_EVENTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.351371217Z ++ cut -d = -f2-
2023-11-27T08:41:45.352808493Z + export backup_job_mysql_events=TRUE
2023-11-27T08:41:45.352817770Z + backup_job_mysql_events=TRUE
2023-11-27T08:41:45.352820177Z + transform_backup_instance_variable 01 MYSQL_MAX_ALLOWED_PACKET backup_job_mysql_max_allowed_packet
2023-11-27T08:41:45.352822739Z + grep -q '^DB01_MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.353874463Z + grep -q '^DB_MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.354711873Z + grep -q '^MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.355562475Z + grep -q '^DEFAULT_MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.356914456Z ++ grep '^DEFAULT_MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.356924083Z ++ cut -d = -f2
2023-11-27T08:41:45.358473313Z + '[' 512M '!=' unset ']'
2023-11-27T08:41:45.359011646Z ++ grep '^DEFAULT_MYSQL_MAX_ALLOWED_PACKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.359017760Z ++ cut -d = -f2-
2023-11-27T08:41:45.360641204Z + export backup_job_mysql_max_allowed_packet=512M
2023-11-27T08:41:45.360657240Z + backup_job_mysql_max_allowed_packet=512M
2023-11-27T08:41:45.360662535Z + transform_backup_instance_variable 01 MYSQL_SINGLE_TRANSACTION backup_job_mysql_single_transaction
2023-11-27T08:41:45.360665020Z + grep -q '^DB01_MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.361781025Z + grep -q '^DB_MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.362627173Z + grep -q '^MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.363494700Z + grep -q '^DEFAULT_MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.364834957Z ++ grep '^DEFAULT_MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.364843689Z ++ cut -d = -f2
2023-11-27T08:41:45.366595661Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.367362028Z ++ grep '^DEFAULT_MYSQL_SINGLE_TRANSACTION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.367373038Z ++ cut -d = -f2-
2023-11-27T08:41:45.368846480Z + export backup_job_mysql_single_transaction=TRUE
2023-11-27T08:41:45.368856256Z + backup_job_mysql_single_transaction=TRUE
2023-11-27T08:41:45.368858897Z + transform_backup_instance_variable 01 MYSQL_STORED_PROCEDURES backup_job_mysql_stored_procedures
2023-11-27T08:41:45.368860756Z + grep -q '^DB01_MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.369413209Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/04-scheduling/run ** [scheduling] Parsing all files from /assets/cron/
2023-11-27T08:41:45.369925271Z + grep -q '^DB_MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.370697089Z + grep -q '^MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.371559167Z + grep -q '^DEFAULT_MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.372859593Z ++ grep '^DEFAULT_MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.372871977Z ++ cut -d = -f2
2023-11-27T08:41:45.374391135Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.375129133Z ++ grep '^DEFAULT_MYSQL_STORED_PROCEDURES=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.375141535Z ++ cut -d = -f2-
2023-11-27T08:41:45.376654943Z + export backup_job_mysql_stored_procedures=TRUE
2023-11-27T08:41:45.376665719Z + backup_job_mysql_stored_procedures=TRUE
2023-11-27T08:41:45.376668500Z + transform_backup_instance_variable 01 MYSQL_TLS_CA_FILE backup_job_mysql_tls_ca_file
2023-11-27T08:41:45.376670517Z + grep -q '^DB01_MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.377671547Z + grep -q '^DB_MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.378453672Z + grep -q '^MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.379446498Z + grep -q '^DEFAULT_MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.381147721Z ++ grep '^DEFAULT_MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.381160576Z ++ cut -d = -f2
2023-11-27T08:41:45.383083959Z + '[' /etc/ssl/cert.pem '!=' unset ']'
2023-11-27T08:41:45.383686657Z ++ grep '^DEFAULT_MYSQL_TLS_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.383719217Z ++ cut -d = -f2-
2023-11-27T08:41:45.385303093Z + export backup_job_mysql_tls_ca_file=/etc/ssl/cert.pem
2023-11-27T08:41:45.385313877Z + backup_job_mysql_tls_ca_file=/etc/ssl/cert.pem
2023-11-27T08:41:45.385316310Z + transform_backup_instance_variable 01 MYSQL_TLS_CERT_FILE backup_job_mysql_tls_cert_file
2023-11-27T08:41:45.385322694Z + grep -q '^DB01_MYSQL_TLS_CERT_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.386372265Z + grep -q '^DB_MYSQL_TLS_CERT_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.387280865Z + grep -q '^MYSQL_TLS_CERT_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.388109743Z + grep -q '^DEFAULT_MYSQL_TLS_CERT_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.388915401Z + transform_backup_instance_variable 01 MYSQL_TLS_KEY_FILE backup_job_mysql_tls_key_file
2023-11-27T08:41:45.388928187Z + grep -q '^DB01_MYSQL_TLS_KEY_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.389796646Z + grep -q '^DB_MYSQL_TLS_KEY_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.390681176Z + grep -q '^MYSQL_TLS_KEY_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.391643154Z + grep -q '^DEFAULT_MYSQL_TLS_KEY_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.392476328Z + transform_backup_instance_variable 01 MYSQL_TLS_VERIFY backup_job_mysql_tls_verify
2023-11-27T08:41:45.392486144Z + grep -q '^DB01_MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.393392405Z + grep -q '^DB_MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.394330768Z + grep -q '^MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.395077943Z + grep -q '^DEFAULT_MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.396707356Z ++ grep '^DEFAULT_MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.396747339Z ++ cut -d = -f2
2023-11-27T08:41:45.398255320Z + '[' FALSE '!=' unset ']'
2023-11-27T08:41:45.398854384Z ++ grep '^DEFAULT_MYSQL_TLS_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.398869297Z ++ cut -d = -f2-
2023-11-27T08:41:45.400352853Z + export backup_job_mysql_tls_verify=FALSE
2023-11-27T08:41:45.400362582Z + backup_job_mysql_tls_verify=FALSE
2023-11-27T08:41:45.400364886Z + transform_backup_instance_variable 01 MYSQL_TLS_VERSION backup_job_mysql_tls_version
2023-11-27T08:41:45.400398680Z + grep -q '^DB01_MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.401489198Z + grep -q '^DB_MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.402336373Z + grep -q '^MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.403303062Z 2023-11-27.08:41:45 [STARTING] /etc/services.available/04-scheduling/run ** [scheduling] [1] Starting cron
2023-11-27T08:41:45.403303646Z + grep -q '^DEFAULT_MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.404668808Z ++ grep '^DEFAULT_MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.404681415Z ++ cut -d = -f2
2023-11-27T08:41:45.406339672Z + '[' TLSv1.1,TLSv1.2,TLSv1.3 '!=' unset ']'
2023-11-27T08:41:45.406903516Z ++ grep '^DEFAULT_MYSQL_TLS_VERSION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.406913083Z ++ cut -d = -f2-
2023-11-27T08:41:45.408436628Z + export backup_job_mysql_tls_version=TLSv1.1,TLSv1.2,TLSv1.3
2023-11-27T08:41:45.408448412Z + backup_job_mysql_tls_version=TLSv1.1,TLSv1.2,TLSv1.3
2023-11-27T08:41:45.408450995Z + transform_backup_instance_variable 01 MSSQL_MODE backup_job_mssql_mode
2023-11-27T08:41:45.408453053Z + grep -q '^DB01_MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.409428260Z + grep -q '^DB_MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.410303847Z + grep -q '^MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.411170373Z + grep -q '^DEFAULT_MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.412588312Z ++ grep '^DEFAULT_MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.412707698Z ++ cut -d = -f2
2023-11-27T08:41:45.414565227Z + '[' database '!=' unset ']'
2023-11-27T08:41:45.415338632Z ++ grep '^DEFAULT_MSSQL_MODE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.415457812Z ++ cut -d = -f2-
2023-11-27T08:41:45.417153491Z + export backup_job_mssql_mode=database
2023-11-27T08:41:45.417166583Z + backup_job_mssql_mode=database
2023-11-27T08:41:45.417169298Z + transform_backup_instance_variable 01 NAME backup_job_db_name
2023-11-27T08:41:45.417171159Z + grep -q '^DB01_NAME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.418654622Z ++ grep '^DB01_NAME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.418664659Z ++ cut -d = -f2
2023-11-27T08:41:45.420283808Z + '[' gse '!=' unset ']'
2023-11-27T08:41:45.420908821Z ++ grep '^DB01_NAME=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.420916297Z ++ cut -d = -f2-
2023-11-27T08:41:45.422665777Z + export backup_job_db_name=gse
2023-11-27T08:41:45.422675025Z + backup_job_db_name=gse
2023-11-27T08:41:45.422677432Z + transform_backup_instance_variable 01 NAME_EXCLUDE backup_job_db_name_exclude
2023-11-27T08:41:45.422679224Z + grep -q '^DB01_NAME_EXCLUDE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.423679366Z + grep -q '^DB_NAME_EXCLUDE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.424551017Z + grep -q '^NAME_EXCLUDE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.425325763Z + grep -q '^DEFAULT_NAME_EXCLUDE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.426200887Z + transform_backup_instance_variable 01 PARALLEL_COMPRESSION_THREADS backup_job_parallel_compression_threads
2023-11-27T08:41:45.426209487Z + grep -q '^DB01_PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.427065719Z + grep -q '^DB_PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.427865757Z + grep -q '^PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.428688639Z + grep -q '^DEFAULT_PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.430148376Z ++ grep '^DEFAULT_PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.430159541Z ++ cut -d = -f2
2023-11-27T08:41:45.431728482Z + '[' 12 '!=' unset ']'
2023-11-27T08:41:45.432520939Z ++ grep '^DEFAULT_PARALLEL_COMPRESSION_THREADS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.432531304Z ++ cut -d = -f2-
2023-11-27T08:41:45.434076126Z + export backup_job_parallel_compression_threads=12
2023-11-27T08:41:45.434085465Z + backup_job_parallel_compression_threads=12
2023-11-27T08:41:45.434087880Z + transform_backup_instance_variable 01 PASS backup_job_db_pass
2023-11-27T08:41:45.434089880Z + grep -q '^DB01_PASS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.435476923Z ++ grep '^DB01_PASS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.435490588Z ++ cut -d = -f2
2023-11-27T08:41:45.437737651Z ++ grep '^DB01_PASS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.437743620Z ++ cut -d = -f2-
2023-11-27T08:41:45.439254032Z + transform_backup_instance_variable 01 PORT backup_job_db_port
2023-11-27T08:41:45.439256201Z + grep -q '^DB01_PORT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.440724594Z ++ grep '^DB01_PORT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.440732899Z ++ cut -d = -f2
2023-11-27T08:41:45.442171282Z + '[' 3306 '!=' unset ']'
2023-11-27T08:41:45.442853201Z ++ grep '^DB01_PORT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.442861254Z ++ cut -d = -f2-
2023-11-27T08:41:45.444402446Z + export backup_job_db_port=3306
2023-11-27T08:41:45.444411768Z + backup_job_db_port=3306
2023-11-27T08:41:45.444414247Z + transform_backup_instance_variable 01 POST_SCRIPT_X_VERIFY backup_job_post_script_x_verify
2023-11-27T08:41:45.444416043Z + grep -q '^DB01_POST_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.445298378Z + grep -q '^DB_POST_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.446133257Z + grep -q '^POST_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.446837237Z + grep -q '^DEFAULT_POST_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.447679270Z + transform_backup_instance_variable 01 POST_SCRIPT backup_job_post_script
2023-11-27T08:41:45.447698855Z + grep -q '^DB01_POST_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.448564759Z + grep -q '^DB_POST_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.449367476Z + grep -q '^POST_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.450085375Z + grep -q '^DEFAULT_POST_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.451137760Z + transform_backup_instance_variable 01 PRE_SCRIPT backup_job_pre_script
2023-11-27T08:41:45.451149400Z + grep -q '^DB01_PRE_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.451819391Z + grep -q '^DB_PRE_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.452590958Z + grep -q '^PRE_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.453380473Z + grep -q '^DEFAULT_PRE_SCRIPT=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.454131343Z + transform_backup_instance_variable 01 PRE_SCRIPT_X_VERIFY backup_job_pre_script_x_verify
2023-11-27T08:41:45.454231554Z + grep -q '^DB01_PRE_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.454986544Z + grep -q '^DB_PRE_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.455781512Z + grep -q '^PRE_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.456575527Z + grep -q '^DEFAULT_PRE_SCRIPT_X_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.457446357Z + transform_backup_instance_variable 01 RESOURCE_OPTIMIZED backup_job_resource_optimized
2023-11-27T08:41:45.457455107Z + grep -q '^DB01_RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.458288210Z + grep -q '^DB_RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.459088465Z + grep -q '^RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.459927257Z + grep -q '^DEFAULT_RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.461303420Z ++ grep '^DEFAULT_RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.461436669Z ++ cut -d = -f2
2023-11-27T08:41:45.463074628Z + '[' FALSE '!=' unset ']'
2023-11-27T08:41:45.463745903Z ++ grep '^DEFAULT_RESOURCE_OPTIMIZED=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.463755286Z ++ cut -d = -f2-
2023-11-27T08:41:45.465285721Z + export backup_job_resource_optimized=FALSE
2023-11-27T08:41:45.465293798Z + backup_job_resource_optimized=FALSE
2023-11-27T08:41:45.465295810Z + transform_backup_instance_variable 01 S3_BUCKET backup_job_s3_bucket
2023-11-27T08:41:45.465297936Z + grep -q '^DB01_S3_BUCKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.466180097Z + grep -q '^DB_S3_BUCKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.467051248Z + grep -q '^S3_BUCKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.467734696Z + grep -q '^DEFAULT_S3_BUCKET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.468506737Z + transform_backup_instance_variable 01 S3_CERT_CA_FILE backup_job_s3_cert_ca_file
2023-11-27T08:41:45.468523562Z + grep -q '^DB01_S3_CERT_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.469327306Z + grep -q '^DB_S3_CERT_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.470190356Z + grep -q '^S3_CERT_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.470872865Z + grep -q '^DEFAULT_S3_CERT_CA_FILE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.471905207Z + transform_backup_instance_variable 01 S3_CERT_SKIP_VERIFY backup_job_s3_cert_skip_verify
2023-11-27T08:41:45.471945961Z + grep -q '^DB01_S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.472780484Z + grep -q '^DB_S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.473685323Z + grep -q '^S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.474451039Z + grep -q '^DEFAULT_S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.475783247Z ++ grep '^DEFAULT_S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.475792182Z ++ cut -d = -f2
2023-11-27T08:41:45.477395979Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.477970695Z ++ grep '^DEFAULT_S3_CERT_SKIP_VERIFY=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.477978685Z ++ cut -d = -f2-
2023-11-27T08:41:45.479497815Z + export backup_job_s3_cert_skip_verify=TRUE
2023-11-27T08:41:45.479507580Z + backup_job_s3_cert_skip_verify=TRUE
2023-11-27T08:41:45.479510394Z + transform_backup_instance_variable 01 S3_EXTRA_OPTS backup_job_s3_extra_opts
2023-11-27T08:41:45.479512532Z + grep -q '^DB01_S3_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.480533321Z + grep -q '^DB_S3_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.481357940Z + grep -q '^S3_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.482259779Z + grep -q '^DEFAULT_S3_EXTRA_OPTS=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.483134214Z + transform_backup_instance_variable 01 S3_HOST backup_job_s3_host
2023-11-27T08:41:45.483143120Z + grep -q '^DB01_S3_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.483846231Z + grep -q '^DB_S3_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.484645059Z + grep -q '^S3_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.485454831Z + grep -q '^DEFAULT_S3_HOST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.486299093Z + transform_backup_instance_variable 01 S3_KEY_ID backup_job_s3_key_id
2023-11-27T08:41:45.486309937Z + grep -q '^DB01_S3_KEY_ID=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.487176681Z + grep -q '^DB_S3_KEY_ID=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.487879030Z + grep -q '^S3_KEY_ID=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.488731639Z + grep -q '^DEFAULT_S3_KEY_ID=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.489480923Z + transform_backup_instance_variable 01 S3_KEY_SECRET backup_job_s3_key_secret
2023-11-27T08:41:45.489490312Z + grep -q '^DB01_S3_KEY_SECRET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.490267351Z + grep -q '^DB_S3_KEY_SECRET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.491082114Z + grep -q '^S3_KEY_SECRET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.491855628Z + grep -q '^DEFAULT_S3_KEY_SECRET=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.492804820Z + transform_backup_instance_variable 01 S3_PATH backup_job_s3_path
2023-11-27T08:41:45.492830496Z + grep -q '^DB01_S3_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.493688822Z + grep -q '^DB_S3_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.494495350Z + grep -q '^S3_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.495295203Z + grep -q '^DEFAULT_S3_PATH=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.496076417Z + transform_backup_instance_variable 01 S3_PROTOCOL backup_job_s3_protocol
2023-11-27T08:41:45.496092487Z + grep -q '^DB01_S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.497181755Z + grep -q '^DB_S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.497970832Z + grep -q '^S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.498751553Z + grep -q '^DEFAULT_S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.500141946Z ++ grep '^DEFAULT_S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.500391445Z ++ cut -d = -f2
2023-11-27T08:41:45.501709808Z + '[' https '!=' unset ']'
2023-11-27T08:41:45.502336280Z ++ grep '^DEFAULT_S3_PROTOCOL=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.502345275Z ++ cut -d = -f2-
2023-11-27T08:41:45.503820090Z + export backup_job_s3_protocol=https
2023-11-27T08:41:45.503828529Z + backup_job_s3_protocol=https
2023-11-27T08:41:45.503831145Z + transform_backup_instance_variable 01 S3_REGION backup_job_s3_region
2023-11-27T08:41:45.503833305Z + grep -q '^DB01_S3_REGION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.504779392Z + grep -q '^DB_S3_REGION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.505505000Z + grep -q '^S3_REGION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.506250073Z + grep -q '^DEFAULT_S3_REGION=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.506978043Z + transform_backup_instance_variable 01 SCRIPT_LOCATION_POST backup_job_script_location_post
2023-11-27T08:41:45.506984048Z + grep -q '^DB01_SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.507811080Z + grep -q '^DB_SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.508600641Z + grep -q '^SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.509391870Z + grep -q '^DEFAULT_SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.510735949Z ++ grep '^DEFAULT_SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.510744896Z ++ cut -d = -f2
2023-11-27T08:41:45.512319159Z + '[' /assets/scripts/post/ '!=' unset ']'
2023-11-27T08:41:45.512909031Z ++ grep '^DEFAULT_SCRIPT_LOCATION_POST=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.512926027Z ++ cut -d = -f2-
2023-11-27T08:41:45.514605777Z + export backup_job_script_location_post=/assets/scripts/post/
2023-11-27T08:41:45.514620487Z + backup_job_script_location_post=/assets/scripts/post/
2023-11-27T08:41:45.514628822Z + transform_backup_instance_variable 01 SCRIPT_LOCATION_PRE backup_job_script_location_pre
2023-11-27T08:41:45.514631440Z + grep -q '^DB01_SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.515738498Z + grep -q '^DB_SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.516556107Z + grep -q '^SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.517376932Z + grep -q '^DEFAULT_SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.518748996Z ++ grep '^DEFAULT_SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.518757998Z ++ cut -d = -f2
2023-11-27T08:41:45.520327766Z + '[' /assets/scripts/pre/ '!=' unset ']'
2023-11-27T08:41:45.520884142Z ++ grep '^DEFAULT_SCRIPT_LOCATION_PRE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.520983536Z ++ cut -d = -f2-
2023-11-27T08:41:45.522398918Z + export backup_job_script_location_pre=/assets/scripts/pre/
2023-11-27T08:41:45.522408046Z + backup_job_script_location_pre=/assets/scripts/pre/
2023-11-27T08:41:45.522498982Z + transform_backup_instance_variable 01 SIZE_VALUE backup_job_size_value
2023-11-27T08:41:45.522507958Z + grep -q '^DB01_SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.523564363Z + grep -q '^DB_SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.524396424Z + grep -q '^SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.525260312Z + grep -q '^DEFAULT_SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.526526626Z ++ grep '^DEFAULT_SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.526536146Z ++ cut -d = -f2
2023-11-27T08:41:45.528194975Z + '[' bytes '!=' unset ']'
2023-11-27T08:41:45.528836418Z ++ grep '^DEFAULT_SIZE_VALUE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.528845654Z ++ cut -d = -f2-
2023-11-27T08:41:45.530450816Z + export backup_job_size_value=bytes
2023-11-27T08:41:45.530462105Z + backup_job_size_value=bytes
2023-11-27T08:41:45.530464871Z + transform_backup_instance_variable 01 SKIP_AVAILABILITY_CHECK backup_job_skip_availability_check
2023-11-27T08:41:45.530466758Z + grep -q '^DB01_SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.531502344Z + grep -q '^DB_SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.532413963Z + grep -q '^SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.533294854Z + grep -q '^DEFAULT_SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.534607969Z ++ grep '^DEFAULT_SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.534621836Z ++ cut -d = -f2
2023-11-27T08:41:45.536370721Z + '[' FALSE '!=' unset ']'
2023-11-27T08:41:45.537032010Z ++ grep '^DEFAULT_SKIP_AVAILABILITY_CHECK=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.537038362Z ++ cut -d = -f2-
2023-11-27T08:41:45.538616910Z + export backup_job_skip_availability_check=FALSE
2023-11-27T08:41:45.538625415Z + backup_job_skip_availability_check=FALSE
2023-11-27T08:41:45.538627673Z + transform_backup_instance_variable 01 SPLIT_DB backup_job_split_db
2023-11-27T08:41:45.538629699Z + grep -q '^DB01_SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.539613942Z + grep -q '^DB_SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.540398308Z + grep -q '^SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.541137835Z + grep -q '^DEFAULT_SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.542471092Z ++ grep '^DEFAULT_SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.542479351Z ++ cut -d = -f2
2023-11-27T08:41:45.544135704Z + '[' TRUE '!=' unset ']'
2023-11-27T08:41:45.544626947Z ++ grep '^DEFAULT_SPLIT_DB=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.544636427Z ++ cut -d = -f2-
2023-11-27T08:41:45.546198964Z + export backup_job_split_db=TRUE
2023-11-27T08:41:45.546209253Z + backup_job_split_db=TRUE
2023-11-27T08:41:45.546211777Z + transform_backup_instance_variable 01 TYPE backup_job_db_type
2023-11-27T08:41:45.546349128Z + grep -q '^DB01_TYPE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.548107280Z ++ grep '^DB01_TYPE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.548121145Z ++ cut -d = -f2
2023-11-27T08:41:45.549632366Z + '[' mysql '!=' unset ']'
2023-11-27T08:41:45.550297102Z ++ grep '^DB01_TYPE=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.550361789Z ++ cut -d = -f2-
2023-11-27T08:41:45.551794786Z + export backup_job_db_type=mysql
2023-11-27T08:41:45.551802842Z + backup_job_db_type=mysql
2023-11-27T08:41:45.551805000Z + transform_backup_instance_variable 01 USER backup_job_db_user
2023-11-27T08:41:45.551810917Z + grep -q '^DB01_USER=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.553257788Z ++ grep '^DB01_USER=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.553267498Z ++ cut -d = -f2
2023-11-27T08:41:45.554796069Z + '[' gseadmin '!=' unset ']'
2023-11-27T08:41:45.555439677Z ++ grep '^DB01_USER=' /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.555448771Z ++ cut -d = -f2-
2023-11-27T08:41:45.556896783Z + export backup_job_db_user=gseadmin
2023-11-27T08:41:45.556905664Z + backup_job_db_user=gseadmin
2023-11-27T08:41:45.557571576Z ++ echo ''\''0 0 * * *'\'''
2023-11-27T08:41:45.557672318Z ++ sed -e 's|'\''||g' -e 's|"||g'
2023-11-27T08:41:45.558434157Z + backup_job_backup_begin='0 0 * * *'
2023-11-27T08:41:45.558442760Z + var_true ''
2023-11-27T08:41:45.558452334Z + '[' '' = true ']'
2023-11-27T08:41:45.558454553Z + '[' '' = yes ']'
2023-11-27T08:41:45.558456186Z + rm -rf /tmp/tmp.cwYwGjcwMW
2023-11-27T08:41:45.560128169Z + var_true ''
2023-11-27T08:41:45.560137294Z + '[' '' = true ']'
2023-11-27T08:41:45.560139619Z + '[' '' = yes ']'
2023-11-27T08:41:45.560421060Z + bootstrap_variables parse_variables 01
2023-11-27T08:41:45.560652577Z + var_true ''
2023-11-27T08:41:45.560657730Z + '[' '' = true ']'
2023-11-27T08:41:45.560659950Z + '[' '' = yes ']'
2023-11-27T08:41:45.561342415Z + case "${1}" in
2023-11-27T08:41:45.561349590Z + parse_variables 01
2023-11-27T08:41:45.561351439Z + local v_instance=01
2023-11-27T08:41:45.561353071Z + check_var backup_job_db_type DB01_TYPE 'appropriate database type'
2023-11-27T08:41:45.561454939Z + output_off
2023-11-27T08:41:45.561463199Z + '[' true = true ']'
2023-11-27T08:41:45.561465914Z + set +x
2023-11-27T08:41:45.568954104Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/dbbackup-01/run ** [db-backup01-scheduler] [parse_variables] Looking for existence of DB01_TYPE environment variable
2023-11-27T08:41:45.578382683Z + '[' '!' -v backup_job_db_type ']'
2023-11-27T08:41:45.578420987Z + output_on
2023-11-27T08:41:45.578425556Z + '[' true = true ']'
2023-11-27T08:41:45.578429016Z + case "$(basename "$0")" in
2023-11-27T08:41:45.578799449Z ++ basename ./run
2023-11-27T08:41:45.580325833Z + case "$PWD" in
2023-11-27T08:41:45.580337647Z + set -x
2023-11-27T08:41:45.580339947Z + case "${backup_job_db_type,,}" in
2023-11-27T08:41:45.580341661Z + dbtype=mysql
2023-11-27T08:41:45.580343538Z + backup_job_db_port=3306
2023-11-27T08:41:45.580345188Z + check_var backup_job_db_name DB01_NAME 'database name. Seperate multiple with commas'
2023-11-27T08:41:45.580346920Z + output_off
2023-11-27T08:41:45.580453974Z + '[' true = true ']'
2023-11-27T08:41:45.580463289Z + set +x
2023-11-27T08:41:45.588302296Z 2023-11-27.08:41:45 [DEBUG] /etc/services.available/dbbackup-01/run ** [db-backup01-scheduler] [parse_variables] Looking for existence of DB01_NAME environment variable
2023-11-27T08:41:45.596923819Z + '[' '!' -v backup_job_db_name ']'
2023-11-27T08:41:45.596948794Z + output_on
2023-11-27T08:41:45.597015116Z + '[' true = true ']'
2023-11-27T08:41:45.597020852Z + case "$(basename "$0")" in
2023-11-27T08:41:45.597335787Z ++ basename ./run
2023-11-27T08:41:45.598673153Z + case "$PWD" in
2023-11-27T08:41:45.598680683Z + set -x
2023-11-27T08:41:45.598696106Z + var_true FALSE
2023-11-27T08:41:45.598815757Z + '[' false = true ']'
2023-11-27T08:41:45.598824319Z + '[' false = yes ']'
2023-11-27T08:41:45.598826605Z + var_true FALSE
2023-11-27T08:41:45.598828775Z + '[' false = true ']'
2023-11-27T08:41:45.598830702Z + '[' false = yes ']'
2023-11-27T08:41:45.599050001Z + var_true ''
2023-11-27T08:41:45.599057631Z + '[' '' = true ']'
2023-11-27T08:41:45.599059539Z + '[' '' = yes ']'
2023-11-27T08:41:45.599367828Z + '[' -z gse ']'
2023-11-27T08:41:45.599373399Z + PROCESS_NAME=01-gse-database__gse
2023-11-27T08:41:45.599375316Z + trap ctrl_c INT
2023-11-27T08:41:45.599457506Z + [[ auto =~ standalone ]]
2023-11-27T08:41:45.599652035Z + '[' auto = manual ']'
2023-11-27T08:41:45.599657199Z + '[' dbbackup-01 = manual ']'
2023-11-27T08:41:45.599659304Z + '[' dbbackup-01 = now ']'
2023-11-27T08:41:45.599661094Z + silent sleep 01
2023-11-27T08:41:45.599662639Z + '[' true = true ']'
2023-11-27T08:41:45.599664602Z + sleep 01
2023-11-27T08:41:46.602055673Z + time_last_run=0
2023-11-27T08:41:46.602439318Z ++ date +%s
2023-11-27T08:41:46.604244056Z + time_current=1701074506
2023-11-27T08:41:46.604253188Z + [[ 0 0 * * * =~ ^\+(.*)$ ]]
2023-11-27T08:41:46.604267080Z + [[ 0 0 * * * =~ ^[0-9]{4}$ ]]
2023-11-27T08:41:46.604546032Z + [[ 0 0 * * * =~ ([0-9]{4})-([0-9]{2})-([0-9]{2})[[:space:]]([0-9]{2}):([0-9]{2}):([0-9]{2}) ]]
2023-11-27T08:41:46.605130702Z + echo '0 0 # # #'
2023-11-27T08:41:46.605142681Z + grep -qP '^(((\d+,)+\d+|(\d+(\/|-)\d+)|\d+|#) ?){5}$'
2023-11-27T08:41:46.606202961Z + print_debug 'BACKUP_BEGIN is a cron expression'
2023-11-27T08:41:46.606212905Z + output_off
2023-11-27T08:41:46.606215578Z + '[' true = true ']'
2023-11-27T08:41:46.606218166Z + set +x
2023-11-27T08:41:46.616362410Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] BACKUP_BEGIN is a cron expression
2023-11-27T08:41:46.629905541Z ++ date +%s
2023-11-27T08:41:46.632210850Z + time_last_run=1701074506
2023-11-27T08:41:46.632227976Z + backup_job_backup_begin='0 0 * * *'
2023-11-27T08:41:46.632231438Z + backup_job_backup_begin='0 0 * * *'
2023-11-27T08:41:46.632279585Z + timer cron '0 0 * * *'<PHONE_NUMBER><PHONE_NUMBER>
2023-11-27T08:41:46.632576410Z + var_true ''
2023-11-27T08:41:46.632598052Z + '[' '' = true ']'
2023-11-27T08:41:46.632601664Z + '[' '' = yes ']'
2023-11-27T08:41:46.632604021Z + case "${1}" in
2023-11-27T08:41:46.632606347Z + local cron_compare=1701074506
2023-11-27T08:41:46.632608460Z + local cron_compare_seconds=1701074506
2023-11-27T08:41:46.632802385Z + local cron_compare_difference=0
2023-11-27T08:41:46.632812364Z + '[' 0 -lt 60 ']'
2023-11-27T08:41:46.632815442Z + cron_compare=1701074566
2023-11-27T08:41:46.633601156Z ++ date --date=@1701074506 +%-S
2023-11-27T08:41:46.635481229Z + local cron_current_seconds=46
2023-11-27T08:41:46.635492516Z + '[' 46 -ne 0 ']'
2023-11-27T08:41:46.635495208Z + cron_compare_seconds=1701074460
2023-11-27T08:41:46.636486398Z ++ echo -n '0 0 * * *'
2023-11-27T08:41:46.636591378Z ++ awk '{print $1}'
2023-11-27T08:41:46.637667465Z + local cron_minute=0
2023-11-27T08:41:46.638483445Z ++ echo -n '0 0 * * *'
2023-11-27T08:41:46.638501086Z ++ awk '{print $2}'
2023-11-27T08:41:46.639620458Z + local cron_hour=0
2023-11-27T08:41:46.640442965Z ++ echo -n '0 0 * * *'
2023-11-27T08:41:46.640457330Z ++ awk '{print $3}'
2023-11-27T08:41:46.641508136Z + local 'cron_day_of_month=*'
2023-11-27T08:41:46.642250736Z ++ echo -n '0 0 * * *'
2023-11-27T08:41:46.642260955Z ++ awk '{print $4}'
2023-11-27T08:41:46.643366347Z + local 'cron_month=*'
2023-11-27T08:41:46.644108910Z ++ echo -n '0 0 * * *'
2023-11-27T08:41:46.644309341Z ++ awk '{print $5}'
2023-11-27T08:41:46.645402746Z + local 'cron_day_of_week=*'
2023-11-27T08:41:46.645843405Z ++ date --date=@1701074566 +%-M
2023-11-27T08:41:46.647613781Z + local cron_next_minute=42
2023-11-27T08:41:46.648222173Z ++ date --date=@1701074566 +%-H
2023-11-27T08:41:46.649763457Z + local cron_next_hour=8
2023-11-27T08:41:46.650299888Z ++ date --date=@1701074566 +%-d
2023-11-27T08:41:46.652063594Z + local cron_next_day_of_month=27
2023-11-27T08:41:46.652546643Z ++ date --date=@1701074566 +%-m
2023-11-27T08:41:46.654353231Z + local cron_next_month=11
2023-11-27T08:41:46.654826671Z ++ date --date=@1701074566 +%-u
2023-11-27T08:41:46.656571809Z + local cron_next_day_of_week=1
2023-11-27T08:41:46.656582791Z + cron_next_day_of_week=1
2023-11-27T08:41:46.657185815Z ++ date --date=@1701074566 +%-Y
2023-11-27T08:41:46.658705779Z + local cron_next_year=2023
2023-11-27T08:41:46.658716024Z + local cron_next=
2023-11-27T08:41:46.658718578Z + local cron_parsed=1
2023-11-27T08:41:46.658720750Z + '[' 1 '!=' 0 ']'
2023-11-27T08:41:46.658731046Z + print_debug '[timer] [cron] Parse Minute'
2023-11-27T08:41:46.658841596Z + output_off
2023-11-27T08:41:46.658851039Z + '[' true = true ']'
2023-11-27T08:41:46.658854051Z + set +x
2023-11-27T08:41:46.666698150Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [timer] [cron] Parse Minute
2023-11-27T08:41:46.676575373Z ++ parse_expression 0 59 42
2023-11-27T08:41:46.676594591Z ++ local expressions=0
2023-11-27T08:41:46.676601892Z ++ expressions=0
2023-11-27T08:41:46.676604033Z ++ local validate_all=
2023-11-27T08:41:46.676703848Z ++ local validate_temp=
2023-11-27T08:41:46.676713000Z ++ for expression in ${expressions}
2023-11-27T08:41:46.676715442Z ++ '[' 0 = '#' ']'
2023-11-27T08:41:46.676717215Z ++ '[' 0 = 42 ']'
2023-11-27T08:41:46.676851310Z ++ expression_step=0
2023-11-27T08:41:46.676860750Z ++ expression_number=0
2023-11-27T08:41:46.676863415Z ++ validate_temp=
2023-11-27T08:41:46.676865655Z ++ local expression_start=
2023-11-27T08:41:46.676867260Z ++ local expression_end=
2023-11-27T08:41:46.676869104Z ++ '[' 0 = '#' ']'
2023-11-27T08:41:46.676870669Z ++ expression_start=0
2023-11-27T08:41:46.676872589Z ++ expression_end=0
2023-11-27T08:41:46.677397585Z +++ seq 0 0
2023-11-27T08:41:46.679051357Z ++ validate_temp=0
2023-11-27T08:41:46.679059108Z ++ '[' 0 '!=' 0 ']'
2023-11-27T08:41:46.679061076Z ++ validate_all=' 0'
2023-11-27T08:41:46.679758994Z +++ echo ' 0'
2023-11-27T08:41:46.679768287Z +++ tr ' ' '\n'
2023-11-27T08:41:46.680221532Z +++ sort -n -u
2023-11-27T08:41:46.680231463Z +++ tr '\n' ' '
2023-11-27T08:41:46.681762009Z ++ validate_all=' '
2023-11-27T08:41:46.681772492Z ++ echo ''
2023-11-27T08:41:46.682178801Z + cron_next=
2023-11-27T08:41:46.682188552Z + '[' '' '!=' 42 ']'
2023-11-27T08:41:46.682190987Z + '[' 42 -gt '' ']'
2023-11-27T08:41:46.682192836Z /assets/functions/10-db-backup: line 1914: [: : integer expression expected
2023-11-27T08:41:46.682194938Z + cron_next_minute=
2023-11-27T08:41:46.682196498Z + print_debug '[timer] [cron] Parse Hour'
2023-11-27T08:41:46.682303989Z + output_off
2023-11-27T08:41:46.682311380Z + '[' true = true ']'
2023-11-27T08:41:46.682313938Z + set +x
2023-11-27T08:41:46.690073879Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [timer] [cron] Parse Hour
2023-11-27T08:41:46.699909138Z ++ parse_expression 0 23 8
2023-11-27T08:41:46.699977665Z ++ local expressions=0
2023-11-27T08:41:46.699986123Z ++ expressions=0
2023-11-27T08:41:46.699991544Z ++ local validate_all=
2023-11-27T08:41:46.699996810Z ++ local validate_temp=
2023-11-27T08:41:46.700117216Z ++ for expression in ${expressions}
2023-11-27T08:41:46.700126830Z ++ '[' 0 = '#' ']'
2023-11-27T08:41:46.700129264Z ++ '[' 0 = 8 ']'
2023-11-27T08:41:46.700131342Z ++ expression_step=0
2023-11-27T08:41:46.700132943Z ++ expression_number=0
2023-11-27T08:41:46.700134528Z ++ validate_temp=
2023-11-27T08:41:46.700136830Z ++ local expression_start=
2023-11-27T08:41:46.700164580Z ++ local expression_end=
2023-11-27T08:41:46.700171378Z ++ '[' 0 = '#' ']'
2023-11-27T08:41:46.700258490Z ++ expression_start=0
2023-11-27T08:41:46.700278578Z ++ expression_end=0
2023-11-27T08:41:46.700671944Z +++ seq 0 0
2023-11-27T08:41:46.702012257Z ++ validate_temp=0
2023-11-27T08:41:46.702024642Z ++ '[' 0 '!=' 0 ']'
2023-11-27T08:41:46.702029233Z ++ validate_all=' 0'
2023-11-27T08:41:46.702656625Z +++ echo ' 0'
2023-11-27T08:41:46.702750016Z +++ tr ' ' '\n'
2023-11-27T08:41:46.703049308Z +++ sort -n -u
2023-11-27T08:41:46.703062680Z +++ tr '\n' ' '
2023-11-27T08:41:46.704485493Z ++ validate_all=' '
2023-11-27T08:41:46.704495112Z ++ echo ''
2023-11-27T08:41:46.704800015Z + cron_next=
2023-11-27T08:41:46.704807450Z + '[' '' '!=' 8 ']'
2023-11-27T08:41:46.704809713Z + '[' 8 -gt '' ']'
2023-11-27T08:41:46.704811445Z /assets/functions/10-db-backup: line 1924: [: : integer expression expected
2023-11-27T08:41:46.704813510Z + cron_next_hour=
2023-11-27T08:41:46.704815127Z + print_debug '[timer] [cron] Parse Day of Week'
2023-11-27T08:41:46.705043638Z + output_off
2023-11-27T08:41:46.705051814Z + '[' true = true ']'
2023-11-27T08:41:46.705054000Z + set +x
2023-11-27T08:41:46.712685167Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [timer] [cron] Parse Day of Week
2023-11-27T08:41:46.722522494Z ++ parse_expression '*' 6 1
2023-11-27T08:41:46.722566657Z ++ local 'expressions=*'
2023-11-27T08:41:46.722603192Z ++ expressions='#'
2023-11-27T08:41:46.722612093Z ++ local validate_all=
2023-11-27T08:41:46.722615659Z ++ local validate_temp=
2023-11-27T08:41:46.722741709Z ++ for expression in ${expressions}
2023-11-27T08:41:46.722749898Z ++ '[' '#' = '#' ']'
2023-11-27T08:41:46.722753124Z ++ echo 1
2023-11-27T08:41:46.722790948Z ++ return 0
2023-11-27T08:41:46.723200169Z + cron_next=1
2023-11-27T08:41:46.723209900Z + '[' 1 '!=' 1 ']'
2023-11-27T08:41:46.723212529Z + print_debug '[timer] [cron] Parse day of month'
2023-11-27T08:41:46.723214536Z + output_off
2023-11-27T08:41:46.723216447Z + '[' true = true ']'
2023-11-27T08:41:46.723218336Z + set +x
2023-11-27T08:41:46.732532851Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [timer] [cron] Parse day of month
2023-11-27T08:41:46.744742547Z + case "${cron_next_month}" in
2023-11-27T08:41:46.744760589Z + last_day_of_month=30
2023-11-27T08:41:46.745370570Z ++ parse_expression '*' 30 27
2023-11-27T08:41:46.745505020Z ++ local 'expressions=*'
2023-11-27T08:41:46.745514092Z ++ expressions='#'
2023-11-27T08:41:46.745516829Z ++ local validate_all=
2023-11-27T08:41:46.745519331Z ++ local validate_temp=
2023-11-27T08:41:46.745521687Z ++ for expression in ${expressions}
2023-11-27T08:41:46.745523928Z ++ '[' '#' = '#' ']'
2023-11-27T08:41:46.745721834Z ++ echo 27
2023-11-27T08:41:46.745732926Z ++ return 0
2023-11-27T08:41:46.746349309Z + cron_next=27
2023-11-27T08:41:46.746373182Z + '[' 27 '!=' 27 ']'
2023-11-27T08:41:46.746380267Z + '[' 27 -gt 27 ']'
2023-11-27T08:41:46.746384503Z + '[' 27 -gt 30 ']'
2023-11-27T08:41:46.746387957Z + cron_next_day_of_month=27
2023-11-27T08:41:46.746664908Z + print_debug '[timer] [cron] Parse Next Month'
2023-11-27T08:41:46.746679018Z + output_off
2023-11-27T08:41:46.746684188Z + '[' true = true ']'
2023-11-27T08:41:46.746688500Z + set +x
2023-11-27T08:41:46.757023409Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [timer] [cron] Parse Next Month
2023-11-27T08:41:46.769751236Z ++ parse_expression '*' 12 11
2023-11-27T08:41:46.769767967Z ++ local 'expressions=*'
2023-11-27T08:41:46.769771521Z ++ expressions='#'
2023-11-27T08:41:46.769773720Z ++ local validate_all=
2023-11-27T08:41:46.769775923Z ++ local validate_temp=
2023-11-27T08:41:46.769778338Z ++ for expression in ${expressions}
2023-11-27T08:41:46.769780689Z ++ '[' '#' = '#' ']'
2023-11-27T08:41:46.769788314Z ++ echo 11
2023-11-27T08:41:46.770121737Z ++ return 0
2023-11-27T08:41:46.770409406Z + cron_next=11
2023-11-27T08:41:46.770419821Z + '[' 11 '!=' 11 ']'
2023-11-27T08:41:46.770422650Z + cron_parsed=0
2023-11-27T08:41:46.770425153Z + '[' 0 '!=' 0 ']'
2023-11-27T08:41:46.771823043Z +++ printf %02d 11
2023-11-27T08:41:46.772660000Z +++ printf %02d 27
2023-11-27T08:41:46.773446267Z +++ printf %02d
2023-11-27T08:41:46.774280237Z +++ printf %02d
2023-11-27T08:41:46.774628639Z ++ date --date=2023-11-27T00:00:00 +%s
2023-11-27T08:41:46.776554048Z + local cron_future=1701043200
2023-11-27T08:41:46.776565484Z + local cron_future_difference=-31260
2023-11-27T08:41:46.776568275Z + time_cron=true
2023-11-27T08:41:46.776570285Z + time_wait=-31260
2023-11-27T08:41:46.776572244Z + time_future=1701043200
2023-11-27T08:41:46.776574749Z + var_true ''
2023-11-27T08:41:46.776576664Z + '[' '' = true ']'
2023-11-27T08:41:46.776695159Z + '[' '' = yes ']'
2023-11-27T08:41:46.777035587Z + print_debug 'Wait Time: -31260 Future execution time:<PHONE_NUMBER> Current Time:<PHONE_NUMBER>'
2023-11-27T08:41:46.777048888Z + output_off
2023-11-27T08:41:46.777066741Z + '[' true = true ']'
2023-11-27T08:41:46.777072267Z + set +x
2023-11-27T08:41:46.787641514Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] Wait Time: -31260 Future execution time:<PHONE_NUMBER> Current Time:<PHONE_NUMBER>
2023-11-27T08:41:46.800834474Z ++ date -d @1701043200 '+%Y-%m-%d %T %Z'
2023-11-27T08:41:46.802718740Z + print_info 'Next Backup at 2023-11-27 00:00:00 UTC'
2023-11-27T08:41:46.802730072Z + output_off
2023-11-27T08:41:46.802732850Z + '[' true = true ']'
2023-11-27T08:41:46.802735388Z + set +x
2023-11-27T08:41:46.812678744Z 2023-11-27.08:41:46 [INFO] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] Next Backup at 2023-11-27 00:00:00 UTC
2023-11-27T08:41:46.825305869Z + silent sleep -31260
2023-11-27T08:41:46.825326803Z + '[' true = true ']'
2023-11-27T08:41:46.825331766Z + sleep -31260
2023-11-27T08:41:46.827137761Z sleep: invalid option -- '3'
2023-11-27T08:41:46.827283284Z Try 'sleep --help' for more information.
2023-11-27T08:41:46.827785770Z + true
2023-11-27T08:41:46.827798749Z + '[' -n '' ']'
2023-11-27T08:41:46.827802220Z + var_true ''
2023-11-27T08:41:46.827804409Z + '[' '' = true ']'
2023-11-27T08:41:46.827806414Z + '[' '' = yes ']'
2023-11-27T08:41:46.827808330Z + timer job start
2023-11-27T08:41:46.827934870Z + var_true ''
2023-11-27T08:41:46.827948770Z + '[' '' = true ']'
2023-11-27T08:41:46.828290142Z + '[' '' = yes ']'
2023-11-27T08:41:46.828306980Z + case "${1}" in
2023-11-27T08:41:46.828366267Z + case "${2}" in
2023-11-27T08:41:46.828726859Z ++ date +%s
2023-11-27T08:41:46.830708550Z + backup_job_start_time=1701074506
2023-11-27T08:41:46.830736004Z + var_true ''
2023-11-27T08:41:46.830739219Z + '[' '' = true ']'
2023-11-27T08:41:46.830741744Z + '[' '' = yes ']'
2023-11-27T08:41:46.830937529Z + process_limiter
2023-11-27T08:41:46.831068330Z + var_true ''
2023-11-27T08:41:46.831076126Z + '[' '' = true ']'
2023-11-27T08:41:46.831079402Z + '[' '' = yes ']'
2023-11-27T08:41:46.831081432Z + true
2023-11-27T08:41:46.831083439Z + counter=0
2023-11-27T08:41:46.831972455Z ++ wc -l /tmp/.container/db-backup-backups
2023-11-27T08:41:46.832129748Z ++ awk '{print $1}'
2023-11-27T08:41:46.833873454Z + process_amount=0
2023-11-27T08:41:46.833885479Z + '[' 0 -ge 1 ']'
2023-11-27T08:41:46.833888704Z + break
2023-11-27T08:41:46.833891222Z + var_true ''
2023-11-27T08:41:46.834134676Z + '[' '' = true ']'
2023-11-27T08:41:46.834144215Z + '[' '' = yes ']'
2023-11-27T08:41:46.834146894Z + echo 01
2023-11-27T08:41:46.835071103Z ++ date '+%Y-%m-%d %T %Z'
2023-11-27T08:41:46.836716585Z + print_debug 'Backup 01 routines started time: 2023-11-27 08:41:46 UTC'
2023-11-27T08:41:46.836728056Z + output_off
2023-11-27T08:41:46.836731041Z + '[' true = true ']'
2023-11-27T08:41:46.836733508Z + set +x
2023-11-27T08:41:46.846715660Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] Backup 01 routines started time: 2023-11-27 08:41:46 UTC
2023-11-27T08:41:46.859229277Z + bootstrap_filesystem
2023-11-27T08:41:46.859246748Z + var_true ''
2023-11-27T08:41:46.859250053Z + '[' '' = true ']'
2023-11-27T08:41:46.859252425Z + '[' '' = yes ']'
2023-11-27T08:41:46.859254726Z + '[' '!' -d /backup ']'
2023-11-27T08:41:46.859717950Z ++ stat -c %U /backup
2023-11-27T08:41:46.861430490Z + '[' dbbackup '!=' dbbackup ']'
2023-11-27T08:41:46.861902467Z ++ stat -c %a /backup
2023-11-27T08:41:46.863812687Z + '[' 700 '!=' 700 ']'
2023-11-27T08:41:46.863825153Z + '[' -d /backup/archive/ ']'
2023-11-27T08:41:46.863828249Z + '[' '!' -d /logs ']'
2023-11-27T08:41:46.864608785Z ++ stat -c %U /logs
2023-11-27T08:41:46.866444206Z + '[' dbbackup '!=' dbbackup ']'
2023-11-27T08:41:46.866932779Z ++ date +%Y%m%d
2023-11-27T08:41:46.868768157Z + '[' '!' -d /logs/20231127 ']'
2023-11-27T08:41:46.869701427Z ++ stat -c %a /logs
2023-11-27T08:41:46.871488148Z + '[' 755 '!=' 755 ']'
2023-11-27T08:41:46.871500500Z + '[' '!' -d /tmp/backups ']'
2023-11-27T08:41:46.871503966Z + mkdir -p /tmp/backups
2023-11-27T08:41:46.873735112Z ++ stat -c %U /tmp/backups
2023-11-27T08:41:46.875538975Z + '[' root '!=' dbbackup ']'
2023-11-27T08:41:46.875549308Z + chown -R dbbackup:dbbackup /tmp/backups
2023-11-27T08:41:46.877382955Z + var_true ''
2023-11-27T08:41:46.877394140Z + '[' '' = true ']'
2023-11-27T08:41:46.877397485Z + '[' '' = yes ']'
2023-11-27T08:41:46.877399569Z + check_availability
2023-11-27T08:41:46.877633619Z + var_true ''
2023-11-27T08:41:46.877641590Z + '[' '' = true ']'
2023-11-27T08:41:46.877643841Z + '[' '' = yes ']'
2023-11-27T08:41:46.877645687Z + var_false FALSE
2023-11-27T08:41:46.877647473Z + '[' false = false ']'
2023-11-27T08:41:46.877649705Z + case "${dbtype}" in
2023-11-27T08:41:46.877651993Z + counter=0
2023-11-27T08:41:46.878237699Z + run_as_user mysqladmin -ugseadmin -P3306 -hgse-database status
2023-11-27T08:41:46.914943841Z + var_true ''
2023-11-27T08:41:46.915120256Z + '[' '' = true ']'
2023-11-27T08:41:46.915129269Z + '[' '' = yes ']'
2023-11-27T08:41:46.915317104Z + backup_mysql
2023-11-27T08:41:46.915352200Z + var_true ''
2023-11-27T08:41:46.915354596Z + '[' '' = true ']'
2023-11-27T08:41:46.915356284Z + '[' '' = yes ']'
2023-11-27T08:41:46.915571411Z + var_true TRUE
2023-11-27T08:41:46.915584628Z + '[' true = true ']'
2023-11-27T08:41:46.915591672Z + events=--events
2023-11-27T08:41:46.915595397Z + var_true TRUE
2023-11-27T08:41:46.915600136Z + '[' true = true ']'
2023-11-27T08:41:46.915607636Z + single_transaction=--single-transaction
2023-11-27T08:41:46.915615820Z + var_true TRUE
2023-11-27T08:41:46.915621840Z + '[' true = true ']'
2023-11-27T08:41:46.915626351Z + stored_procedures=--routines
2023-11-27T08:41:46.915667885Z + '[' gse = all ']'
2023-11-27T08:41:46.916819971Z ++ echo gse
2023-11-27T08:41:46.916894651Z ++ tr , '\n'
2023-11-27T08:41:46.918788660Z + db_names=gse
2023-11-27T08:41:46.918801080Z + var_true ''
2023-11-27T08:41:46.918803299Z + '[' '' = true ']'
2023-11-27T08:41:46.918805026Z + '[' '' = yes ']'
2023-11-27T08:41:46.919752552Z ++ echo gse
2023-11-27T08:41:46.919763377Z ++ xargs
2023-11-27T08:41:46.920123424Z ++ tr ' ' ,
2023-11-27T08:41:46.922447084Z + write_log debug 'Databases Found: gse'
2023-11-27T08:41:46.922458369Z + var_true ''
2023-11-27T08:41:46.922467082Z + '[' '' = true ']'
2023-11-27T08:41:46.922469534Z + '[' '' = yes ']'
2023-11-27T08:41:46.922471262Z + output_off
2023-11-27T08:41:46.922472960Z + '[' true = true ']'
2023-11-27T08:41:46.922474646Z + set +x
2023-11-27T08:41:46.930549840Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] Databases Found: gse
2023-11-27T08:41:46.940300439Z + output_on
2023-11-27T08:41:46.940315351Z + '[' true = true ']'
2023-11-27T08:41:46.940318281Z + case "$(basename "$0")" in
2023-11-27T08:41:46.940644618Z ++ basename ./run
2023-11-27T08:41:46.942559855Z + case "$PWD" in
2023-11-27T08:41:46.942577217Z + set -x
2023-11-27T08:41:46.942581446Z + var_true ''
2023-11-27T08:41:46.942584368Z + '[' '' = true ']'
2023-11-27T08:41:46.942587366Z + '[' '' = yes ']'
2023-11-27T08:41:46.942767236Z + var_true TRUE
2023-11-27T08:41:46.942782239Z + '[' true = true ']'
2023-11-27T08:41:46.942800615Z + for db in ${db_names}
2023-11-27T08:41:46.942805347Z + prepare_dbbackup
2023-11-27T08:41:46.942807141Z + timer backup start
2023-11-27T08:41:46.942820456Z + var_true ''
2023-11-27T08:41:46.942828570Z + '[' '' = true ']'
2023-11-27T08:41:46.942831263Z + '[' '' = yes ']'
2023-11-27T08:41:46.943133704Z + case "${1}" in
2023-11-27T08:41:46.943141632Z + case "${2}" in
2023-11-27T08:41:46.943516885Z ++ run_as_user date +%s
2023-11-27T08:41:46.943526412Z ++ sudo -Eu dbbackup date +%s
2023-11-27T08:41:46.946830519Z + dbbackup_start_time=1701074506
2023-11-27T08:41:46.946846303Z + var_true ''
2023-11-27T08:41:46.946848630Z + '[' '' = true ']'
2023-11-27T08:41:46.946850368Z + '[' '' = yes ']'
2023-11-27T08:41:46.947418502Z ++ run_as_user date +%Y%m%d-%H%M%S
2023-11-27T08:41:46.947428891Z ++ sudo -Eu dbbackup date +%Y%m%d-%H%M%S
2023-11-27T08:41:46.951061666Z + now=20231127-084146
2023-11-27T08:41:46.951076152Z + backup_job_filename_base=mysql_gse_gse-database
2023-11-27T08:41:46.951078864Z + backup_job_filename=mysql_gse_gse-database_20231127-084146.sql
2023-11-27T08:41:46.951081048Z + backup_job_filename=mysql_gse_gse-database_20231127-084146.sql
2023-11-27T08:41:46.951082974Z + backup_job_filename_base=mysql_gse_gse-database
2023-11-27T08:41:46.951084621Z + compression
2023-11-27T08:41:46.951277158Z + var_true ''
2023-11-27T08:41:46.951286205Z + '[' '' = true ']'
2023-11-27T08:41:46.951438398Z + '[' '' = yes ']'
2023-11-27T08:41:46.951452605Z + var_false TRUE
2023-11-27T08:41:46.951454906Z + '[' true = false ']'
2023-11-27T08:41:46.951456571Z + '[' true = no ']'
2023-11-27T08:41:46.951557344Z + var_true ''
2023-11-27T08:41:46.951568670Z + '[' '' = true ']'
2023-11-27T08:41:46.951571899Z + '[' '' = yes ']'
2023-11-27T08:41:46.951573902Z + case "${backup_job_compression,,}" in
2023-11-27T08:41:46.951575649Z + print_debug '[compression] Selected GZIP'
2023-11-27T08:41:46.951577646Z + output_off
2023-11-27T08:41:46.951579226Z + '[' true = true ']'
2023-11-27T08:41:46.951580939Z + set +x
2023-11-27T08:41:46.959469748Z 2023-11-27.08:41:46 [DEBUG] /etc/services.available/dbbackup-01/run ** [01-gse-database__gse] [compression] Selected GZIP
2023-11-27T08:41:46.969464959Z + compress_cmd=' pigz -q -3 -p 12 '
2023-11-27T08:41:46.969478958Z + compression_type=gzip
2023-11-27T08:41:46.969481421Z + extension=.gz
2023-11-27T08:41:46.969483574Z + dir_compress_cmd=' pigz -q -3 -p 12 '
2023-11-27T08:41:46.969485281Z + backup_job_filename_dir=mysql_gse_gse-database_20231127-084146.sql
2023-11-27T08:41:46.969487307Z + backup_job_filename=mysql_gse_gse-database_20231127-084146.sql.gz
2023-11-27T08:41:46.969489381Z + case "${CONTAINER_LOG_LEVEL,,}" in
2023-11-27T08:41:46.969491409Z + '[' gzip = none ']'
2023-11-27T08:41:46.969493308Z + compression_string='and compressing with '\''gzip:3'\'' with '\''12'\'' threads'
2023-11-27T08:41:46.969495162Z + var_true ''
2023-11-27T08:41:46.969496870Z + '[' '' = true ']'
2023-11-27T08:41:46.969498567Z + '[' '' = yes ']'
2023-11-27T08:41:46.969606990Z + pre_dbbackup gse
2023-11-27T08:41:46.969618155Z + var_true ''
2023-11-27T08:41:46.969621659Z + '[' '' = true ']'
2023-11-27T08:41:46.969623427Z + '[' '' = yes ']'
2023-11-27T08:41:46.969625365Z + '[' -n '' ']'
2023-11-27T08:41:46.969627223Z + '[' -d /assets/custom-scripts/pre ']'
2023-11-27T08:41:46.969629145Z + '[' -d /assets/scripts/pre/ ']'
2023-11-27T08:41:46.969740685Z + dir_notempty /assets/scripts/pre/
2023-11-27T08:41:46.970248564Z ++ ls -A /assets/scripts/pre/
2023-11-27T08:41:46.972112597Z + '[' -n 00_clean_flyway_history.sh ']'
2023-11-27T08:41:46.972633054Z ++ find /assets/scripts/pre/ -name '*.sh' -type f
2023-11-27T08:41:46.973581357Z + for f in $(find ${backup_job_script_location_pre} -name \*.sh -type f)
2023-11-27T08:41:46.973591833Z + var_true ''
2023-11-27T08:41:46.973594234Z + '[' '' = true ']'
2023-11-27T08:41:46.973596471Z + '[' '' = yes ']'
2023-11-27T08:41:46.973634782Z + '[' -x /assets/scripts/pre/00_clean_flyway_history.sh ']'
2023-11-27T08:41:46.973647644Z + write_log notice 'Executing pre backup custom script : '\''/assets/scripts/pre/00_clean_flyway_history.sh'\'''
2023-11-27T08:41:46.973850806Z + var_true ''
2023-11-27T08:41:46.973874331Z + '[' '' = true ']'
2023-11-27T08:41:46.973878230Z + '[' '' = yes ']'
2023-11-27T08:41:46.973881171Z + output_off
2023-11-27T08:41:46.973890465Z + '[' true = true ']'
2023-11-27T08:41:46.973892958Z + set +x