Bamboo Setup SqlServer Exception

Question

Hi, Bamboo external db exception. help me ? 2019-06-10 21:52:52 Commons Daemon procrun stdout initialized 2019-06-10 21:53:24,575 INFO [localhost-startStop-1] [BootstrapLoaderListener] Starting BootstrapLoaderListener 2019-06-10 21:53:24,575 INFO [localhost-startStop-1] [lifecycle] ******************************* 2019-06-10 21:53:24,575 INFO [localhost-startStop-1] [lifecycle] * Bamboo is starting up * 2019-06-10 21:53:24,575 INFO [localhost-startStop-1] [lifecycle] ******************************* 2019-06-10 21:53:24,575 INFO [localhost-startStop-1] [ServletContextHolder] Setting servlet context: Bamboo 2019-06-10 21:53:24,637 INFO [localhost-startStop-1] [lifecycle] atlassian.org.osgi.framework.bootdelegation set to javax.servlet,javax.servlet.*,sun.*,com.sun.*,org.w3c.dom.*,org.apache.xerces.*,org.jboss.byteman.*,jdk.internal.reflect 2019-06-10 21:53:24,778 INFO [localhost-startStop-1] [BootstrapLoaderListener] App classloader is the same as web app classloader 2019-06-10 21:53:25,981 INFO [localhost-startStop-1] [lifecycle] Starting Bamboo 6.9.1 (build #60910 Tue Jun 04 09:21:13 EEST 2019) using Java 1.8.0_211 from Oracle Corporation 2019-06-10 21:53:25,981 INFO [localhost-startStop-1] [lifecycle] Real path of servlet context: C:\Program Files\Bamboo\atlassian-bamboo\ 2019-06-10 21:53:26,122 INFO [localhost-startStop-1] [lifecycle] Bamboo home directory: D: \Atlassian\Bamboo 2019-06-10 21:53:26,122 INFO [localhost-startStop-1] [lifecycle] Default charset: windows-1252, file name ecoding: Cp1252 2019-06-10 21:53:26,137 INFO [localhost-startStop-1] [UpgradeLauncher] Upgrades not performed since the application has not been set up yet. 2019-06-10 21:53:26,153 INFO [localhost-startStop-1] [CompressingFilter] CompressingFilter has initialized 2019-06-10 21:53:26,809 INFO [localhost-startStop-1] [SpringObjectFactoryProxy] Deferring initialisation of com.atlassian.bamboo.plugin.xwork.SpringObjectFactoryProxy 2019-06-10 21:53:27,731 INFO [localhost-startStop-1] [Dispatchers] Dispatcher org.apache.struts2.dispatcher.Dispatcher initialised 2019-06-10 21:53:27,794 INFO [localhost-startStop-1] [SpringObjectFactoryProxy] Deferring initialisation of com.atlassian.bamboo.plugin.xwork.SpringObjectFactoryProxy 2019-06-10 21:53:28,465 INFO [localhost-startStop-1] [AccessLogFilter] AccessLogFilter initialized. Format is: +- 2019-06-10 21:53:28,544 INFO [localhost-startStop-1] [SpringObjectFactoryProxy] Deferring initialisation of com.atlassian.bamboo.plugin.xwork.SpringObjectFactoryProxy 2019-06-10 21:53:28,622 INFO [localhost-startStop-1] [Dispatchers] Dispatcher org.apache.struts2.dispatcher.Dispatcher initialised 2019-06-10 21:53:28,669 INFO [localhost-startStop-1] [SpringObjectFactoryProxy] Deferring initialisation of com.atlassian.bamboo.plugin.xwork.SpringObjectFactoryProxy 2019-06-10 21:53:56,414 INFO [http-nio-8085-exec-1] [JohnsonFilter] The application is not yet setup. Redirecting request from '/start.action' to '/bootstrap/selectSetupStep.action' 2019-06-10 21:53:56,428 INFO [http-nio-8085-exec-2] [AccessLogFilter] 127.0.0.1 GET http://127.0.0.1:8085/bootstrap/selectSetupStep.action 585694kb 2019-06-10 21:53:56,756 INFO [http-nio-8085-exec-2] [SelectSetupStepAction] Current setup step is /setup/setupDatabase.action 2019-06-10 21:53:56,788 INFO [http-nio-8085-exec-3] [AccessLogFilter] 127.0.0.1 GET http://127.0.0.1:8085/setup/setupDatabase.action 445080kb 2019-06-10 21:53:57,723 INFO [http-nio-8085-exec-4] [AccessLogFilter] 127.0.0.1 GET http://127.0.0.1:8085/bootstrap/selectSetupStep.action 454932kb 2019-06-10 21:53:57,733 INFO [http-nio-8085-exec-4] [SelectSetupStepAction] Current setup step is /setup/setupDatabase.action 2019-06-10 21:53:57,919 WARN [http-nio-8085-exec-3] [TextProviderHelper] The first TextProvider in the ValueStack (com.atlassian.bamboo.ww2.actions.setup.SetupDatabaseAction) could not locate the message resource with key 'help.prefix' 2019-06-10 21:53:57,920 WARN [http-nio-8085-exec-3] [TextProviderHelper] The default value expression 'help.prefix' was evaluated and did not match a property. The literal value 'help.prefix' will be used. 2019-06-10 21:53:57,922 WARN [http-nio-8085-exec-3] [TextProviderHelper] The first TextProvider in the ValueStack (com.atlassian.bamboo.ww2.actions.setup.SetupDatabaseAction) could not locate the message resource with key 'db.mysql' 2019-06-10 21:53:57,922 WARN [http-nio-8085-exec-3] [TextProviderHelper] The default value expression 'db.mysql' was evaluated and did not match a property. The literal value 'db.mysql' will be used. 2019-06-10 21:54:12,597 INFO [http-nio-8085-exec-5] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/chooseDatabaseType.action 568048kb 2019-06-10 21:54:12,706 INFO [http-nio-8085-exec-6] [AccessLogFilter] 127.0.0.1 GET http://127.0.0.1:8085/setup/setupDatabaseConnection.action?selectedDatabase=mssql 513189kb 2019-06-10 21:54:12,873 WARN [http-nio-8085-exec-6] [TextProviderHelper] The first TextProvider in the ValueStack (com.atlassian.bamboo.ww2.actions.setup.SetupDatabaseConnectionAction) could not locate the message resource with key 'help.prefix' 2019-06-10 21:54:12,874 WARN [http-nio-8085-exec-6] [TextProviderHelper] The default value expression 'help.prefix' was evaluated and did not match a property. The literal value 'help.prefix' will be used. 2019-06-10 21:54:12,875 WARN [http-nio-8085-exec-6] [TextProviderHelper] The first TextProvider in the ValueStack (com.atlassian.bamboo.ww2.actions.setup.SetupDatabaseConnectionAction) could not locate the message resource with key 'db.mysql' 2019-06-10 21:54:12,875 WARN [http-nio-8085-exec-6] [TextProviderHelper] The default value expression 'db.mysql' was evaluated and did not match a property. The literal value 'db.mysql' will be used. 2019-06-10 22:03:22,158 INFO [http-nio-8085-exec-9] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/performSetupDatabaseConnection.action 439256kb 2019-06-10 22:03:22,260 INFO [performSetupDatabaseConnectionBackgroundThread] [SetupDatabaseConnectionAction] Validating database configuration... 2019-06-10 22:03:22,330 INFO [performSetupDatabaseConnectionBackgroundThread] [SetupDatabaseConnectionAction] Validating connection to url: [jdbc:sqlserver://10.0.0.100:1433;databaseName=BambooDB] 2019-06-10 22:03:22,726 INFO [performSetupDatabaseConnectionBackgroundThread] [SetupDatabaseConnectionAction] Database configuration is valid. 2019-06-10 22:03:22,726 INFO [performSetupDatabaseConnectionBackgroundThread] [SetupUtilityBean] Setting up database: mssql 2019-06-10 22:03:22,726 INFO [performSetupDatabaseConnectionBackgroundThread] [SetupUtilityBean] Bootstrapping database: mssql 2019-06-10 22:03:22,726 INFO [performSetupDatabaseConnectionBackgroundThread] [DefaultHibernateConfigurator] Saving bootstrap configuration... 2019-06-10 22:03:22,754 INFO [performSetupDatabaseConnectionBackgroundThread] [DefaultHibernateConfigurator] Refreshing Spring context... 2019-06-10 22:03:24,305 WARN [http-nio-8085-exec-9] [TokenHelper] Could not find token mapped to token name: token 2019-06-10 22:03:25,503 WARN [performSetupDatabaseConnectionBackgroundThread] [GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'mappingResources' being accessed! Ambiguous write methods found next to actually used [public void bucket.core.persistence.hibernate.ConfigurableLocalSessionFactoryBean.setMappingResources(bucket.core.persistence.hibernate.MappingResources)]: [public void org.springframework.orm.hibernate5.LocalSessionFactoryBean.setMappingResources(java.lang.String[])] 2019-06-10 22:03:26,596 INFO [http-nio-8085-exec-10] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/performSetupDatabaseConnection.action 501373kb 2019-06-10 22:03:27,222 INFO [MLog-Init-Reporter] [MLog] MLog clients using slf4j logging. 2019-06-10 22:03:27,335 INFO [performSetupDatabaseConnectionBackgroundThread] [C3P0Registry] Initializing c3p0-0.9.5.3 [built 27-January-2019 00:11:37 -0800; debug? true; trace: 10] 2019-06-10 22:03:27,459 INFO [performSetupDatabaseConnectionBackgroundThread] [AbstractPoolBackedDataSource] Initializing c3p0 pool... com.mchange.v2.c3p0.PoolBackedDataSource@868677c6 [ connectionPoolDataSource -> com.mchange.v2.c3p0.WrapperConnectionPoolDataSource@de2a3b1d [ acquireIncrement -> 3, acquireRetryAttempts -> 30, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, contextClassLoaderSource -> caller, debugUnreturnedConnectionStackTraces -> false, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, forceSynchronousCheckins -> false, identityToken -> 2rvxxwa3iizgoo1dxdjmy|9923a18, idleConnectionTestPeriod -> 30, initialPoolSize -> 3, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 120, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 100, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 3, nestedDataSource -> com.mchange.v2.c3p0.DriverManagerDataSource@976c09f7 [ description -> null, driverClass -> null, factoryClassLocation -> null, forceUseNamedDriverClass -> false, identityToken -> 2rvxxwa3iizgoo1dxdjmy|121f4e51, jdbcUrl -> jdbc:sqlserver://10.0.0.100:1433;databaseName=BambooDB, properties -> {handling_mode=DELAYED_ACQUISITION_AND_HOLD, user=******, password=******} ], preferredTestQuery -> null, privilegeSpawnedThreads -> false, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> false, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, usesTraditionalReflectiveProxies -> false; userOverrides: {} ], dataSourceName -> null, extensions -> {}, factoryClassLocation -> null, identityToken -> 2rvxxwa3iizgoo1dxdjmy|257fc1c7, numHelperThreads -> 3 ] 2019-06-10 22:03:28,394 INFO [performSetupDatabaseConnectionBackgroundThread] [ResettableTableHiLoGenerator] Registering exportables... 2019-06-10 22:03:28,397 INFO [performSetupDatabaseConnectionBackgroundThread] [ResettableTableHiLoGenerator] Generator table: org.hibernate.mapping.Table(hibernate_unique_key) 2019-06-10 22:03:28,640 INFO [http-nio-8085-exec-11] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/performSetupDatabaseConnection.action 400167kb 2019-06-10 22:03:29,172 WARN [performSetupDatabaseConnectionBackgroundThread] [cache] HHH90001006: Missing cache[default-update-timestamps-region] was created on-the-fly. The created cache will use a provider-specific default configuration: make sure you defined one. You can disable this warning by setting 'hibernate.cache.ehcache.missing_cache_strategy' to 'create'. 2019-06-10 22:03:29,176 WARN [performSetupDatabaseConnectionBackgroundThread] [cache] HHH90001006: Missing cache[default-query-results-region] was created on-the-fly. The created cache will use a provider-specific default configuration: make sure you defined one. You can disable this warning by setting 'hibernate.cache.ehcache.missing_cache_strategy' to 'create'. 2019-06-10 22:03:29,257 WARN [performSetupDatabaseConnectionBackgroundThread] [cache] HHH90001006: Missing cache[bucket.user.propertyset.BucketPropertySetItem] was created on-the-fly. The created cache will use a provider-specific default configuration: make sure you defined one. You can disable this warning by setting 'hibernate.cache.ehcache.missing_cache_strategy' to 'create'. 2019-06-10 22:03:29,886 ERROR [performSetupDatabaseConnectionBackgroundThread] [PojoEntityTuplizer] HHH000243: Setters of lazy classes cannot be final: com.atlassian.bamboo.plan.AbstractChain.notificationSet 2019-06-10 22:03:30,648 INFO [http-nio-8085-exec-12] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/performSetupDatabaseConnection.action 515870kb 2019-06-10 22:03:30,971 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.resultsummary.AbstractResultsSummary_#testClassResults; expected type : org.hibernate.metamodel.internal.PluralAttributeImpl$SetAttributeImpl; encountered type : javax.persistence.metamodel.ListAttribute 2019-06-10 22:03:30,975 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.agent.elastic.server.ElasticImageConfigurationImpl_#subnetIds; expected type : org.hibernate.metamodel.internal.SingularAttributeImpl; encountered type : javax.persistence.metamodel.CollectionAttribute 2019-06-10 22:03:30,975 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.agent.elastic.server.ElasticImageConfigurationImpl_#availabilityZones; expected type : org.hibernate.metamodel.internal.SingularAttributeImpl; encountered type : javax.persistence.metamodel.CollectionAttribute 2019-06-10 22:03:30,988 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.project.DefaultProject_#allPlans; expected type : org.hibernate.metamodel.internal.PluralAttributeImpl$CollectionAttributeImpl; encountered type : javax.persistence.metamodel.ListAttribute 2019-06-10 22:03:31,032 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.commit.CommitImpl_#files; expected type : org.hibernate.metamodel.internal.PluralAttributeImpl$SetAttributeImpl; encountered type : javax.persistence.metamodel.ListAttribute 2019-06-10 22:03:31,054 ERROR [performSetupDatabaseConnectionBackgroundThread] [MetadataContext] HHH015007: Illegal argument on static metamodel field injection : com.atlassian.bamboo.resultsummary.tests.TestClassImpl_#testCases; expected type : org.hibernate.metamodel.internal.PluralAttributeImpl$SetAttributeImpl; encountered type : javax.persistence.metamodel.ListAttribute 2019-06-10 22:03:32,669 INFO [http-nio-8085-exec-14] [AccessLogFilter] 127.0.0.1 POST http://127.0.0.1:8085/setup/performSetupDatabaseConnection.action 425427kb 2019-06-10 22:03:32,859 INFO [performSetupDatabaseConnectionBackgroundThread] [BrokerService] Loaded the Bouncy Castle security provider. 2019-06-10 22:03:32,981 INFO [performSetupDatabaseConnectionBackgroundThread] [BrokerService] Using Persistence Adapter: KahaDBPersistenceAdapter[D:\Atlassian\Bamboo\jms-store\bamboo\KahaDB] 2019-06-10 22:03:33,085 INFO [performSetupDatabaseConnectionBackgroundThread] [MessageDatabase] Persistence store purged. 2019-06-10 22:03:33,904 INFO [performSetupDatabaseConnectionBackgroundThread] [PListStoreImpl] PListStore:[D:\Atlassian\Bamboo\jms-store\bamboo mp_storage] started 2019-06-10 22:03:34,038 INFO [performSetupDatabaseConnectionBackgroundThread] [BrokerService] Apache ActiveMQ 5.15.8 (bamboo, ID:SRV-CI-49273-1560193413911-0:1) is starting

Daniel Santos_157bm4 · Answer

Hi @YildizNet App

Thank you for raising this one to try clarifying this exception.

The exceptions you see are will cause no harm in your instance, they can be ignored. They happen due to an incorrect metamodel for some Bamboo autogenerated classes. You can see this in more details here:

* [BAM-18777] Hibernate generates incorrect metamodel which causes error level log messages on start-up

Please let me know if you see any other errors after the ones shared and if your instance is working as expected.