Hi Following these instructions <https://docs.gocd.org/current/advanced_usage/logging.html#example-logstash-setup>, I've downloaded the source code for logstash-logback-encoder, created jar files (described here <https://blog.jetbrains.com/idea/2010/08/quickly-create-jar-artifact/>) and copied them to the goserver\lib dir (on a Windows server). I've added a logback-include.xml file (Identical to the one on the instructions, just with a different IP in the destination) into the goserver\config dir. When I start the service, I get this error (log file attached):
ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender Does anyone know where I'm going wrong? Are there any downloadable versions of the jar files? Thanks -- ********************************************************************************************** Important Note This email (including any attachments) contains information which is confidential and may be subject to legal privilege. If you are not the intended recipient you must not use, distribute or copy this email. If you have received this email in error please notify the sender immediately and delete this email. Any views expressed in this email are not necessarily the views of IRESS Limited. It is the duty of the recipient to virus scan and otherwise test the information provided before loading onto any computer system. IRESS Limited does not warrant that the information is free of a virus or any other defect or error. ********************************************************************************************** -- You received this message because you are subscribed to the Google Groups "go-cd" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. For more options, visit https://groups.google.com/d/optout.
STATUS | wrapper | 2018/09/13 13:59:39 | --> Wrapper Started as Service STATUS | wrapper | 2018/09/13 13:59:39 | Java Service Wrapper Standard Edition 64-bit 3.5.30 STATUS | wrapper | 2018/09/13 13:59:39 | Copyright (C) 1999-2016 Tanuki Software, Ltd. All Rights Reserved. STATUS | wrapper | 2018/09/13 13:59:39 | http://wrapper.tanukisoftware.com STATUS | wrapper | 2018/09/13 13:59:39 | Licensed to ThoughtWorks for Go Server STATUS | wrapper | 2018/09/13 13:59:39 | STATUS | wrapper | 2018/09/13 13:59:39 | Launching a JVM... INFO | jvm 1 | 2018/09/13 13:59:39 | WrapperManager: Initializing... INFO | jvm 1 | 2018/09/13 13:59:40 | [Thu Sep 13 13:59:40 BST 2018] Starting process: INFO | jvm 1 | 2018/09/13 13:59:40 | [Thu Sep 13 13:59:40 BST 2018] Working directory : C:\Go\Server1 INFO | jvm 1 | 2018/09/13 13:59:40 | [Thu Sep 13 13:59:40 BST 2018] Application arguments: [] INFO | jvm 1 | 2018/09/13 13:59:40 | [Thu Sep 13 13:59:40 BST 2018] GoCD Version: 18.7.0-7121 INFO | jvm 1 | 2018/09/13 13:59:40 | Could not find file `c:\Go\Server1\config\logback.xml'. Attempting to load from classpath. INFO | jvm 1 | 2018/09/13 13:59:40 | Using classpath resource `jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml'. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,727 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3ef108a7 - URL [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] is not of type file INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,805 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,821 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,821 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 seconds INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,821 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,821 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,837 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,868 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,868 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,868 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Will use gz compression INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,884 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Will use the pattern logs/go-server.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,884 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,884 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,884 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - Setting initial period to Thu Sep 13 13:59:23 BST 2018 INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - Active log file name: logs/go-server.log INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - File property is set to [logs/go-server.log] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ShineFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Will use gz compression INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,899 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Will use the pattern logs/go-shine.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-shine.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - Active log file name: logs/go-shine.log INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - File property is set to [logs/go-shine.log] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [WebRequestsFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Will use gz compression INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Will use the pattern logs/web-requests.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/web-requests.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,915 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - Active log file name: logs/web-requests.log INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - File property is set to [logs/web-requests.log] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [PerformanceFileAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Will use gz compression INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,930 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Will use the pattern logs/go-server-perf.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server-perf.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - Active log file name: logs/go-server-perf.log INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - File property is set to [logs/go-server-perf.log] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FileAppender] to Logger[ROOT] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go] to INFO INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.studios.shine] to WARN INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ShineFileAppender] to Logger[com.thoughtworks.studios.shine] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go.server.Rails] to WARN INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@6ed56670 - Adding [file:/c:/Go/Server1/config/logback-include.xml] to configuration watch list. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender] INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 13:59:41 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 13:59:41 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 13:59:41 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@7:90 - ActionException in Action for tag [appender] ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:76) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 13:59:41 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 13:59:41 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 13:59:41 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 13:59:41 | Caused by: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 13:59:41 | at ... 23 common frames omitted INFO | jvm 1 | 2018/09/13 13:59:41 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 13:59:41 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 13:59:41 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 13:59:41 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - Could not find an appender named [stash]. Did you define it below instead of above in the configuration file? INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - See http://logback.qos.ch/codes.html#appender_order for more details. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. INFO | jvm 1 | 2018/09/13 13:59:41 | 13:59:40,946 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@18613aa9 - Registering current configuration as safe fallback point INFO | jvm 1 | 2018/09/13 13:59:41 | INFO | jvm 1 | 2018/09/13 14:00:28 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:00:28 | WARNING: Shutting down your server at this point will lead to a database corruption. Please wait until the database upgrade completes. INFO | jvm 1 | 2018/09/13 14:00:28 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:00:28 | Reading change scripts from directory C:\Go\Server1\db\h2deltas... INFO | jvm 1 | 2018/09/13 14:00:28 | dbdeploy v2.11 INFO | jvm 1 | 2018/09/13 14:00:29 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:00:29 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:00:29 | Changes currently applied to database: INFO | jvm 1 | 2018/09/13 14:00:29 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:00:29 | Scripts available: INFO | jvm 1 | 2018/09/13 14:00:29 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:00:29 | To be applied: INFO | jvm 1 | 2018/09/13 14:00:29 | (none) INFO | jvm 1 | 2018/09/13 14:00:29 | Database upgrade completed successfully. INFO | jvm 1 | 2018/09/13 14:00:32 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:00:32 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:01:22 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:01:22 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:01:23 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:01:23 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) STATUS | wrapper | 2018/09/13 14:05:09 | <-- Wrapper Stopped STATUS | wrapper | 2018/09/13 14:05:10 | --> Wrapper Started as Service STATUS | wrapper | 2018/09/13 14:05:10 | Java Service Wrapper Standard Edition 64-bit 3.5.30 STATUS | wrapper | 2018/09/13 14:05:10 | Copyright (C) 1999-2016 Tanuki Software, Ltd. All Rights Reserved. STATUS | wrapper | 2018/09/13 14:05:10 | http://wrapper.tanukisoftware.com STATUS | wrapper | 2018/09/13 14:05:10 | Licensed to ThoughtWorks for Go Server STATUS | wrapper | 2018/09/13 14:05:10 | STATUS | wrapper | 2018/09/13 14:05:10 | Launching a JVM... INFO | jvm 1 | 2018/09/13 14:05:10 | WrapperManager: Initializing... INFO | jvm 1 | 2018/09/13 14:05:11 | [Thu Sep 13 14:05:10 BST 2018] Starting process: INFO | jvm 1 | 2018/09/13 14:05:11 | [Thu Sep 13 14:05:10 BST 2018] Working directory : C:\Go\Server1 INFO | jvm 1 | 2018/09/13 14:05:11 | [Thu Sep 13 14:05:10 BST 2018] Application arguments: [] INFO | jvm 1 | 2018/09/13 14:05:11 | [Thu Sep 13 14:05:10 BST 2018] GoCD Version: 18.7.0-7121 INFO | jvm 1 | 2018/09/13 14:05:11 | Could not find file `c:\Go\Server1\config\logback.xml'. Attempting to load from classpath. INFO | jvm 1 | 2018/09/13 14:05:11 | Using classpath resource `jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml'. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,349 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@23837d27 - URL [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] is not of type file INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,412 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,412 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,412 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 seconds INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,412 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,427 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,427 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,474 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1661709252 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,474 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1661709252 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,474 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1661709252 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,474 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1661709252 - Will use the pattern logs/go-server.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@70070888 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@70070888 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@70070888 - Setting initial period to Thu Sep 13 14:05:08 BST 2018 INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - Active log file name: logs/go-server.log INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - File property is set to [logs/go-server.log] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ShineFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1821493903 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1821493903 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1821493903 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1821493903 - Will use the pattern logs/go-shine.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@54c3f87f - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-shine.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@54c3f87f - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,490 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@54c3f87f - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - Active log file name: logs/go-shine.log INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - File property is set to [logs/go-shine.log] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [WebRequestsFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1789410472 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1789410472 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1789410472 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1789410472 - Will use the pattern logs/web-requests.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@22232a3d - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/web-requests.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@22232a3d - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@22232a3d - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - Active log file name: logs/web-requests.log INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - File property is set to [logs/web-requests.log] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [PerformanceFileAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1082415428 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1082415428 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1082415428 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,505 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1082415428 - Will use the pattern logs/go-server-perf.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@b4f512b - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server-perf.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@b4f512b - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@b4f512b - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - Active log file name: logs/go-server-perf.log INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - File property is set to [logs/go-server-perf.log] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FileAppender] to Logger[ROOT] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go] to INFO INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.studios.shine] to WARN INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ShineFileAppender] to Logger[com.thoughtworks.studios.shine] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go.server.Rails] to WARN INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@20a97196 - Adding [file:/c:/Go/Server1/config/logback-include.xml] to configuration watch list. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender] INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:05:11 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:05:11 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 14:05:11 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@7:90 - ActionException in Action for tag [appender] ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:76) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:05:11 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:05:11 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:05:11 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:05:11 | Caused by: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:05:11 | at ... 23 common frames omitted INFO | jvm 1 | 2018/09/13 14:05:11 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:05:11 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:05:11 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 14:05:11 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - Could not find an appender named [stash]. Did you define it below instead of above in the configuration file? INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - See http://logback.qos.ch/codes.html#appender_order for more details. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. INFO | jvm 1 | 2018/09/13 14:05:11 | 14:05:11,521 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@8fb3126 - Registering current configuration as safe fallback point INFO | jvm 1 | 2018/09/13 14:05:11 | INFO | jvm 1 | 2018/09/13 14:05:57 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:05:57 | WARNING: Shutting down your server at this point will lead to a database corruption. Please wait until the database upgrade completes. INFO | jvm 1 | 2018/09/13 14:05:57 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:05:57 | Reading change scripts from directory C:\Go\Server1\db\h2deltas... INFO | jvm 1 | 2018/09/13 14:05:58 | dbdeploy v2.11 INFO | jvm 1 | 2018/09/13 14:05:58 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:05:58 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:05:58 | Changes currently applied to database: INFO | jvm 1 | 2018/09/13 14:05:58 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:05:58 | Scripts available: INFO | jvm 1 | 2018/09/13 14:05:58 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:05:58 | To be applied: INFO | jvm 1 | 2018/09/13 14:05:58 | (none) INFO | jvm 1 | 2018/09/13 14:05:58 | Database upgrade completed successfully. INFO | jvm 1 | 2018/09/13 14:06:01 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:06:01 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:06:42 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:06:43 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:06:44 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:06:44 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) STATUS | wrapper | 2018/09/13 14:11:09 | <-- Wrapper Stopped STATUS | wrapper | 2018/09/13 14:11:10 | --> Wrapper Started as Service STATUS | wrapper | 2018/09/13 14:11:10 | Java Service Wrapper Standard Edition 64-bit 3.5.30 STATUS | wrapper | 2018/09/13 14:11:10 | Copyright (C) 1999-2016 Tanuki Software, Ltd. All Rights Reserved. STATUS | wrapper | 2018/09/13 14:11:10 | http://wrapper.tanukisoftware.com STATUS | wrapper | 2018/09/13 14:11:10 | Licensed to ThoughtWorks for Go Server STATUS | wrapper | 2018/09/13 14:11:10 | STATUS | wrapper | 2018/09/13 14:11:11 | Launching a JVM... INFO | jvm 1 | 2018/09/13 14:11:11 | WrapperManager: Initializing... INFO | jvm 1 | 2018/09/13 14:11:11 | [Thu Sep 13 14:11:11 BST 2018] Starting process: INFO | jvm 1 | 2018/09/13 14:11:11 | [Thu Sep 13 14:11:11 BST 2018] Working directory : C:\Go\Server1 INFO | jvm 1 | 2018/09/13 14:11:11 | [Thu Sep 13 14:11:11 BST 2018] Application arguments: [] INFO | jvm 1 | 2018/09/13 14:11:11 | [Thu Sep 13 14:11:11 BST 2018] GoCD Version: 18.7.0-7121 INFO | jvm 1 | 2018/09/13 14:11:13 | Could not find file `c:\Go\Server1\config\logback.xml'. Attempting to load from classpath. INFO | jvm 1 | 2018/09/13 14:11:13 | Using classpath resource `jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml'. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,707 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3e58b759 - URL [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] is not of type file INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,754 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,770 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,770 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 seconds INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,770 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,770 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,785 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@77372871 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@77372871 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@77372871 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@77372871 - Will use the pattern logs/go-server.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@4f2e4863 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@4f2e4863 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,848 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@4f2e4863 - Setting initial period to Thu Sep 13 14:11:09 BST 2018 INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - Active log file name: logs/go-server.log INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - File property is set to [logs/go-server.log] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ShineFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1047880902 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1047880902 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1047880902 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1047880902 - Will use the pattern logs/go-shine.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@45ecfe2e - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-shine.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,864 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@45ecfe2e - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@45ecfe2e - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - Active log file name: logs/go-shine.log INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - File property is set to [logs/go-shine.log] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [WebRequestsFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@637411825 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@637411825 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@637411825 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@637411825 - Will use the pattern logs/web-requests.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@182e187d - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/web-requests.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@182e187d - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@182e187d - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - Active log file name: logs/web-requests.log INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - File property is set to [logs/web-requests.log] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [PerformanceFileAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,879 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@233311466 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@233311466 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@233311466 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@233311466 - Will use the pattern logs/go-server-perf.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@2fd79ef7 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server-perf.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@2fd79ef7 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@2fd79ef7 - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - Active log file name: logs/go-server-perf.log INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - File property is set to [logs/go-server-perf.log] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FileAppender] to Logger[ROOT] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go] to INFO INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.studios.shine] to WARN INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ShineFileAppender] to Logger[com.thoughtworks.studios.shine] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go.server.Rails] to WARN INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@7bf2c355 - Adding [file:/c:/Go/Server1/config/logback-include.xml] to configuration watch list. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender] INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:11:13 | at ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:11:13 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:11:13 | Caused by: java.lang.NoClassDefFoundError: com/lmax/disruptor/EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.getDeclaredConstructors0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.privateGetDeclaredConstructors(Class.java:2671) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.getConstructor0(Class.java:3075) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.newInstance(Class.java:412) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:61) INFO | jvm 1 | 2018/09/13 14:11:13 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:11:13 | Caused by: java.lang.ClassNotFoundException: com.lmax.disruptor.EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:11:13 | at ... 31 common frames omitted INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@7:90 - ActionException in Action for tag [appender] ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:11:13 | at ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:76) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:11:13 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:11:13 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:11:13 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:11:13 | Caused by: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:11:13 | at ... 23 common frames omitted INFO | jvm 1 | 2018/09/13 14:11:13 | Caused by: java.lang.NoClassDefFoundError: com/lmax/disruptor/EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.getDeclaredConstructors0(Native Method) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.privateGetDeclaredConstructors(Class.java:2671) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.getConstructor0(Class.java:3075) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.Class.newInstance(Class.java:412) INFO | jvm 1 | 2018/09/13 14:11:13 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:61) INFO | jvm 1 | 2018/09/13 14:11:13 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:11:13 | Caused by: java.lang.ClassNotFoundException: com.lmax.disruptor.EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:11:13 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:11:13 | at ... 31 common frames omitted INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - Could not find an appender named [stash]. Did you define it below instead of above in the configuration file? INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - See http://logback.qos.ch/codes.html#appender_order for more details. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. INFO | jvm 1 | 2018/09/13 14:11:13 | 14:11:13,895 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@4d861d79 - Registering current configuration as safe fallback point INFO | jvm 1 | 2018/09/13 14:11:13 | INFO | jvm 1 | 2018/09/13 14:12:01 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:12:01 | WARNING: Shutting down your server at this point will lead to a database corruption. Please wait until the database upgrade completes. INFO | jvm 1 | 2018/09/13 14:12:01 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:12:01 | Reading change scripts from directory C:\Go\Server1\db\h2deltas... INFO | jvm 1 | 2018/09/13 14:12:01 | dbdeploy v2.11 INFO | jvm 1 | 2018/09/13 14:12:02 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:12:02 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:12:02 | Changes currently applied to database: INFO | jvm 1 | 2018/09/13 14:12:02 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:12:02 | Scripts available: INFO | jvm 1 | 2018/09/13 14:12:02 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:12:02 | To be applied: INFO | jvm 1 | 2018/09/13 14:12:02 | (none) INFO | jvm 1 | 2018/09/13 14:12:02 | Database upgrade completed successfully. INFO | jvm 1 | 2018/09/13 14:12:05 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:12:05 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:12:48 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:12:48 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:12:49 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:12:49 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) STATUS | wrapper | 2018/09/13 14:29:42 | <-- Wrapper Stopped STATUS | wrapper | 2018/09/13 14:29:43 | --> Wrapper Started as Service STATUS | wrapper | 2018/09/13 14:29:43 | Java Service Wrapper Standard Edition 64-bit 3.5.30 STATUS | wrapper | 2018/09/13 14:29:43 | Copyright (C) 1999-2016 Tanuki Software, Ltd. All Rights Reserved. STATUS | wrapper | 2018/09/13 14:29:43 | http://wrapper.tanukisoftware.com STATUS | wrapper | 2018/09/13 14:29:43 | Licensed to ThoughtWorks for Go Server STATUS | wrapper | 2018/09/13 14:29:43 | STATUS | wrapper | 2018/09/13 14:29:43 | Launching a JVM... INFO | jvm 1 | 2018/09/13 14:29:44 | WrapperManager: Initializing... INFO | jvm 1 | 2018/09/13 14:29:45 | [Thu Sep 13 14:29:45 BST 2018] Starting process: INFO | jvm 1 | 2018/09/13 14:29:45 | [Thu Sep 13 14:29:45 BST 2018] Working directory : C:\Go\Server1 INFO | jvm 1 | 2018/09/13 14:29:45 | [Thu Sep 13 14:29:45 BST 2018] Application arguments: [] INFO | jvm 1 | 2018/09/13 14:29:45 | [Thu Sep 13 14:29:45 BST 2018] GoCD Version: 18.7.0-7121 INFO | jvm 1 | 2018/09/13 14:29:45 | Could not find file `c:\Go\Server1\config\logback.xml'. Attempting to load from classpath. INFO | jvm 1 | 2018/09/13 14:29:45 | Using classpath resource `jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml'. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,883 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3bfeb716 - URL [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] is not of type file INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,961 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,976 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,976 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 seconds INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,976 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,976 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:45,992 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,023 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1667076597 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,023 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1667076597 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1667076597 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1667076597 - Will use the pattern logs/go-server.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@ae8e6a6 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@ae8e6a6 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@ae8e6a6 - Setting initial period to Thu Sep 13 14:29:41 BST 2018 INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - Active log file name: logs/go-server.log INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - File property is set to [logs/go-server.log] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ShineFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,039 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1153901190 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1153901190 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1153901190 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1153901190 - Will use the pattern logs/go-shine.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@acf6b0f - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-shine.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@acf6b0f - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@acf6b0f - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - Active log file name: logs/go-shine.log INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - File property is set to [logs/go-shine.log] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [WebRequestsFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,054 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@93487514 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@93487514 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@93487514 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@93487514 - Will use the pattern logs/web-requests.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@48829a58 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/web-requests.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@48829a58 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,070 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@48829a58 - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - Active log file name: logs/web-requests.log INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - File property is set to [logs/web-requests.log] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [PerformanceFileAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@892097244 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@892097244 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@892097244 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@892097244 - Will use the pattern logs/go-server-perf.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@44cad065 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server-perf.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@44cad065 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@44cad065 - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - Active log file name: logs/go-server-perf.log INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - File property is set to [logs/go-server-perf.log] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,086 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FileAppender] to Logger[ROOT] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go] to INFO INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.studios.shine] to WARN INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ShineFileAppender] to Logger[com.thoughtworks.studios.shine] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go.server.Rails] to WARN INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@55451737 - Adding [file:/c:/Go/Server1/config/logback-include.xml] to configuration watch list. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender] INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:29:46 | at ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:29:46 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:29:46 | Caused by: java.lang.NoClassDefFoundError: com/lmax/disruptor/EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.getDeclaredConstructors0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.privateGetDeclaredConstructors(Class.java:2671) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.getConstructor0(Class.java:3075) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.newInstance(Class.java:412) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:61) INFO | jvm 1 | 2018/09/13 14:29:46 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:29:46 | Caused by: java.lang.ClassNotFoundException: com.lmax.disruptor.EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:29:46 | at ... 31 common frames omitted INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@7:90 - ActionException in Action for tag [appender] ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:29:46 | at ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:76) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:29:46 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:29:46 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:29:46 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:29:46 | Caused by: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:29:46 | at ... 23 common frames omitted INFO | jvm 1 | 2018/09/13 14:29:46 | Caused by: java.lang.NoClassDefFoundError: com/lmax/disruptor/EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.getDeclaredConstructors0(Native Method) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.privateGetDeclaredConstructors(Class.java:2671) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.getConstructor0(Class.java:3075) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.Class.newInstance(Class.java:412) INFO | jvm 1 | 2018/09/13 14:29:46 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:61) INFO | jvm 1 | 2018/09/13 14:29:46 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:29:46 | Caused by: java.lang.ClassNotFoundException: com.lmax.disruptor.EventTranslatorOneArg INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:29:46 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:29:46 | at ... 31 common frames omitted INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - Could not find an appender named [stash]. Did you define it below instead of above in the configuration file? INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - See http://logback.qos.ch/codes.html#appender_order for more details. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. INFO | jvm 1 | 2018/09/13 14:29:46 | 14:29:46,101 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@4cffa493 - Registering current configuration as safe fallback point INFO | jvm 1 | 2018/09/13 14:29:46 | INFO | jvm 1 | 2018/09/13 14:30:34 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:30:34 | WARNING: Shutting down your server at this point will lead to a database corruption. Please wait until the database upgrade completes. INFO | jvm 1 | 2018/09/13 14:30:34 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:30:34 | Reading change scripts from directory C:\Go\Server1\db\h2deltas... INFO | jvm 1 | 2018/09/13 14:30:34 | dbdeploy v2.11 INFO | jvm 1 | 2018/09/13 14:30:34 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:30:34 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:30:34 | Changes currently applied to database: INFO | jvm 1 | 2018/09/13 14:30:34 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:30:34 | Scripts available: INFO | jvm 1 | 2018/09/13 14:30:34 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:30:34 | To be applied: INFO | jvm 1 | 2018/09/13 14:30:34 | (none) INFO | jvm 1 | 2018/09/13 14:30:35 | Database upgrade completed successfully. INFO | jvm 1 | 2018/09/13 14:30:38 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:30:38 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:31:27 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:31:27 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:31:27 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:31:28 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) STATUS | wrapper | 2018/09/13 14:46:27 | <-- Wrapper Stopped STATUS | wrapper | 2018/09/13 14:52:02 | --> Wrapper Started as Service STATUS | wrapper | 2018/09/13 14:52:02 | Java Service Wrapper Standard Edition 64-bit 3.5.30 STATUS | wrapper | 2018/09/13 14:52:02 | Copyright (C) 1999-2016 Tanuki Software, Ltd. All Rights Reserved. STATUS | wrapper | 2018/09/13 14:52:02 | http://wrapper.tanukisoftware.com STATUS | wrapper | 2018/09/13 14:52:02 | Licensed to ThoughtWorks for Go Server STATUS | wrapper | 2018/09/13 14:52:02 | STATUS | wrapper | 2018/09/13 14:52:03 | Launching a JVM... INFO | jvm 1 | 2018/09/13 14:52:03 | WrapperManager: Initializing... INFO | jvm 1 | 2018/09/13 14:52:03 | [Thu Sep 13 14:52:03 BST 2018] Starting process: INFO | jvm 1 | 2018/09/13 14:52:03 | [Thu Sep 13 14:52:03 BST 2018] Working directory : C:\Go\Server1 INFO | jvm 1 | 2018/09/13 14:52:03 | [Thu Sep 13 14:52:03 BST 2018] Application arguments: [] INFO | jvm 1 | 2018/09/13 14:52:03 | [Thu Sep 13 14:52:03 BST 2018] GoCD Version: 18.7.0-7121 INFO | jvm 1 | 2018/09/13 14:52:03 | Could not find file `c:\Go\Server1\config\logback.xml'. Attempting to load from classpath. INFO | jvm 1 | 2018/09/13 14:52:03 | Using classpath resource `jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml'. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:03,992 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3ef108a7 - URL [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] is not of type file INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,055 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,070 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:onejar:lib/server-launcher-18.7.0-7121-main.jar!/config/logback.xml] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,070 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 seconds INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,070 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,070 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,102 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,133 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,133 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1119674759 - Will use the pattern logs/go-server.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7ddff84 - Setting initial period to Thu Sep 13 14:46:27 BST 2018 INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - Active log file name: logs/go-server.log INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,149 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FileAppender] - File property is set to [logs/go-server.log] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ShineFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1263759078 - Will use the pattern logs/go-shine.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-shine.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@7d51f31b - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - Active log file name: logs/go-shine.log INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ShineFileAppender] - File property is set to [logs/go-shine.log] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [WebRequestsFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,164 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1489278447 - Will use the pattern logs/web-requests.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/web-requests.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@308d60ac - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - Active log file name: logs/web-requests.log INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[WebRequestsFileAppender] - File property is set to [logs/web-requests.log] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [PerformanceFileAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - setting totalSizeCap to 512 MB INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Archive files will be limited to [10 MB] each. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Will use gz compression INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,180 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1626938373 - Will use the pattern logs/go-server-perf.log.%d{yyyy-MM-dd}.%i for the active file INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - The date pattern is 'yyyy-MM-dd' from file name pattern 'logs/go-server-perf.log.%d{yyyy-MM-dd}.%i.gz'. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - Roll-over at midnight. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@12c2f22a - Setting initial period to Fri Aug 31 10:56:00 BST 2018 INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - Active log file name: logs/go-server-perf.log INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[PerformanceFileAppender] - File property is set to [logs/go-server-perf.log] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FileAppender] to Logger[ROOT] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go] to INFO INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.studios.shine] to WARN INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ShineFileAppender] to Logger[com.thoughtworks.studios.shine] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.thoughtworks.go.server.Rails] to WARN INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,195 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@6ed56670 - Adding [file:/c:/Go/Server1/config/logback-include.xml] to configuration watch list. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender] INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-ERROR in ch.qos.logback.core.joran.action.AppenderAction - Could not create an Appender of type [net.logstash.logback.appender.LogstashTcpSocketAppender]. ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:52:04 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:52:04 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 14:52:04 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@7:90 - ActionException in Action for tag [appender] ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at ch.qos.logback.core.joran.spi.ActionException: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:76) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.callBeginAction(Interpreter.java:269) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:145) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.Interpreter.startElement(Interpreter.java:128) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:50) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:165) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:152) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:110) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:53) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.logging.LogConfigurator.configureWith(LogConfigurator.java:109) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.logging.LogConfigurator.initialize(LogConfigurator.java:89) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.go.server.util.GoLauncher.main(GoLauncher.java:41) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.gocd.Boot.run(Boot.java:111) INFO | jvm 1 | 2018/09/13 14:52:04 | at at com.thoughtworks.gocd.Boot.main(Boot.java:57) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) INFO | jvm 1 | 2018/09/13 14:52:04 | at at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.reflect.Method.invoke(Method.java:498) INFO | jvm 1 | 2018/09/13 14:52:04 | at at org.tanukisoftware.wrapper.WrapperJarApp.run(WrapperJarApp.java:427) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.Thread.run(Thread.java:745) INFO | jvm 1 | 2018/09/13 14:52:04 | Caused by: ch.qos.logback.core.util.DynamicClassLoadingException: Failed to instantiate type net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:69) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:45) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassName(OptionHelper.java:34) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.joran.action.AppenderAction.begin(AppenderAction.java:52) INFO | jvm 1 | 2018/09/13 14:52:04 | at ... 23 common frames omitted INFO | jvm 1 | 2018/09/13 14:52:04 | Caused by: java.lang.ClassNotFoundException: net.logstash.logback.appender.LogstashTcpSocketAppender INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.net.URLClassLoader.findClass(URLClassLoader.java:381) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:424) INFO | jvm 1 | 2018/09/13 14:52:04 | at at java.lang.ClassLoader.loadClass(ClassLoader.java:357) INFO | jvm 1 | 2018/09/13 14:52:04 | at at ch.qos.logback.core.util.OptionHelper.instantiateByClassNameAndParameter(OptionHelper.java:56) INFO | jvm 1 | 2018/09/13 14:52:04 | at ... 26 common frames omitted INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - Could not find an appender named [stash]. Did you define it below instead of above in the configuration file? INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-ERROR in ch.qos.logback.core.joran.action.AppenderRefAction - See http://logback.qos.ch/codes.html#appender_order for more details. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. INFO | jvm 1 | 2018/09/13 14:52:04 | 14:52:04,211 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@18613aa9 - Registering current configuration as safe fallback point INFO | jvm 1 | 2018/09/13 14:52:04 | INFO | jvm 1 | 2018/09/13 14:52:51 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:52:51 | WARNING: Shutting down your server at this point will lead to a database corruption. Please wait until the database upgrade completes. INFO | jvm 1 | 2018/09/13 14:52:51 | ************************************************************************ INFO | jvm 1 | 2018/09/13 14:52:51 | Reading change scripts from directory C:\Go\Server1\db\h2deltas... INFO | jvm 1 | 2018/09/13 14:52:51 | dbdeploy v2.11 INFO | jvm 1 | 2018/09/13 14:52:52 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:52:52 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:52:52 | Changes currently applied to database: INFO | jvm 1 | 2018/09/13 14:52:52 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:52:52 | Scripts available: INFO | jvm 1 | 2018/09/13 14:52:52 | 1..90, 221001, 230001..230009, 240001, 240002, 300001..300011, 1202001..1202003, 1203002..1203005, 1301001, 1302001, 1303001..1303004, 1304001, 1401001, 1403001, 1403002, 1501001..1501003, 1502001, 1503001, 1503002, 1606001, 1606002, 1607001, 1610001, 1701001, 1702001, 1704001..1704003, 1708001, 1801001..1801007, 1802001, 1802002, 1804001, 1805001, 1807001, 1807002 INFO | jvm 1 | 2018/09/13 14:52:52 | To be applied: INFO | jvm 1 | 2018/09/13 14:52:52 | (none) INFO | jvm 1 | 2018/09/13 14:52:52 | Database upgrade completed successfully. INFO | jvm 1 | 2018/09/13 14:52:55 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:52:55 | Creating index SYS:SYS_ID 0% INFO | jvm 1 | 2018/09/13 14:53:44 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:53:44 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:53:45 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18) INFO | jvm 1 | 2018/09/13 14:53:45 | DEPRECATION WARNING: Filter object with #filter method is deprecated. Define method corresponding to filter type (#before, #after or #around). (called from transaction_actions at C:/Go/Server1/work/jetty-0.0.0.0-3101-cruise.war-_go-any-/webapp/WEB-INF/rails.new/vendor/engines/oauth2_provider/lib/oauth2_provider/transaction_helper.rb:18)
