You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@directory.apache.org by John Peter <jm...@iki.fi> on 2015/04/07 12:36:48 UTC

[ApacheDS] failed to startup after reboot

Hi,

I'm using apacheds 2.0.0 M_19.

The server had a scheduled montly reboot at 2015/04/02 02:21:51.

After the reboot we noticed that the apacheDS port is open, but logins are
failing.

What we did is a manual restart of the apacheDS service and it started
working again.

Below is the apacheDS wrapper.log.

After the reboot which didn't work we can see a
java.lang.ArrayIndexOutOfBoundsException:
-11870. What might be causing this?

I can also see a WARNING on each startup, is that related to the issue?

STATUS | wrapper  | 2015/02/19 11:42:33 | --> Wrapper Started as Service
STATUS | wrapper  | 2015/02/19 11:42:34 | Launching a JVM...
INFO   | jvm 1    | 2015/02/19 11:42:34 | Wrapper (Version 3.2.3)
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2015/02/19 11:42:34 |   Copyright 1999-2006 Tanuki
Software, Inc.  All Rights Reserved.
INFO   | jvm 1    | 2015/02/19 11:42:34 |
INFO   | jvm 1    | 2015/02/19 11:42:34 |
INFO   | jvm 1    | 2015/02/19 11:42:34 | WARNING - Unable to load the
Wrapper's native library 'wrapper.dll'.
INFO   | jvm 1    | 2015/02/19 11:42:34 |           The file is located on
the path at the following location but
INFO   | jvm 1    | 2015/02/19 11:42:34 |           could not be loaded:
INFO   | jvm 1    | 2015/02/19 11:42:34 |
d:\ApacheDS\bin\..\lib\wrapper.dll
INFO   | jvm 1    | 2015/02/19 11:42:34 |           Please verify that the
file is readable by the current user
INFO   | jvm 1    | 2015/02/19 11:42:34 |           and that the file has
not been corrupted in any way.
INFO   | jvm 1    | 2015/02/19 11:42:34 |           One common cause of
this problem is running a 32-bit version
INFO   | jvm 1    | 2015/02/19 11:42:34 |           of the Wrapper with a
64-bit version of Java, or vica versa.
INFO   | jvm 1    | 2015/02/19 11:42:34 |           This is a 64-bit JVM.
INFO   | jvm 1    | 2015/02/19 11:42:34 |           Reported cause:
INFO   | jvm 1    | 2015/02/19 11:42:34 |
D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
platform
INFO   | jvm 1    | 2015/02/19 11:42:34 |           System signals will not
be handled correctly.
INFO   | jvm 1    | 2015/02/19 11:42:34 |
INFO   | jvm 1    | 2015/02/19 11:42:39 |            _
_          ____  ____
INFO   | jvm 1    | 2015/02/19 11:42:39 |           / \   _ __    ___  ___|
|__   ___|  _ \/ ___|
INFO   | jvm 1    | 2015/02/19 11:42:39 |          / _ \ | '_ \ / _` |/ __|
'_ \ / _ \ | | \___ \
INFO   | jvm 1    | 2015/02/19 11:42:39 |         / ___ \| |_) | (_| | (__|
| | |  __/ |_| |___) |
INFO   | jvm 1    | 2015/02/19 11:42:39 |        /_/   \_\ .__/
\__,_|\___|_| |_|\___|____/|____/
INFO   | jvm 1    | 2015/02/19 11:42:39 |                |_|

INFO   | jvm 1    | 2015/02/19 11:42:39 |
STATUS | wrapper  | 2015/03/05 03:06:42 | <-- Wrapper Stopped
STATUS | wrapper  | 2015/03/05 03:08:30 | --> Wrapper Started as Service
STATUS | wrapper  | 2015/03/05 03:08:31 | Launching a JVM...
INFO   | jvm 1    | 2015/03/05 03:08:33 | Wrapper (Version 3.2.3)
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2015/03/05 03:08:33 |   Copyright 1999-2006 Tanuki
Software, Inc.  All Rights Reserved.
INFO   | jvm 1    | 2015/03/05 03:08:33 |
INFO   | jvm 1    | 2015/03/05 03:08:33 |
INFO   | jvm 1    | 2015/03/05 03:08:33 | WARNING - Unable to load the
Wrapper's native library 'wrapper.dll'.
INFO   | jvm 1    | 2015/03/05 03:08:33 |           The file is located on
the path at the following location but
INFO   | jvm 1    | 2015/03/05 03:08:33 |           could not be loaded:
INFO   | jvm 1    | 2015/03/05 03:08:33 |
d:\ApacheDS\bin\..\lib\wrapper.dll
INFO   | jvm 1    | 2015/03/05 03:08:33 |           Please verify that the
file is readable by the current user
INFO   | jvm 1    | 2015/03/05 03:08:33 |           and that the file has
not been corrupted in any way.
INFO   | jvm 1    | 2015/03/05 03:08:33 |           One common cause of
this problem is running a 32-bit version
INFO   | jvm 1    | 2015/03/05 03:08:33 |           of the Wrapper with a
64-bit version of Java, or vica versa.
INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit JVM.
INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
INFO   | jvm 1    | 2015/03/05 03:08:33 |
D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
platform
INFO   | jvm 1    | 2015/03/05 03:08:33 |           System signals will not
be handled correctly.
INFO   | jvm 1    | 2015/03/05 03:08:33 |
INFO   | jvm 1    | 2015/03/05 03:08:48 |            _
_          ____  ____
INFO   | jvm 1    | 2015/03/05 03:08:48 |           / \   _ __    ___  ___|
|__   ___|  _ \/ ___|
INFO   | jvm 1    | 2015/03/05 03:08:48 |          / _ \ | '_ \ / _` |/ __|
'_ \ / _ \ | | \___ \
INFO   | jvm 1    | 2015/03/05 03:08:48 |         / ___ \| |_) | (_| | (__|
| | |  __/ |_| |___) |
INFO   | jvm 1    | 2015/03/05 03:08:48 |        /_/   \_\ .__/
\__,_|\___|_| |_|\___|____/|____/
INFO   | jvm 1    | 2015/03/05 03:08:48 |                |_|

