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,542]   INFO -    jetbrains.buildServer.AGENT - Recieved "stop force" command from launcher
[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).
4 comments
Comment actions Permalink

Any findings on this please ? We are getting the same error

0
Comment actions Permalink

Hello,

What TeamCity version do you use? Could you please attach zipped /log directory from TeamCity server?

0
Comment actions Permalink

We too having same issue. Any fix for this ?

0
Comment actions Permalink

Yes Satish. Can you share about which version TeamCity you are using currently and JDK Version?

0

Please sign in to leave a comment.