com.atlassian.jira.issue.index.IndexException: Wait attempt timed out - waited 30000 milliseconds

Atlassian JIRA | Mike Knight | 6 years ago
tip
Click on the to mark the solution that helps you, Samebug will learn from it.
As a community member, you’ll be rewarded for you help.
  1. 0

    It was reported that after the 2.4 upgrade lots of issues were missing. A re-index fixed the problem. It turns out the automatic indexing that JIRA performs as part of the upgrade process failed. Here are the relevant logs: {noformat} 2011-02-13 15:01:27,463 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Setting current build number on to 552 2011-02-13 15:01:27,466 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Performing Upgrade Task: Reindexing all data in JIRA. 2011-02-13 15:01:27,700 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex All starting... 2011-02-13 15:01:27,700 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 0% complete. Current index: Issue 2011-02-13 15:01:27,700 main INFO [jira.issue.index.DefaultIndexManager] Reindexing all issues 2011-02-13 15:01:58,073 main ERROR [jira.issue.index.DefaultIndexManager] Wait attempt timed out - waited 30000 milliseconds com.atlassian.jira.issue.index.IndexException: Wait attempt timed out - waited 30000 milliseconds at com.atlassian.jira.issue.index.DefaultIndexManager.obtain(DefaultIndexManager.java:494) at com.atlassian.jira.issue.index.DefaultIndexManager.reIndexAll(DefaultIndexManager.java:197) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.util.profiling.object.ObjectProfiler.profiledInvoke(ObjectProfiler.java:81) at com.atlassian.jira.config.component.SwitchingInvocationHandler.invoke(SwitchingInvocationHandler.java:28) at $Proxy89.reIndexAll(Unknown Source) at com.atlassian.jira.util.index.IndexLifecycleManager$Composite.reIndexAll(IndexLifecycleManager.java:113) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167) at $Proxy244.reIndexAll(Unknown Source) at com.atlassian.jira.upgrade.tasks.AbstractReindexUpgradeTask.doUpgrade(AbstractReindexUpgradeTask.java:44) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeTaskSucess(UpgradeManagerImpl.java:579) at com.atlassian.jira.upgrade.UpgradeManagerImpl.runUpgradeTasks(UpgradeManagerImpl.java:483) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgrade(UpgradeManagerImpl.java:418) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeeded(UpgradeManagerImpl.java:369) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeededAndAllowed(UpgradeManagerImpl.java:308) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167) at $Proxy263.doUpgradeIfNeededAndAllowed(Unknown Source) at com.atlassian.jira.upgrade.UpgradeLauncher.checkIfUpgradeNeeded(UpgradeLauncher.java:100) at com.atlassian.jira.upgrade.UpgradeLauncher.contextInitialized(UpgradeLauncher.java:49) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3764) at org.apache.catalina.core.StandardContext.start(StandardContext.java:4216) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:760) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:740) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:544) at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:626) at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553) at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488) at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1138) at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311) at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:120) at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1022) at org.apache.catalina.core.StandardHost.start(StandardHost.java:736) at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1014) at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:443) at org.apache.catalina.core.StandardService.start(StandardService.java:448) at org.apache.catalina.core.StandardServer.start(StandardServer.java:700) at org.apache.catalina.startup.Catalina.start(Catalina.java:552) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:295) at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:433) 2011-02-13 15:01:58,079 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex took: -1ms. Indexer: DefaultIndexManager: paths: [/data/jirastudio/jira/caches/indexes/comments, /data/jirastudio/jira/caches/indexes/issues] 2011-02-13 15:01:59,331 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 0% complete. Current index: SearchRequest 2011-02-13 15:02:00,368 SharedEntityIndexer:thread-20 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 1% complete. Current index: SearchRequest 2011-02-13 15:02:00,491 SharedEntityIndexer:thread-1 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 2% complete. Current index: SearchRequest 2011-02-13 15:02:00,564 SharedEntityIndexer:thread-18 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 3% complete. Current index: SearchRequest 2011-02-13 15:02:01,383 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 3% complete. Current index: PortalPage 2011-02-13 15:02:01,388 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 4% complete. Current index: PortalPage 2011-02-13 15:02:01,406 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex took: 1531ms. Indexer: SharedEntityIndexManager: paths: [] 2011-02-13 15:02:01,406 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 4% complete. Current index: 2011-02-13 15:02:01,406 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex All complete. Total time: 1530ms. 2011-02-13 15:02:01,407 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Upgrade Task: 'Reindexing all data in JIRA.' succeeded {noformat}

    Atlassian JIRA | 6 years ago | Mike Knight
    com.atlassian.jira.issue.index.IndexException: Wait attempt timed out - waited 30000 milliseconds
  2. 0

    It was reported that after the 2.4 upgrade lots of issues were missing. A re-index fixed the problem. It turns out the automatic indexing that JIRA performs as part of the upgrade process failed. Here are the relevant logs: {noformat} 2011-02-13 15:01:27,463 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Setting current build number on to 552 2011-02-13 15:01:27,466 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Performing Upgrade Task: Reindexing all data in JIRA. 2011-02-13 15:01:27,700 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex All starting... 2011-02-13 15:01:27,700 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 0% complete. Current index: Issue 2011-02-13 15:01:27,700 main INFO [jira.issue.index.DefaultIndexManager] Reindexing all issues 2011-02-13 15:01:58,073 main ERROR [jira.issue.index.DefaultIndexManager] Wait attempt timed out - waited 30000 milliseconds com.atlassian.jira.issue.index.IndexException: Wait attempt timed out - waited 30000 milliseconds at com.atlassian.jira.issue.index.DefaultIndexManager.obtain(DefaultIndexManager.java:494) at com.atlassian.jira.issue.index.DefaultIndexManager.reIndexAll(DefaultIndexManager.java:197) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.util.profiling.object.ObjectProfiler.profiledInvoke(ObjectProfiler.java:81) at com.atlassian.jira.config.component.SwitchingInvocationHandler.invoke(SwitchingInvocationHandler.java:28) at $Proxy89.reIndexAll(Unknown Source) at com.atlassian.jira.util.index.IndexLifecycleManager$Composite.reIndexAll(IndexLifecycleManager.java:113) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167) at $Proxy244.reIndexAll(Unknown Source) at com.atlassian.jira.upgrade.tasks.AbstractReindexUpgradeTask.doUpgrade(AbstractReindexUpgradeTask.java:44) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeTaskSucess(UpgradeManagerImpl.java:579) at com.atlassian.jira.upgrade.UpgradeManagerImpl.runUpgradeTasks(UpgradeManagerImpl.java:483) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgrade(UpgradeManagerImpl.java:418) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeeded(UpgradeManagerImpl.java:369) at com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeededAndAllowed(UpgradeManagerImpl.java:308) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167) at $Proxy263.doUpgradeIfNeededAndAllowed(Unknown Source) at com.atlassian.jira.upgrade.UpgradeLauncher.checkIfUpgradeNeeded(UpgradeLauncher.java:100) at com.atlassian.jira.upgrade.UpgradeLauncher.contextInitialized(UpgradeLauncher.java:49) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3764) at org.apache.catalina.core.StandardContext.start(StandardContext.java:4216) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:760) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:740) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:544) at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:626) at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553) at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488) at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1138) at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311) at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:120) at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1022) at org.apache.catalina.core.StandardHost.start(StandardHost.java:736) at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1014) at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:443) at org.apache.catalina.core.StandardService.start(StandardService.java:448) at org.apache.catalina.core.StandardServer.start(StandardServer.java:700) at org.apache.catalina.startup.Catalina.start(Catalina.java:552) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:295) at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:433) 2011-02-13 15:01:58,079 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex took: -1ms. Indexer: DefaultIndexManager: paths: [/data/jirastudio/jira/caches/indexes/comments, /data/jirastudio/jira/caches/indexes/issues] 2011-02-13 15:01:59,331 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 0% complete. Current index: SearchRequest 2011-02-13 15:02:00,368 SharedEntityIndexer:thread-20 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 1% complete. Current index: SearchRequest 2011-02-13 15:02:00,491 SharedEntityIndexer:thread-1 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 2% complete. Current index: SearchRequest 2011-02-13 15:02:00,564 SharedEntityIndexer:thread-18 INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 3% complete. Current index: SearchRequest 2011-02-13 15:02:01,383 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 3% complete. Current index: PortalPage 2011-02-13 15:02:01,388 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 4% complete. Current index: PortalPage 2011-02-13 15:02:01,406 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex took: 1531ms. Indexer: SharedEntityIndexManager: paths: [] 2011-02-13 15:02:01,406 main INFO [jira.upgrade.tasks.UpgradeTask_Build553] Re-indexing is 4% complete. Current index: 2011-02-13 15:02:01,406 main INFO [jira.util.index.IndexLifecycleManager$Composite] Reindex All complete. Total time: 1530ms. 2011-02-13 15:02:01,407 main INFO [atlassian.jira.upgrade.UpgradeManagerImpl] Upgrade Task: 'Reindexing all data in JIRA.' succeeded {noformat}

    Atlassian JIRA | 6 years ago | Mike Knight
    com.atlassian.jira.issue.index.IndexException: Wait attempt timed out - waited 30000 milliseconds

    Root Cause Analysis

    1. com.atlassian.jira.issue.index.IndexException

      Wait attempt timed out - waited 30000 milliseconds

      at com.atlassian.jira.issue.index.DefaultIndexManager.obtain()
    2. com.atlassian.jira
      DefaultIndexManager.reIndexAll
      1. com.atlassian.jira.issue.index.DefaultIndexManager.obtain(DefaultIndexManager.java:494)
      2. com.atlassian.jira.issue.index.DefaultIndexManager.reIndexAll(DefaultIndexManager.java:197)
      2 frames
    3. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:597)
      4 frames
    4. com.atlassian.util
      ObjectProfiler.profiledInvoke
      1. com.atlassian.util.profiling.object.ObjectProfiler.profiledInvoke(ObjectProfiler.java:81)
      1 frame
    5. com.atlassian.jira
      SwitchingInvocationHandler.invoke
      1. com.atlassian.jira.config.component.SwitchingInvocationHandler.invoke(SwitchingInvocationHandler.java:28)
      1 frame
    6. Unknown
      $Proxy89.reIndexAll
      1. $Proxy89.reIndexAll(Unknown Source)
      1 frame
    7. com.atlassian.jira
      IndexLifecycleManager$Composite.reIndexAll
      1. com.atlassian.jira.util.index.IndexLifecycleManager$Composite.reIndexAll(IndexLifecycleManager.java:113)
      1 frame
    8. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:597)
      4 frames
    9. com.atlassian.jira
      ProxyAdapter$ProxiedComponentInvocationHandler.invoke
      1. com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167)
      1 frame
    10. Unknown
      $Proxy244.reIndexAll
      1. $Proxy244.reIndexAll(Unknown Source)
      1 frame
    11. com.atlassian.jira
      UpgradeManagerImpl.doUpgradeIfNeededAndAllowed
      1. com.atlassian.jira.upgrade.tasks.AbstractReindexUpgradeTask.doUpgrade(AbstractReindexUpgradeTask.java:44)
      2. com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeTaskSucess(UpgradeManagerImpl.java:579)
      3. com.atlassian.jira.upgrade.UpgradeManagerImpl.runUpgradeTasks(UpgradeManagerImpl.java:483)
      4. com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgrade(UpgradeManagerImpl.java:418)
      5. com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeeded(UpgradeManagerImpl.java:369)
      6. com.atlassian.jira.upgrade.UpgradeManagerImpl.doUpgradeIfNeededAndAllowed(UpgradeManagerImpl.java:308)
      6 frames
    12. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:597)
      4 frames
    13. com.atlassian.jira
      ProxyAdapter$ProxiedComponentInvocationHandler.invoke
      1. com.atlassian.jira.ProxyAdapter$ProxiedComponentInvocationHandler.invoke(ProxyAdapter.java:167)
      1 frame
    14. Unknown
      $Proxy263.doUpgradeIfNeededAndAllowed
      1. $Proxy263.doUpgradeIfNeededAndAllowed(Unknown Source)
      1 frame
    15. com.atlassian.jira
      UpgradeLauncher.contextInitialized
      1. com.atlassian.jira.upgrade.UpgradeLauncher.checkIfUpgradeNeeded(UpgradeLauncher.java:100)
      2. com.atlassian.jira.upgrade.UpgradeLauncher.contextInitialized(UpgradeLauncher.java:49)
      2 frames
    16. Glassfish Core
      Catalina.start
      1. org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3764)
      2. org.apache.catalina.core.StandardContext.start(StandardContext.java:4216)
      3. org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:760)
      4. org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:740)
      5. org.apache.catalina.core.StandardHost.addChild(StandardHost.java:544)
      6. org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:626)
      7. org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553)
      8. org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488)
      9. org.apache.catalina.startup.HostConfig.start(HostConfig.java:1138)
      10. org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311)
      11. org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:120)
      12. org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1022)
      13. org.apache.catalina.core.StandardHost.start(StandardHost.java:736)
      14. org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1014)
      15. org.apache.catalina.core.StandardEngine.start(StandardEngine.java:443)
      16. org.apache.catalina.core.StandardService.start(StandardService.java:448)
      17. org.apache.catalina.core.StandardServer.start(StandardServer.java:700)
      18. org.apache.catalina.startup.Catalina.start(Catalina.java:552)
      18 frames
    17. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:597)
      4 frames
    18. Glassfish Core
      Bootstrap.main
      1. org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:295)
      2. org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:433)
      2 frames