INFO   | jvm 1    | 2015/03/05 03:08:48 |
ERROR  | wrapper  | 2015/04/02 02:21:51 | Shutdown failed: Timed out
waiting for signal from JVM.
ERROR  | wrapper  | 2015/04/02 02:21:51 | JVM did not exit on request,
terminated
STATUS | wrapper  | 2015/04/02 02:21:52 | <-- Wrapper Stopped
STATUS | wrapper  | 2015/04/02 02:23:19 | --> Wrapper Started as Service
STATUS | wrapper  | 2015/04/02 02:23:19 | Launching a JVM...
INFO   | jvm 1    | 2015/04/02 02:23:21 | Wrapper (Version 3.2.3)
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2015/04/02 02:23:21 |   Copyright 1999-2006 Tanuki
Software, Inc.  All Rights Reserved.
INFO   | jvm 1    | 2015/04/02 02:23:21 |
INFO   | jvm 1    | 2015/04/02 02:23:21 |
INFO   | jvm 1    | 2015/04/02 02:23:21 | WARNING - Unable to load the
Wrapper's native library 'wrapper.dll'.
INFO   | jvm 1    | 2015/04/02 02:23:21 |           The file is located on
the path at the following location but
INFO   | jvm 1    | 2015/04/02 02:23:21 |           could not be loaded:
INFO   | jvm 1    | 2015/04/02 02:23:21 |
d:\ApacheDS\bin\..\lib\wrapper.dll
INFO   | jvm 1    | 2015/04/02 02:23:21 |           Please verify that the
file is readable by the current user
INFO   | jvm 1    | 2015/04/02 02:23:21 |           and that the file has
not been corrupted in any way.
INFO   | jvm 1    | 2015/04/02 02:23:21 |           One common cause of
this problem is running a 32-bit version
INFO   | jvm 1    | 2015/04/02 02:23:21 |           of the Wrapper with a
64-bit version of Java, or vica versa.
INFO   | jvm 1    | 2015/04/02 02:23:21 |           This is a 64-bit JVM.
INFO   | jvm 1    | 2015/04/02 02:23:21 |           Reported cause:
INFO   | jvm 1    | 2015/04/02 02:23:21 |
D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
platform
INFO   | jvm 1    | 2015/04/02 02:23:21 |           System signals will not
be handled correctly.
INFO   | jvm 1    | 2015/04/02 02:23:21 |
INFO   | jvm 1    | 2015/04/02 02:23:56 |            _
_          ____  ____
INFO   | jvm 1    | 2015/04/02 02:23:56 |           / \   _ __    ___  ___|
|__   ___|  _ \/ ___|
INFO   | jvm 1    | 2015/04/02 02:23:56 |          / _ \ | '_ \ / _` |/ __|
'_ \ / _ \ | | \___ \
INFO   | jvm 1    | 2015/04/02 02:23:56 |         / ___ \| |_) | (_| | (__|
| | |  __/ |_| |___) |
INFO   | jvm 1    | 2015/04/02 02:23:56 |        /_/   \_\ .__/
\__,_|\___|_| |_|\___|____/|____/
INFO   | jvm 1    | 2015/04/02 02:23:56 |                |_|

