Hi Nuno,

today I do not have enough time to redo this scenario, I'll do it tomorrow.
The Problem is, that after a certain number of succeeded initilized
databases on the Cluster, new databases fail during dump transfer with an
error like: "Cannot find Controller xyz in group", but the controller is
there, has the configured vdb and is waiting for connections...
When I did the scenario tomorrow, I'll post the whole logfile, not only
the single part, maybe this time I left out the important parts, sorry.

Kind regards,

Malte


> Hi Malte,
>
> I'm sorry, but I cannot see anything wrong here. In fact, I do not
> see the initial problem, that was messages like this:
>
> 2007-05-23 10:26:41,264 WARN  Member(address=/xxx.234.68.194:32862,
> uid=xxx.234.68.194:32862) has left distributed virtual database
> test_big_13_C
>
> that indicated that some member was left the cluster.
>
> I only see joins (one for each group) and that is quite normal.
>
> regards,
> nuno
>
> On May 29, 2007, at 11:02 , [EMAIL PROTECTED] wrote:
>
>> Hi Nuno,
>>
>> here we go, I added the lines to the logging and startet a
>> testscenario.
>> The VDB test_big_43_C, test_big_41_C and test_big_38_C did not find
>> each
>> other, the others worked fine. Here is the log:
>>
>> 2007-05-29 11:47:16,044 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:47:16,046 INFO
>> backend.DatabaseBackend.test_big_38_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:47:16,067 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_38_C
>> 2007-05-29 11:47:16,070 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_38_C
>> 2007-05-29 11:47:16,073 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_38_C
>> 2007-05-29 11:47:16,075 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_38_C
>> 2007-05-29 11:47:16,087 INFO  controller.RequestManager.test_big_38_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:47:16,096 INFO  controller.virtualdatabase.test_big_38_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:47:16,112 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:47:16,141 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:47:16,149 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_38_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39752]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39752],]
>> addresses: [/xxx.234.68.193:39752,]
>>
>> 2007-05-29 11:47:16,151 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_38_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39752]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39752],]
>> addresses: [/xxx.234.68.193:39752,]
>>
>> 2007-05-29 11:47:18,164 INFO  controller.virtualdatabase.test_big_38_C
>> Group test_big_38_C connected to Member(address=/xxx.234.68.193:39752,
>> uid=xxx.234.68.193:39752)
>> 2007-05-29 11:47:18,167 INFO  controller.virtualdatabase.test_big_38_C
>> First controller in group test_big_38_C
>> 2007-05-29 11:47:18,173 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:47:18,201 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_38_C
>> 2007-05-29 11:47:20,058 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:47:21,585 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_38_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39752]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39752]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35676]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39752],[AppiaHedera@/xxx.
>> 234.68.194:35676],]
>> addresses: [/xxx.234.68.193:39752,/xxx.234.68.194:35676,]
>>
>> 2007-05-29 11:47:21,588 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_38_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39752]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39752]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35676]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39752],[AppiaHedera@/xxx.
>> 234.68.194:35676],]
>> addresses: [/xxx.234.68.193:39752,/xxx.234.68.194:35676,]
>>
>> 2007-05-29 11:47:21,589 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35676, uid=xxx.234.68.194:35676) joins
>> Group(gid=test_big_38_C).
>> 2007-05-29 11:47:23,003 INFO
>> backend.DatabaseBackend.test_big_38_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:47:23,081 INFO  controller.RequestManager.test_big_38_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:23,129 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:23,560 INFO
>> controller.RequestManager.test_big_38_C All
>> activity is suspended for test_big_38_C
>> 2007-05-29 11:47:23,564 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:23,637 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_38_Bbeqv377w is now enabled
>> 2007-05-29 11:47:23,643 WARN
>> controller.virtualdatabase.test_big_38_C No
>> response while getting static metadata from remote controller
>> 2007-05-29 11:47:23,706 INFO
>> controller.RequestManager.test_big_38_C All
>> activity is suspended for test_big_38_C
>> 2007-05-29 11:47:23,716 INFO  controller.virtualdatabase.test_big_38_C
>> Checkpoint backup
>> init_dump_test_big_38_C-xxx.234.68.193:25322-20070529114723676+0200
>> was
>> stored
>> 2007-05-29 11:47:23,721 INFO  controller.virtualdatabase.test_big_38_C
>> Disabling backend test_big_38_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:47:23,725 INFO  controller.RequestManager.test_big_38_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:23,731 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_38"
>> 2007-05-29 11:47:25,003 INFO  controller.virtualdatabase.test_big_38_C
>> Backend test_big_38_Bbeqv377w is now disabled
>> 2007-05-29 11:47:25,004 WARN
>> controller.virtualdatabase.test_big_38_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39752, uid=xxx.234.68.193:39752)
>> 2007-05-29 11:47:25,005 WARN  controller.virtualdatabase.test_big_38_C
>> Updating backend list with unknown backend test_big_38_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39752,
>> uid=xxx.234.68.193:39752)
>> 2007-05-29 11:47:25,325 INFO  controller.RequestManager.test_big_38_C
>> Backend test_big_38_Bbeqv377w is now disabled
>> 2007-05-29 11:47:25,326 INFO  controller.RequestManager.test_big_38_C
>> Starting backup of backend test_big_38_Bbeqv377w
>> 2007-05-29 11:47:26,950 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_38"
>> 2007-05-29 11:47:27,395 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_38" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:47:27,454 INFO  controller.RequestManager.test_big_38_C
>> Backup has completed.
>> 2007-05-29 11:47:27,634 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:27,735 INFO
>> controller.RequestManager.test_big_38_C All
>> activity is suspended for test_big_38_C
>> 2007-05-29 11:47:27,739 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:27,799 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_38_Bbeqv377w is now enabled
>> 2007-05-29 11:47:27,816 INFO  controller.backup.BackupManager Using
>> provided dump-server address: xxx.234.68.193
>> 2007-05-29 11:47:27,826 INFO  controller.backup.BackupManager Dump
>> server
>> started @ 0.0.0.0/0.0.0.0:39763
>> 2007-05-29 11:47:28,366 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:47:28,368 INFO
>> backend.DatabaseBackend.test_big_39_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:47:28,387 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_39_C
>> 2007-05-29 11:47:28,389 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_39_C
>> 2007-05-29 11:47:28,392 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_39_C
>> 2007-05-29 11:47:28,393 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_39_C
>> 2007-05-29 11:47:28,419 INFO  controller.RequestManager.test_big_39_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:47:28,427 INFO  controller.virtualdatabase.test_big_39_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:47:28,441 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:47:28,487 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:47:28,518 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_39_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39764]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39764],]
>> addresses: [/xxx.234.68.193:39764,]
>>
>> 2007-05-29 11:47:28,521 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_39_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39764]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39764],]
>> addresses: [/xxx.234.68.193:39764,]
>>
>> 2007-05-29 11:47:30,529 INFO  controller.virtualdatabase.test_big_39_C
>> Group test_big_39_C connected to Member(address=/xxx.234.68.193:39764,
>> uid=xxx.234.68.193:39764)
>> 2007-05-29 11:47:30,531 INFO  controller.virtualdatabase.test_big_39_C
>> First controller in group test_big_39_C
>> 2007-05-29 11:47:30,534 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:47:30,544 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_39_C
>> 2007-05-29 11:47:32,699 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:47:33,607 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_39_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39764]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39764]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35678]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39764],[AppiaHedera@/xxx.
>> 234.68.194:35678],]
>> addresses: [/xxx.234.68.193:39764,/xxx.234.68.194:35678,]
>>
>> 2007-05-29 11:47:33,609 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_39_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39764]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39764]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35678]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39764],[AppiaHedera@/xxx.
>> 234.68.194:35678],]
>> addresses: [/xxx.234.68.193:39764,/xxx.234.68.194:35678,]
>>
>> 2007-05-29 11:47:33,610 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35678, uid=xxx.234.68.194:35678) joins
>> Group(gid=test_big_39_C).
>> 2007-05-29 11:47:33,965 INFO  controller.virtualdatabase.test_big_39_C
>> Checking virtual database configuration from xxx.234.68.194:25322
>> 2007-05-29 11:47:34,008 INFO  controller.virtualdatabase.test_big_39_C
>> Controller xxx.234.68.194:25322 is compatible with the local
>> configuration
>> 2007-05-29 11:47:34,030 INFO  controller.virtualdatabase.test_big_39_C
>> Updating backend list for controller Member(address=/xxx.
>> 234.68.194:35678,
>> uid=xxx.234.68.194:35678)
>> 2007-05-29 11:47:34,956 INFO
>> backend.DatabaseBackend.test_big_39_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:47:35,017 INFO  controller.RequestManager.test_big_39_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:35,051 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:35,457 INFO
>> controller.RequestManager.test_big_39_C All
>> activity is suspended for test_big_39_C
>> 2007-05-29 11:47:35,461 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:35,532 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_39_Bbeqv377w is now enabled
>> 2007-05-29 11:47:35,616 INFO
>> controller.RequestManager.test_big_39_C All
>> activity is suspended for test_big_39_C
>> 2007-05-29 11:47:35,647 INFO  controller.virtualdatabase.test_big_39_C
>> Checkpoint backup
>> init_dump_test_big_39_C-xxx.234.68.193:25322-20070529114735583+0200
>> was
>> stored
>> 2007-05-29 11:47:35,650 INFO  controller.virtualdatabase.test_big_39_C
>> Disabling backend test_big_39_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:47:35,655 INFO  controller.RequestManager.test_big_39_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:35,665 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_39"
>> 2007-05-29 11:47:36,781 INFO  controller.virtualdatabase.test_big_39_C
>> Backend test_big_39_Bbeqv377w is now disabled
>> 2007-05-29 11:47:36,782 WARN
>> controller.virtualdatabase.test_big_39_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39764, uid=xxx.234.68.193:39764)
>> 2007-05-29 11:47:36,783 WARN  controller.virtualdatabase.test_big_39_C
>> Updating backend list with unknown backend test_big_39_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39764,
>> uid=xxx.234.68.193:39764)
>> 2007-05-29 11:47:36,925 INFO  controller.RequestManager.test_big_39_C
>> Backend test_big_39_Bbeqv377w is now disabled
>> 2007-05-29 11:47:36,925 INFO  controller.RequestManager.test_big_39_C
>> Starting backup of backend test_big_39_Bbeqv377w
>> 2007-05-29 11:47:38,481 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_39"
>> 2007-05-29 11:47:38,777 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_39" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:47:38,830 INFO  controller.RequestManager.test_big_39_C
>> Backup has completed.
>> 2007-05-29 11:47:39,104 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:39,520 INFO
>> controller.RequestManager.test_big_39_C All
>> activity is suspended for test_big_39_C
>> 2007-05-29 11:47:39,524 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:39,594 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_39_Bbeqv377w is now enabled
>> 2007-05-29 11:47:39,616 INFO  controller.backup.BackupManager Using
>> provided dump-server address: xxx.234.68.193
>> 2007-05-29 11:47:39,623 INFO  controller.backup.BackupManager Dump
>> server
>> started @ 0.0.0.0/0.0.0.0:39776
>> 2007-05-29 11:47:39,649 INFO  controller.backup.BackupManager Client
>> connected to dump server from /xxx.234.68.194:35679
>> 2007-05-29 11:47:39,657 INFO  controller.backup.BackupManager Dump
>> server
>> terminated.
>> 2007-05-29 11:47:41,683 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:47:41,685 INFO
>> backend.DatabaseBackend.test_big_40_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:47:41,702 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_40_C
>> 2007-05-29 11:47:41,708 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_40_C
>> 2007-05-29 11:47:41,710 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_40_C
>> 2007-05-29 11:47:41,711 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_40_C
>> 2007-05-29 11:47:41,718 INFO  controller.RequestManager.test_big_40_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:47:41,731 INFO  controller.virtualdatabase.test_big_40_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:47:41,742 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:47:41,768 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:47:41,783 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_40_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39777]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39777],]
>> addresses: [/xxx.234.68.193:39777,]
>>
>> 2007-05-29 11:47:41,787 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_40_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39777]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39777],]
>> addresses: [/xxx.234.68.193:39777,]
>>
>> 2007-05-29 11:47:43,830 INFO  controller.virtualdatabase.test_big_40_C
>> Group test_big_40_C connected to Member(address=/xxx.234.68.193:39777,
>> uid=xxx.234.68.193:39777)
>> 2007-05-29 11:47:43,832 INFO  controller.virtualdatabase.test_big_40_C
>> First controller in group test_big_40_C
>> 2007-05-29 11:47:43,992 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:47:43,997 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_40_C
>> 2007-05-29 11:47:45,102 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:47:46,646 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_40_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39777]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39777]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35685]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39777],[AppiaHedera@/xxx.
>> 234.68.194:35685],]
>> addresses: [/xxx.234.68.193:39777,/xxx.234.68.194:35685,]
>>
>> 2007-05-29 11:47:46,648 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_40_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39777]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39777]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35685]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39777],[AppiaHedera@/xxx.
>> 234.68.194:35685],]
>> addresses: [/xxx.234.68.193:39777,/xxx.234.68.194:35685,]
>>
>> 2007-05-29 11:47:46,651 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35685, uid=xxx.234.68.194:35685) joins
>> Group(gid=test_big_40_C).
>> 2007-05-29 11:47:47,103 INFO  controller.virtualdatabase.test_big_40_C
>> Checking virtual database configuration from xxx.234.68.194:25322
>> 2007-05-29 11:47:47,209 INFO  controller.virtualdatabase.test_big_40_C
>> Controller xxx.234.68.194:25322 is compatible with the local
>> configuration
>> 2007-05-29 11:47:47,278 INFO  controller.virtualdatabase.test_big_40_C
>> Updating backend list for controller Member(address=/xxx.
>> 234.68.194:35685,
>> uid=xxx.234.68.194:35685)
>> 2007-05-29 11:47:48,176 INFO
>> backend.DatabaseBackend.test_big_40_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:47:48,277 INFO  controller.RequestManager.test_big_40_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:48,324 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:48,362 INFO
>> controller.RequestManager.test_big_40_C All
>> activity is suspended for test_big_40_C
>> 2007-05-29 11:47:48,366 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:48,406 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_40_Bbeqv377w is now enabled
>> 2007-05-29 11:47:48,482 INFO
>> controller.RequestManager.test_big_40_C All
>> activity is suspended for test_big_40_C
>> 2007-05-29 11:47:48,496 INFO  controller.virtualdatabase.test_big_40_C
>> Checkpoint backup
>> init_dump_test_big_40_C-xxx.234.68.193:25322-20070529114748452+0200
>> was
>> stored
>> 2007-05-29 11:47:48,502 INFO  controller.virtualdatabase.test_big_40_C
>> Disabling backend test_big_40_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:47:48,510 INFO  controller.RequestManager.test_big_40_C
>> Setting new virtual database schema.
>> 2007-05-29 11:47:48,521 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_40"
>> 2007-05-29 11:47:49,558 INFO  controller.virtualdatabase.test_big_40_C
>> Backend test_big_40_Bbeqv377w is now disabled
>> 2007-05-29 11:47:49,559 WARN
>> controller.virtualdatabase.test_big_40_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39777, uid=xxx.234.68.193:39777)
>> 2007-05-29 11:47:49,559 WARN  controller.virtualdatabase.test_big_40_C
>> Updating backend list with unknown backend test_big_40_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39777,
>> uid=xxx.234.68.193:39777)
>> 2007-05-29 11:47:49,809 INFO  controller.RequestManager.test_big_40_C
>> Backend test_big_40_Bbeqv377w is now disabled
>> 2007-05-29 11:47:49,811 INFO  controller.RequestManager.test_big_40_C
>> Starting backup of backend test_big_40_Bbeqv377w
>> 2007-05-29 11:47:51,695 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_40"
>> 2007-05-29 11:47:51,983 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_40" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:47:52,016 INFO  controller.RequestManager.test_big_40_C
>> Backup has completed.
>> 2007-05-29 11:47:52,139 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:47:52,393 INFO
>> controller.RequestManager.test_big_40_C All
>> activity is suspended for test_big_40_C
>> 2007-05-29 11:47:52,396 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:47:52,441 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_40_Bbeqv377w is now enabled
>> 2007-05-29 11:47:52,455 INFO  controller.backup.BackupManager Using
>> provided dump-server address: xxx.234.68.193
>> 2007-05-29 11:47:52,459 INFO  controller.backup.BackupManager Dump
>> server
>> started @ 0.0.0.0/0.0.0.0:39788
>> 2007-05-29 11:47:52,486 INFO  controller.backup.BackupManager Client
>> connected to dump server from /xxx.234.68.194:35687
>> 2007-05-29 11:47:52,488 INFO  controller.backup.BackupManager Dump
>> server
>> terminated.
>> 2007-05-29 11:47:54,830 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:47:54,834 INFO
>> backend.DatabaseBackend.test_big_41_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:47:54,866 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_41_C
>> 2007-05-29 11:47:54,869 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_41_C
>> 2007-05-29 11:47:54,873 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_41_C
>> 2007-05-29 11:47:54,875 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_41_C
>> 2007-05-29 11:47:54,885 INFO  controller.RequestManager.test_big_41_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:47:54,892 INFO  controller.virtualdatabase.test_big_41_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:47:54,908 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:47:54,943 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:47:54,951 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_41_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39789]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39789],]
>> addresses: [/xxx.234.68.193:39789,]
>>
>> 2007-05-29 11:47:54,962 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_41_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39789]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39789],]
>> addresses: [/xxx.234.68.193:39789,]
>>
>> 2007-05-29 11:47:56,975 INFO  controller.virtualdatabase.test_big_41_C
>> Group test_big_41_C connected to Member(address=/xxx.234.68.193:39789,
>> uid=xxx.234.68.193:39789)
>> 2007-05-29 11:47:56,976 INFO  controller.virtualdatabase.test_big_41_C
>> First controller in group test_big_41_C
>> 2007-05-29 11:47:56,980 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:47:56,985 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_41_C
>> 2007-05-29 11:47:58,391 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:48:00,689 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_41_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39789]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39789]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35693]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39789],[AppiaHedera@/xxx.
>> 234.68.194:35693],]
>> addresses: [/xxx.234.68.193:39789,/xxx.234.68.194:35693,]
>>
>> 2007-05-29 11:48:00,699 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_41_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39789]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39789]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35693]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39789],[AppiaHedera@/xxx.
>> 234.68.194:35693],]
>> addresses: [/xxx.234.68.193:39789,/xxx.234.68.194:35693,]
>>
>> 2007-05-29 11:48:00,700 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35693, uid=xxx.234.68.194:35693) joins
>> Group(gid=test_big_41_C).
>> 2007-05-29 11:48:01,643 INFO
>> backend.DatabaseBackend.test_big_41_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:48:01,714 INFO  controller.RequestManager.test_big_41_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:01,738 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:02,244 INFO
>> controller.RequestManager.test_big_41_C All
>> activity is suspended for test_big_41_C
>> 2007-05-29 11:48:02,247 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:02,288 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_41_Bbeqv377w is now enabled
>> 2007-05-29 11:48:02,290 WARN
>> controller.virtualdatabase.test_big_41_C No
>> response while getting static metadata from remote controller
>> 2007-05-29 11:48:02,347 INFO
>> controller.RequestManager.test_big_41_C All
>> activity is suspended for test_big_41_C
>> 2007-05-29 11:48:02,358 INFO  controller.virtualdatabase.test_big_41_C
>> Checkpoint backup
>> init_dump_test_big_41_C-xxx.234.68.193:25322-20070529114802315+0200
>> was
>> stored
>> 2007-05-29 11:48:02,362 INFO  controller.virtualdatabase.test_big_41_C
>> Disabling backend test_big_41_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:48:02,371 INFO  controller.RequestManager.test_big_41_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:02,378 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_41"
>> 2007-05-29 11:48:03,609 INFO  controller.virtualdatabase.test_big_41_C
>> Backend test_big_41_Bbeqv377w is now disabled
>> 2007-05-29 11:48:03,610 WARN
>> controller.virtualdatabase.test_big_41_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39789, uid=xxx.234.68.193:39789)
>> 2007-05-29 11:48:03,610 WARN  controller.virtualdatabase.test_big_41_C
>> Updating backend list with unknown backend test_big_41_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39789,
>> uid=xxx.234.68.193:39789)
>> 2007-05-29 11:48:03,814 INFO  controller.RequestManager.test_big_41_C
>> Backend test_big_41_Bbeqv377w is now disabled
>> 2007-05-29 11:48:03,814 INFO  controller.RequestManager.test_big_41_C
>> Starting backup of backend test_big_41_Bbeqv377w
>> 2007-05-29 11:48:05,324 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_41"
>> 2007-05-29 11:48:05,631 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_41" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:48:05,684 INFO  controller.RequestManager.test_big_41_C
>> Backup has completed.
>> 2007-05-29 11:48:05,775 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:05,921 INFO
>> controller.RequestManager.test_big_41_C All
>> activity is suspended for test_big_41_C
>> 2007-05-29 11:48:05,924 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:05,980 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_41_Bbeqv377w is now enabled
>> 2007-05-29 11:48:05,997 INFO  controller.backup.BackupManager Using
>> provided dump-server address: xxx.234.68.193
>> 2007-05-29 11:48:06,004 INFO  controller.backup.BackupManager Dump
>> server
>> started @ 0.0.0.0/0.0.0.0:39801
>> 2007-05-29 11:48:06,345 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:48:06,350 INFO
>> backend.DatabaseBackend.test_big_42_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:48:06,370 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_42_C
>> 2007-05-29 11:48:06,373 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_42_C
>> 2007-05-29 11:48:06,376 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_42_C
>> 2007-05-29 11:48:06,378 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_42_C
>> 2007-05-29 11:48:06,407 INFO  controller.RequestManager.test_big_42_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:48:06,421 INFO  controller.virtualdatabase.test_big_42_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:48:06,444 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:48:06,478 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:48:06,494 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_42_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39802]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39802],]
>> addresses: [/xxx.234.68.193:39802,]
>>
>> 2007-05-29 11:48:06,498 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_42_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39802]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39802],]
>> addresses: [/xxx.234.68.193:39802,]
>>
>> 2007-05-29 11:48:08,542 INFO  controller.virtualdatabase.test_big_42_C
>> Group test_big_42_C connected to Member(address=/xxx.234.68.193:39802,
>> uid=xxx.234.68.193:39802)
>> 2007-05-29 11:48:08,545 INFO  controller.virtualdatabase.test_big_42_C
>> First controller in group test_big_42_C
>> 2007-05-29 11:48:08,555 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:48:08,562 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_42_C
>> 2007-05-29 11:48:09,447 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:48:11,086 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_42_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39802]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39802]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35694]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39802],[AppiaHedera@/xxx.
>> 234.68.194:35694],]
>> addresses: [/xxx.234.68.193:39802,/xxx.234.68.194:35694,]
>>
>> 2007-05-29 11:48:11,088 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_42_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39802]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39802]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35694]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39802],[AppiaHedera@/xxx.
>> 234.68.194:35694],]
>> addresses: [/xxx.234.68.193:39802,/xxx.234.68.194:35694,]
>>
>> 2007-05-29 11:48:11,091 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35694, uid=xxx.234.68.194:35694) joins
>> Group(gid=test_big_42_C).
>> 2007-05-29 11:48:11,397 INFO  controller.virtualdatabase.test_big_42_C
>> Checking virtual database configuration from xxx.234.68.194:25322
>> 2007-05-29 11:48:11,697 INFO  controller.virtualdatabase.test_big_42_C
>> Controller xxx.234.68.194:25322 is compatible with the local
>> configuration
>> 2007-05-29 11:48:11,723 INFO  controller.virtualdatabase.test_big_42_C
>> Updating backend list for controller Member(address=/xxx.
>> 234.68.194:35694,
>> uid=xxx.234.68.194:35694)
>> 2007-05-29 11:48:12,538 INFO
>> backend.DatabaseBackend.test_big_42_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:48:12,589 INFO  controller.RequestManager.test_big_42_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:12,635 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:12,672 INFO
>> controller.RequestManager.test_big_42_C All
>> activity is suspended for test_big_42_C
>> 2007-05-29 11:48:12,681 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:12,771 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_42_Bbeqv377w is now enabled
>> 2007-05-29 11:48:12,851 INFO
>> controller.RequestManager.test_big_42_C All
>> activity is suspended for test_big_42_C
>> 2007-05-29 11:48:12,869 INFO  controller.virtualdatabase.test_big_42_C
>> Checkpoint backup
>> init_dump_test_big_42_C-xxx.234.68.193:25322-20070529114812831+0200
>> was
>> stored
>> 2007-05-29 11:48:12,874 INFO  controller.virtualdatabase.test_big_42_C
>> Disabling backend test_big_42_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:48:12,880 INFO  controller.RequestManager.test_big_42_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:12,893 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_42"
>> 2007-05-29 11:48:14,571 INFO  controller.virtualdatabase.test_big_42_C
>> Backend test_big_42_Bbeqv377w is now disabled
>> 2007-05-29 11:48:14,572 WARN
>> controller.virtualdatabase.test_big_42_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39802, uid=xxx.234.68.193:39802)
>> 2007-05-29 11:48:14,573 WARN  controller.virtualdatabase.test_big_42_C
>> Updating backend list with unknown backend test_big_42_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39802,
>> uid=xxx.234.68.193:39802)
>> 2007-05-29 11:48:14,658 INFO  controller.RequestManager.test_big_42_C
>> Backend test_big_42_Bbeqv377w is now disabled
>> 2007-05-29 11:48:14,659 INFO  controller.RequestManager.test_big_42_C
>> Starting backup of backend test_big_42_Bbeqv377w
>> 2007-05-29 11:48:16,219 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_42"
>> 2007-05-29 11:48:16,631 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_42" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:48:16,665 INFO  controller.RequestManager.test_big_42_C
>> Backup has completed.
>> 2007-05-29 11:48:16,765 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:17,211 INFO
>> controller.RequestManager.test_big_42_C All
>> activity is suspended for test_big_42_C
>> 2007-05-29 11:48:17,223 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:17,305 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_42_Bbeqv377w is now enabled
>> 2007-05-29 11:48:17,330 INFO  controller.backup.BackupManager Using
>> provided dump-server address: xxx.234.68.193
>> 2007-05-29 11:48:17,334 INFO  controller.backup.BackupManager Dump
>> server
>> started @ 0.0.0.0/0.0.0.0:39814
>> 2007-05-29 11:48:17,377 INFO  controller.backup.BackupManager Client
>> connected to dump server from /xxx.234.68.194:35695
>> 2007-05-29 11:48:17,381 INFO  controller.backup.BackupManager Dump
>> server
>> terminated.
>> 2007-05-29 11:48:21,056 INFO  controller.backup.BackupManager
>> Registering
>> backuper MySQL to handle format MySQL raw dump
>> 2007-05-29 11:48:21,058 INFO
>> backend.DatabaseBackend.test_big_43_Bbeqv377w Adding connection
>> manager
>> for virtual user "mySQLSimpleUser"
>> 2007-05-29 11:48:21,082 INFO  sequoia.controller.recoverylog Creating
>> recovery log table: RECOVERY_TEST_BIG_43_C
>> 2007-05-29 11:48:21,086 INFO  sequoia.controller.recoverylog Creating
>> checkpoint table: CHECKPOINT_TEST_BIG_43_C
>> 2007-05-29 11:48:21,102 INFO  sequoia.controller.recoverylog Creating
>> backend table: BACKEND_TEST_BIG_43_C
>> 2007-05-29 11:48:21,104 INFO  sequoia.controller.recoverylog
>> Creating dump
>> table: DUMP_TEST_BIG_43_C
>> 2007-05-29 11:48:21,112 INFO  controller.RequestManager.test_big_43_C
>> Request manager will parse requests with the following granularity:
>> TABLE
>> 2007-05-29 11:48:21,117 INFO  controller.virtualdatabase.test_big_43_C
>> Using Hedera properties file: /hedera_appia.properties
>> 2007-05-29 11:48:21,128 INFO  appia.xml.AppiaXML Loading XML
>> configuration
>> from file: /opt/sequoia-2.10.6-bin/config/appia.xml
>> 2007-05-29 11:48:21,152 INFO  continuent.hedera.appia AppiaThread:
>> Starting Appia.
>> 2007-05-29 11:48:21,196 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_43_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39815]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39815],]
>> addresses: [/xxx.234.68.193:39815,]
>>
>> 2007-05-29 11:48:21,199 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_43_C]
>> id: [ViewID:0;[AppiaHedera@/xxx.234.68.193:39815]]
>> previous: []
>> view: [[AppiaHedera@/xxx.234.68.193:39815],]
>> addresses: [/xxx.234.68.193:39815,]
>>
>> 2007-05-29 11:48:23,212 INFO  controller.virtualdatabase.test_big_43_C
>> Group test_big_43_C connected to Member(address=/xxx.234.68.193:39815,
>> uid=xxx.234.68.193:39815)
>> 2007-05-29 11:48:23,213 INFO  controller.virtualdatabase.test_big_43_C
>> First controller in group test_big_43_C
>> 2007-05-29 11:48:23,215 INFO  sequoia.controller.recoverylog Checking
>> recovery log consistency
>> 2007-05-29 11:48:23,219 INFO  controller.core.Controller Adding
>> VirtualDatabase test_big_43_C
>> 2007-05-29 11:48:24,134 DEBUG continuent.hedera.gms Appia reported
>> block()
>> 2007-05-29 11:48:25,706 DEBUG continuent.hedera.appia Received new
>> view:
>> version: 1
>> group: [Group:test_big_43_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39815]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39815]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35701]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39815],[AppiaHedera@/xxx.
>> 234.68.194:35701],]
>> addresses: [/xxx.234.68.193:39815,/xxx.234.68.194:35701,]
>>
>> 2007-05-29 11:48:25,708 DEBUG continuent.hedera.gms Appia reported
>> new view:
>> version: 1
>> group: [Group:test_big_43_C]
>> id: [ViewID:1;[AppiaHedera@/xxx.234.68.193:39815]]
>> previous:
>> [[ViewID:0;[AppiaHedera@/xxx.234.68.193:39815]],[ViewID:0;
>> [AppiaHedera@/xxx.234.68.194:35701]],]
>> view:
>> [[AppiaHedera@/xxx.234.68.193:39815],[AppiaHedera@/xxx.
>> 234.68.194:35701],]
>> addresses: [/xxx.234.68.193:39815,/xxx.234.68.194:35701,]
>>
>> 2007-05-29 11:48:25,709 DEBUG continuent.hedera.gms
>> Member(address=/xxx.234.68.194:35701, uid=xxx.234.68.194:35701) joins
>> Group(gid=test_big_43_C).
>> 2007-05-29 11:48:25,946 INFO  controller.virtualdatabase.test_big_43_C
>> Checking virtual database configuration from xxx.234.68.194:25322
>> 2007-05-29 11:48:25,987 INFO  controller.virtualdatabase.test_big_43_C
>> Controller xxx.234.68.194:25322 is compatible with the local
>> configuration
>> 2007-05-29 11:48:26,015 INFO  controller.virtualdatabase.test_big_43_C
>> Updating backend list for controller Member(address=/xxx.
>> 234.68.194:35701,
>> uid=xxx.234.68.194:35701)
>> 2007-05-29 11:48:26,873 INFO
>> backend.DatabaseBackend.test_big_43_Bbeqv377w Detected backend as:
>> MySQL
>> 2007-05-29 11:48:26,916 INFO  controller.RequestManager.test_big_43_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:26,966 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:26,995 INFO
>> controller.RequestManager.test_big_43_C All
>> activity is suspended for test_big_43_C
>> 2007-05-29 11:48:27,000 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:27,126 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_43_Bbeqv377w is now enabled
>> 2007-05-29 11:48:27,184 INFO
>> controller.RequestManager.test_big_43_C All
>> activity is suspended for test_big_43_C
>> 2007-05-29 11:48:27,205 INFO  controller.virtualdatabase.test_big_43_C
>> Checkpoint backup
>> init_dump_test_big_43_C-xxx.234.68.193:25322-20070529114827158+0200
>> was
>> stored
>> 2007-05-29 11:48:27,208 INFO  controller.virtualdatabase.test_big_43_C
>> Disabling backend test_big_43_Bbeqv377w, waiting for current
>> transaction
>> to complete on this backend
>> 2007-05-29 11:48:27,212 INFO  controller.RequestManager.test_big_43_C
>> Setting new virtual database schema.
>> 2007-05-29 11:48:27,219 INFO  sequoia.controller.connection 2
>> connections
>> freed on "jdbc:mysql://beqv377w/test_big_43"
>> 2007-05-29 11:48:28,342 INFO  controller.virtualdatabase.test_big_43_C
>> Backend test_big_43_Bbeqv377w is now disabled
>> 2007-05-29 11:48:28,343 WARN
>> controller.virtualdatabase.test_big_43_C No
>> information has been found for remote controller
>> Member(address=/xxx.234.68.193:39815, uid=xxx.234.68.193:39815)
>> 2007-05-29 11:48:28,344 WARN  controller.virtualdatabase.test_big_43_C
>> Updating backend list with unknown backend test_big_43_Bbeqv377w
>> disabled
>> on controller Member(address=/xxx.234.68.193:39815,
>> uid=xxx.234.68.193:39815)
>> 2007-05-29 11:48:30,002 INFO  controller.RequestManager.test_big_43_C
>> Backend test_big_43_Bbeqv377w is now disabled
>> 2007-05-29 11:48:30,004 INFO  controller.RequestManager.test_big_43_C
>> Starting backup of backend test_big_43_Bbeqv377w
>> 2007-05-29 11:48:31,607 INFO  backup.backupers.NativeCommandExec
>> Starting
>> execution of "mysqldump --routines --add-drop-database -h beqv377w
>> --port=3306 -uuser1 --password=pass1 --databases test_big_43"
>> 2007-05-29 11:48:31,850 INFO  backup.backupers.NativeCommandExec
>> Command
>> "mysqldump --routines --add-drop-database -h beqv377w --port=3306 -
>> uuser1
>> --password=pass1 --databases test_big_43" logged 0 errors and
>> terminated
>> with exitcode 0
>> 2007-05-29 11:48:31,885 INFO  controller.RequestManager.test_big_43_C
>> Backup has completed.
>> 2007-05-29 11:48:32,014 INFO  controller.recoverylog.RecoverThread
>> Starting recovery
>> 2007-05-29 11:48:33,300 INFO
>> controller.RequestManager.test_big_43_C All
>> activity is suspended for test_big_43_C
>> 2007-05-29 11:48:33,303 INFO  controller.recoverylog.RecoverThread
>> Recovery completed
>> 2007-05-29 11:48:33,588 INFO  controller.recoverylog.RecoverThread
>> Database backend test_big_43_Bbeqv377w is now enabled
>>
>>
>> I hope you'll see / find something which may cause the trouble. If you
>> need further / other information, let me know!
>>
>> Best regards,
>>
>> Malte
>>
>>> Hi,
>>>
>>> On May 25, 2007, at 12:42 , [EMAIL PROTECTED] wrote:
>>>
>>>> Hi Nuno,
>>>>
>>>> excuse me, could you tell me, what exactly I should add to the
>>>> log4j.properties?
>>>> I would be glad if you just give me the lines to add to the
>>>> property file.
>>>>>
>>>
>>> The lines for log4j are the ones that you already have, plus this
>>> one:
>>>
>>> log4j.logger.org.continuent.hedera.appia=DEBUG, Console, Filetrace
>>> log4j.additivity.org.continuent.hedera.appia=false
>>>
>>>
>>>> I have a few other questions, maybe you have an idea for it.
>>>> Is it possible to force the controllers to use a specific port,
>>>> at the
>>>> moment the controllers seem to get one randomly.
>>>> And Is it possible to give appia a hint, on which IP adresses Group
>>>> Members could be? (Maybe this could prevent losing each other of
>>>> sight).
>>>>
>>>
>>> Yes, you can setup some options for an initial configuration and
>>> config the ports that Appia will use. It is described here:
>>> https://forge.continuent.org/pipermail/appia/2006-November/
>>> 000168.html
>>>
>>> But I do not think that this will solve your problem. This is being
>>> caused by delayed messages that trigger the failure detector. You can
>>> increase the timeouts in the appia.xml config file, but this will
>>> only delay the problem. We need to understand what is causing the
>>> delay of message processing.
>>>
>>> Cheers,
>>> --
>>> Nuno Carvalho
>>> University of Lisbon, Portugal
>>> http://dialnp.di.fc.ul.pt
>>>
>>>
>>>
>>> _______________________________________________
>>> Sequoia mailing list
>>> [email protected]
>>> https://forge.continuent.org/mailman/listinfo/sequoia
>>>
>>
>>
>>
>> _______________________________________________
>> Sequoia mailing list
>> [email protected]
>> https://forge.continuent.org/mailman/listinfo/sequoia
>
>
> --
> Nuno Carvalho
> University of Lisbon, Portugal
> http://dialnp.di.fc.ul.pt
>
>
>
> _______________________________________________
> Sequoia mailing list
> [email protected]
> https://forge.continuent.org/mailman/listinfo/sequoia
>



_______________________________________________
Sequoia mailing list
[email protected]
https://forge.continuent.org/mailman/listinfo/sequoia

Reply via email to