TeamCity-server doesn't start
Hi all. I'am new about teamcity. Can someone help with problem?
I just install TeamCity 8.0.6 (build 27767) to my debian-7-amd64 server.
When I start configtest.sh from TeamCity/bin dir, in output I see
Using CATALINA_BASE: /usr/share/TeamCity
Using CATALINA_HOME: /usr/share/TeamCity
Using CATALINA_TMPDIR: /usr/share/TeamCity/temp
Using JRE_HOME: /usr/java/latest/jre1.7.0_45
Using CLASSPATH: /usr/share/TeamCity/bin/bootstrap.jar:/usr/share/TeamCity/bin/tomcat-juli.jar
Jan 23, 2014 10:44:50 AM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
Jan 23, 2014 10:44:50 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-nio-8111"]
Jan 23, 2014 10:44:50 AM org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
INFO: Using a shared selector for servlet write/read
Jan 23, 2014 10:44:50 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1294 ms
root@daigrdev:/usr/share/TeamCity/bin# Initializing TeamCity server components
-bash: Initializing: command not found
root@daigrdev:/usr/share/TeamCity/bin#
root@daigrdev:/usr/share/TeamCity/bin# This page will be reloaded automatically as soon as TeamCity is ready.
______________________________________________________________________________________________
Tomcat version is - Tomcat7. Then I start my runAll.sh script. It seems like everything is normal, but when I go to localhost:8111 I see:
Initializing TeamCity server components
This page will be reloaded automatically as soon as TeamCity is ready.
And this page just doesn't reloaded for hours. See buildAgent.log and teamcity-server.log below.
teamcity-server.log
[2014-01-23 10:53:17,265] INFO - jetbrains.buildServer.STARTUP -
[2014-01-23 10:53:17,265] INFO - jetbrains.buildServer.STARTUP - ===========================================================
[2014-01-23 10:53:17,265] INFO - jetbrains.buildServer.STARTUP - Starting TeamCity server
[2014-01-23 10:53:17,771] INFO - jetbrains.buildServer.STARTUP - TeamCity version: 8.0.6 (build 27767), data format version 628
[2014-01-23 10:53:17,786] INFO - jetbrains.buildServer.STARTUP - OS: Linux, JRE: 1.7.0_45-b18
[2014-01-23 10:53:17,786] INFO - jetbrains.buildServer.STARTUP - Servlet real path: /usr/share/TeamCity/webapps/ROOT/
[2014-01-23 10:53:17,787] INFO - jetbrains.buildServer.STARTUP - Current stage: Looking for the TeamCity Data Directory
[2014-01-23 10:53:17,787] INFO - jetbrains.buildServer.STARTUP - TeamCity Data Directory path is determined using the user home directory
[2014-01-23 10:53:17,787] INFO - jetbrains.buildServer.STARTUP - Data Directory "/root/.BuildServer" exists
[2014-01-23 10:53:17,983] INFO - jetbrains.buildServer.STARTUP - The main configuration file "/root/.BuildServer/config/main-config.xml" exists
[2014-01-23 10:53:17,983] INFO - jetbrains.buildServer.STARTUP - The database properties file "/root/.BuildServer/config/database.properties" doesn't exist
[2014-01-23 10:53:17,984] INFO - jetbrains.buildServer.STARTUP - The internal database data file "/root/.BuildServer/system/buildserver.data" exists
[2014-01-23 10:53:18,170] INFO - jetbrains.buildServer.STARTUP - Data Directory version: 628
[2014-01-23 10:53:18,170] INFO - jetbrains.buildServer.STARTUP - Current stage: Looking for the database configuration
[2014-01-23 10:53:18,170] INFO - jetbrains.buildServer.STARTUP - Database properties file "/root/.BuildServer/config/database.properties" doesn't exist
[2014-01-23 10:53:18,170] INFO - jetbrains.buildServer.STARTUP - Internal HSQL database file (/root/.BuildServer/system/buildserver.data) exists, version: 2.2.9
[2014-01-23 10:53:18,174] INFO - jetbrains.buildServer.STARTUP - Using internal (HSQL) database
[2014-01-23 10:53:18,174] INFO - jetbrains.buildServer.STARTUP - Current stage: Connecting to the database
[2014-01-23 10:53:21,921] INFO - jetbrains.buildServer.STARTUP - Connected to the database successfully
[2014-01-23 10:53:21,921] INFO - jetbrains.buildServer.STARTUP - Current stage: Checking the database
[2014-01-23 10:53:21,954] INFO - jetbrains.buildServer.STARTUP - Using schema: PUBLIC
[2014-01-23 10:53:22,059] INFO - jetbrains.buildServer.STARTUP - Schema contains 120 tables.
[2014-01-23 10:53:22,076] INFO - jetbrains.buildServer.STARTUP - Database version is 628
[2014-01-23 10:53:22,076] INFO - ide.db.TeamCityDatabaseManager - Attempt to capture TeamCity DB lock (java thread 16, starting code 1276008578, attempt 1)
[2014-01-23 10:53:22,077] INFO - ide.db.TeamCityDatabaseManager - The TeamCity DB lock has been captured successfully (java thread 16, starting code 1276008578, attempt 1)
[2014-01-23 10:53:22,131] INFO - jetbrains.buildServer.STARTUP - Current stage: Initializing TeamCity server components
[2014-01-23 10:53:22,230] INFO - jetbrains.buildServer.STARTUP - Starting the main application
[2014-01-23 10:53:22,576] INFO - ebDispatcherApplicationContext - Refreshing jetbrains.buildServer.maintenance.WebDispatcherApplicationContext@66bef646: startup date [Thu Jan 23 10:53:22 MSK 2014]; root of context hierarchy
[2014-01-23 10:53:22,670] INFO - MainTeamCityApplicationContext - Refreshing WebApplicationContext for namespace 'buildServer-servlet': startup date [Thu Jan 23 10:53:22 MSK 2014]; parent: jetbrains.buildServer.maintenance.WebDispatcherApplicationContext@66bef646
[2014-01-23 10:53:36,774] INFO - jetbrains.buildServer.SERVER - Loading test names index from database...
[2014-01-23 10:53:36,903] INFO - jetbrains.buildServer.SERVER - Finished loading test names index
[2014-01-23 10:53:37,515] INFO - jetbrains.buildServer.SERVER - Start initializing build durations cache...
[2014-01-23 10:53:37,532] INFO - jetbrains.buildServer.SERVER - Finished initializing build durations cache
[2014-01-23 10:53:45,893] INFO - jetbrains.buildServer.SERVER - Loading roles from the configuration file: /root/.BuildServer/config/roles-config.xml
[2014-01-23 10:54:04,343] INFO - jetbrains.buildServer.STARTUP - TeamCity Spring context contains 945 beans
[2014-01-23 10:54:04,647] INFO - jetbrains.buildServer.STARTUP - TeamCity Spring context created in: 41980 ms
teamcity-agent.log
[2014-01-23 10:53:07,543] INFO - jetbrains.buildServer.AGENT - Starting agent shutdown sequence, reason: Stop command called
[2014-01-23 10:53:07,557] INFO - agent.impl.AgentPortFileWriter - Delete agent runtime file from /usr/share/TeamCity/buildAgent/bin/../logs/buildAgent.port
[2014-01-23 10:53:07,567] INFO - jetbrains.buildServer.AGENT - Shutdown agent WebServer start
[2014-01-23 10:53:07,567] INFO - jetbrains.buildServer.AGENT - Shutdown agent WebServer finish
[2014-01-23 10:53:07,567] INFO - jetbrains.buildServer.AGENT - Shutdown agent finish
[2014-01-23 10:53:07,567] INFO - jetbrains.buildServer.AGENT - Shutdown agent agent and exit with code DIE_USER_COMMAND
[2014-01-23 10:53:07,568] INFO - buildServer.agent.AgentMain2$2 - Closing jetbrains.buildServer.agent.AgentMain2$2@62b9f149: startup date [Thu Jan 23 00:25:54 MSK 2014]; root of context hierarchy
[2014-01-23 10:53:17,517] INFO - jetbrains.buildServer.SERVER - Starting TeamCity agent
[2014-01-23 10:53:17,518] INFO - s.buildServer.agent.AgentMain2 -
[2014-01-23 10:53:17,518] INFO - s.buildServer.agent.AgentMain2 - ===========================================================
[2014-01-23 10:53:17,574] INFO - s.buildServer.agent.AgentMain2 - TeamCity Build Agent 8.0.6 (build 27767), OS: Linux, JRE: 1.7.0_45-b18
[2014-01-23 10:53:17,574] INFO - s.buildServer.agent.AgentMain2 - Starting...
[2014-01-23 10:53:17,582] INFO - s.buildServer.agent.AgentMain2 - Agent home is /usr/share/TeamCity/buildAgent
[2014-01-23 10:53:17,866] INFO - buildServer.agent.AgentMain2$2 - Refreshing jetbrains.buildServer.agent.AgentMain2$2@62b9f149: startup date [Thu Jan 23 10:53:17 MSK 2014]; root of context hierarchy
[2014-01-23 10:53:24,247] WARN - jetbrains.buildServer.AGENT - Calculating CPU benchmark index...
[2014-01-23 10:53:46,185] WARN - jetbrains.buildServer.AGENT - CPU benchmark index is set to 163
[2014-01-23 10:53:46,984] INFO - dAgentConfigurationInitializer - Loading build agent configuration from ../conf/buildAgent.properties
[2014-01-23 10:53:47,078] INFO - rver.plugins.PluginManagerImpl - ===========================================================
[2014-01-23 10:53:47,078] INFO - rver.plugins.PluginManagerImpl - Plugins initialization started...
[2014-01-23 10:53:47,079] INFO - rver.plugins.PluginManagerImpl - Scanning plugins folders
[2014-01-23 10:53:47,083] INFO - .plugins.files.JarSearcherBase - Scanning plugin folder: /usr/share/TeamCity/buildAgent/plugins
[2014-01-23 10:53:47,085] INFO - .plugins.files.JarSearcherBase - Scanning plugin folder: /usr/share/TeamCity/buildAgent/tools
[2014-01-23 10:53:47,085] INFO - rver.plugins.PluginManagerImpl - Found 1 plugins: [amazonEC2]
[2014-01-23 10:53:47,096] INFO - rver.plugins.PluginsCollection - No plugins were loaded with standalone classloaders
[2014-01-23 10:53:47,096] INFO - rver.plugins.PluginsCollection - Load shared classloader for 1 plugins [amazonEC2]
[2014-01-23 10:53:47,553] INFO - ctories.CleanupRegistryCleaner - Removing files from .old to meet free space requirements.
[2014-01-23 10:53:47,642] INFO - rver.plugins.PluginManagerImpl - Plugins initialization completed:
[2014-01-23 10:53:47,643] INFO - rver.plugins.PluginManagerImpl - Loaded 1 plugins: [amazonEC2]
[2014-01-23 10:53:47,643] INFO - rver.plugins.PluginManagerImpl - ===========================================================
[2014-01-23 10:53:47,666] INFO - jetbrains.buildServer.AGENT - Build Agent version: 27767, plugins signature: NA
[2014-01-23 10:53:47,666] INFO - dAgentConfigurationInitializer - Loading build agent configuration from ../conf/buildAgent.properties
[2014-01-23 10:53:50,816] INFO - t.AmazonInstanceMetadataReader - Amazon is not available. Amazon EC2 integration is not active: Failed to connect to http://169.254.169.254/2009-04-04. No route to host
[2014-01-23 10:53:50,817] INFO - .agent.AmazonPropertiesUpdater - Fetched AmazonEC2 instance metadata:
[2014-01-23 10:53:50,819] INFO - zon.agent.AmazonMetadataChecks - Amazon EC instance metadata contains no keys
[2014-01-23 10:53:50,819] WARN - .agent.AmazonPropertiesUpdater - Fetched Amazon EC2 instance metadata does not contain required values. Probably this agent was not started inside Amazon EC2. Is proxy server used?
[2014-01-23 10:53:50,847] INFO - jetbrains.buildServer.AGENT - Start build agent
[2014-01-23 10:53:50,886] INFO - jetbrains.buildServer.AGENT - Agent Web server started
[2014-01-23 10:53:50,924] INFO - ctories.CleanupRegistryCleaner - Removing files from .old to meet free space requirements.
[2014-01-23 10:53:50,946] INFO - agent.impl.AgentDetailsFactory - Build agent ownAddress will be defined by the server. Define 'ownAddress' property in the conf/buildAgent.properties file
[2014-01-23 10:53:51,090] INFO - buildServer.AGENT.registration - Registering on server http://localhost:8111, AgentDetails{Name='Default Agent', AgentId=null, BuildId=null, AgentOwnAddress='null', AlternativeAddresses=[188.120.255.35], Port=9090, Version='27767', PluginsVersion='NA', AvailableRunners=[], AvailableVcs=[], AuthorizationToken=''}
[2014-01-23 10:53:51,349] INFO - l.directories.DirectoryMapImpl - Cleaning up old checkout directories. Default lifetime = 192 hour(s)
[2014-01-23 10:53:51,399] INFO - agent.impl.AgentPortFileWriter - Writing agent runtime file to /usr/share/TeamCity/buildAgent/bin/../logs/buildAgent.port
[2014-01-23 10:53:51,406] INFO - agent.impl.AgentPortFileWriter - Launcher version is 27767
[2014-01-23 10:53:51,406] INFO - agent.impl.AgentPortFileWriter - Writing agent runtime file to /usr/share/TeamCity/buildAgent/bin/../logs/buildAgent.port :DONE!
[2014-01-23 10:53:51,408] INFO - jetbrains.buildServer.AGENT - Build agent started
[2014-01-23 10:53:53,464] WARN - buildServer.AGENT.registration - Call http://localhost:8111/RPC2 buildServer.registerAgent3: java.io.IOException: Server returned status 503 (service unavailable), try later
[2014-01-23 10:53:53,464] WARN - buildServer.AGENT.registration - Connection to TeamCity server is probably lost. Will be trying to restore it. Take a look at logs/teamcity-agent.log for details (unless you're using custom logging).
Please sign in to leave a comment.
Any findings on this please ? We are getting the same error
Hello,
What TeamCity version do you use? Could you please attach zipped /log directory from TeamCity server?
We too having same issue. Any fix for this ?
Yes Satish. Can you share about which version TeamCity you are using currently and JDK Version?