INFO   | jvm 1    | 2015/04/02 02:23:56 |
INFO   | jvm 1    | 2015/04/02 03:00:41 |
java.lang.ArrayIndexOutOfBoundsException: -11870
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.BlockIo.readInt(BlockIo.java:282)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.RecordHeader.getAvailableSize(RecordHeader.java:105)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:216)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.partition.impl.btree.AbstractBTreePartition.add(AbstractBTreePartition.java:861)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.add(DefaultPartitionNexus.java:352)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor$1.add(BaseInterceptor.java:165)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.journal.JournalInterceptor.add(JournalInterceptor.java:139)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.trigger.TriggerInterceptor.add(TriggerInterceptor.java:300)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.event.EventInterceptor.add(EventInterceptor.java:226)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.subtree.SubentryInterceptor.add(SubentryInterceptor.java:1014)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.collective.CollectiveAttributeInterceptor.add(CollectiveAttributeInterceptor.java:134)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.operational.OperationalAttributeInterceptor.add(OperationalAttributeInterceptor.java:232)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.schema.SchemaInterceptor.add(SchemaInterceptor.java:1101)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.hash.PasswordHashingInterceptor.add(PasswordHashingInterceptor.java:93)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.exception.ExceptionInterceptor.add(ExceptionInterceptor.java:189)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.admin.AdministrativePointInterceptor.add(AdministrativePointInterceptor.java:1201)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.authz.AciAuthorizationInterceptor.add(AciAuthorizationInterceptor.java:515)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.referral.ReferralInterceptor.add(ReferralInterceptor.java:249)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.authn.AuthenticationInterceptor.add(AuthenticationInterceptor.java:410)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.normalization.NormalizationInterceptor.add(NormalizationInterceptor.java:131)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.DefaultOperationManager.add(DefaultOperationManager.java:394)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:255)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:239)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:57)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:39)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at
org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
INFO   | jvm 1    | 2015/04/02 03:00:41 | at java.lang.Thread.run(Unknown
Source)
INFO   | jvm 1    | 2015/04/02 03:00:42 | Exception in thread
"pool-6-thread-3" java.lang.Error: ERR_554 double get for block 41 630
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.RecordFile.get(RecordFile.java:185)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:202)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.partition.impl.btree.AbstractBTreePartition.add(AbstractBTreePartition.java:861)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.add(DefaultPartitionNexus.java:352)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor$1.add(BaseInterceptor.java:165)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.journal.JournalInterceptor.add(JournalInterceptor.java:139)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.trigger.TriggerInterceptor.add(TriggerInterceptor.java:300)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.event.EventInterceptor.add(EventInterceptor.java:226)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.subtree.SubentryInterceptor.add(SubentryInterceptor.java:1014)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.collective.CollectiveAttributeInterceptor.add(CollectiveAttributeInterceptor.java:134)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.operational.OperationalAttributeInterceptor.add(OperationalAttributeInterceptor.java:232)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.schema.SchemaInterceptor.add(SchemaInterceptor.java:1101)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.hash.PasswordHashingInterceptor.add(PasswordHashingInterceptor.java:93)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.exception.ExceptionInterceptor.add(ExceptionInterceptor.java:189)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.admin.AdministrativePointInterceptor.add(AdministrativePointInterceptor.java:1201)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.authz.AciAuthorizationInterceptor.add(AciAuthorizationInterceptor.java:515)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.referral.ReferralInterceptor.add(ReferralInterceptor.java:249)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.authn.AuthenticationInterceptor.add(AuthenticationInterceptor.java:410)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.normalization.NormalizationInterceptor.add(NormalizationInterceptor.java:131)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.DefaultOperationManager.add(DefaultOperationManager.java:394)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:255)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:239)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:57)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:39)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at
org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
INFO   | jvm 1    | 2015/04/02 03:00:42 | at java.lang.Thread.run(Unknown
Source)
INFO   | jvm 1    | 2015/04/02 09:25:56 | Error in WrapperListener.stop
callback.  java.lang.Error: ERR_554 double get for block 41 630
INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554 double
get for block 41 630
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.RecordFile.get(RecordFile.java:185)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:202)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.sync(DefaultPartitionNexus.java:320)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.core.DefaultDirectoryService.shutdown(DefaultDirectoryService.java:1283)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.ApacheDsService.stop(ApacheDsService.java:600)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.apache.directory.server.wrapper.ApacheDsTanukiWrapper.stop(ApacheDsTanukiWrapper.java:97)
INFO   | jvm 1    | 2015/04/02 09:25:56 | at
org.tanukisoftware.wrapper.WrapperManager$13.run(WrapperManager.java:3134)
ERROR  | wrapper  | 2015/04/02 09:27:00 | Shutdown failed: Timed out
waiting for the JVM to terminate.
ERROR  | wrapper  | 2015/04/02 09:27:00 | JVM did not exit on request,
terminated
STATUS | wrapper  | 2015/04/02 09:27:01 | <-- Wrapper Stopped
STATUS | wrapper  | 2015/04/02 09:27:02 | --> Wrapper Started as Service
STATUS | wrapper  | 2015/04/02 09:27:02 | Launching a JVM...
INFO   | jvm 1    | 2015/04/02 09:27:06 | Wrapper (Version 3.2.3)
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2015/04/02 09:27:06 |   Copyright 1999-2006 Tanuki
Software, Inc.  All Rights Reserved.
INFO   | jvm 1    | 2015/04/02 09:27:06 |
INFO   | jvm 1    | 2015/04/02 09:27:06 |
INFO   | jvm 1    | 2015/04/02 09:27:06 | WARNING - Unable to load the
Wrapper's native library 'wrapper.dll'.
INFO   | jvm 1    | 2015/04/02 09:27:06 |           The file is located on
the path at the following location but
INFO   | jvm 1    | 2015/04/02 09:27:06 |           could not be loaded:
INFO   | jvm 1    | 2015/04/02 09:27:06 |
d:\ApacheDS\bin\..\lib\wrapper.dll
INFO   | jvm 1    | 2015/04/02 09:27:06 |           Please verify that the
file is readable by the current user
INFO   | jvm 1    | 2015/04/02 09:27:06 |           and that the file has
not been corrupted in any way.
INFO   | jvm 1    | 2015/04/02 09:27:06 |           One common cause of
this problem is running a 32-bit version
INFO   | jvm 1    | 2015/04/02 09:27:06 |           of the Wrapper with a
64-bit version of Java, or vica versa.
INFO   | jvm 1    | 2015/04/02 09:27:06 |           This is a 64-bit JVM.
INFO   | jvm 1    | 2015/04/02 09:27:06 |           Reported cause:
INFO   | jvm 1    | 2015/04/02 09:27:06 |
D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
platform
INFO   | jvm 1    | 2015/04/02 09:27:06 |           System signals will not
be handled correctly.
INFO   | jvm 1    | 2015/04/02 09:27:06 |
INFO   | jvm 1    | 2015/04/02 09:27:29 |            _
_          ____  ____
INFO   | jvm 1    | 2015/04/02 09:27:29 |           / \   _ __    ___  ___|
|__   ___|  _ \/ ___|
INFO   | jvm 1    | 2015/04/02 09:27:29 |          / _ \ | '_ \ / _` |/ __|
'_ \ / _ \ | | \___ \
INFO   | jvm 1    | 2015/04/02 09:27:29 |         / ___ \| |_) | (_| | (__|
| | |  __/ |_| |___) |
INFO   | jvm 1    | 2015/04/02 09:27:29 |        /_/   \_\ .__/
\__,_|\___|_| |_|\___|____/|____/
INFO   | jvm 1    | 2015/04/02 09:27:29 |                |_|

INFO   | jvm 1    | 2015/04/02 09:27:29 |

Thanks for the help,
John

Re: [ApacheDS] failed to startup after reboot

Posted by Emmanuel Lécharny <el...@gmail.com>.
Le 09/04/15 10:22, John Peter a écrit :
> Thanks Kiran and Emmanuel for the quick responses.
>
> Kiran you wrote:
> "One workaround is to make sure the server has no active write connections at
> the time of shutdown."
>
> The reboot was at 2:21. We don't have manual writing to apacheDS at that
> time. We have a user integration running at 03:00 every night, but that
> shouldn't have effected this since its only later.
>
> So no one should have been actively writing to apacheDS at that time. What
> else could have caused the issue?
>
> Emmanuel you wrote:
> "AFAIR, the Windows installer only works with a 32 bit wrapper, which
> expect to use a 32 bits JVM"
>
> There is a 64bit apacheDS instalaltion package that we used. It's working
> fine otherwise but apacheds gives that warning each time it starts. Isn't
> apacheDS meant yo be used with 64bit Java?

