INFO [2018-05-16 01:06:46,228] org.eclipse.jetty.util.log: Logging initialized @3078ms INFO [2018-05-16 01:06:46,294] io.dropwizard.server.DefaultServerFactory: Registering jersey handler with root path prefix: / INFO [2018-05-16 01:06:46,294] io.dropwizard.server.DefaultServerFactory: Registering admin handler with root path prefix: / INFO [2018-05-16 01:06:46,294] io.dropwizard.assets.AssetsBundle: Registering AssetBundle with name: swagger for path /swagger/* INFO [2018-05-16 01:06:46,322] io.dropwizard.assets.AssetsBundle: Registering AssetBundle with name: swagger-assets for path /swagger-static/* INFO [2018-05-16 01:06:48,878] org.reflections.Reflections: Reflections took 2510 ms to scan 1 urls, producing 29299 keys and 54339 values INFO [2018-05-16 01:06:49,003] org.hibernate.Version: HHH000412: Hibernate Core {5.1.0.Final} INFO [2018-05-16 01:06:49,004] org.hibernate.cfg.Environment: HHH000206: hibernate.properties not found INFO [2018-05-16 01:06:49,006] org.hibernate.cfg.Environment: HHH000021: Bytecode provider name : javassist INFO [2018-05-16 01:06:49,013] io.dropwizard.hibernate.SessionFactoryFactory: Entity classes: [com.thingworx.analytics.results.db.ResultsModel, com.thingworx.analytics.results.db.TagsModel] INFO [2018-05-16 01:06:49,034] org.hibernate.annotations.common.Version: HCANN000001: Hibernate Commons Annotations {5.0.1.Final} INFO [2018-05-16 01:06:49,268] org.hibernate.dialect.Dialect: HHH000400: Using dialect: org.hibernate.dialect.H2Dialect INFO [2018-05-16 01:06:49,676] org.hibernate.type.BasicTypeRegistry: HHH000270: Type registration [java.util.Currency] overrides previous : org.hibernate.type.CurrencyType@11e75f7 INFO [2018-05-16 01:06:49,830] org.springframework.context.support.ClassPathXmlApplicationContext: Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@1377123: startup date [Wed May 16 10:36:49 IST 2018]; root of context hierarchy INFO [2018-05-16 01:06:49,831] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/properties-wiring.xml] INFO [2018-05-16 01:06:49,858] org.springframework.context.support.ClassPathXmlApplicationContext: Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@2ae89a: startup date [Wed May 16 10:36:49 IST 2018]; root of context hierarchy INFO [2018-05-16 01:06:49,859] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/aws-s3nfs.xml] INFO [2018-05-16 01:06:49,879] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/service.xml] INFO [2018-05-16 01:06:49,918] org.apache.commons.vfs2.impl.StandardFileSystemManager: Using "C:\Users\CLOUDT~1\AppData\Local\Temp\vfs_cache" as temporary files store. INFO [2018-05-16 01:06:49,949] org.springframework.context.support.ClassPathXmlApplicationContext: Closing org.springframework.context.support.ClassPathXmlApplicationContext@1377123: startup date [Wed May 16 10:36:49 IST 2018]; root of context hierarchy INFO [2018-05-16 01:06:49,954] com.thingworx.analytics.ccc.dropwizard.utils.DropwizardBaseApplication: BEGIN database flyway migrations INFO [2018-05-16 01:06:49,961] org.flywaydb.core.internal.util.VersionPrinter: Flyway 4.0.3 by Boxfuse INFO [2018-05-16 01:06:49,969] org.flywaydb.core.internal.dbsupport.DbSupportFactory: Database: jdbc:h2:file:D:\AnomalyMicroservices\db\model-db (H2 1.4) INFO [2018-05-16 01:06:50,028] org.flywaydb.core.internal.command.DbValidate: Successfully validated 4 migrations (execution time 00:00.006s) INFO [2018-05-16 01:06:50,036] org.flywaydb.core.internal.metadatatable.MetaDataTableImpl: Creating Metadata table: "PUBLIC"."schema_version" INFO [2018-05-16 01:06:50,051] org.flywaydb.core.internal.command.DbMigrate: Current version of schema "PUBLIC": << Empty Schema >> INFO [2018-05-16 01:06:50,051] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1 - Create Base Schema INFO [2018-05-16 01:06:50,066] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.1 - Model Name CheckConstraint INFO [2018-05-16 01:06:50,073] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2 - Create Model Tags INFO [2018-05-16 01:06:50,086] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.3 - Move To Results INFO [2018-05-16 01:06:50,114] org.flywaydb.core.internal.command.DbMigrate: Successfully applied 4 migrations to schema "PUBLIC" (execution time 00:00.078s). INFO [2018-05-16 01:06:50,115] com.thingworx.analytics.ccc.dropwizard.utils.DropwizardBaseApplication: END database flyway migrations INFO [2018-05-16 01:06:50,121] io.dropwizard.server.DefaultServerFactory: Registering jersey handler with root path prefix: / INFO [2018-05-16 01:06:50,121] io.dropwizard.server.DefaultServerFactory: Registering admin handler with root path prefix: / INFO [2018-05-16 01:06:50,129] io.dropwizard.server.ServerFactory: Starting ThingWorx Analytics Results Microservice ____ _ _ __ __ _ _ | _ \ ___ ___ _ _| | |_ ___ | \/ (_) ___ _ __ ___ ___ ___ _ ____ _(_) ___ ___ | |_) / _ \/ __| | | | | __/ __| | |\/| | |/ __| '__/ _ \/ __|/ _ \ '__\ \ / / |/ __/ _ \ | _ < __/\__ \ |_| | | |_\__ \ | | | | | (__| | | (_) \__ \ __/ | \ V /| | (_| __/ |_| \_\___||___/\__,_|_|\__|___/ |_| |_|_|\___|_| \___/|___/\___|_| \_/ |_|\___\___| INFO [2018-05-16 01:06:50,235] org.eclipse.jetty.setuid.SetUIDListener: Opened application@1ec35b0{HTTP/1.1,[http/1.1]}{0.0.0.0:8091} INFO [2018-05-16 01:06:50,236] org.eclipse.jetty.setuid.SetUIDListener: Opened admin@1f8f30f{HTTP/1.1,[http/1.1]}{0.0.0.0:8092} INFO [2018-05-16 01:06:50,238] org.eclipse.jetty.server.Server: jetty-9.3.z-SNAPSHOT INFO [2018-05-16 01:06:50,869] io.dropwizard.jersey.DropwizardResourceConfig: The following paths were found for the configured resources: GET /results/models (com.thingworx.analytics.results.resources.ModelResource) POST /results/models (com.thingworx.analytics.results.resources.ModelResource) DELETE /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) POST /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/inputfields (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/models.xml (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/outputfields (com.thingworx.analytics.results.resources.ModelResource) DELETE /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) GET /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) POST /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) PUT /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) GET /swagger (io.federecio.dropwizard.swagger.SwaggerResource) GET /swagger.{type:json|yaml} (io.swagger.jaxrs.listing.ApiListingResource) INFO [2018-05-16 01:06:50,875] org.eclipse.jetty.server.handler.ContextHandler: Started i.d.j.MutableServletContextHandler@78383c{/,null,AVAILABLE} INFO [2018-05-16 01:06:50,880] io.dropwizard.setup.AdminEnvironment: tasks = POST /tasks/log-level (io.dropwizard.servlets.tasks.LogConfigurationTask) POST /tasks/gc (io.dropwizard.servlets.tasks.GarbageCollectionTask) INFO [2018-05-16 01:06:50,884] org.eclipse.jetty.server.handler.ContextHandler: Started i.d.j.MutableServletContextHandler@1e22903{/,null,AVAILABLE} INFO [2018-05-16 01:06:50,897] org.eclipse.jetty.server.AbstractConnector: Started application@1ec35b0{HTTP/1.1,[http/1.1]}{0.0.0.0:8091} INFO [2018-05-16 01:06:50,900] org.eclipse.jetty.server.AbstractConnector: Started admin@1f8f30f{HTTP/1.1,[http/1.1]}{0.0.0.0:8092} INFO [2018-05-16 01:06:50,901] org.eclipse.jetty.server.Server: Started @7752ms INFO [2018-05-16 01:08:14,378] com.thingworx.analytics.results.resources.ModelResource: List of models with name [null], sortBy [], limit null ,tag [] INFO [2018-05-16 01:08:14,461] org.hibernate.engine.internal.StatisticalLoggingSessionEventListener: Session Metrics { 41534 nanoseconds spent acquiring 1 JDBC connections; 0 nanoseconds spent releasing 0 JDBC connections; 539941 nanoseconds spent preparing 2 JDBC statements; 290360 nanoseconds spent executing 2 JDBC statements; 0 nanoseconds spent executing 0 JDBC batches; 0 nanoseconds spent performing 0 L2C puts; 0 nanoseconds spent performing 0 L2C hits; 0 nanoseconds spent performing 0 L2C misses; 0 nanoseconds spent executing 0 flushes (flushing a total of 0 entities and 0 collections); 50219 nanoseconds spent executing 2 partial-flushes (flushing a total of 0 entities and 0 collections) } INFO [2018-05-16 01:08:43,210] com.thingworx.analytics.results.resources.ModelResource: List of models with name [null], sortBy [], limit null ,tag [] INFO [2018-05-16 01:08:43,213] org.hibernate.engine.internal.StatisticalLoggingSessionEventListener: Session Metrics { 50973 nanoseconds spent acquiring 1 JDBC connections; 0 nanoseconds spent releasing 0 JDBC connections; 74005 nanoseconds spent preparing 2 JDBC statements; 97038 nanoseconds spent executing 2 JDBC statements; 0 nanoseconds spent executing 0 JDBC batches; 0 nanoseconds spent performing 0 L2C puts; 0 nanoseconds spent performing 0 L2C hits; 0 nanoseconds spent performing 0 L2C misses; 0 nanoseconds spent executing 0 flushes (flushing a total of 0 entities and 0 collections); 14349 nanoseconds spent executing 2 partial-flushes (flushing a total of 0 entities and 0 collections) } INFO [2018-05-16 01:16:32,004] org.eclipse.jetty.server.AbstractConnector: Stopped application@1ec35b0{HTTP/1.1,[http/1.1]}{0.0.0.0:8091} INFO [2018-05-16 01:16:32,013] org.eclipse.jetty.server.AbstractConnector: Stopped admin@1f8f30f{HTTP/1.1,[http/1.1]}{0.0.0.0:8092} INFO [2018-05-16 01:16:32,017] org.eclipse.jetty.server.handler.ContextHandler: Stopped i.d.j.MutableServletContextHandler@1e22903{/,null,UNAVAILABLE} INFO [2018-05-16 01:16:32,055] org.eclipse.jetty.server.handler.ContextHandler: Stopped i.d.j.MutableServletContextHandler@78383c{/,null,UNAVAILABLE} INFO [2018-05-16 01:26:25,926] org.eclipse.jetty.util.log: Logging initialized @2546ms INFO [2018-05-16 01:26:25,983] io.dropwizard.server.DefaultServerFactory: Registering jersey handler with root path prefix: / INFO [2018-05-16 01:26:25,983] io.dropwizard.server.DefaultServerFactory: Registering admin handler with root path prefix: / INFO [2018-05-16 01:26:25,983] io.dropwizard.assets.AssetsBundle: Registering AssetBundle with name: swagger for path /swagger/* INFO [2018-05-16 01:26:26,009] io.dropwizard.assets.AssetsBundle: Registering AssetBundle with name: swagger-assets for path /swagger-static/* INFO [2018-05-16 01:26:28,352] org.reflections.Reflections: Reflections took 2301 ms to scan 1 urls, producing 29299 keys and 54339 values INFO [2018-05-16 01:26:28,457] org.hibernate.Version: HHH000412: Hibernate Core {5.1.0.Final} INFO [2018-05-16 01:26:28,458] org.hibernate.cfg.Environment: HHH000206: hibernate.properties not found INFO [2018-05-16 01:26:28,460] org.hibernate.cfg.Environment: HHH000021: Bytecode provider name : javassist INFO [2018-05-16 01:26:28,466] io.dropwizard.hibernate.SessionFactoryFactory: Entity classes: [com.thingworx.analytics.results.db.ResultsModel, com.thingworx.analytics.results.db.TagsModel] INFO [2018-05-16 01:26:28,486] org.hibernate.annotations.common.Version: HCANN000001: Hibernate Commons Annotations {5.0.1.Final} INFO [2018-05-16 01:26:28,692] org.hibernate.dialect.Dialect: HHH000400: Using dialect: org.hibernate.dialect.H2Dialect INFO [2018-05-16 01:26:29,029] org.hibernate.type.BasicTypeRegistry: HHH000270: Type registration [java.util.Currency] overrides previous : org.hibernate.type.CurrencyType@11e75f7 INFO [2018-05-16 01:26:29,160] org.springframework.context.support.ClassPathXmlApplicationContext: Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@1377123: startup date [Wed May 16 10:56:29 IST 2018]; root of context hierarchy INFO [2018-05-16 01:26:29,162] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/properties-wiring.xml] INFO [2018-05-16 01:26:29,190] org.springframework.context.support.ClassPathXmlApplicationContext: Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@2ae89a: startup date [Wed May 16 10:56:29 IST 2018]; root of context hierarchy INFO [2018-05-16 01:26:29,191] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/aws-s3nfs.xml] INFO [2018-05-16 01:26:29,207] org.springframework.beans.factory.xml.XmlBeanDefinitionReader: Loading XML bean definitions from class path resource [spring/service.xml] INFO [2018-05-16 01:26:29,240] org.apache.commons.vfs2.impl.StandardFileSystemManager: Using "C:\Users\CLOUDT~1\AppData\Local\Temp\vfs_cache" as temporary files store. INFO [2018-05-16 01:26:29,267] org.springframework.context.support.ClassPathXmlApplicationContext: Closing org.springframework.context.support.ClassPathXmlApplicationContext@1377123: startup date [Wed May 16 10:56:29 IST 2018]; root of context hierarchy INFO [2018-05-16 01:26:29,273] com.thingworx.analytics.ccc.dropwizard.utils.DropwizardBaseApplication: BEGIN database flyway migrations INFO [2018-05-16 01:26:29,279] org.flywaydb.core.internal.util.VersionPrinter: Flyway 4.0.3 by Boxfuse INFO [2018-05-16 01:26:29,288] org.flywaydb.core.internal.dbsupport.DbSupportFactory: Database: jdbc:h2:file:D:\AnomalyMicroservices\db\model-db (H2 1.4) INFO [2018-05-16 01:26:29,339] org.flywaydb.core.internal.command.DbValidate: Successfully validated 4 migrations (execution time 00:00.006s) INFO [2018-05-16 01:26:29,348] org.flywaydb.core.internal.metadatatable.MetaDataTableImpl: Creating Metadata table: "PUBLIC"."schema_version" INFO [2018-05-16 01:26:29,362] org.flywaydb.core.internal.command.DbMigrate: Current version of schema "PUBLIC": << Empty Schema >> INFO [2018-05-16 01:26:29,362] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1 - Create Base Schema INFO [2018-05-16 01:26:29,374] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.1 - Model Name CheckConstraint INFO [2018-05-16 01:26:29,378] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2 - Create Model Tags INFO [2018-05-16 01:26:29,389] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.3 - Move To Results INFO [2018-05-16 01:26:29,412] org.flywaydb.core.internal.command.DbMigrate: Successfully applied 4 migrations to schema "PUBLIC" (execution time 00:00.065s). INFO [2018-05-16 01:26:29,414] com.thingworx.analytics.ccc.dropwizard.utils.DropwizardBaseApplication: END database flyway migrations INFO [2018-05-16 01:26:29,417] io.dropwizard.server.DefaultServerFactory: Registering jersey handler with root path prefix: / INFO [2018-05-16 01:26:29,417] io.dropwizard.server.DefaultServerFactory: Registering admin handler with root path prefix: / INFO [2018-05-16 01:26:29,425] io.dropwizard.server.ServerFactory: Starting ThingWorx Analytics Results Microservice ____ _ _ __ __ _ _ | _ \ ___ ___ _ _| | |_ ___ | \/ (_) ___ _ __ ___ ___ ___ _ ____ _(_) ___ ___ | |_) / _ \/ __| | | | | __/ __| | |\/| | |/ __| '__/ _ \/ __|/ _ \ '__\ \ / / |/ __/ _ \ | _ < __/\__ \ |_| | | |_\__ \ | | | | | (__| | | (_) \__ \ __/ | \ V /| | (_| __/ |_| \_\___||___/\__,_|_|\__|___/ |_| |_|_|\___|_| \___/|___/\___|_| \_/ |_|\___\___| INFO [2018-05-16 01:26:29,494] org.eclipse.jetty.setuid.SetUIDListener: Opened application@1ec35b0{HTTP/1.1,[http/1.1]}{0.0.0.0:8091} INFO [2018-05-16 01:26:29,495] org.eclipse.jetty.setuid.SetUIDListener: Opened admin@1f8f30f{HTTP/1.1,[http/1.1]}{0.0.0.0:8092} INFO [2018-05-16 01:26:29,497] org.eclipse.jetty.server.Server: jetty-9.3.z-SNAPSHOT INFO [2018-05-16 01:26:30,035] io.dropwizard.jersey.DropwizardResourceConfig: The following paths were found for the configured resources: GET /results/models (com.thingworx.analytics.results.resources.ModelResource) POST /results/models (com.thingworx.analytics.results.resources.ModelResource) DELETE /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) POST /results/models/{id} (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/inputfields (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/models.xml (com.thingworx.analytics.results.resources.ModelResource) GET /results/models/{id}/outputfields (com.thingworx.analytics.results.resources.ModelResource) DELETE /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) GET /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) POST /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) PUT /results/models/{id}/tags (com.thingworx.analytics.results.resources.ModelTagsResource) GET /swagger (io.federecio.dropwizard.swagger.SwaggerResource) GET /swagger.{type:json|yaml} (io.swagger.jaxrs.listing.ApiListingResource) INFO [2018-05-16 01:26:30,039] org.eclipse.jetty.server.handler.ContextHandler: Started i.d.j.MutableServletContextHandler@78383c{/,null,AVAILABLE} INFO [2018-05-16 01:26:30,042] io.dropwizard.setup.AdminEnvironment: tasks = POST /tasks/log-level (io.dropwizard.servlets.tasks.LogConfigurationTask) POST /tasks/gc (io.dropwizard.servlets.tasks.GarbageCollectionTask) INFO [2018-05-16 01:26:30,046] org.eclipse.jetty.server.handler.ContextHandler: Started i.d.j.MutableServletContextHandler@1e22903{/,null,AVAILABLE} INFO [2018-05-16 01:26:30,057] org.eclipse.jetty.server.AbstractConnector: Started application@1ec35b0{HTTP/1.1,[http/1.1]}{0.0.0.0:8091} INFO [2018-05-16 01:26:30,060] org.eclipse.jetty.server.AbstractConnector: Started admin@1f8f30f{HTTP/1.1,[http/1.1]}{0.0.0.0:8092} INFO [2018-05-16 01:26:30,060] org.eclipse.jetty.server.Server: Started @6681ms INFO [2018-05-16 01:27:28,961] com.thingworx.analytics.results.resources.ModelResource: List of models with name [null], sortBy [], limit null ,tag [] INFO [2018-05-16 01:27:29,109] org.hibernate.engine.internal.StatisticalLoggingSessionEventListener: Session Metrics { 63434 nanoseconds spent acquiring 1 JDBC connections; 0 nanoseconds spent releasing 0 JDBC connections; 935269 nanoseconds spent preparing 2 JDBC statements; 454608 nanoseconds spent executing 2 JDBC statements; 0 nanoseconds spent executing 0 JDBC batches; 0 nanoseconds spent performing 0 L2C puts; 0 nanoseconds spent performing 0 L2C hits; 0 nanoseconds spent performing 0 L2C misses; 0 nanoseconds spent executing 0 flushes (flushing a total of 0 entities and 0 collections); 72874 nanoseconds spent executing 2 partial-flushes (flushing a total of 0 entities and 0 collections) } INFO [2018-05-16 01:28:07,245] com.thingworx.analytics.results.resources.ModelResource: List of models with name [null], sortBy [], limit null ,tag [] INFO [2018-05-16 01:28:07,248] org.hibernate.engine.internal.StatisticalLoggingSessionEventListener: Session Metrics { 44932 nanoseconds spent acquiring 1 JDBC connections; 0 nanoseconds spent releasing 0 JDBC connections; 61169 nanoseconds spent preparing 2 JDBC statements; 100814 nanoseconds spent executing 2 JDBC statements; 0 nanoseconds spent executing 0 JDBC batches; 0 nanoseconds spent performing 0 L2C puts; 0 nanoseconds spent performing 0 L2C hits; 0 nanoseconds spent performing 0 L2C misses; 0 nanoseconds spent executing 0 flushes (flushing a total of 0 entities and 0 collections); 12460 nanoseconds spent executing 2 partial-flushes (flushing a total of 0 entities and 0 collections) }