Alex wrote:

I've now got a file-based hsqldb in-place (once I remebered to use login "sa" with no password for the login, as this is the default created). However, I get exactly the same problem, it seems - I have a hang on "enable backend1", and the full controller log can be seen here:

http://ohmslaw.org.uk/controllerLog-withHsqlForRecoveryDB.txt
Aha - I turned log4j for Jgroups from WARN to DEBUG, and I have a lot more output to look at now:


11:27:09,196 DEBUG continuent.hedera.adapters Sending message 0 to 1 members. 11:27:09,219 DEBUG protocols.pbcast.NAKACK 192.168.0.128:32962: sending msg #0 11:27:09,220 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {NAKACK=[MSG, seqno=0], UDP=[channel_name=myDB], SEQUENCER=BCAST (tag=[192.168.0.128:32962|0])} 11:27:09,250 DEBUG jgroups.protocols.UDP sending 1 msgs (1369 bytes (2.14% of max_bundle_size), collected in 30ms) to 1 destination(s) 11:27:13,489 DEBUG jgroups.protocols.PingWaiter waiting for initial members: time_to_wait=2000, got 0 rsps
11:27:13,489 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:13,490 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:13,520 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s) 11:27:14,207 DEBUG protocols.pbcast.STABLE setting latest_local_digest from NAKACK: [192.168.0.128:32962#0] 11:27:14,207 DEBUG protocols.pbcast.STABLE sending stable msg [192.168.0.128:32962#0] 11:27:14,208 DEBUG protocols.pbcast.NAKACK 192.168.0.128:32962: sending msg #1 11:27:14,208 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {NAKACK=[MSG, seqno=1], STABLE=[STABLE_GOSSIP]: digest is 192.168.0.128:32962: [0 : 0], UDP=[channel_name=myDB]} 11:27:14,238 DEBUG jgroups.protocols.UDP sending 1 msgs (109 bytes (0.17% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:14,490 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:14,490 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:14,521 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:15,490 DEBUG jgroups.protocols.PingWaiter initial mbrs are []
11:27:15,490 DEBUG jgroups.protocols.MERGE2 initial_mbrs=[[own_addr=192.168.0.128:32962, coord_addr=192.168.0.128:32962, is_server=true]]
11:27:22,400 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:22,400 DEBUG jgroups.protocols.PingWaiter waiting for initial members: time_to_wait=2000, got 0 rsps 11:27:22,400 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:22,431 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:23,401 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:23,401 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:23,431 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:24,401 DEBUG jgroups.protocols.PingWaiter initial mbrs are []
11:27:24,401 DEBUG jgroups.protocols.MERGE2 initial_mbrs=[[own_addr=192.168.0.128:32962, coord_addr=192.168.0.128:32962, is_server=true]] 11:27:24,539 DEBUG protocols.pbcast.STABLE setting latest_local_digest from NAKACK: [192.168.0.128:32962#0] 11:27:24,539 DEBUG protocols.pbcast.STABLE sending stable msg [192.168.0.128:32962#0] 11:27:24,539 DEBUG protocols.pbcast.NAKACK 192.168.0.128:32962: sending msg #2 11:27:24,539 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {NAKACK=[MSG, seqno=2], STABLE=[STABLE_GOSSIP]: digest is 192.168.0.128:32962: [0 : 0 (0)], UDP=[channel_name=myDB]} 11:27:24,570 DEBUG jgroups.protocols.UDP sending 1 msgs (109 bytes (0.17% of max_bundle_size), collected in 31ms) to 1 destination(s)
11:27:32,074 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:32,074 DEBUG jgroups.protocols.PingWaiter waiting for initial members: time_to_wait=2000, got 0 rsps 11:27:32,074 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:32,104 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:33,074 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:33,075 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:33,105 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:34,074 DEBUG jgroups.protocols.PingWaiter initial mbrs are []
11:27:34,075 DEBUG jgroups.protocols.MERGE2 initial_mbrs=[[own_addr=192.168.0.128:32962, coord_addr=192.168.0.128:32962, is_server=true]] 11:27:39,097 DEBUG sequoia.controller.connection Released idle connection (idle timeout reached) 11:27:39,098 DEBUG sequoia.controller.connection Released idle connection (idle timeout reached) 11:27:39,098 DEBUG sequoia.controller.connection Released idle connection (idle timeout reached) 11:27:39,100 DEBUG sequoia.controller.connection Released idle connection (idle timeout reached) 11:27:39,100 DEBUG sequoia.controller.connection Released idle connection (idle timeout reached)
11:27:41,556 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:41,556 DEBUG jgroups.protocols.PingWaiter waiting for initial members: time_to_wait=2000, got 0 rsps 11:27:41,557 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:41,587 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 30ms) to 1 destination(s)
11:27:42,557 DEBUG jgroups.protocols.PingSender sending GET_MBRS_REQ
11:27:42,557 DEBUG jgroups.protocols.UDP sending msg to null (src=192.168.0.128:32962), headers are {PING=[PING: type=GET_MBRS_REQ, arg=null], UDP=[channel_name=myDB]} 11:27:42,588 DEBUG jgroups.protocols.UDP sending 1 msgs (42 bytes (0.07% of max_bundle_size), collected in 31ms) to 1 destination(s)
11:27:43,557 DEBUG jgroups.protocols.PingWaiter initial mbrs are []
11:27:43,557 DEBUG jgroups.protocols.MERGE2 initial_mbrs=[[own_addr=192.168.0.128:32962, coord_addr=192.168.0.128:32962, is_server=true]]


Alex


cheers,
Alex


_______________________________________________
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