Yes, but the installer itself on windows is limited to 32bits.

The reason is that the guys who wrote the installer decided to make mony
by selling a 64 bits version of it for what they expected to be the most
used platform, 6 years ago.

We will work on uing another installer for the next versions.

Re: [ApacheDS] failed to startup after reboot

Posted by Kiran Ayyagari <ka...@apache.org>.
On Thu, Apr 9, 2015 at 4:22 PM, John Peter <jm...@iki.fi> wrote:

> Thanks Kiran and Emmanuel for the quick responses.
>
> Kiran you wrote:
> "One workaround is to make sure the server has no active write connections
> at
> the time of shutdown."
>
> The reboot was at 2:21. We don't have manual writing to apacheDS at that
> time. We have a user integration running at 03:00 every night, but that
> shouldn't have effected this since its only later.
>
> So no one should have been actively writing to apacheDS at that time. What
> else could have caused the issue?
>
> I have no reasonable explanation about this behavior other than to suspect
that
JDBM cache flushing is likely buggy resulting in corrupted page blocks.

> Emmanuel you wrote:
> "AFAIR, the Windows installer only works with a 32 bit wrapper, which
> expect to use a 32 bits JVM"
>
> There is a 64bit apacheDS instalaltion package that we used. It's working
> fine otherwise but apacheds gives that warning each time it starts. Isn't
> apacheDS meant yo be used with 64bit Java?
>
> Thanks for the help.
>
> --
> John
>
> On Tue, Apr 7, 2015 at 4:08 PM, Emmanuel Lécharny <el...@gmail.com>
> wrote:
>
> > Le 07/04/15 14:44, Kiran Ayyagari a écrit :
> > > On Tue, Apr 7, 2015 at 8:17 PM, Emmanuel Lécharny <elecharny@gmail.com
> >
> > > wrote:
> > >
> > >> Le 07/04/15 13:31, Kiran Ayyagari a écrit :
> > >>> On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:
> > >>>
> > >>>> Hi,
> > >>>>
> > >>>> I'm using apacheds 2.0.0 M_19.
> > >>>>
> > >>>> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
> > >>>>
> > >>>> After the reboot we noticed that the apacheDS port is open, but
> logins
> > >> are
> > >>>> failing.
> > >>>>
> > >>>> What we did is a manual restart of the apacheDS service and it
> started
> > >>>> working again.
> > >>>>
> > >>>> Below is the apacheDS wrapper.log.
> > >>>>
> > >>>> After the reboot which didn't work we can see a
> > >>>> java.lang.ArrayIndexOutOfBoundsException:
> > >>>> -11870. What might be causing this?
> > >>>>
> > >>> during shutdown the JDBM partition was not cleanly closed
> > >>> by the server, this can happen due to various reasons, and there is
> > >>> no fix for this issue.
> > >>>
> > >>> One workaround is to make sure the server has no active write
> > connections
> > >>> at the
> > >>> time of shutdown.
> > >>>
> > >>> We are working on Mavibot, a new backend, to prevent these kind of
> > issues
> > >>> from happening and it will replace JDBM.
> > >> I think this is not the problem here. Looking at the logs, we see :
> > >>
> > >> INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit
> > JVM.
> > >> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
> > >> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> > >> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> > >> platform
> > >>
> > >>
> > >> AFAIR, the Windows installer only works with a 32 bit wrapper, which
> > >> expect to use a 32 bits JVM. The installed JVM is a 64 bits one, which
> > >> explain the failure. Restarting by hand works because this time, the
> > user
> > >> launch the 64 bits JVM with the 64 bits library.
> > >> This is an issue we can't fix with Tanuki wrapper, as it only supports
> > 32
> > >> bits JVM in its free installer. We have to consider switching to
> another
> > >> installer (YAJSW ?)
> > >>
> > >> hmm, the below error is a clear JDBM issue
> > > callback.  java.lang.Error: ERR_554 double get for block 41 630
> > > INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554
> double
> > > get for block 41 630
> >
> > Ah, you are right. I think then we have 2 problems :/
> >
> >
>



-- 
Kiran Ayyagari
http://keydap.com

Re: [ApacheDS] failed to startup after reboot

Posted by John Peter <jm...@iki.fi>.
Thanks Kiran and Emmanuel for the quick responses.

Kiran you wrote:
"One workaround is to make sure the server has no active write connections at
the time of shutdown."

The reboot was at 2:21. We don't have manual writing to apacheDS at that
time. We have a user integration running at 03:00 every night, but that
shouldn't have effected this since its only later.

So no one should have been actively writing to apacheDS at that time. What
else could have caused the issue?

Emmanuel you wrote:
"AFAIR, the Windows installer only works with a 32 bit wrapper, which
expect to use a 32 bits JVM"

There is a 64bit apacheDS instalaltion package that we used. It's working
fine otherwise but apacheds gives that warning each time it starts. Isn't
apacheDS meant yo be used with 64bit Java?

Thanks for the help.

--
John

On Tue, Apr 7, 2015 at 4:08 PM, Emmanuel Lécharny <el...@gmail.com>
wrote:

