2006-10-16 15:32:56 [MgmSrvr] INFO -- NDB Cluster Management Server. Version 5.1.11 (beta) 2006-10-16 15:32:56 [MgmSrvr] INFO -- Id: 1, Command port: 1186 2006-10-16 15:32:56 [MgmSrvr] INFO -- Mgmt server state: nodeid 2 reserved for ip 127.0.0.1, m_reserved_nodes 0000000000000006. 2006-10-16 15:32:56 [MgmSrvr] INFO -- Mgmt server state: nodeid 3 reserved for ip 127.0.0.1, m_reserved_nodes 000000000000000e. 2006-10-16 15:32:56 [MgmSrvr] INFO -- Node 1: Node 2 Connected 2006-10-16 15:32:56 [MgmSrvr] INFO -- Node 1: Node 3 Connected 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: Start phase 0 completed 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: Communication to Node 3 opened 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: Initial start, waiting for 0000000000000008 to connect, nodes [ all: 000000000000000c connected: 0000000000000004 no-wait: 0000000000000000 ] 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 3: Start phase 0 completed 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 3: Communication to Node 2 opened 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 3: Initial start, waiting for 0000000000000004 to connect, nodes [ all: 000000000000000c connected: 0000000000000008 no-wait: 0000000000000000 ] 2006-10-16 15:32:57 [MgmSrvr] INFO -- Mgmt server state: nodeid 3 freed, m_reserved_nodes 0000000000000006. 2006-10-16 15:32:57 [MgmSrvr] INFO -- Mgmt server state: nodeid 2 freed, m_reserved_nodes 0000000000000002. 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: Node 3 Connected 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: Initial start with nodes 000000000000000c [ missing: 0000000000000000 no-wait: 0000000000000000 ] 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 2: CM_REGCONF president = 2, own Node = 2, our dynamic id = 1 2006-10-16 15:32:57 [MgmSrvr] INFO -- Node 3: Node 2 Connected 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 2: Node 3: API version 5.1.11 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 2: Start phase 1 completed 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 3: CM_REGCONF president = 2, own Node = 3, our dynamic id = 2 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 3: Node 2: API version 5.1.11 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 3: Start phase 1 completed 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 2: Start phase 2 completed (initial start) 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 3: Start phase 2 completed (initial start) 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 2: Start phase 3 completed (initial start) 2006-10-16 15:33:00 [MgmSrvr] INFO -- Node 3: Start phase 3 completed (initial start) 2006-10-16 15:33:01 [MgmSrvr] INFO -- Node 2: Start phase 4 completed (initial start) 2006-10-16 15:33:01 [MgmSrvr] INFO -- Node 3: Start phase 4 completed (initial start) 2006-10-16 15:33:03 [MgmSrvr] INFO -- Node 2: Local checkpoint 1 started. Keep GCI = 1 oldest restorable GCI = 1 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 5 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 6 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: President restarts arbitration thread [state=1] 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 7 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Communication to Node 4 opened 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Communication to Node 5 opened 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 8 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 9 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 100 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Start phase 101 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Started (version 5.1.11) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 5 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 6 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 7 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Communication to Node 4 opened 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Communication to Node 5 opened 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 8 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 9 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 100 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Start phase 101 completed (initial start) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Started (version 5.1.11) 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 2: Node 1: API version 5.1.11 2006-10-16 15:33:04 [MgmSrvr] INFO -- Node 3: Node 1: API version 5.1.11 2006-10-16 15:33:05 [MgmSrvr] INFO -- Node 3: Prepare arbitrator node 1 [ticket=07b5000151534ee8] 2006-10-16 15:33:05 [MgmSrvr] INFO -- Node 2: Started arbitrator node 1 [ticket=07b5000151534ee8] 2006-10-16 15:33:08 [MgmSrvr] INFO -- Mgmt server state: nodeid 4 reserved for ip 127.0.0.1, m_reserved_nodes 0000000000000012. 2006-10-16 15:33:08 [MgmSrvr] INFO -- Node 4: mysqld --server-id=4 2006-10-16 15:33:09 [MgmSrvr] INFO -- Node 2: Node 4 Connected 2006-10-16 15:33:09 [MgmSrvr] INFO -- Node 2: Node 4: API version 5.1.11 2006-10-16 15:33:09 [MgmSrvr] INFO -- Node 3: Node 4 Connected 2006-10-16 15:33:09 [MgmSrvr] INFO -- Node 3: Node 4: API version 5.1.11 2006-10-16 15:33:12 [MgmSrvr] INFO -- Mgmt server state: nodeid 5 reserved for ip 127.0.0.1, m_reserved_nodes 0000000000000032. 2006-10-16 15:33:12 [MgmSrvr] INFO -- Node 5: mysqld --server-id=5 2006-10-16 15:33:12 [MgmSrvr] INFO -- Node 2: Node 5 Connected 2006-10-16 15:33:12 [MgmSrvr] INFO -- Node 2: Node 5: API version 5.1.11 2006-10-16 15:33:12 [MgmSrvr] INFO -- Node 3: Node 5 Connected 2006-10-16 15:33:12 [MgmSrvr] INFO -- Node 3: Node 5: API version 5.1.11 2006-10-16 15:34:36 [MgmSrvr] INFO -- Node 4: Event buffer status: used=1500KB(100%) alloc=1500KB(0%) max=0B apply_gci=45 latest_gci=45 2006-10-16 15:34:36 [MgmSrvr] INFO -- Node 5: Event buffer status: used=1500KB(100%) alloc=1500KB(0%) max=0B apply_gci=45 latest_gci=45 2006-10-16 15:34:39 [MgmSrvr] INFO -- Node 2: Local checkpoint 2 started. Keep GCI = 1 oldest restorable GCI = 2 2006-10-16 15:34:39 [MgmSrvr] INFO -- Node 4: Event buffer status: used=2000KB(100%) alloc=2000KB(0%) max=0B apply_gci=46 latest_gci=46 2006-10-16 15:34:39 [MgmSrvr] INFO -- Node 5: Event buffer status: used=2000KB(100%) alloc=2000KB(0%) max=0B apply_gci=46 latest_gci=46 2006-10-16 15:34:45 [MgmSrvr] INFO -- Node 2: Local checkpoint 3 started. Keep GCI = 47 oldest restorable GCI = 48 2006-10-16 15:34:45 [MgmSrvr] INFO -- Node 4: Event buffer status: used=2500KB(100%) alloc=2500KB(0%) max=0B apply_gci=49 latest_gci=49 2006-10-16 15:34:45 [MgmSrvr] INFO -- Node 5: Event buffer status: used=2500KB(100%) alloc=2500KB(0%) max=0B apply_gci=49 latest_gci=49 2006-10-16 15:34:50 [MgmSrvr] INFO -- Node 2: Local checkpoint 4 started. Keep GCI = 49 oldest restorable GCI = 50 2006-10-16 15:34:53 [MgmSrvr] WARNING -- Node 2: Transporter to node 3 reported error 0x16 2006-10-16 15:34:54 [MgmSrvr] WARNING -- Node 2: Transporter to node 3 reported error 0x16 2006-10-16 15:34:54 [MgmSrvr] WARNING -- Node 3: Transporter to node 5 reported error 0x16 2006-10-16 15:34:54 [MgmSrvr] WARNING -- Node 3: Transporter to node 5 reported error 0x16 - Repeated 2 times 2006-10-16 15:34:54 [MgmSrvr] INFO -- Node 4: Event buffer status: used=4500KB(100%) alloc=4500KB(0%) max=0B apply_gci=52 latest_gci=52 2006-10-16 15:34:54 [MgmSrvr] INFO -- Node 5: Event buffer status: used=4500KB(100%) alloc=4500KB(0%) max=0B apply_gci=52 latest_gci=52 2006-10-16 15:34:54 [MgmSrvr] WARNING -- Node 2: Transporter to node 5 reported error 0x16 2006-10-16 15:34:55 [MgmSrvr] INFO -- Node 2: Local checkpoint 5 started. Keep GCI = 51 oldest restorable GCI = 52 2006-10-16 15:35:02 [MgmSrvr] INFO -- Node 2: Local checkpoint 6 started. Keep GCI = 53 oldest restorable GCI = 53 2006-10-16 15:35:05 [MgmSrvr] WARNING -- Node 3: Transporter to node 2 reported error 0x16 2006-10-16 15:35:06 [MgmSrvr] WARNING -- Node 3: Transporter to node 2 reported error 0x16 - Repeated 10 times 2006-10-16 15:35:06 [MgmSrvr] INFO -- Node 1: Node 3 Connected 2006-10-16 15:35:07 [MgmSrvr] ALERT -- Node 3: Forced node shutdown completed. Initiated by signal 0. Caused by error 2341: 'Internal program error (failed ndbrequire)(Internal error, programming error or missing error message, please report a bug). Temporary error, restart node'. 2006-10-16 15:35:07 [MgmSrvr] INFO -- Node 1: Node 2 Connected 2006-10-16 15:35:07 [MgmSrvr] ALERT -- Node 2: Forced node shutdown completed. Initiated by signal 0. Caused by error 2341: 'Internal program error (failed ndbrequire)(Internal error, programming error or missing error message, please report a bug). Temporary error, restart node'.