If the MySQL client returns with a "MySQL server has gone away" error, then provision attempts to log that message into the hosting_task_log table. I believe the attempt to log that message is in-turn generating another MySQL server has gone away error logging attempt. That second attempt should not generate a third, but the double log attempt is repeated for every step in the process.

Perhaps this has been identified and corrected in 1.6?

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush bootstrap phase : _drush_bootstrap_drush()', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush
bootstrap phase : _drush_bootstrap_drush()', '', 1329840448) database.mysqli.inc:134 [688.38 sec, 53.08 MB]
Drush bootstrap phase : _drush_bootstrap_drush() [688.38 sec, 53.07 MB]                                                         [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Load alias @www.socialimpactexchange.org', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

The detailed log:

aegir@rs2:~$ drush @hostmaster hosting-task 3368 --debug
Bootstrap to phase 0. [0.03 sec, 2.79 MB]                            [bootstrap]
Drush bootstrap phase : _drush_bootstrap_drush() [0.03 sec, 3.01 MB] [bootstrap]
Load alias @hostmaster [0.03 sec, 3.02 MB]                                                                                         [notice]
Loading drushrc "/var/aegir/hostmaster-6.x-1.4/sites/rs2.someotherdomain.com/drushrc.php" into "site" scope. [0.03 sec, 3.03 MB][bootstrap]
Assigning the return value of new by reference is deprecated civicrm.drush.inc:437 [0.06 sec, 4.14 MB]                             [notice]
Assigning the return value of new by reference is deprecated civicrm.drush.inc:742 [0.06 sec, 4.24 MB]                             [notice]
Bootstrap to phase 5. [0.12 sec, 11.51 MB]                                                                                      [bootstrap]
Drush bootstrap phase : _drush_bootstrap_drupal_root() [0.12 sec, 11.51 MB]                                                     [bootstrap]
Loading drushrc "/var/aegir/hostmaster-6.x-1.4/drushrc.php" into "drupal" scope. [0.12 sec, 11.51 MB]                           [bootstrap]
Initialized Drupal 6.22 root directory at /var/aegir/hostmaster-6.x-1.4 [0.15 sec, 12.77 MB]                                       [notice]
Drush bootstrap phase : _drush_bootstrap_drupal_site() [0.15 sec, 12.77 MB]                                                     [bootstrap]
Initialized Drupal site rs2.someotherdomain.com at sites/rs2.someotherdomain.com [0.15 sec, 12.77 MB]                              [notice]
Loading drushrc "/var/aegir/hostmaster-6.x-1.4/sites/rs2.someotherdomain.com/drushrc.php" into "site" scope. [0.15 sec, 12.78   [bootstrap]
MB]
Drush bootstrap phase : _drush_bootstrap_drupal_configuration() [0.16 sec, 12.78 MB]                                            [bootstrap]
Drush bootstrap phase : _drush_bootstrap_drupal_database() [0.17 sec, 12.83 MB]                                                 [bootstrap]
Successfully connected to the Drupal database. [0.17 sec, 12.83 MB]                                                             [bootstrap]
Drush bootstrap phase : _drush_bootstrap_drupal_full() [0.17 sec, 13.21 MB]                                                     [bootstrap]
Bootstrap to phase 5. [0.31 sec, 23.37 MB]                                                                                      [bootstrap]
Found command: hosting-task (commandfile=hosting) [0.31 sec, 23.37 MB]                                                          [bootstrap]
Initializing drush commandfile: drush_make [0.31 sec, 23.37 MB]                                                                 [bootstrap]
Initializing drush commandfile: drush_make_d_o [0.31 sec, 23.38 MB]                                                             [bootstrap]
Initializing drush commandfile: githook [0.31 sec, 23.38 MB]                                                                    [bootstrap]
Initializing drush commandfile: provision [0.31 sec, 23.38 MB]                                                                  [bootstrap]
Load alias @server_localhost [0.31 sec, 23.4 MB]                                                                                   [notice]
Load alias @server_master [0.31 sec, 23.42 MB]                                                                                     [notice]
Loading nginx driver for the http service [0.32 sec, 23.45 MB]                                                                     [notice]
Loading mysql driver for the db service [0.32 sec, 23.46 MB]                                                                       [notice]
Load alias @platform_hostmaster6x14 [0.32 sec, 23.47 MB]                                                                           [notice]
Initializing drush commandfile: user [0.32 sec, 23.48 MB]                                                                       [bootstrap]
Including profiles/hostmaster/modules/hosting/task.hosting.inc [0.32 sec, 23.48 MB]                                             [bootstrap]
Drush bootstrap phase : _drush_bootstrap_drupal_login() [0.32 sec, 23.55 MB]                                                    [bootstrap]
Successfully logged into Drupal as padmin (uid=1) [0.33 sec, 23.56 MB]                                                          [bootstrap]
Task starts processing [0.38 sec, 24.41 MB]                                                                                         [queue]
Undefined variable: additions hosting_client.module:882 [0.4 sec, 25.29 MB]                                                        [notice]
Undefined variable: site hosting_clone.drush.inc:23 [0.41 sec, 25.3 MB]                                                            [notice]
Trying to get property of non-object hosting_clone.drush.inc:23 [0.41 sec, 25.3 MB]                                                [notice]
Undefined index: aliases hosting_clone.drush.inc:28 [0.42 sec, 25.53 MB]                                                           [notice]
Undefined index: redirection hosting_clone.drush.inc:29 [0.42 sec, 25.53 MB]                                                       [notice]
Running: /usr/bin/php /var/aegir/drush/drush.php --php='/usr/bin/php'  --profile='drupal_commons'                                 [command]
--new_db_server='@server_srv1someotherdomaincom' @www.somedomainexchange.org provision-clone '@site.dev1.srv.someotherdomain.com'
'@platform_Platform6x2210dev' --backend  2>&1 [0.42 sec, 25.55 MB]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap to phase 0.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap to phase 0.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap
to phase 0.', '', 1329840448) database.mysqli.inc:134 [688.38 sec, 53.08 MB]
Bootstrap to phase 0. [688.38 sec, 53.07 MB]                                                                                    [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush bootstrap phase : _drush_bootstrap_drush()', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush bootstrap phase : _drush_bootstrap_drush()', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush
bootstrap phase : _drush_bootstrap_drush()', '', 1329840448) database.mysqli.inc:134 [688.38 sec, 53.08 MB]
Drush bootstrap phase : _drush_bootstrap_drush() [688.38 sec, 53.07 MB]                                                         [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Load alias @www.socialimpactexchange.org', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Load alias @www.socialimpactexchange.org', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Load alias
@www.socialimpactexchange.org', '', 1329840448) database.mysqli.inc:134 [688.39 sec, 53.08 MB]
Load alias @www.socialimpactexchange.org [688.38 sec, 53.07 MB]                                                                    [notice]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading drushrc \\"/var/aegir/platforms/blessed-commons-6.x-2.2/sites/www.socialimpactexchange.org/drushrc.php\\" into \\"site\\" scope.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading drushrc \\"/var/aegir/platforms/blessed-commons-6.x-2.2/sites/www.socialimpactexchange.org/drushrc.php\\" into \\"site\\" scope.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading
drushrc \"/var/aegir/platforms/blessed-commons-6.x-2.2/sites/www.socialimpactexchange.org/drushrc.php\" into
\"site\" scope.', '', 1329840448) database.mysqli.inc:134 [688.39 sec, 53.09 MB]
Loading drushrc "/var/aegir/platforms/blessed-commons-6.x-2.2/sites/www.socialimpactexchange.org/drushrc.php" into "site" scope.[bootstrap]
[688.39 sec, 53.08 MB]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning the return value of new by reference is deprecated civicrm.drush.inc:437', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning the return value of new by reference is deprecated civicrm.drush.inc:437', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning
the return value of new by reference is deprecated civicrm.drush.inc:437', '', 1329840448)
database.mysqli.inc:134 [688.39 sec, 53.09 MB]
Assigning the return value of new by reference is deprecated civicrm.drush.inc:437 [688.39 sec, 53.08 MB]                          [notice]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning the return value of new by reference is deprecated civicrm.drush.inc:742', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning the return value of new by reference is deprecated civicrm.drush.inc:742', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Assigning
the return value of new by reference is deprecated civicrm.drush.inc:742', '', 1329840448)
database.mysqli.inc:134 [688.39 sec, 53.09 MB]
Assigning the return value of new by reference is deprecated civicrm.drush.inc:742 [688.39 sec, 53.08 MB]                          [notice]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap to phase 1.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap to phase 1.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Bootstrap
to phase 1.', '', 1329840448) database.mysqli.inc:134 [688.39 sec, 53.1 MB]
Bootstrap to phase 1. [688.39 sec, 53.09 MB]                                                                                    [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush bootstrap phase : _drush_bootstrap_drupal_root()', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush bootstrap phase : _drush_bootstrap_drupal_root()', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Drush
bootstrap phase : _drush_bootstrap_drupal_root()', '', 1329840448) database.mysqli.inc:134 [688.39 sec, 53.1 MB]
Drush bootstrap phase : _drush_bootstrap_drupal_root() [688.39 sec, 53.09 MB]                                                   [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading drushrc \\"/var/aegir/platforms/blessed-commons-6.x-2.2/drushrc.php\\" into \\"drupal\\" scope.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading drushrc \\"/var/aegir/platforms/blessed-commons-6.x-2.2/drushrc.php\\" into \\"drupal\\" scope.', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Loading
drushrc \"/var/aegir/platforms/blessed-commons-6.x-2.2/drushrc.php\" into \"drupal\" scope.',
'', 1329840448) database.mysqli.inc:134 [688.4 sec, 53.1 MB]
Loading drushrc "/var/aegir/platforms/blessed-commons-6.x-2.2/drushrc.php" into "drupal" scope. [688.4 sec, 53.09 MB]           [bootstrap]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Initialized Drupal 6.22 root directory at /var/aegir/platforms/blessed-commons-6.x-2.2', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134

Warning: MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Initialized Drupal 6.22 root directory at /var/aegir/platforms/blessed-commons-6.x-2.2', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134
MySQL server has gone away                                                                                                        [warning]
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'notice', 'Initialized
Drupal 6.22 root directory at /var/aegir/platforms/blessed-commons-6.x-2.2', '', 1329840448)
database.mysqli.inc:134 [688.4 sec, 53.11 MB]
Initialized Drupal 6.22 root directory at /var/aegir/platforms/blessed-commons-6.x-2.2 [688.4 sec, 53.1 MB]                        [notice]
PHP Warning:  MySQL server has gone away
query: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'warning', 'MySQL server has gone away\nquery: INSERT INTO hosting_task_log (vid, type, message, error, timestamp) VALUES (25885, 'bootstrap', 'Found command: provision-clone (commandfile=provision)', '', 1329840448) database.mysqli.inc:134', '', 1329840448) in /var/aegir/hostmaster-6.x-1.4/includes/database.mysqli.inc on line 134


.. etc.

Comments

jason.fisher’s picture

It actually does not seem to be recursive, but the log files absolutely flood with the message.

Maybe the solution is a more graceful abort/resume process that pauses a task until the server has returned and attempts to recover, or at least back out and redo that step?

steven jones’s picture

Issue summary: View changes

corrected assumption