> Le 07/04/15 14:44, Kiran Ayyagari a écrit :
> > On Tue, Apr 7, 2015 at 8:17 PM, Emmanuel Lécharny <el...@gmail.com>
> > wrote:
> >
> >> Le 07/04/15 13:31, Kiran Ayyagari a écrit :
> >>> On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:
> >>>
> >>>> Hi,
> >>>>
> >>>> I'm using apacheds 2.0.0 M_19.
> >>>>
> >>>> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
> >>>>
> >>>> After the reboot we noticed that the apacheDS port is open, but logins
> >> are
> >>>> failing.
> >>>>
> >>>> What we did is a manual restart of the apacheDS service and it started
> >>>> working again.
> >>>>
> >>>> Below is the apacheDS wrapper.log.
> >>>>
> >>>> After the reboot which didn't work we can see a
> >>>> java.lang.ArrayIndexOutOfBoundsException:
> >>>> -11870. What might be causing this?
> >>>>
> >>> during shutdown the JDBM partition was not cleanly closed
> >>> by the server, this can happen due to various reasons, and there is
> >>> no fix for this issue.
> >>>
> >>> One workaround is to make sure the server has no active write
> connections
> >>> at the
> >>> time of shutdown.
> >>>
> >>> We are working on Mavibot, a new backend, to prevent these kind of
> issues
> >>> from happening and it will replace JDBM.
> >> I think this is not the problem here. Looking at the logs, we see :
> >>
> >> INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit
> JVM.
> >> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
> >> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> >> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> >> platform
> >>
> >>
> >> AFAIR, the Windows installer only works with a 32 bit wrapper, which
> >> expect to use a 32 bits JVM. The installed JVM is a 64 bits one, which
> >> explain the failure. Restarting by hand works because this time, the
> user
> >> launch the 64 bits JVM with the 64 bits library.
> >> This is an issue we can't fix with Tanuki wrapper, as it only supports
> 32
> >> bits JVM in its free installer. We have to consider switching to another
> >> installer (YAJSW ?)
> >>
> >> hmm, the below error is a clear JDBM issue
> > callback.  java.lang.Error: ERR_554 double get for block 41 630
> > INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554 double
> > get for block 41 630
>
> Ah, you are right. I think then we have 2 problems :/
>
>

Re: [ApacheDS] failed to startup after reboot

Posted by Emmanuel Lécharny <el...@gmail.com>.
Le 07/04/15 14:44, Kiran Ayyagari a écrit :
> On Tue, Apr 7, 2015 at 8:17 PM, Emmanuel Lécharny <el...@gmail.com>
> wrote:
>
>> Le 07/04/15 13:31, Kiran Ayyagari a écrit :
>>> On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:
>>>
>>>> Hi,
>>>>
>>>> I'm using apacheds 2.0.0 M_19.
>>>>
>>>> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
>>>>
>>>> After the reboot we noticed that the apacheDS port is open, but logins
>> are
>>>> failing.
>>>>
>>>> What we did is a manual restart of the apacheDS service and it started
>>>> working again.
>>>>
>>>> Below is the apacheDS wrapper.log.
>>>>
>>>> After the reboot which didn't work we can see a
>>>> java.lang.ArrayIndexOutOfBoundsException:
>>>> -11870. What might be causing this?
>>>>
>>> during shutdown the JDBM partition was not cleanly closed
>>> by the server, this can happen due to various reasons, and there is
>>> no fix for this issue.
>>>
>>> One workaround is to make sure the server has no active write connections
>>> at the
>>> time of shutdown.
>>>
>>> We are working on Mavibot, a new backend, to prevent these kind of issues
>>> from happening and it will replace JDBM.
>> I think this is not the problem here. Looking at the logs, we see :
>>
>> INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit JVM.
>> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
>> INFO   | jvm 1    | 2015/03/05 03:08:33 |
>> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
>> platform
>>
>>
>> AFAIR, the Windows installer only works with a 32 bit wrapper, which
>> expect to use a 32 bits JVM. The installed JVM is a 64 bits one, which
>> explain the failure. Restarting by hand works because this time, the user
>> launch the 64 bits JVM with the 64 bits library.
>> This is an issue we can't fix with Tanuki wrapper, as it only supports 32
>> bits JVM in its free installer. We have to consider switching to another
>> installer (YAJSW ?)
>>
>> hmm, the below error is a clear JDBM issue
> callback.  java.lang.Error: ERR_554 double get for block 41 630
> INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554 double
> get for block 41 630

Ah, you are right. I think then we have 2 problems :/


Re: [ApacheDS] failed to startup after reboot

Posted by Kiran Ayyagari <ka...@apache.org>.
On Tue, Apr 7, 2015 at 8:17 PM, Emmanuel Lécharny <el...@gmail.com>
wrote:

> Le 07/04/15 13:31, Kiran Ayyagari a écrit :
> > On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:
> >
> >> Hi,
> >>
> >> I'm using apacheds 2.0.0 M_19.
> >>
> >> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
> >>
> >> After the reboot we noticed that the apacheDS port is open, but logins
> are
> >> failing.
> >>
> >> What we did is a manual restart of the apacheDS service and it started
> >> working again.
> >>
> >> Below is the apacheDS wrapper.log.
> >>
> >> After the reboot which didn't work we can see a
> >> java.lang.ArrayIndexOutOfBoundsException:
> >> -11870. What might be causing this?
> >>
> > during shutdown the JDBM partition was not cleanly closed
> > by the server, this can happen due to various reasons, and there is
> > no fix for this issue.
> >
> > One workaround is to make sure the server has no active write connections
> > at the
> > time of shutdown.
> >
> > We are working on Mavibot, a new backend, to prevent these kind of issues
> > from happening and it will replace JDBM.
>
> I think this is not the problem here. Looking at the logs, we see :
>
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit JVM.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> platform
>
>
> AFAIR, the Windows installer only works with a 32 bit wrapper, which
> expect to use a 32 bits JVM. The installed JVM is a 64 bits one, which
> explain the failure. Restarting by hand works because this time, the user
> launch the 64 bits JVM with the 64 bits library.
> This is an issue we can't fix with Tanuki wrapper, as it only supports 32
> bits JVM in its free installer. We have to consider switching to another
> installer (YAJSW ?)
>
> hmm, the below error is a clear JDBM issue

callback.  java.lang.Error: ERR_554 double get for block 41 630
INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554 double
get for block 41 630


-- 
Kiran Ayyagari
http://keydap.com

Re: [ApacheDS] failed to startup after reboot

