[root@VM-centos67 ~]# cat /tmp/pt-osc_t1.out No slaves found. See --recursion-method if host VM-centos67 has slaves. Not checking slave lag because no slaves were found and --check-slave-lag was not specified. Operation, tries, wait: analyze_table, 10, 1 copy_rows, 10, 0.25 create_triggers, 10, 1 drop_triggers, 10, 1 swap_tables, 10, 1 update_foreign_keys, 10, 1 Altering `test`.`t1`... Creating new table... Created new table test._t1_new OK. Altering new table... Altered `test`.`_t1_new` OK. 2015-12-14T23:40:20 Creating triggers... 2015-12-14T23:40:20 Created triggers OK. 2015-12-14T23:40:20 Copying approximately 1 rows... 2015-12-14T23:40:20 Copied rows OK. 2015-12-14T23:40:20 Analyzing new table... 2015-12-14T23:40:20 Swapping tables... 2015-12-14T23:40:20 Dropping triggers... 2015-12-14T23:40:20 Dropped triggers OK. Not dropping the new table `test`.`_t1_new` because --swap-tables failed. To drop the new table, execute: DROP TABLE IF EXISTS `test`.`_t1_new`; `test`.`t1` was not altered. [root@VM-centos67 ~]# cat /tmp/pt-osc_t1.out.err # /usr/bin/perl 5.010001 # Linux VM-centos67 2.6.32-431.1.2.0.1.el6.x86_64 #1 SMP Fri Dec 13 13:06:13 UTC 2013 x86_64 x86_64 x86_64 GNU/Linux # Arguments: _[h=127.0.0.1,P=3306,u=root,D=test,t=t1]_ _[--alter]_ _[ADD COLUMN field1 int]_ _[--execute]_ _[--no-drop-old-table]_ # OptionParser:291 24239 Option rule: --dry-run and --execute are mutually exclusive. # OptionParser:291 24239 Option rule: This tool accepts additional command-line arguments. Refer to the SYNOPSIS and usage information for details. # OptionParser:300 24239 =item --alter # OptionParser:327 24239 Short help: The schema modification, without the ALTER TABLE keywords # OptionParser:300 24239 =item --alter-foreign-keys-method # OptionParser:327 24239 Short help: How to modify foreign keys so they reference the new table # OptionParser:300 24239 =item --[no]analyze-before-swap # OptionParser:327 24239 Short help: Execute ANALYZE TABLE on the new table before swaping with the old one # OptionParser:300 24239 =item --ask-pass # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Prompt for a password when connecting to MySQL # OptionParser:300 24239 =item --charset # OptionParser:327 24239 Short help: Default character set # OptionParser:300 24239 =item --[no]check-alter # OptionParser:327 24239 Short help: Parses the --alter specified and tries to warn of possible unintended behavior # OptionParser:300 24239 =item --check-interval # OptionParser:327 24239 Short help: Sleep time between checks for --max-lag # OptionParser:300 24239 =item --[no]check-plan # OptionParser:327 24239 Short help: Check query execution plans for safety # OptionParser:300 24239 =item --[no]check-replication-filters # OptionParser:327 24239 Short help: Abort if any replication filter is set on any server # OptionParser:300 24239 =item --check-slave-lag # OptionParser:327 24239 Short help: Pause the data copy until this replica's lag is less than --max-lag # OptionParser:300 24239 =item --chunk-index # OptionParser:327 24239 Short help: Prefer this index for chunking tables # OptionParser:300 24239 =item --chunk-index-columns # OptionParser:327 24239 Short help: Use only this many left-most columns of a --chunk-index # OptionParser:300 24239 =item --chunk-size # OptionParser:327 24239 Short help: Number of rows to select for each chunk copied # OptionParser:300 24239 =item --chunk-size-limit # OptionParser:327 24239 Short help: Do not copy chunks this much larger than the desired chunk size # OptionParser:300 24239 =item --chunk-time # OptionParser:327 24239 Short help: Adjust the chunk size dynamically so each data-copy query takes this long to execute # OptionParser:300 24239 =item --config # OptionParser:327 24239 Short help: Read this comma-separated list of config files; if specified, this must be the first option on the command line # OptionParser:300 24239 =item --critical-load # OptionParser:327 24239 Short help: Examine SHOW GLOBAL STATUS after every chunk, and abort if the load is too high # OptionParser:300 24239 =item --database # OptionParser:327 24239 Short help: Connect to this database # OptionParser:300 24239 =item --default-engine # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Remove ENGINE from the new table # OptionParser:300 24239 =item --defaults-file # OptionParser:327 24239 Short help: Only read mysql options from the given file # OptionParser:300 24239 =item --[no]drop-new-table # OptionParser:327 24239 Short help: Drop the new table if copying the original table fails # OptionParser:300 24239 =item --[no]drop-old-table # OptionParser:327 24239 Short help: Drop the original table after renaming it # OptionParser:300 24239 =item --[no]drop-triggers # OptionParser:327 24239 Short help: Drop triggers on the old table. --no-drop-triggers forces --no-drop-old-table # OptionParser:300 24239 =item --dry-run # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Create and alter the new table, but do not create triggers, copy data, or replace the original table # OptionParser:300 24239 =item --execute # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Indicate that you have read the documentation and want to alter the table # OptionParser:300 24239 =item --force # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: This options bypasses confirmation in case of using alter-foreign-keys-method = none , which might break foreign key constraints # OptionParser:300 24239 =item --help # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Show help and exit # OptionParser:300 24239 =item --host # OptionParser:327 24239 Short help: Connect to host # OptionParser:300 24239 =item --max-flow-ctl # OptionParser:327 24239 Short help: Somewhat similar to --max-lag but for PXC clusters # OptionParser:300 24239 =item --max-lag # OptionParser:327 24239 Short help: Pause the data copy until all replicas' lag is less than this value # OptionParser:300 24239 =item --max-load # OptionParser:327 24239 Short help: Examine SHOW GLOBAL STATUS after every chunk, and pause if any status variables are higher than their thresholds # OptionParser:300 24239 =item --new-table-name # OptionParser:327 24239 Short help: New table name before it is swapped. %T is replaced with the original table name # OptionParser:300 24239 =item --password # OptionParser:327 24239 Short help: Password to use when connecting # OptionParser:300 24239 =item --pid # OptionParser:327 24239 Short help: Create the given PID file # OptionParser:300 24239 =item --plugin # OptionParser:327 24239 Short help: Perl module file that defines a pt_online_schema_change_plugin class # OptionParser:300 24239 =item --port # OptionParser:327 24239 Short help: Port number to use for connection # OptionParser:300 24239 =item --print # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Print SQL statements to STDOUT # OptionParser:300 24239 =item --progress # OptionParser:327 24239 Short help: Print progress reports to STDERR while copying rows # OptionParser:300 24239 =item --quiet # OptionParser:327 24239 Short help: Do not print messages to STDOUT (disables --progress) # OptionParser:300 24239 =item --recurse # OptionParser:327 24239 Short help: Number of levels to recurse in the hierarchy when discovering replicas # OptionParser:300 24239 =item --recursion-method # OptionParser:327 24239 Short help: Preferred recursion method for discovering replicas # OptionParser:300 24239 =item --set-vars # OptionParser:327 24239 Short help: Set the MySQL variables in this comma-separated list of variable=value pairs # OptionParser:300 24239 =item --sleep # OptionParser:327 24239 Short help: How long to sleep (in seconds) after copying each chunk # OptionParser:300 24239 =item --socket # OptionParser:327 24239 Short help: Socket file to use for connection # OptionParser:300 24239 =item --statistics # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Print statistics about internal counters # OptionParser:300 24239 =item --[no]swap-tables # OptionParser:327 24239 Short help: Swap the original table and the new, altered table # OptionParser:300 24239 =item --tries # OptionParser:327 24239 Short help: How many times to try critical operations # OptionParser:300 24239 =item --user # OptionParser:327 24239 Short help: User for login if not current user # OptionParser:300 24239 =item --version # OptionParser:319 24239 Option has no attributes # OptionParser:327 24239 Short help: Show version and exit # OptionParser:300 24239 =item --[no]version-check # OptionParser:327 24239 Short help: Check for the latest version of Percona Toolkit, MySQL, and other programs # OptionParser:367 24239 Parsing opt spec: group => default spec => alter=s desc => The schema modification, without the ALTER TABLE keywords attributes => HASH(0x207d6d8) # OptionParser:406 24239 alter type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => alter-foreign-keys-method=s desc => How to modify foreign keys so they reference the new table attributes => HASH(0x2d22538) # OptionParser:406 24239 alter-foreign-keys-method type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => analyze-before-swap! desc => Execute ANALYZE TABLE on the new table before swaping with the old one (default yes) attributes => HASH(0x2d23980) # OptionParser:406 24239 analyze-before-swap type: undef # OptionParser:413 24239 analyze-before-swap default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => ask-pass desc => Prompt for a password when connecting to MySQL attributes => HASH(0x2d23a58) # OptionParser:406 24239 ask-pass type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => charset|A=s desc => Default character set attributes => HASH(0x2d23b00) # OptionParser:406 24239 charset type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => check-alter! desc => Parses the --alter specified and tries to warn of possible unintended behavior (default yes) attributes => HASH(0x2d23bd8) # OptionParser:406 24239 check-alter type: undef # OptionParser:413 24239 check-alter default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => check-interval=m desc => Sleep time between checks for --max-lag (default 1) attributes => HASH(0x2d23cb0) # OptionParser:406 24239 check-interval type: m # OptionParser:413 24239 check-interval default: 1 # OptionParser:367 24239 Parsing opt spec: group => default spec => check-plan! desc => Check query execution plans for safety (default yes) attributes => HASH(0x2d23d88) # OptionParser:406 24239 check-plan type: undef # OptionParser:413 24239 check-plan default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => check-replication-filters! desc => Abort if any replication filter is set on any server (default yes) attributes => HASH(0x2d23e60) # OptionParser:406 24239 check-replication-filters type: undef # OptionParser:413 24239 check-replication-filters default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => check-slave-lag=s desc => Pause the data copy until this replica's lag is less than --max-lag attributes => HASH(0x2d23f38) # OptionParser:406 24239 check-slave-lag type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => chunk-index=s desc => Prefer this index for chunking tables attributes => HASH(0x2d23ff8) # OptionParser:406 24239 chunk-index type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => chunk-index-columns=i desc => Use only this many left-most columns of a --chunk-index attributes => HASH(0x2d240b8) # OptionParser:406 24239 chunk-index-columns type: i # OptionParser:367 24239 Parsing opt spec: group => default spec => chunk-size=z desc => Number of rows to select for each chunk copied (default 1000) attributes => HASH(0x2d24178) # OptionParser:406 24239 chunk-size type: z # OptionParser:413 24239 chunk-size default: 1000 # OptionParser:367 24239 Parsing opt spec: group => default spec => chunk-size-limit=f desc => Do not copy chunks this much larger than the desired chunk size (default 4.0) attributes => HASH(0x2d24250) # OptionParser:406 24239 chunk-size-limit type: f # OptionParser:413 24239 chunk-size-limit default: 4.0 # OptionParser:367 24239 Parsing opt spec: group => default spec => chunk-time=f desc => Adjust the chunk size dynamically so each data-copy query takes this long to execute (default 0.5) attributes => HASH(0x2d24328) # OptionParser:406 24239 chunk-time type: f # OptionParser:413 24239 chunk-time default: 0.5 # OptionParser:367 24239 Parsing opt spec: group => default spec => config=A desc => Read this comma-separated list of config files; if specified, this must be the first option on the command line attributes => HASH(0x2d24400) # OptionParser:406 24239 config type: A # OptionParser:367 24239 Parsing opt spec: group => default spec => critical-load=A desc => Examine SHOW GLOBAL STATUS after every chunk, and abort if the load is too high (default Threads_running=50) attributes => HASH(0x2d244c0) # OptionParser:406 24239 critical-load type: A # OptionParser:413 24239 critical-load default: Threads_running=50 # OptionParser:367 24239 Parsing opt spec: group => default spec => database|D=s desc => Connect to this database attributes => HASH(0x2d24598) # OptionParser:406 24239 database type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => default-engine desc => Remove ENGINE from the new table attributes => HASH(0x2d24670) # OptionParser:406 24239 default-engine type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => defaults-file|F=s desc => Only read mysql options from the given file attributes => HASH(0x2d24718) # OptionParser:406 24239 defaults-file type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => drop-new-table! desc => Drop the new table if copying the original table fails (default yes) attributes => HASH(0x2d247f0) # OptionParser:406 24239 drop-new-table type: undef # OptionParser:413 24239 drop-new-table default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => drop-old-table! desc => Drop the original table after renaming it (default yes) attributes => HASH(0x2d248c8) # OptionParser:406 24239 drop-old-table type: undef # OptionParser:413 24239 drop-old-table default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => drop-triggers! desc => Drop triggers on the old table. --no-drop-triggers forces --no-drop-old-table (default yes) attributes => HASH(0x2d2b738) # OptionParser:406 24239 drop-triggers type: undef # OptionParser:413 24239 drop-triggers default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => dry-run desc => Create and alter the new table, but do not create triggers, copy data, or replace the original table attributes => HASH(0x2d2b810) # OptionParser:406 24239 dry-run type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => execute desc => Indicate that you have read the documentation and want to alter the table attributes => HASH(0x2d2b8b8) # OptionParser:406 24239 execute type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => force desc => This options bypasses confirmation in case of using alter-foreign-keys-method = none , which might break foreign key constraints attributes => HASH(0x2d2b960) # OptionParser:406 24239 force type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => help desc => Show help and exit attributes => HASH(0x2d2ba08) # OptionParser:406 24239 help type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => host|h=s desc => Connect to host attributes => HASH(0x2d2bab0) # OptionParser:406 24239 host type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => max-flow-ctl=f desc => Somewhat similar to --max-lag but for PXC clusters attributes => HASH(0x2d2bb88) # OptionParser:406 24239 max-flow-ctl type: f # OptionParser:367 24239 Parsing opt spec: group => default spec => max-lag=m desc => Pause the data copy until all replicas' lag is less than this value (default 1s) attributes => HASH(0x2d2bc48) # OptionParser:406 24239 max-lag type: m # OptionParser:413 24239 max-lag default: 1s # OptionParser:367 24239 Parsing opt spec: group => default spec => max-load=A desc => Examine SHOW GLOBAL STATUS after every chunk, and pause if any status variables are higher than their thresholds (default Threads_running=25) attributes => HASH(0x2d2bd20) # OptionParser:406 24239 max-load type: A # OptionParser:413 24239 max-load default: Threads_running=25 # OptionParser:367 24239 Parsing opt spec: group => default spec => new-table-name=s desc => New table name before it is swapped. %T is replaced with the original table name (default %T_new) attributes => HASH(0x2d2bdf8) # OptionParser:406 24239 new-table-name type: s # OptionParser:413 24239 new-table-name default: %T_new # OptionParser:367 24239 Parsing opt spec: group => default spec => password|p=s desc => Password to use when connecting attributes => HASH(0x2d2bed0) # OptionParser:406 24239 password type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => pid=s desc => Create the given PID file attributes => HASH(0x2d2bfa8) # OptionParser:406 24239 pid type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => plugin=s desc => Perl module file that defines a pt_online_schema_change_plugin class attributes => HASH(0x2d2c068) # OptionParser:406 24239 plugin type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => port|P=i desc => Port number to use for connection attributes => HASH(0x2d2c128) # OptionParser:406 24239 port type: i # OptionParser:367 24239 Parsing opt spec: group => default spec => print desc => Print SQL statements to STDOUT attributes => HASH(0x2d2c200) # OptionParser:406 24239 print type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => progress=a desc => Print progress reports to STDERR while copying rows (default time,30) attributes => HASH(0x2d2c2a8) # OptionParser:406 24239 progress type: a # OptionParser:413 24239 progress default: time,30 # OptionParser:367 24239 Parsing opt spec: group => default spec => quiet|q desc => Do not print messages to STDOUT (disables --progress) attributes => HASH(0x2d2c380) # OptionParser:406 24239 quiet type: undef # OptionParser:422 24239 Deferring check of disables rule for HASH(0x2d2c320) disables --progress) # OptionParser:367 24239 Parsing opt spec: group => default spec => recurse=i desc => Number of levels to recurse in the hierarchy when discovering replicas attributes => HASH(0x2d2c440) # OptionParser:406 24239 recurse type: i # OptionParser:367 24239 Parsing opt spec: group => default spec => recursion-method=a desc => Preferred recursion method for discovering replicas (default processlist,hosts) attributes => HASH(0x2d2c500) # OptionParser:406 24239 recursion-method type: a # OptionParser:413 24239 recursion-method default: processlist,hosts # OptionParser:367 24239 Parsing opt spec: group => default spec => set-vars=A desc => Set the MySQL variables in this comma-separated list of variable=value pairs attributes => HASH(0x2d2c5d8) # OptionParser:406 24239 set-vars type: A # OptionParser:367 24239 Parsing opt spec: group => default spec => sleep=f desc => How long to sleep (in seconds) after copying each chunk (default 0) attributes => HASH(0x2d2f460) # OptionParser:406 24239 sleep type: f # OptionParser:413 24239 sleep default: 0 # OptionParser:367 24239 Parsing opt spec: group => default spec => socket|S=s desc => Socket file to use for connection attributes => HASH(0x2d2f538) # OptionParser:406 24239 socket type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => statistics desc => Print statistics about internal counters attributes => HASH(0x2d2f610) # OptionParser:406 24239 statistics type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => swap-tables! desc => Swap the original table and the new, altered table (default yes) attributes => HASH(0x2d2f6b8) # OptionParser:406 24239 swap-tables type: undef # OptionParser:413 24239 swap-tables default: yes # OptionParser:367 24239 Parsing opt spec: group => default spec => tries=a desc => How many times to try critical operations attributes => HASH(0x2d2f790) # OptionParser:406 24239 tries type: a # OptionParser:367 24239 Parsing opt spec: group => default spec => user|u=s desc => User for login if not current user attributes => HASH(0x2d2f850) # OptionParser:406 24239 user type: s # OptionParser:367 24239 Parsing opt spec: group => default spec => version desc => Show version and exit attributes => HASH(0x2d2f928) # OptionParser:406 24239 version type: undef # OptionParser:367 24239 Parsing opt spec: group => default spec => version-check! desc => Check for the latest version of Percona Toolkit, MySQL, and other programs (default yes) attributes => HASH(0x2d2f9d0) # OptionParser:406 24239 version-check type: undef # OptionParser:413 24239 version-check default: yes # OptionParser:428 24239 Parsing rule: --dry-run and --execute are mutually exclusive. # OptionParser:484 24239 Participants for --dry-run and --execute are mutually exclusive. : dry-run execute # OptionParser:436 24239 dry-run execute are mutually exclusive # OptionParser:428 24239 Parsing rule: This tool accepts additional command-line arguments. Refer to the SYNOPSIS and usage information for details. # OptionParser:484 24239 Participants for This tool accepts additional command-line arguments. Refer to the SYNOPSIS and usage information for details. : # OptionParser:460 24239 Strict mode disabled by rule # OptionParser:484 24239 Participants for disables --progress) : progress # OptionParser:470 24239 Option quiet disables progress # OptionParser:210 24239 Parsing DSN OPTIONS # OptionParser:300 24239 =item * A # OptionParser:327 24239 Short help: Default character set # OptionParser:300 24239 =item * D # OptionParser:327 24239 Short help: Database for the old and new table # OptionParser:300 24239 =item * F # OptionParser:327 24239 Short help: Only read default options from the given file # OptionParser:300 24239 =item * h # OptionParser:327 24239 Short help: Connect to host # OptionParser:300 24239 =item * p # OptionParser:327 24239 Short help: Password to use when connecting # OptionParser:300 24239 =item * P # OptionParser:327 24239 Short help: Port number to use for connection # OptionParser:300 24239 =item * S # OptionParser:327 24239 Short help: Socket file to use for connection # OptionParser:300 24239 =item * t # OptionParser:327 24239 Short help: Table to alter # OptionParser:300 24239 =item * u # OptionParser:327 24239 Short help: User for login if not current user # DSNParser:2089 24239 DSN option: copy=1, dsn=charset, desc=Default character set, key=A # DSNParser:2089 24239 DSN option: copy=1, dsn=database, desc=Database for the old and new table, key=D # DSNParser:2089 24239 DSN option: copy=1, dsn=mysql_read_default_file, desc=Only read default options from the given file, key=F # DSNParser:2089 24239 DSN option: copy=1, dsn=host, desc=Connect to host, key=h # DSNParser:2089 24239 DSN option: copy=1, dsn=password, desc=Password to use when connecting, key=p # DSNParser:2089 24239 DSN option: copy=1, dsn=port, desc=Port number to use for connection, key=P # DSNParser:2089 24239 DSN option: copy=1, dsn=mysql_socket, desc=Socket file to use for connection, key=S # DSNParser:2089 24239 DSN option: copy=, dsn=table, desc=Table to alter, key=t # DSNParser:2089 24239 DSN option: copy=1, dsn=user, desc=User for login if not current user, key=u # OptionParser:254 24239 pt-online-schema-change 2.2.16 # OptionParser:588 24239 Cannot open /etc/percona-toolkit/percona-toolkit.conf: No such file or directory # # OptionParser:588 24239 Cannot open /etc/percona-toolkit/pt-online-schema-change.conf: No such file or directory # # OptionParser:588 24239 Cannot open /root/.percona-toolkit.conf: No such file or directory # # OptionParser:588 24239 Cannot open /root/.pt-online-schema-change.conf: No such file or directory # # OptionParser:556 24239 Got option alter = ADD COLUMN field1 int # OptionParser:556 24239 Got option execute = 1 # OptionParser:556 24239 Got option drop-old-table = 0 # OptionParser:766 24239 Parsing option chunk-size as a size value # OptionParser:776 24239 Nothing to validate for option max-flow-ctl type f value undef # OptionParser:776 24239 Nothing to validate for option check-slave-lag type s value undef # OptionParser:776 24239 Nothing to validate for option chunk-index type s value undef # OptionParser:776 24239 Nothing to validate for option password type s value undef # OptionParser:776 24239 Nothing to validate for option chunk-index-columns type i value undef # OptionParser:776 24239 Nothing to validate for option pid type s value undef # OptionParser:776 24239 Nothing to validate for option user type s value undef # OptionParser:776 24239 Nothing to validate for option alter type s value ADD COLUMN field1 int # OptionParser:776 24239 Nothing to validate for option tries type a value undef # OptionParser:776 24239 Nothing to validate for option chunk-time type f value 0.5 # OptionParser:776 24239 Nothing to validate for option alter-foreign-keys-method type s value undef # OptionParser:776 24239 Nothing to validate for option charset type s value undef # OptionParser:776 24239 Nothing to validate for option port type i value undef # OptionParser:776 24239 Nothing to validate for option socket type s value undef # OptionParser:727 24239 Parsing option check-interval as a time value # OptionParser:732 24239 No suffix given; using s for check-interval (value: 1 ) # OptionParser:741 24239 Setting option check-interval to 1 # OptionParser:776 24239 Nothing to validate for option recurse type i value undef # OptionParser:727 24239 Parsing option max-lag as a time value # OptionParser:741 24239 Setting option max-lag to 1 # OptionParser:776 24239 Nothing to validate for option plugin type s value undef # OptionParser:776 24239 Nothing to validate for option chunk-size-limit type f value 4.0 # OptionParser:776 24239 Nothing to validate for option defaults-file type s value undef # OptionParser:776 24239 Nothing to validate for option host type s value undef # OptionParser:776 24239 Nothing to validate for option database type s value undef # OptionParser:776 24239 Nothing to validate for option new-table-name type s value %T_new # OptionParser:776 24239 Nothing to validate for option sleep type f value 0 # OptionParser:1178 24239 --set-vars: $VAR1 = { # innodb_lock_wait_timeout => { # default => 1, # val => '1' # }, # lock_wait_timeout => { # default => 1, # val => '60' # }, # wait_timeout => { # default => 1, # val => '10000' # } # }; # # DSNParser:2105 24239 Setting set-vars property # DSNParser:2177 24239 DSN string made from options: # DSNParser:2114 24239 No DSN to parse # DSNParser:2117 24239 Parsing h=127.0.0.1,P=3306,u=root,D=test,t=t1 # DSNParser:2136 24239 Finding value for S # DSNParser:2146 24239 Copying value for S from defaults # DSNParser:2136 24239 Finding value for F # DSNParser:2146 24239 Copying value for F from defaults # DSNParser:2136 24239 Finding value for A # DSNParser:2146 24239 Copying value for A from defaults # DSNParser:2136 24239 Finding value for P # DSNParser:2136 24239 Finding value for p # DSNParser:2146 24239 Copying value for p from defaults # DSNParser:2136 24239 Finding value for u # DSNParser:2136 24239 Finding value for h # DSNParser:2136 24239 Finding value for D # DSNParser:2136 24239 Finding value for t # pt_online_schema_change:9756 24239 --tries: $VAR1 = { # analyze_table => { # tries => 10, # wait => 1 # }, # copy_rows => { # tries => 10, # wait => '0.25' # }, # create_triggers => { # tries => 10, # wait => 1 # }, # drop_triggers => { # tries => 10, # wait => 1 # }, # swap_tables => { # tries => 10, # wait => 1 # }, # update_foreign_keys => { # tries => 10, # wait => 1 # } # }; # # OptionParser:850 24239 Getting description and usage from SYNOPSIS in /usr/bin/pt-online-schema-change # OptionParser:1111 24239 Parsing SYNOPSIS in /usr/bin/pt-online-schema-change # OptionParser:1124 24239 Raw SYNOPSIS text: Usage: pt-online-schema-change [OPTIONS] DSN # # pt-online-schema-change alters a table's structure without blocking reads or # writes. Specify the database and table in the DSN. Do not use this tool before # reading its documentation and checking your backups carefully. # # # OptionParser:854 24239 Description: pt-online-schema-change alters a table's structure without blocking reads or writes. Specify the database and table in the DSN. Do not use this tool before reading its documentation and checking your backups carefully. # Usage: pt-online-schema-change [OPTIONS] DSN # DSNParser:2177 24239 DSN string made from options: # DSNParser:2114 24239 No DSN to parse # DSNParser:2230 24239 DBI:mysql:test;host=127.0.0.1;port=3306;mysql_read_default_group=client # DSNParser:2279 24239 DBI:mysql:test;host=127.0.0.1;port=3306;mysql_read_default_group=client root undef mysql_enable_utf8=>0, ShowErrorStatement=>1, AutoCommit=>1, RaiseError=>1, PrintError=>0 # DSNParser:2307 24239 DBI::db=HASH(0x2660b50) SELECT @@SQL_MODE # DSNParser:2438 24239 DBI::db=HASH(0x2660b50) SET SESSION innodb_lock_wait_timeout=1 # DSNParser:2438 24239 DBI::db=HASH(0x2660b50) SET SESSION lock_wait_timeout=60 # DSNParser:2438 24239 DBI::db=HASH(0x2660b50) SET SESSION wait_timeout=10000 # DSNParser:2338 24239 DBI::db=HASH(0x2660b50) SET @@SQL_QUOTE_SHOW_CREATE = 1/*!40101, @@SQL_MODE='NO_AUTO_VALUE_ON_ZERO,NO_ENGINE_SUBSTITUTION'*/ # DSNParser:2347 24239 DBH info: DBI::db=HASH(0x2660b50) $VAR1 = { # '@@hostname' => 'VM-centos67', # 'CONNECTION_ID()' => '1096258', # 'DATABASE()' => 'test', # 'VERSION()' => '5.6.27-75.0-log' # }; # Connection info: 127.0.0.1 via TCP/IP Character set info: $VAR1 = [ # { # Value => 'latin1', # Variable_name => 'character_set_client' # }, # { # Value => 'latin1', # Variable_name => 'character_set_connection' # }, # { # Value => 'latin1', # Variable_name => 'character_set_database' # }, # { # Value => 'binary', # Variable_name => 'character_set_filesystem' # }, # { # Value => 'latin1', # Variable_name => 'character_set_results' # }, # { # Value => 'latin1', # Variable_name => 'character_set_server' # }, # { # Value => 'utf8', # Variable_name => 'character_set_system' # }, # { # Value => '/usr/share/percona-server/charsets/', # Variable_name => 'character_sets_dir' # } # ]; # $DBD::mysql::VERSION: 4.013 $DBI::VERSION: 1.609 # Cxn:3887 24239 DBI::db=HASH(0x2660b50) Setting dbh # Cxn:3892 24239 DBI::db=HASH(0x2660b50) SELECT @@server_id /*!50038 , @@hostname*/ # Cxn:3894 24239 DBI::db=HASH(0x2660b50) hostname: VM-centos67 1 # Cxn:3875 24239 DBI::db=HASH(0x2660b50) Connected dbh to VM-centos67 h=127.0.0.1,P=3306 # DSNParser:2177 24239 DSN string made from options: # DSNParser:2114 24239 No DSN to parse # DSNParser:2230 24239 DBI:mysql:test;host=127.0.0.1;port=3306;mysql_read_default_group=client # DSNParser:2279 24239 DBI:mysql:test;host=127.0.0.1;port=3306;mysql_read_default_group=client root undef mysql_enable_utf8=>0, ShowErrorStatement=>1, AutoCommit=>1, RaiseError=>1, PrintError=>0 # DSNParser:2307 24239 DBI::db=HASH(0x265fd28) SELECT @@SQL_MODE # DSNParser:2438 24239 DBI::db=HASH(0x265fd28) SET SESSION innodb_lock_wait_timeout=1 # DSNParser:2438 24239 DBI::db=HASH(0x265fd28) SET SESSION lock_wait_timeout=60 # DSNParser:2438 24239 DBI::db=HASH(0x265fd28) SET SESSION wait_timeout=10000 # DSNParser:2338 24239 DBI::db=HASH(0x265fd28) SET @@SQL_QUOTE_SHOW_CREATE = 1/*!40101, @@SQL_MODE='NO_AUTO_VALUE_ON_ZERO,NO_ENGINE_SUBSTITUTION'*/ # DSNParser:2347 24239 DBH info: DBI::db=HASH(0x265fd28) $VAR1 = { # '@@hostname' => 'VM-centos67', # 'CONNECTION_ID()' => '1096259', # 'DATABASE()' => 'test', # 'VERSION()' => '5.6.27-75.0-log' # }; # Connection info: 127.0.0.1 via TCP/IP Character set info: $VAR1 = [ # { # Value => 'latin1', # Variable_name => 'character_set_client' # }, # { # Value => 'latin1', # Variable_name => 'character_set_connection' # }, # { # Value => 'latin1', # Variable_name => 'character_set_database' # }, # { # Value => 'binary', # Variable_name => 'character_set_filesystem' # }, # { # Value => 'latin1', # Variable_name => 'character_set_results' # }, # { # Value => 'latin1', # Variable_name => 'character_set_server' # }, # { # Value => 'utf8', # Variable_name => 'character_set_system' # }, # { # Value => '/usr/share/percona-server/charsets/', # Variable_name => 'character_sets_dir' # } # ]; # $DBD::mysql::VERSION: 4.013 $DBI::VERSION: 1.609 # Cxn:3887 24239 DBI::db=HASH(0x265fd28) Setting dbh # Cxn:3892 24239 DBI::db=HASH(0x265fd28) SELECT @@server_id /*!50038 , @@hostname*/ # Cxn:3894 24239 DBI::db=HASH(0x265fd28) hostname: VM-centos67 1 # Cxn:3875 24239 DBI::db=HASH(0x265fd28) Connected dbh to VM-centos67 h=127.0.0.1,P=3306 # Percona::XtraDB::Cluster:7828 24239 VM-centos67 SHOW VARIABLES LIKE 'wsrep_on' # Percona::XtraDB::Cluster:7830 24239 $VAR1 = undef; # # VersionParser:1969 24239 VersionParser got a dbh, trying to get the version # VersionParser:2017 24239 InnoDB support: DEFAULT # VersionParser:2029 24239 InnoDB version: 5.6.27-75.0 # pt_online_schema_change:8290 24239 innodb_stats_peristent is ON, enabling --analyze-before-swap # MasterSlave:4171 24239 Recursion methods: processlist hosts # MasterSlave:4181 24239 Connected to D=test,P=3306,h=127.0.0.1,t=t1,u=root # MasterSlave:4190 24239 SELECT @@SERVER_ID # MasterSlave:4192 24239 Working on server ID 1 # MasterSlave:4225 24239 Looking for slaves on D=test,P=3306,h=127.0.0.1,t=t1,u=root using methods processlist hosts # MasterSlave:4232 24239 Finding slaves with _find_slaves_by_processlist # MasterSlave:4294 24239 DBI::db=HASH(0x2660b50) SHOW GRANTS FOR CURRENT_USER() # MasterSlave:4324 24239 DBI::db=HASH(0x2660b50) SHOW PROCESSLIST # MasterSlave:4232 24239 Finding slaves with _find_slaves_by_hosts # MasterSlave:4266 24239 DBI::db=HASH(0x2660b50) SHOW SLAVE HOSTS # MasterSlave:4237 24239 Found 0 slaves # pt_online_schema_change:8357 24239 0 slaves found # pt_online_schema_change:8382 24239 Will check slave lag on all slaves # pt_online_schema_change:8400 24239 Checking slave replication filters # MySQLStatusWaiter:5045 24239 Parsing spec for max thresholds # MySQLStatusWaiter:5187 24239 Checking and setting values # pt_online_schema_change:8502 24239 SHOW GLOBAL STATUS LIKE ? Threads_running # MySQLStatusWaiter:5203 24239 Wait if Threads_running >= 25 # MySQLStatusWaiter:5055 24239 Parsing spec for critical thresholds # MySQLStatusWaiter:5187 24239 Checking and setting values # pt_online_schema_change:8502 24239 SHOW GLOBAL STATUS LIKE ? Threads_running # MySQLStatusWaiter:5203 24239 Wait if Threads_running >= 50 # VersionCheck:7279 24239 FindBin::Bin: /usr/bin # VersionCheck:7444 24239 SELECT CONCAT(@@hostname, @@port) # VersionCheck:7465 24239 MySQL instance: d46842fd9caaa06a82254322e73b16c4 VM-centos673306 $VAR1 = { # A => undef, # D => 'test', # F => undef, # P => 3306, # S => undef, # h => '127.0.0.1', # p => undef, # t => 't1', # u => 'root' # }; # # VersionCheck:7259 24239 Version check file percona-version-check in /tmp # VersionCheck:7379 24239 Version check file /tmp/percona-version-check contents: 0,1450127030 # d46842fd9caaa06a82254322e73b16c4,1450127030 # VersionCheck:7387 24239 Intsance d46842fd9caaa06a82254322e73b16c4 last checked 1450127030 now 1450136420 diff 9390 hours until next check 21.39 # VersionCheck:7387 24239 Intsance 0 last checked 1450127030 now 1450136420 diff 9390 hours until next check 21.39 # VersionCheck:7307 24239 0 instances to check # TableParser:3366 24239 Checking `test`.`t1` # TableParser:3372 24239 SHOW TABLES FROM `test` LIKE 't1' # TableParser:3387 24239 Table test t1 exists # pt_online_schema_change:10191 24239 SHOW TRIGGERS FROM `test` LIKE 't1' # TableParser:3192 24239 /*!40101 SET @OLD_SQL_MODE := @@SQL_MODE, @@SQL_MODE := '', @OLD_QUOTE := @@SQL_QUOTE_SHOW_CREATE, @@SQL_QUOTE_SHOW_CREATE := 1 */ # TableParser:3197 24239 DBI::db=HASH(0x2660b50) USE `test` # TableParser:3201 24239 SHOW CREATE TABLE `test`.`t1` # TableParser:3211 24239 /*!40101 SET @@SQL_MODE := @OLD_SQL_MODE, @@SQL_QUOTE_SHOW_CREATE := @OLD_QUOTE */ # TableParser:3395 24239 Storage engine: InnoDB # TableParser:3243 24239 Table cols: `id` # TableParser:3395 24239 Storage engine: InnoDB # TableParser:3411 24239 Parsed key: PRIMARY KEY (`id`) # TableParser:3431 24239 PRIMARY key cols: `id` # TableParser:3453 24239 This key is the clustered key # NibbleIterator:5800 24239 EXPLAIN SELECT * FROM `test`.`t1` WHERE 1=1 # NibbleIterator:5802 24239 $VAR1 = { # extra => 'Using index', # id => '1', # key => 'PRIMARY', # key_len => '4', # possible_keys => undef, # ref => undef, # rows => '1', # select_type => 'SIMPLE', # table => 't1', # type => 'index' # }; # # NibbleIterator:5677 24239 One nibble: yes # NibbleIterator:5732 24239 Auto-selecting best index # TableParser:3307 24239 Indexes sorted best-first: PRIMARY # NibbleIterator:5765 24239 Best index: PRIMARY # pt_online_schema_change:10238 24239 Finding child tables # pt_online_schema_change:10244 24239 SELECT table_schema, table_name FROM information_schema.key_column_usage WHERE referenced_table_schema='test' AND referenced_table_name='t1' # pt_online_schema_change:10247 24239 No child tables found # CleanupTask:6372 24239 Created cleanup task CODE(0x265bc78) # pt_online_schema_change:9894 24239 Renamed columns (old => new): $VAR1 = {}; # # Percona::XtraDB::Cluster:7828 24239 VM-centos67 SHOW VARIABLES LIKE 'wsrep_on' # Percona::XtraDB::Cluster:7830 24239 $VAR1 = undef; # # Daemon:2513 24239 Starting daemon # Daemon:2583 24239 Daemon running # TableParser:3192 24239 /*!40101 SET @OLD_SQL_MODE := @@SQL_MODE, @@SQL_MODE := '', @OLD_QUOTE := @@SQL_QUOTE_SHOW_CREATE, @@SQL_QUOTE_SHOW_CREATE := 1 */ # TableParser:3197 24239 DBI::db=HASH(0x2660b50) USE `test` # TableParser:3201 24239 SHOW CREATE TABLE `test`.`t1` # TableParser:3211 24239 /*!40101 SET @@SQL_MODE := @OLD_SQL_MODE, @@SQL_QUOTE_SHOW_CREATE := @OLD_QUOTE */ # pt_online_schema_change:10033 24239 CREATE TABLE `test`.`_t1_new` ( # `id` int(11) NOT NULL, # PRIMARY KEY (`id`) # ) ENGINE=InnoDB DEFAULT CHARSET=latin1 # pt_online_schema_change:8963 24239 ALTER TABLE `test`.`_t1_new` ADD COLUMN field1 int # TableParser:3192 24239 /*!40101 SET @OLD_SQL_MODE := @@SQL_MODE, @@SQL_MODE := '', @OLD_QUOTE := @@SQL_QUOTE_SHOW_CREATE, @@SQL_QUOTE_SHOW_CREATE := 1 */ # TableParser:3197 24239 DBI::db=HASH(0x2660b50) USE `test` # TableParser:3201 24239 SHOW CREATE TABLE `test`.`_t1_new` # TableParser:3211 24239 /*!40101 SET @@SQL_MODE := @OLD_SQL_MODE, @@SQL_QUOTE_SHOW_CREATE := @OLD_QUOTE */ # TableParser:3395 24239 Storage engine: InnoDB # TableParser:3243 24239 Table cols: `id`, `field1` # TableParser:3395 24239 Storage engine: InnoDB # TableParser:3411 24239 Parsed key: PRIMARY KEY (`id`) # TableParser:3431 24239 PRIMARY key cols: `id` # TableParser:3453 24239 This key is the clustered key # pt_online_schema_change:8997 24239 Common columns $VAR1 = [ # { # new => 'id', # old => 'id' # } # ]; # # TableParser:3307 24239 Indexes sorted best-first: PRIMARY # pt_online_schema_change:9006 24239 Delete trigger new index: $VAR1 = 'PRIMARY'; # # pt_online_schema_change:9011 24239 New table delete index: PRIMARY # TableParser:3307 24239 Indexes sorted best-first: PRIMARY # pt_online_schema_change:9018 24239 Delete trigger orig index: $VAR1 = 'PRIMARY'; # # pt_online_schema_change:9023 24239 Orig table delete index: PRIMARY # pt_online_schema_change:9065 24239 Index for delete trigger: table `test`.`_t1_new` index PRIMARY columns id # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10582 24239 CREATE TRIGGER `pt_osc_test_t1_del` AFTER DELETE ON `test`.`t1` FOR EACH ROW DELETE IGNORE FROM `test`.`_t1_new` WHERE `test`.`_t1_new`.`id` <=> OLD.`id` # Retry:3762 24239 Try code succeeded # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10582 24239 CREATE TRIGGER `pt_osc_test_t1_upd` AFTER UPDATE ON `test`.`t1` FOR EACH ROW REPLACE INTO `test`.`_t1_new` (`id`) VALUES (NEW.`id`) # Retry:3762 24239 Try code succeeded # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10582 24239 CREATE TRIGGER `pt_osc_test_t1_ins` AFTER INSERT ON `test`.`t1` FOR EACH ROW REPLACE INTO `test`.`_t1_new` (`id`) VALUES (NEW.`id`) # Retry:3762 24239 Try code succeeded # NibbleIterator:5800 24239 EXPLAIN SELECT * FROM `test`.`t1` WHERE 1=1 # NibbleIterator:5802 24239 $VAR1 = { # extra => 'Using index', # id => '1', # key => 'PRIMARY', # key_len => '4', # possible_keys => undef, # ref => undef, # rows => '1', # select_type => 'SIMPLE', # table => 't1', # type => 'index' # }; # # NibbleIterator:5677 24239 One nibble: yes # NibbleIterator:5732 24239 Auto-selecting best index # TableParser:3307 24239 Indexes sorted best-first: PRIMARY # NibbleIterator:5765 24239 Best index: PRIMARY # NibbleIterator:5350 24239 One nibble statement: INSERT LOW_PRIORITY IGNORE INTO `test`.`_t1_new` (`id`) SELECT `id` FROM `test`.`t1` LOCK IN SHARE MODE /*pt-online-schema-change 24239 copy table*/ # NibbleIterator:5360 24239 Explain one nibble statement: EXPLAIN SELECT `id` FROM `test`.`t1` LOCK IN SHARE MODE /*explain pt-online-schema-change 24239 copy table*/ # NibbleIterator:5812 24239 Preparing statement handles # pt_online_schema_change:9205 24239 Getting table row estimate on replicas # NibbleIterator:5512 24239 init callback returned 1 # NibbleIterator:5530 24239 Nibble: INSERT LOW_PRIORITY IGNORE INTO `test`.`_t1_new` (`id`) SELECT `id` FROM `test`.`t1` LOCK IN SHARE MODE /*pt-online-schema-change 24239 copy table*/ params: # pt_online_schema_change:10872 24239 EXPLAIN SELECT `id` FROM `test`.`t1` LOCK IN SHARE MODE /*explain pt-online-schema-change 24239 copy table*/ params: # pt_online_schema_change:10881 24239 EXPLAIN plan: $VAR1 = { # extra => 'Using index', # id => '1', # key => 'PRIMARY', # key_len => '4', # possible_keys => undef, # ref => undef, # rows => '1', # select_type => 'SIMPLE', # table => 't1', # type => 'index' # }; # # Quoter:2812 24239 Serializing $VAR1 = []; # # Quoter:2812 24239 Serializing $VAR1 = []; # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10790 24239 INSERT LOW_PRIORITY IGNORE INTO `test`.`_t1_new` (`id`) SELECT `id` FROM `test`.`t1` LOCK IN SHARE MODE /*pt-online-schema-change 24239 copy table*/ lower boundary: upper boundary: # pt_online_schema_change:10809 24239 SHOW WARNINGS # pt_online_schema_change:10816 24239 Ignoring warning: 1592 Unsafe statement written to the binary log using statement format since BINLOG_FORMAT = STATEMENT. INSERT IGNORE... SELECT is unsafe because the order in which rows are retrieved by the SELECT determines which (if any) rows are ignored. This order cannot be predicted and may differ on master and the slave. # Retry:3762 24239 Try code succeeded # pt_online_schema_change:9335 24239 Nibble time: 0.00176191329956055 # NibbleIterator:5538 24239 0 rows in nibble 1 # NibbleIterator:5550 24239 No rows in nibble or nibble skipped # ReplicaLagWaiter:4897 24239 All slaves caught up # MySQLStatusWaiter:5145 24239 Checking status variables # pt_online_schema_change:8502 24239 SHOW GLOBAL STATUS LIKE ? Threads_running # MySQLStatusWaiter:5148 24239 Threads_running = 1 # MySQLStatusWaiter:5175 24239 All var vals are low enough # NibbleIterator:5874 24239 No more boundaries # NibbleIterator:5558 24239 Done nibbling # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10106 24239 ANALYZE TABLE `test`.`_t1_new` /* pt-online-schema-change */ # Retry:3762 24239 Try code succeeded # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`_t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '_t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '_t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '_t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`__t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '__t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '__t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '__t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`___t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '___t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`___t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '___t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`___t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '___t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`___t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`____t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`_____t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '_____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '_____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '_____t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_____t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`______t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`_______t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '_______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '_______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '_______t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_______t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`________t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`_________t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '_________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '_________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '_________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`_________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10133 24239 RENAME TABLE `test`.`t1` TO `test`.`__________t1_old`, `test`.`_t1_new` TO `test`.`t1` # Retry:3751 24239 Try code failed: DBD::mysql::db do failed: Table '__________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # pt_online_schema_change:10691 24239 Retry fail: DBD::mysql::db do failed: Table '__________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # Retry:3767 24239 Try code did not succeed # pt_online_schema_change:10149 24239 2015-12-14T23:40:20 DBD::mysql::db do failed: Table '__________t1_old' already exists [for Statement "RENAME TABLE `test`.`t1` TO `test`.`__________t1_old`, `test`.`_t1_new` TO `test`.`t1`"] at /usr/bin/pt-online-schema-change line 10134. # # CleanupTask:6380 24239 Calling cleanup task CODE(0x265bc78) # pt_online_schema_change:9090 24239 Clean up triggers # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10631 24239 DROP TRIGGER IF EXISTS `test`.`pt_osc_test_t1_del`; # Retry:3762 24239 Try code succeeded # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10631 24239 DROP TRIGGER IF EXISTS `test`.`pt_osc_test_t1_upd`; # Retry:3762 24239 Try code succeeded # Retry:3745 24239 Try 1 of 10 # pt_online_schema_change:10631 24239 DROP TRIGGER IF EXISTS `test`.`pt_osc_test_t1_ins`; # Retry:3762 24239 Try code succeeded # pt_online_schema_change:8854 24239 Clean up new table # TableParser:3366 24239 Checking `test`.`_t1_new` # TableParser:3372 24239 SHOW TABLES FROM `test` LIKE '\_t1\_new' # TableParser:3387 24239 Table test _t1_new exists # pt_online_schema_change:8860 24239 New table exists: yes # pt_online_schema_change:8732 24239 Clean up done, report if orig table was altered 2015-12-14T23:40:20 Error swapping tables: 2015-12-14T23:40:20 Failed to find a unique old table name after serveral attempts. To clean up, first verify that the original table `test`.`t1` has not been modified or renamed, then drop the new table `test`.`_t1_new` if it exists. # NibbleIterator:5971 24239 Finish nibble_sth # NibbleIterator:5971 24239 Finish explain_nibble_sth # Cxn:4013 24239 Destroying cxn # Cxn:4022 24239 DBI::db=HASH(0x265fd28) Disconnecting dbh on VM-centos67 h=127.0.0.1,P=3306 # Cxn:4013 24239 Destroying cxn # Cxn:4022 24239 DBI::db=HASH(0x2660b50) Disconnecting dbh on VM-centos67 h=127.0.0.1,P=3306