Aug 13, 2021 2:25:27 PM org.apache.karaf.main.Main$KarafLockCallback lockAcquired
INFO: Lock acquired. Setting startlevel to 100
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Examining bundle for SPI provider: org.eclipse.jetty.http
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://113.0:0/META-INF/services/org.eclipse.jetty.http.HttpFieldPreEncoder
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.http.Http1FieldPreEncoder
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@7a304d4c
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.http.HttpFieldPreEncoder in bundle org.eclipse.jetty.http
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Examining bundle for SPI provider: org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://130.0:0/META-INF/services/org.eclipse.jetty.websocket.api.extensions.Extension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.identity.IdentityExtension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@5dc957ae
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.fragment.FragmentExtension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@3a77185a
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@2ff66bd5
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.DeflateFrameExtension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@6d95ff67
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.common.extensions.compress.XWebkitDeflateFrameExtension
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@6f26fbd9
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: org.eclipse.jetty.websocket.api.extensions.Extension in bundle org.eclipse.jetty.websocket.common
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Examining bundle for SPI provider: org.eclipse.jetty.websocket.javax.websocket
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://131.0:0/META-INF/services/javax.websocket.ContainerProvider
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.JettyClientContainerProvider
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@5b0f6f44
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: javax.websocket.ContainerProvider in bundle org.eclipse.jetty.websocket.javax.websocket
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Examining bundle for SPI provider: org.eclipse.jetty.websocket.javax.websocket.server
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://132.0:0/META-INF/services/javax.servlet.ServletContainerInitializer
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.server.deploy.WebSocketServerContainerInitializer
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@7f37a1a7
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.javax.websocket.server
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://132.0:0/META-INF/services/javax.websocket.server.ServerEndpointConfig$Configurator
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.jsr356.server.ContainerDefaultConfigurator
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@16caf5f5
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: javax.websocket.server.ServerEndpointConfig$Configurator in bundle org.eclipse.jetty.websocket.javax.websocket.server
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Examining bundle for SPI provider: org.eclipse.jetty.websocket.server
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Found SPI resource: bundle://133.0:0/META-INF/services/javax.servlet.ServletContainerInitializer
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Loaded SPI provider: class org.eclipse.jetty.websocket.server.NativeWebSocketServletContainerInitializer
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered service: org.apache.felix.framework.ServiceRegistrationImpl@408f64bb
Aug 13, 2021 2:25:29 PM org.apache.aries.spifly.BaseActivator log
INFO: Registered provider: javax.servlet.ServletContainerInitializer in bundle org.eclipse.jetty.websocket.server
2021-08-13 14:25:29.618:INFO::FelixStartLevel: Logging initialized @4682ms to org.eclipse.jetty.util.log.StdErrLog
Aug 13, 2021 2:25:29 PM org.apache.cxf.bus.osgi.CXFExtensionBundleListener addExtensions
INFO: Adding the extensions from bundle org.apache.cxf.cxf-rt-management (157) [org.apache.cxf.management.InstrumentationManager]
Aug 13, 2021 2:25:29 PM org.apache.cxf.bus.osgi.CXFExtensionBundleListener addExtensions
INFO: Adding the extensions from bundle org.apache.cxf.cxf-rt-rs-service-description (162) [org.apache.cxf.jaxrs.model.wadl.WadlGenerator]
Aug 13, 2021 2:25:29 PM org.apache.cxf.bus.osgi.CXFExtensionBundleListener addExtensions
INFO: Adding the extensions from bundle org.apache.cxf.cxf-rt-transports-http (164) [org.apache.cxf.transport.http.HTTPTransportFactory, org.apache.cxf.transport.http.HTTPWSDLExtensionLoader, org.apache.cxf.transport.http.policy.HTTPClientAssertionBuilder, org.apache.cxf.transport.http.policy.HTTPServerAssertionBuilder, org.apache.cxf.transport.http.policy.NoOpPolicyInterceptorProvider]
Aug 13, 2021 2:25:29 PM org.apache.cxf.transport.http.osgi.ServletExporter updated
INFO: Registering new instance of "/cxf" servlet
2021-08-13 14:25:30.398:INFO:oejws.WebSocketServerFactory:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:30.476:INFO:oejs.session:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): DefaultSessionIdManager workerName=node0
2021-08-13 14:25:30.476:INFO:oejs.session:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): No SessionScavenger set, using defaults
2021-08-13 14:25:30.477:INFO:oejs.session:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): node0 Scavenging every 600000ms
2021-08-13 14:25:30.497:INFO:oejsh.ContextHandler:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.apache.cxf.cxf-rt-transports-http [164], contextID=default]}
2021-08-13 14:25:30.502:INFO:oejs.Server:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): jetty-9.4.18.v20190429; built: 2019-04-29T20:42:08.989Z; git: e1bc35120a6617ee3df052294e433f3a25ce7097; jvm 1.8.0_292-8u292-b10-0ubuntu1~18.04-b10
Aug 13, 2021 2:25:30 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /i18n
2021-08-13 14:25:30.549:INFO:oejs.AbstractConnector:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): Started default@66d304f2{HTTP/1.1,[http/1.1]}{0.0.0.0:9051}
2021-08-13 14:25:30.550:INFO:oejs.Server:CM Configuration Updater (ManagedService Update: pid=[org.apache.cxf.osgi]): Started @5615ms
Aug 13, 2021 2:25:30 PM org.pentaho.caching.impl.PentahoCacheManagerFactory$RegistrationHandler$1 onSuccess
INFO: New Caching Service registered
2021-08-13 14:25:30.681:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:30.684:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-i18n-webservice-bundle [176], contextID=default]}
2021-08-13 14:25:31.469:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:31.476:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-pdi-platform [250], contextID=default]}
2021-08-13 14:25:32.186:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.188:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=core-ui [266], contextID=default]}
2021-08-13 14:25:32.248:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.251:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.pentaho.requirejs-manager-impl [267], contextID=default]}
2021-08-13 14:25:32.258:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.261:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular [268], contextID=default]}
2021-08-13 14:25:32.273:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.276:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-animate [269], contextID=default]}
2021-08-13 14:25:32.288:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.293:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-i18n [270], contextID=default]}
2021-08-13 14:25:32.301:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.304:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-route [271], contextID=default]}
2021-08-13 14:25:32.314:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.316:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-sanitize [272], contextID=default]}
2021-08-13 14:25:32.324:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.326:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-translate [273], contextID=default]}
2021-08-13 14:25:32.334:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.337:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-ui-router [274], contextID=default]}
2021-08-13 14:25:32.348:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.351:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-dojo [275], contextID=default]}
2021-08-13 14:25:32.359:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.361:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-require-css [276], contextID=default]}
2021-08-13 14:25:32.371:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.374:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-requirejs-text [277], contextID=default]}
Aug 13, 2021 2:25:32 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /repositories
Aug 13, 2021 2:25:32 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /browser
2021-08-13 14:25:32.655:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.659:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:32.660:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=repositories-plugin-core [278], contextID=default]}
2021-08-13 14:25:32.668:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-i18n [281], contextID=default]}
Aug 13, 2021 2:25:32 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /browser-new
2021-08-13 14:25:32.760:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
Aug 13, 2021 2:25:32 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /get-fields
2021-08-13 14:25:32.764:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=file-open-save-core [280], contextID=default]}
Aug 13, 2021 2:25:32 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /connection
2021-08-13 14:25:33.026:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.033:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=file-open-save-new-core [283], contextID=default]}
2021-08-13 14:25:33.178:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.183:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=get-fields-core [284], contextID=default]}
Aug 13, 2021 2:25:33 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /marketplace
2021-08-13 14:25:33.456:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.458:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.459:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=connections-ui [285], contextID=default]}
2021-08-13 14:25:33.463:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-angular-ui-bootstrap-bower [287], contextID=default]}
2021-08-13 14:25:33.615:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.622:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-marketplace-di [286], contextID=default]}
2021-08-13 14:25:33.622:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.624:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-jquery [288], contextID=default]}
2021-08-13 14:25:33.636:INFO:oejws.WebSocketServerFactory:FelixStartLevel: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:33.638:INFO:oejsh.ContextHandler:FelixStartLevel: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=pentaho-webjars-underscore [289], contextID=default]}
Aug 13, 2021 2:25:33 PM org.apache.cxf.endpoint.ServerImpl initDestination
INFO: Setting the server's publish address to be /hadoop-cluster
2021-08-13 14:25:35.035:INFO:oejws.WebSocketServerFactory:FelixDispatchQueue: No DecoratedObjectFactory provided, using new org.eclipse.jetty.util.DecoratedObjectFactory[decorators=1]
2021-08-13 14:25:35.039:INFO:oejsh.ContextHandler:FelixDispatchQueue: Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=hadoop-cluster-ui [291], contextID=default]}
Graphics2D from BufferedImage lacks BUFFERED_IMAGE hint
2021/08/13 14:25:37 - Carte - Installing timer to purge stale objects after 1440 minutes.
Loading class `com.mysql.jdbc.Driver'. This is deprecated. The new driver class is `com.mysql.cj.jdbc.Driver'. The driver is automatically registered via the SPI and manual loading of the driver class is generally unnecessary.
2021/08/13 14:28:48 - Spoon - Running transformation using the Kettle execution engine
2021/08/13 14:28:48 - Spoon - Transformation opened.
2021/08/13 14:28:48 - Spoon - Launching transformation [test]...
2021/08/13 14:28:48 - Spoon - Started the transformation execution.
2021/08/13 14:28:49 - test - Dispatching started for transformation [test]
2021/08/13 14:28:49 - org.openvpms.etl.pentaho.LoaderPluginMeta@77553e55 - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Failed to load application context
2021/08/13 14:28:49 - OpenVPMS Loader.0 - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Error initializing step [OpenVPMS Loader]
2021/08/13 14:28:49 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Step [OpenVPMS Loader.0] failed to initialize!
2021/08/13 14:28:49 - Spoon - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : test: preparing transformation execution failed
2021/08/13 14:28:49 - Spoon - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : org.pentaho.di.core.exception.KettleException: 
2021/08/13 14:28:49 - Spoon - We failed to initialize at least one step.  Execution can not begin!
2021/08/13 14:28:49 - Spoon - 
2021/08/13 14:28:49 - Spoon - 
2021/08/13 14:28:49 - Spoon - 	at org.pentaho.di.trans.Trans.prepareExecution(Trans.java:1286)
2021/08/13 14:28:49 - Spoon - 	at org.pentaho.di.ui.spoon.trans.TransGraph$30.run(TransGraph.java:4281)
2021/08/13 14:28:49 - Spoon - 	at java.lang.Thread.run(Thread.java:748)
2021/08/13 14:28:49 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Errors detected!
2021/08/13 14:28:49 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Errors detected!
2021/08/13 14:29:18 - Spoon - Running transformation using the Kettle execution engine
2021/08/13 14:29:18 - test - Transformation is pre-loaded.
2021/08/13 14:29:18 - test - nr of steps to run : 2  , nr of hops : 1
2021/08/13 14:29:18 - Spoon - Transformation opened.
2021/08/13 14:29:18 - Spoon - Launching transformation [test]...
2021/08/13 14:29:18 - Spoon - Started the transformation execution.
2021/08/13 14:29:18 - test - Dispatching started for transformation [test]
2021/08/13 14:29:18 - test - Nr of arguments detected:0 
2021/08/13 14:29:18 - test - This is not a replay transformation
2021/08/13 14:29:18 - test - I found 2 different steps to launch.
2021/08/13 14:29:18 - test - Allocating rowsets...
2021/08/13 14:29:18 - test -  Allocating rowsets for step 0 --> CSV file input
2021/08/13 14:29:18 - test -   prevcopies = 1, nextcopies=1
2021/08/13 14:29:18 - test - Transformation allocated new rowset [CSV file input.0 - OpenVPMS Loader.0]
2021/08/13 14:29:18 - test -  Allocated 1 rowsets for step 0 --> CSV file input  
2021/08/13 14:29:18 - test -  Allocating rowsets for step 1 --> OpenVPMS Loader
2021/08/13 14:29:18 - test -  Allocated 1 rowsets for step 1 --> OpenVPMS Loader  
2021/08/13 14:29:18 - test - Allocating Steps & StepData...
2021/08/13 14:29:18 - test -  Transformation is about to allocate step [CSV file input] of type [CsvInput]
2021/08/13 14:29:18 - test -   Step has nrcopies=1
2021/08/13 14:29:18 - CSV file input.0 - distribution activated
2021/08/13 14:29:18 - CSV file input.0 - Starting allocation of buffers & new threads...
2021/08/13 14:29:18 - CSV file input.0 - Step info: nrinput=0 nroutput=1
2021/08/13 14:29:18 - CSV file input.0 - output rel. is  1:1
2021/08/13 14:29:18 - CSV file input.0 - Found output rowset [CSV file input.0 - OpenVPMS Loader.0]
2021/08/13 14:29:18 - CSV file input.0 - Finished dispatching
2021/08/13 14:29:18 - test -  Transformation has allocated a new step: [CSV file input].0
2021/08/13 14:29:18 - test -  Transformation is about to allocate step [OpenVPMS Loader] of type [OpenVPMSLoaderPlugin]
2021/08/13 14:29:18 - test -   Step has nrcopies=1
2021/08/13 14:29:18 - org.openvpms.etl.pentaho.LoaderPluginMeta@35a7091b - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Failed to load application context
2021/08/13 14:29:18 - OpenVPMS Loader.0 - distribution activated
2021/08/13 14:29:18 - OpenVPMS Loader.0 - Starting allocation of buffers & new threads...
2021/08/13 14:29:18 - OpenVPMS Loader.0 - Step info: nrinput=1 nroutput=0
2021/08/13 14:29:18 - OpenVPMS Loader.0 - Got previous step from [OpenVPMS Loader] #0 --> CSV file input
2021/08/13 14:29:18 - OpenVPMS Loader.0 - input rel is 1:1
2021/08/13 14:29:18 - OpenVPMS Loader.0 - Found input rowset [CSV file input.0 - OpenVPMS Loader.0]
2021/08/13 14:29:18 - OpenVPMS Loader.0 - Finished dispatching
2021/08/13 14:29:18 - test -  Transformation has allocated a new step: [OpenVPMS Loader].0
2021/08/13 14:29:18 - test - This transformation can be replayed with replay date: 2021/08/13 14:29:18
2021/08/13 14:29:18 - test - Initialising 2 steps...
2021/08/13 14:29:18 - CSV file input.0 - Released server socket on port 0
2021/08/13 14:29:18 - OpenVPMS Loader.0 - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Error initializing step [OpenVPMS Loader]
2021/08/13 14:29:18 - test - Step [CSV file input.0] initialized flawlessly.
2021/08/13 14:29:18 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Step [OpenVPMS Loader.0] failed to initialize!
2021/08/13 14:29:18 - Spoon - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : test: preparing transformation execution failed
2021/08/13 14:29:18 - Spoon - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : org.pentaho.di.core.exception.KettleException: 
2021/08/13 14:29:18 - Spoon - We failed to initialize at least one step.  Execution can not begin!
2021/08/13 14:29:18 - Spoon - 
2021/08/13 14:29:18 - Spoon - 
2021/08/13 14:29:18 - Spoon - 	at org.pentaho.di.trans.Trans.prepareExecution(Trans.java:1286)
2021/08/13 14:29:18 - Spoon - 	at org.pentaho.di.ui.spoon.trans.TransGraph$30.run(TransGraph.java:4281)
2021/08/13 14:29:18 - Spoon - 	at java.lang.Thread.run(Thread.java:748)
2021/08/13 14:29:18 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Errors detected!
2021/08/13 14:29:18 - test - ERROR (version 9.0.0.0-423, build 9.0.0.0-423 from 2020-01-31 04.53.04 by buildguy) : Errors detected!