Posted by Emmanuel Lécharny <el...@gmail.com>.
Le 07/04/15 13:31, Kiran Ayyagari a écrit :
> On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:
>
>> Hi,
>>
>> I'm using apacheds 2.0.0 M_19.
>>
>> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
>>
>> After the reboot we noticed that the apacheDS port is open, but logins are
>> failing.
>>
>> What we did is a manual restart of the apacheDS service and it started
>> working again.
>>
>> Below is the apacheDS wrapper.log.
>>
>> After the reboot which didn't work we can see a
>> java.lang.ArrayIndexOutOfBoundsException:
>> -11870. What might be causing this?
>>
> during shutdown the JDBM partition was not cleanly closed
> by the server, this can happen due to various reasons, and there is
> no fix for this issue.
>
> One workaround is to make sure the server has no active write connections
> at the
> time of shutdown.
>
> We are working on Mavibot, a new backend, to prevent these kind of issues
> from happening and it will replace JDBM.

I think this is not the problem here. Looking at the logs, we see :

INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit JVM.
INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
INFO   | jvm 1    | 2015/03/05 03:08:33 |
D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
platform


AFAIR, the Windows installer only works with a 32 bit wrapper, which expect to use a 32 bits JVM. The installed JVM is a 64 bits one, which explain the failure. Restarting by hand works because this time, the user launch the 64 bits JVM with the 64 bits library.
This is an issue we can't fix with Tanuki wrapper, as it only supports 32 bits JVM in its free installer. We have to consider switching to another installer (YAJSW ?)


Re: [ApacheDS] failed to startup after reboot

Posted by Kiran Ayyagari <ka...@apache.org>.
On Tue, Apr 7, 2015 at 6:36 PM, John Peter <jm...@iki.fi> wrote:

> Hi,
>
> I'm using apacheds 2.0.0 M_19.
>
> The server had a scheduled montly reboot at 2015/04/02 02:21:51.
>
> After the reboot we noticed that the apacheDS port is open, but logins are
> failing.
>
> What we did is a manual restart of the apacheDS service and it started
> working again.
>
> Below is the apacheDS wrapper.log.
>
> After the reboot which didn't work we can see a
> java.lang.ArrayIndexOutOfBoundsException:
> -11870. What might be causing this?
>
during shutdown the JDBM partition was not cleanly closed
by the server, this can happen due to various reasons, and there is
no fix for this issue.

One workaround is to make sure the server has no active write connections
at the
time of shutdown.

We are working on Mavibot, a new backend, to prevent these kind of issues
from happening and it will replace JDBM.


