It's not the same without you

Join the community to find out what other Atlassian users are discussing, debating and creating.

Atlassian Community Hero Image Collage

Service fails to start with BITBUCKET_HOME on network drive - SpringMVC could not be started

I recently migrated BBS to a new server and subsequently moved the repositories (BITBUCKET_HOME) to a network drive.

BBS works fine if I launch it as a normal Windows process using the start-bitbucket.bat batch file in the 'bin' directory.

When trying to run as a service, the startup sequence fails with the error message

SpringMVC dispatcher [springMvc] could not be started

The service is set to run as a local user and that user has full control of the BITBUCKET_HOME folder on the network.

Other points to note...

  • BitBucket Server v6.4.0 (note install directory is 6.4.1)
  • Accessing network share via symbolic link (mklink) rather than mapped drive or UNC path
  • Setting BITBUCKET_HOME to use a mapped drive stops the service from starting altogether
  • The log reports 'connection refused' but it's not clear what is refusing the connection or why

Any thoughts of suggestions on how to resolve this issue would be greatly appreciated :-)

 

. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v2.1.3.RELEASE)


2020-07-30 22:13:10,786 INFO [main] c.a.b.i.b.BitbucketServerApplication Starting BitbucketServerApplication on LEA-BITBUCKET-1 with PID 5932 (C:\Atlassian\Bitbucket\6.4.1\app\WEB-INF\classes started by batman in C:\Atlassian\Bitbucket\6.4.1\app)
2020-07-30 22:13:10,786 INFO [main] c.a.b.i.b.BitbucketServerApplication The following profiles are active: windows
2020-07-30 22:13:11,296 INFO [main] c.a.b.i.boot.log.BuildInfoLogger Starting Bitbucket 6.4.0 (31a17cd built on Mon Jun 17 06:06:41 BST 2019)
2020-07-30 22:13:11,296 INFO [main] c.a.b.i.boot.log.BuildInfoLogger JVM: Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 1.8.0_172-b11
2020-07-30 22:13:13,093 INFO [main] c.a.b.i.b.BitbucketServerApplication Started BitbucketServerApplication in 4.167 seconds (JVM running for 7.886)
2020-07-30 22:13:15,923 INFO [spring-startup] c.a.s.internal.home.HomeLockAcquirer Successfully acquired lock on home directory \\lea-nas-bit-1\Repos\BBSData
2020-07-30 22:13:20,140 INFO [spring-startup] c.a.s.internal.home.HomeLockAcquirer Successfully acquired lock on home directory \\lea-nas-bit-1\Repos\BBSData\shared
2020-07-30 22:13:21,736 WARN [spring-startup] com.hazelcast.instance.Node [192.168.113.217]:5701 [batman] [3.11.1] No join method is enabled! Starting standalone.
2020-07-30 22:13:32,427 INFO [hz.hazelcast.event-1] com.atlassian.bitbucket Switching to log level [DEBUG]
2020-07-30 22:13:32,427 WARN [hz.hazelcast.event-3] ROOT Switching to log level [INFO]
2020-07-30 22:13:32,427 WARN [hz.hazelcast.event-4] org.hibernate Switching to log level [INFO]
2020-07-30 22:13:32,427 INFO [hz.hazelcast.event-1] com.atlassian.stash Switching to log level [DEBUG]
2020-07-30 22:13:32,427 WARN [hz.hazelcast.event-4] org.springframework Switching to log level [INFO]
2020-07-30 22:13:32,427 ERROR [hz.hazelcast.event-3] com.atlassian.event.remote Switching to log level [DEBUG]
2020-07-30 22:13:32,427 INFO [hz.hazelcast.event-3] c.h.i.diagnostics.HealthMonitor Switching to log level [DEBUG]
2020-07-30 22:13:32,833 DEBUG [spring-startup] c.a.s.i.s.DefaultOperatingSystemService Pre-fetch of CPU load: 0.0
2020-07-30 22:13:32,865 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [git-lfs] Configuration-derived value for fixed ticket limit: 80
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [git-lfs] Configured fixed throttling: [tickets=80, queue-timeout=0s]
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Configuration-derived value for minimum ticket limit: 8
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Configuration-derived value for maximum ticket limit: 32
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] The total memory on this machine is 16158 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated typical memory per ticket: 256 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated application webapp requirement: 1024 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated application search requirement: 512 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated combined application webapp and search requirements: 1536 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated remaining memory available to ticketed operations: 14622 MB
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Estimated safe max tickets: 57
2020-07-30 22:13:32,880 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Choosing an adaptive ticket range of 8..32
2020-07-30 22:13:32,896 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Configuration-derived value for fixed ticket limit: 12
2020-07-30 22:13:32,896 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-hosting] Configured adaptive throttling: [range=8..32, no-cpu-tickets=12, cpu-target=0.75, cpu-per-typical-ticket=0.01, cpu-historical-weighting=0.8, interval=5s, queue-timeout=300s, no-cpu-threshold=20s]
2020-07-30 22:13:32,896 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-command] Configuration-derived value for fixed ticket limit: 25
2020-07-30 22:13:32,896 DEBUG [spring-startup] c.a.s.i.t.ResourceThrottleStrategyProvider [scm-command] Configured fixed throttling: [tickets=25, queue-timeout=2s]
2020-07-30 22:13:32,912 DEBUG [spring-startup] c.a.s.i.t.SemaphoreThrottleService Configured resource [scm-hosting]
2020-07-30 22:13:32,912 DEBUG [spring-startup] c.a.s.i.t.SemaphoreThrottleService Configured resource [git-lfs]
2020-07-30 22:13:32,912 DEBUG [spring-startup] c.a.s.i.t.SemaphoreThrottleService Configured resource [scm-command]
2020-07-30 22:13:34,208 INFO [spring-startup] c.a.s.i.h.s.WindowsHookScriptCommandLineFactory Found GNU bash at C:\Program Files\Git\bin\bash.exe
2020-07-30 22:13:34,396 DEBUG [spring-startup] c.a.s.i.i.u.MoveSnapshotDirUpgradeTask Skipping upgrade task to move the repository snapshots as this has already been completed
2020-07-30 22:13:36,708 WARN [spring-startup] o.s.w.c.s.XmlWebApplicationContext Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'mailSupportInfo' defined in URL [jar:file:/C:/Atlassian/Bitbucket/6.4.1/app/WEB-INF/lib/bitbucket-service-impl-6.4.0.jar!/com/atlassian/stash/internal/mail/MailSupportInfo.class]: Unsatisfied dependency expressed through constructor parameter 0; nested exception is org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dateFormatter' defined in URL [jar:file:/C:/Atlassian/Bitbucket/6.4.1/app/WEB-INF/lib/bitbucket-service-impl-6.4.0.jar!/com/atlassian/stash/internal/util/DefaultDateFormatter.class]: Unsatisfied dependency expressed through constructor parameter 2; nested exception is org.springframework.beans.factory.BeanExpressionException: Expression parsing failed; nested exception is org.springframework.expression.spel.SpelEvaluationException: EL1021E: A problem occurred whilst attempting to access the property 'dateFormatProperties': 'Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect'
2020-07-30 22:13:36,724 DEBUG [spring-startup] c.a.s.i.c.HazelcastBucketedExecutor Executor service has shutdown gracefully
2020-07-30 22:13:36,739 INFO [spring-startup] o.s.s.c.ThreadPoolExecutorFactoryBean Shutting down ExecutorService 'org.springframework.scheduling.concurrent.ThreadPoolExecutorFactoryBean#7ba81c63'
2020-07-30 22:13:36,755 DEBUG [spring-startup] c.a.s.i.topic.HazelcastTopicService Executor service has shutdown gracefully
2020-07-30 22:13:36,770 INFO [spring-startup] o.h.internal.SessionFactoryRegistry HHH000097: Unbound factory from JNDI name: bitbucket.core
2020-07-30 22:13:36,770 INFO [spring-startup] c.a.s.internal.home.HomeLockAcquirer Releasing lock on \\lea-nas-bit-1\Repos\BBSData\shared
2020-07-30 22:13:36,786 DEBUG [spring-startup] c.a.s.i.e.SingletonEventExecutorFactory Executor service has shutdown gracefully
2020-07-30 22:13:36,786 INFO [spring-startup] com.zaxxer.hikari.HikariDataSource bitbucket - Shutdown initiated...
2020-07-30 22:13:36,802 INFO [spring-startup] com.zaxxer.hikari.HikariDataSource bitbucket - Shutdown completed.
2020-07-30 22:13:36,802 INFO [spring-startup] c.a.s.internal.home.HomeLockAcquirer Releasing lock on \\lea-nas-bit-1\Repos\BBSData
2020-07-30 22:13:36,817 ERROR [spring-startup] c.a.j.s.w.s.JohnsonDispatcherServlet SpringMVC dispatcher [springMvc] could not be started
org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'mailSupportInfo' defined in URL [jar:file:/C:/Atlassian/Bitbucket/6.4.1/app/WEB-INF/lib/bitbucket-service-impl-6.4.0.jar!/com/atlassian/stash/internal/mail/MailSupportInfo.class]: Unsatisfied dependency expressed through constructor parameter 0; nested exception is org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dateFormatter' defined in URL [jar:file:/C:/Atlassian/Bitbucket/6.4.1/app/WEB-INF/lib/bitbucket-service-impl-6.4.0.jar!/com/atlassian/stash/internal/util/DefaultDateFormatter.class]: Unsatisfied dependency expressed through constructor parameter 2; nested exception is org.springframework.beans.factory.BeanExpressionException: Expression parsing failed; nested exception is org.springframework.expression.spel.SpelEvaluationException: EL1021E: A problem occurred whilst attempting to access the property 'dateFormatProperties': 'Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect'
at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:769)
at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:877)
at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:549)
at javax.servlet.GenericServlet.init(GenericServlet.java:158)
at java.lang.Thread.run(Thread.java:748)
... 18 frames trimmed
Caused by: org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dateFormatter' defined in URL [jar:file:/C:/Atlassian/Bitbucket/6.4.1/app/WEB-INF/lib/bitbucket-service-impl-6.4.0.jar!/com/atlassian/stash/internal/util/DefaultDateFormatter.class]: Unsatisfied dependency expressed through constructor parameter 2; nested exception is org.springframework.beans.factory.BeanExpressionException: Expression parsing failed; nested exception is org.springframework.expression.spel.SpelEvaluationException: EL1021E: A problem occurred whilst attempting to access the property 'dateFormatProperties': 'Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect'
... 6 common frames omitted
Caused by: org.springframework.beans.factory.BeanExpressionException: Expression parsing failed; nested exception is org.springframework.expression.spel.SpelEvaluationException: EL1021E: A problem occurred whilst attempting to access the property 'dateFormatProperties': 'Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect'
at org.springframework.context.expression.StandardBeanExpressionResolver.evaluate(StandardBeanExpressionResolver.java:164)
... 5 common frames omitted
Caused by: org.springframework.expression.spel.SpelEvaluationException: EL1021E: A problem occurred whilst attempting to access the property 'dateFormatProperties': 'Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect'
at org.springframework.expression.spel.ast.PropertyOrFieldReference.readProperty(PropertyOrFieldReference.java:209)
at org.springframework.expression.spel.ast.PropertyOrFieldReference.getValueInternal(PropertyOrFieldReference.java:104)
at org.springframework.expression.spel.ast.PropertyOrFieldReference.getValueInternal(PropertyOrFieldReference.java:91)
at org.springframework.expression.spel.ast.SpelNodeImpl.getValue(SpelNodeImpl.java:109)
at org.springframework.expression.spel.standard.SpelExpression.getValue(SpelExpression.java:265)
at org.springframework.context.expression.StandardBeanExpressionResolver.evaluate(StandardBeanExpressionResolver.java:161)
... 5 common frames omitted
Caused by: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'dateFormatProperties' defined in class path resource [stash-context.xml]: Invocation of init method failed; nested exception is java.net.ConnectException: Connection refused: connect
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1762)
at org.springframework.context.expression.BeanExpressionContextAccessor.read(BeanExpressionContextAccessor.java:45)
at org.springframework.expression.spel.ast.PropertyOrFieldReference.readProperty(PropertyOrFieldReference.java:204)
... 10 common frames omitted
Caused by: java.net.ConnectException: Connection refused: connect
at java.net.DualStackPlainSocketImpl.waitForConnect(Native Method)
at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:85)
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)
at java.net.Socket.connect(Socket.java:589)
at sun.net.ftp.impl.FtpClient.doConnect(FtpClient.java:962)
at sun.net.ftp.impl.FtpClient.tryConnect(FtpClient.java:924)
at sun.net.ftp.impl.FtpClient.connect(FtpClient.java:1019)
at sun.net.ftp.impl.FtpClient.connect(FtpClient.java:1005)
at sun.net.www.protocol.ftp.FtpURLConnection.connect(FtpURLConnection.java:294)
at sun.net.www.protocol.ftp.FtpURLConnection.getInputStream(FtpURLConnection.java:400)
at org.springframework.core.io.UrlResource.getInputStream(UrlResource.java:173)
at org.springframework.core.io.support.EncodedResource.getInputStream(EncodedResource.java:159)
at org.springframework.core.io.support.PropertiesLoaderUtils.fillProperties(PropertiesLoaderUtils.java:99)
at org.springframework.core.io.support.PropertiesLoaderSupport.loadProperties(PropertiesLoaderSupport.java:181)
at org.springframework.core.io.support.PropertiesLoaderSupport.mergeProperties(PropertiesLoaderSupport.java:162)
... 12 common frames omitted
2020-07-30 22:13:36,849 INFO [spring-startup] c.a.j.s.l.LifecycleDispatcherServlet$1 Completed initialization in 23703 ms
2020-07-30 22:14:23,042 WARN [http-nio-7990-exec-1] c.a.j.s.w.f.BypassableDelegatingFilterProxy Bypassing [hazelcastFilter]; no Spring WebApplicationContext is available

 

0 answers

Suggest an answer

Log in or Sign up to answer
DEPLOYMENT TYPE
SERVER
VERSION
6.4.0
TAGS
Community showcase
Published in Bitbucket

Powering DevOps with Bitbucket Server & Data Center

Hi everyone, The Cloud team recently announced 12 new DevOps features that help developers ship better code, faster   ! While we’re all excited about the new improvements to Bitbucket ...

996 views 0 5
Read article

Community Events

Connect with like-minded Atlassian users at free events near you!

Find an event

Connect with like-minded Atlassian users at free events near you!

Unfortunately there are no Community Events near you at the moment.

Host an event

You're one step closer to meeting fellow Atlassian users at your local event. Learn more about Community Events

Events near you