> I can also see a WARNING on each startup, is that related to the issue?
>
> STATUS | wrapper  | 2015/02/19 11:42:33 | --> Wrapper Started as Service
> STATUS | wrapper  | 2015/02/19 11:42:34 | Launching a JVM...
> INFO   | jvm 1    | 2015/02/19 11:42:34 | Wrapper (Version 3.2.3)
> http://wrapper.tanukisoftware.org
> INFO   | jvm 1    | 2015/02/19 11:42:34 |   Copyright 1999-2006 Tanuki
> Software, Inc.  All Rights Reserved.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |
> INFO   | jvm 1    | 2015/02/19 11:42:34 |
> INFO   | jvm 1    | 2015/02/19 11:42:34 | WARNING - Unable to load the
> Wrapper's native library 'wrapper.dll'.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           The file is located on
> the path at the following location but
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           could not be loaded:
> INFO   | jvm 1    | 2015/02/19 11:42:34 |
> d:\ApacheDS\bin\..\lib\wrapper.dll
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           Please verify that the
> file is readable by the current user
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           and that the file has
> not been corrupted in any way.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           One common cause of
> this problem is running a 32-bit version
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           of the Wrapper with a
> 64-bit version of Java, or vica versa.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           This is a 64-bit JVM.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           Reported cause:
> INFO   | jvm 1    | 2015/02/19 11:42:34 |
> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> platform
> INFO   | jvm 1    | 2015/02/19 11:42:34 |           System signals will not
> be handled correctly.
> INFO   | jvm 1    | 2015/02/19 11:42:34 |
> INFO   | jvm 1    | 2015/02/19 11:42:39 |            _
> _          ____  ____
> INFO   | jvm 1    | 2015/02/19 11:42:39 |           / \   _ __    ___  ___|
> |__   ___|  _ \/ ___|
> INFO   | jvm 1    | 2015/02/19 11:42:39 |          / _ \ | '_ \ / _` |/ __|
> '_ \ / _ \ | | \___ \
> INFO   | jvm 1    | 2015/02/19 11:42:39 |         / ___ \| |_) | (_| | (__|
> | | |  __/ |_| |___) |
> INFO   | jvm 1    | 2015/02/19 11:42:39 |        /_/   \_\ .__/
> \__,_|\___|_| |_|\___|____/|____/
> INFO   | jvm 1    | 2015/02/19 11:42:39 |                |_|
>
> INFO   | jvm 1    | 2015/02/19 11:42:39 |
> STATUS | wrapper  | 2015/03/05 03:06:42 | <-- Wrapper Stopped
> STATUS | wrapper  | 2015/03/05 03:08:30 | --> Wrapper Started as Service
> STATUS | wrapper  | 2015/03/05 03:08:31 | Launching a JVM...
> INFO   | jvm 1    | 2015/03/05 03:08:33 | Wrapper (Version 3.2.3)
> http://wrapper.tanukisoftware.org
> INFO   | jvm 1    | 2015/03/05 03:08:33 |   Copyright 1999-2006 Tanuki
> Software, Inc.  All Rights Reserved.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> INFO   | jvm 1    | 2015/03/05 03:08:33 | WARNING - Unable to load the
> Wrapper's native library 'wrapper.dll'.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           The file is located on
> the path at the following location but
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           could not be loaded:
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> d:\ApacheDS\bin\..\lib\wrapper.dll
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Please verify that the
> file is readable by the current user
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           and that the file has
> not been corrupted in any way.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           One common cause of
> this problem is running a 32-bit version
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           of the Wrapper with a
> 64-bit version of Java, or vica versa.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           This is a 64-bit JVM.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           Reported cause:
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> platform
> INFO   | jvm 1    | 2015/03/05 03:08:33 |           System signals will not
> be handled correctly.
> INFO   | jvm 1    | 2015/03/05 03:08:33 |
> INFO   | jvm 1    | 2015/03/05 03:08:48 |            _
> _          ____  ____
> INFO   | jvm 1    | 2015/03/05 03:08:48 |           / \   _ __    ___  ___|
> |__   ___|  _ \/ ___|
> INFO   | jvm 1    | 2015/03/05 03:08:48 |          / _ \ | '_ \ / _` |/ __|
> '_ \ / _ \ | | \___ \
> INFO   | jvm 1    | 2015/03/05 03:08:48 |         / ___ \| |_) | (_| | (__|
> | | |  __/ |_| |___) |
> INFO   | jvm 1    | 2015/03/05 03:08:48 |        /_/   \_\ .__/
> \__,_|\___|_| |_|\___|____/|____/
> INFO   | jvm 1    | 2015/03/05 03:08:48 |                |_|
>
> INFO   | jvm 1    | 2015/03/05 03:08:48 |
> ERROR  | wrapper  | 2015/04/02 02:21:51 | Shutdown failed: Timed out
> waiting for signal from JVM.
> ERROR  | wrapper  | 2015/04/02 02:21:51 | JVM did not exit on request,
> terminated
> STATUS | wrapper  | 2015/04/02 02:21:52 | <-- Wrapper Stopped
> STATUS | wrapper  | 2015/04/02 02:23:19 | --> Wrapper Started as Service
> STATUS | wrapper  | 2015/04/02 02:23:19 | Launching a JVM...
> INFO   | jvm 1    | 2015/04/02 02:23:21 | Wrapper (Version 3.2.3)
> http://wrapper.tanukisoftware.org
> INFO   | jvm 1    | 2015/04/02 02:23:21 |   Copyright 1999-2006 Tanuki
> Software, Inc.  All Rights Reserved.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |
> INFO   | jvm 1    | 2015/04/02 02:23:21 |
> INFO   | jvm 1    | 2015/04/02 02:23:21 | WARNING - Unable to load the
> Wrapper's native library 'wrapper.dll'.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           The file is located on
> the path at the following location but
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           could not be loaded:
> INFO   | jvm 1    | 2015/04/02 02:23:21 |
> d:\ApacheDS\bin\..\lib\wrapper.dll
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           Please verify that the
> file is readable by the current user
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           and that the file has
> not been corrupted in any way.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           One common cause of
> this problem is running a 32-bit version
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           of the Wrapper with a
> 64-bit version of Java, or vica versa.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           This is a 64-bit JVM.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           Reported cause:
> INFO   | jvm 1    | 2015/04/02 02:23:21 |
> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> platform
> INFO   | jvm 1    | 2015/04/02 02:23:21 |           System signals will not
> be handled correctly.
> INFO   | jvm 1    | 2015/04/02 02:23:21 |
> INFO   | jvm 1    | 2015/04/02 02:23:56 |            _
> _          ____  ____
> INFO   | jvm 1    | 2015/04/02 02:23:56 |           / \   _ __    ___  ___|
> |__   ___|  _ \/ ___|
> INFO   | jvm 1    | 2015/04/02 02:23:56 |          / _ \ | '_ \ / _` |/ __|
> '_ \ / _ \ | | \___ \
> INFO   | jvm 1    | 2015/04/02 02:23:56 |         / ___ \| |_) | (_| | (__|
> | | |  __/ |_| |___) |
> INFO   | jvm 1    | 2015/04/02 02:23:56 |        /_/   \_\ .__/
> \__,_|\___|_| |_|\___|____/|____/
> INFO   | jvm 1    | 2015/04/02 02:23:56 |                |_|
>
> INFO   | jvm 1    | 2015/04/02 02:23:56 |
> INFO   | jvm 1    | 2015/04/02 03:00:41 |
> java.lang.ArrayIndexOutOfBoundsException: -11870
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.BlockIo.readInt(BlockIo.java:282)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.RecordHeader.getAvailableSize(RecordHeader.java:105)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:216)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.partition.impl.btree.AbstractBTreePartition.add(AbstractBTreePartition.java:861)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.add(DefaultPartitionNexus.java:352)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor$1.add(BaseInterceptor.java:165)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.journal.JournalInterceptor.add(JournalInterceptor.java:139)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.trigger.TriggerInterceptor.add(TriggerInterceptor.java:300)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.event.EventInterceptor.add(EventInterceptor.java:226)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.subtree.SubentryInterceptor.add(SubentryInterceptor.java:1014)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.collective.CollectiveAttributeInterceptor.add(CollectiveAttributeInterceptor.java:134)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.operational.OperationalAttributeInterceptor.add(OperationalAttributeInterceptor.java:232)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.schema.SchemaInterceptor.add(SchemaInterceptor.java:1101)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.hash.PasswordHashingInterceptor.add(PasswordHashingInterceptor.java:93)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.exception.ExceptionInterceptor.add(ExceptionInterceptor.java:189)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.admin.AdministrativePointInterceptor.add(AdministrativePointInterceptor.java:1201)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.authz.AciAuthorizationInterceptor.add(AciAuthorizationInterceptor.java:515)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.referral.ReferralInterceptor.add(ReferralInterceptor.java:249)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.authn.AuthenticationInterceptor.add(AuthenticationInterceptor.java:410)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.normalization.NormalizationInterceptor.add(NormalizationInterceptor.java:131)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.DefaultOperationManager.add(DefaultOperationManager.java:394)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:255)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:239)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:57)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:39)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
> org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at
>
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
> INFO   | jvm 1    | 2015/04/02 03:00:41 | at java.lang.Thread.run(Unknown
> Source)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | Exception in thread
> "pool-6-thread-3" java.lang.Error: ERR_554 double get for block 41 630
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.RecordFile.get(RecordFile.java:185)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:202)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.partition.impl.btree.AbstractBTreePartition.add(AbstractBTreePartition.java:861)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.add(DefaultPartitionNexus.java:352)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor$1.add(BaseInterceptor.java:165)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.journal.JournalInterceptor.add(JournalInterceptor.java:139)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.trigger.TriggerInterceptor.add(TriggerInterceptor.java:300)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.event.EventInterceptor.add(EventInterceptor.java:226)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.subtree.SubentryInterceptor.add(SubentryInterceptor.java:1014)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.collective.CollectiveAttributeInterceptor.add(CollectiveAttributeInterceptor.java:134)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.operational.OperationalAttributeInterceptor.add(OperationalAttributeInterceptor.java:232)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.schema.SchemaInterceptor.add(SchemaInterceptor.java:1101)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.hash.PasswordHashingInterceptor.add(PasswordHashingInterceptor.java:93)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.exception.ExceptionInterceptor.add(ExceptionInterceptor.java:189)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.admin.AdministrativePointInterceptor.add(AdministrativePointInterceptor.java:1201)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.authz.AciAuthorizationInterceptor.add(AciAuthorizationInterceptor.java:515)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.referral.ReferralInterceptor.add(ReferralInterceptor.java:249)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.authn.AuthenticationInterceptor.add(AuthenticationInterceptor.java:410)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.api.interceptor.BaseInterceptor.next(BaseInterceptor.java:422)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.normalization.NormalizationInterceptor.add(NormalizationInterceptor.java:131)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.DefaultOperationManager.add(DefaultOperationManager.java:394)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:255)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.core.shared.DefaultCoreSession.add(DefaultCoreSession.java:239)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:57)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.ldap.handlers.request.AddRequestHandler.handle(AddRequestHandler.java:39)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
> org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at
>
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
> INFO   | jvm 1    | 2015/04/02 03:00:42 | at java.lang.Thread.run(Unknown
> Source)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | Error in WrapperListener.stop
> callback.  java.lang.Error: ERR_554 double get for block 41 630
> INFO   | jvm 1    | 2015/04/02 09:25:56 | java.lang.Error: ERR_554 double
> get for block 41 630
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.RecordFile.get(RecordFile.java:185)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.PhysicalRowIdManager.allocNew(PhysicalRowIdManager.java:202)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.PhysicalRowIdManager.alloc(PhysicalRowIdManager.java:177)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.PhysicalRowIdManager.update(PhysicalRowIdManager.java:101)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.BaseRecordManager.update(BaseRecordManager.java:281)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> jdbm.recman.CacheRecordManager.updateCacheEntries(CacheRecordManager.java:417)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> jdbm.recman.CacheRecordManager.commit(CacheRecordManager.java:349)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmTable.sync(JdbmTable.java:977)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> org.apache.directory.server.core.partition.impl.btree.jdbm.JdbmPartition.sync(JdbmPartition.java:332)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> org.apache.directory.server.core.shared.partition.DefaultPartitionNexus.sync(DefaultPartitionNexus.java:320)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> org.apache.directory.server.core.DefaultDirectoryService.shutdown(DefaultDirectoryService.java:1283)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> org.apache.directory.server.ApacheDsService.stop(ApacheDsService.java:600)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
>
> org.apache.directory.server.wrapper.ApacheDsTanukiWrapper.stop(ApacheDsTanukiWrapper.java:97)
> INFO   | jvm 1    | 2015/04/02 09:25:56 | at
> org.tanukisoftware.wrapper.WrapperManager$13.run(WrapperManager.java:3134)
> ERROR  | wrapper  | 2015/04/02 09:27:00 | Shutdown failed: Timed out
> waiting for the JVM to terminate.
> ERROR  | wrapper  | 2015/04/02 09:27:00 | JVM did not exit on request,
> terminated
> STATUS | wrapper  | 2015/04/02 09:27:01 | <-- Wrapper Stopped
> STATUS | wrapper  | 2015/04/02 09:27:02 | --> Wrapper Started as Service
> STATUS | wrapper  | 2015/04/02 09:27:02 | Launching a JVM...
> INFO   | jvm 1    | 2015/04/02 09:27:06 | Wrapper (Version 3.2.3)
> http://wrapper.tanukisoftware.org
> INFO   | jvm 1    | 2015/04/02 09:27:06 |   Copyright 1999-2006 Tanuki
> Software, Inc.  All Rights Reserved.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |
> INFO   | jvm 1    | 2015/04/02 09:27:06 |
> INFO   | jvm 1    | 2015/04/02 09:27:06 | WARNING - Unable to load the
> Wrapper's native library 'wrapper.dll'.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           The file is located on
> the path at the following location but
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           could not be loaded:
> INFO   | jvm 1    | 2015/04/02 09:27:06 |
> d:\ApacheDS\bin\..\lib\wrapper.dll
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           Please verify that the
> file is readable by the current user
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           and that the file has
> not been corrupted in any way.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           One common cause of
> this problem is running a 32-bit version
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           of the Wrapper with a
> 64-bit version of Java, or vica versa.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           This is a 64-bit JVM.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           Reported cause:
> INFO   | jvm 1    | 2015/04/02 09:27:06 |
> D:\ApacheDS\lib\wrapper.dll: Can't load IA 32-bit .dll on a AMD 64-bit
> platform
> INFO   | jvm 1    | 2015/04/02 09:27:06 |           System signals will not
> be handled correctly.
> INFO   | jvm 1    | 2015/04/02 09:27:06 |
> INFO   | jvm 1    | 2015/04/02 09:27:29 |            _
> _          ____  ____
> INFO   | jvm 1    | 2015/04/02 09:27:29 |           / \   _ __    ___  ___|
> |__   ___|  _ \/ ___|
> INFO   | jvm 1    | 2015/04/02 09:27:29 |          / _ \ | '_ \ / _` |/ __|
> '_ \ / _ \ | | \___ \
> INFO   | jvm 1    | 2015/04/02 09:27:29 |         / ___ \| |_) | (_| | (__|
> | | |  __/ |_| |___) |
> INFO   | jvm 1    | 2015/04/02 09:27:29 |        /_/   \_\ .__/
> \__,_|\___|_| |_|\___|____/|____/
> INFO   | jvm 1    | 2015/04/02 09:27:29 |                |_|
>
> INFO   | jvm 1    | 2015/04/02 09:27:29 |
>
> Thanks for the help,
> John
>



-- 
Kiran Ayyagari
http://keydap.com