Hi Team,
i am currently executing my tests for my
pipelet. When having a look onto the log file I have the impression that not
everything is working perfectly.
I found several ERROR and WARN messages
within the log. Vould we please discuss, how we could improve the logging. I think
that way we could improve the end user trust a bit.
2008-10-14
17:44:20,971 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added: [org.eclipse.smila.processing.pipelets.CommitRecordsPipelet,
org.eclipse.smila.processing.pipelets.HtmlToTextPipelet,
org.eclipse.smila.processing.pipelets.SetAnnotationPipelet]
2008-10-14
17:44:20,996 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added:
[org.eclipse.smila.processing.pipelets.mimetype.SimpleMimeTypeIdentifier]
2008-10-14
17:44:21,035 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added: [org.eclipse.smila.processing.bpel.test.ErrorPipelet,
org.eclipse.smila.processing.bpel.test.SplitterPipelet,
org.eclipse.smila.processing.bpel.test.SimpleTestPipelet]
2008-10-14
17:44:21,041 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added:
[org.eclipse.smila.processing.pipelets.aperture.AperturePipelet]
2008-10-14
17:44:21,097 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added:
[org.eclipse.smila.processing.pipelets.xmlprocessing.XPathFilterPipelet,
org.eclipse.smila.processing.pipelets.xmlprocessing.XslTransformationPipelet,
org.eclipse.smila.processing.pipelets.xmlprocessing.StxTransformationPipelet,
org.eclipse.smila.processing.pipelets.xmlprocessing.RemoveElementFromXMLPipelet,
org.eclipse.smila.processing.pipelets.xmlprocessing.TidyPipelet,
org.eclipse.smila.processing.pipelets.xmlprocessing.XPathExtractorPipelet]
2008-10-14
17:44:21,105 [SCR Work Queue] INFO bpel.SimplePipeletManager - SimplePipelets
have been added: [org.eclipse.smila.processing.test.Test1Pipelet,
org.eclipse.smila.processing.test.Test2Pipelet]
2008-10-14
17:44:22,272 [SCR Work Queue] INFO config.ConfigUtils - CONFIGURATION_FOLDER =
D:\eccenca\EILF\org.eclipse.smila.processing.pipelets.mimetype.test\configuration
2008-10-14
17:44:23,013 [SCR Work Queue] INFO workspace.WorkspaceHelper - Using default
workspace.
2008-10-14
17:44:23,025 [SCR Work Queue] INFO impl.XssUtils - physical storage is @
D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.xmlstorage\DefaultXmlStorage
2008-10-14
17:44:23,413 [SCR Work Queue] INFO impl.BlackboardServiceImpl - BlackboardService
started
2008-10-14
17:44:23,738 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Have reference
to processing service SimpleMimeTypeIdentifier
2008-10-14
17:44:23,738 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Have reference
to processing service SplitterService
2008-10-14
17:44:23,739 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Have reference
to processing service ErrorService
2008-10-14
17:44:23,791 [SCR Work Queue] INFO il.EmbeddedGeronimoFactory - Using embedded
Geronimo transaction manager
2008-10-14
17:44:23,830 [SCR Work Queue] INFO dbutil.Database - ODE using internal
database "jdbc:hsqldb:mem:odedb" with driver org.hsqldb.jdbcDriver.
2008-10-14
17:44:23,882 [SCR Work Queue] INFO dbutil.Database - Using DAO Connection
Factory class org.apache.ode.dao.jpa.BPELDAOConnectionFactoryImpl.
2008-10-14
17:44:24,470 [SCR Work Queue] INFO simple.JdbcDelegate - Using database
dialect: HSQL
2008-10-14
17:44:24,977 [SCR Work Queue] INFO ode.ODEServer - BPEL process execution
timeout: 3 seconds.
2008-10-14
17:44:25,025 [SCR Work Queue] INFO engine.BpelServerImpl - BPEL Server
Started.
2008-10-14
17:44:25,035 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Pipeline deploy
directory is D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines
2008-10-14
17:44:25,038 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Copying
deploy.xml to
D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines\deploy.xml
2008-10-14
17:44:25,040 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Copying id.xsd
to
D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines\id.xsd
2008-10-14
17:44:25,044 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Copying
processor.wsdl to
D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines\processor.wsdl
2008-10-14
17:44:25,060 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Copying
record.xsd to D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines\record.xsd
2008-10-14
17:44:25,062 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Copying
SimpleMimeTypeIdentifierPipeline.bpel to
D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines\SimpleMimeTypeIdentifierPipeline.bpel
2008-10-14
17:44:25,063 [SCR Work Queue] INFO store.ProcessStoreImpl - Starting
deployment of processes from directory
"D:\junit-workspace\.metadata\.plugins\org.eclipse.smila.processing.bpel\pipelines".
2008-10-14
17:44:25,914 [SCR Work Queue] INFO compiler.BpelC - info: [CompilingProcess]
Compiling BPEL process.
2008-10-14
17:44:26,434 [SCR Work Queue] WARN bom.BpelObjectFactory - Unrecognized
element in BPEL dom: {http://www.eclipse.org/smila/processor}invokeService
2008-10-14
17:44:26,434 [SCR Work Queue] WARN bom.BpelObjectFactory - Unrecognized
element in BPEL dom: {http://www.eclipse.org/smila/processor}service
2008-10-14
17:44:26,434 [SCR Work Queue] WARN bom.BpelObjectFactory - Unrecognized
element in BPEL dom: {http://www.eclipse.org/smila/processor}variables
2008-10-14
17:44:26,606 [ProcessStoreImpl-1] INFO openjpa.Runtime - Starting OpenJPA
1.1.0
2008-10-14
17:44:26,948 [ProcessStoreImpl-1] INFO jdbc.JDBC - Using dictionary class
"org.apache.openjpa.jdbc.sql.HSQLDictionary" (HSQL Database Engine
1.7.3 ,HSQL Database Engine Driver 1.7.3).
2008-10-14
17:44:27,664 [SCR Work Queue] INFO store.ProcessStoreImpl - Process
{http://www.eclipse.org/smila/processor}SimpleMimeTypeIdentifierPipeline-1
deployed from
"{http://www.eclipse.org/smila/processor}SimpleMimeTypeIdentifierPipeline-1".
2008-10-14
17:44:27,891 [SCR Work Queue] WARN v2.RuntimeImpl - The process declares the
extension namespace http://www.eclipse.org/smila/processor that is unkown to
the engine
2008-10-14
17:44:27,935 [SCR Work Queue] INFO engine.BpelServerImpl - Registered process
{http://www.eclipse.org/smila/processor}SimpleMimeTypeIdentifierPipeline-1.
2008-10-14
17:44:27,940 [SCR Work Queue] INFO bpel.ODEWorkflowProcessor - Initializing
pipeline
{http://www.eclipse.org/smila/processor}SimpleMimeTypeIdentifierPipeline-1.
2008-10-14
17:44:28,006 [SCR Work Queue] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: found
service SimpleMimeTypeIdentifier, processing request -> null
2008-10-14
17:44:28,024 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
28d847a27b44ab31e5474fc86d57aabeb84792f83ad67e7e568937e9a828ae2 is not loaded
in the blackboard.
2008-10-14
17:46:08,513 [ODEServerImpl-1] INFO openjpa.Runtime - Starting OpenJPA 1.1.0
2008-10-14
17:46:08,513 [ODEServerImpl-1] INFO jdbc.JDBC - Using dictionary class
"org.apache.openjpa.jdbc.sql.HSQLDictionary" (HSQL Database Engine
1.7.3 ,HSQL Database Engine Driver 1.7.3).
2008-10-14
17:46:09,244 [ODEServerImpl-1] INFO bpel.ODEWorkflowProcessor - Resolved
service reference SimpleMimeTypeIdentifier
2008-10-14
17:46:09,244 [ODEServerImpl-1] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:46:57,591 [ODEServerImpl-2] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:46:57,598 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash = 47761c21b79532180dc3161c241a0dae25bf28ed9ebe933ca728b717b26bf
is not loaded in the blackboard.
2008-10-14
17:48:02,728 [ODEServerImpl-4] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:35,705 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
c562e9813daa45614464f6b1f93554f11420952f8839fe772473d56e978ab is not loaded in
the blackboard.
2008-10-14
17:54:38,955 [ODEServerImpl-7] WARN memdao.ProcessDaoImpl - Discarding
in-memory instance 0 because it exceeded its time-to-live: null
2008-10-14
17:54:38,955 [ODEServerImpl-7] WARN memdao.ProcessDaoImpl - Discarding
in-memory instance 2 because it exceeded its time-to-live:
mem.instance(type={http://www.eclipse.org/smila/processor}SimpleMimeTypeIdentifierPipeline
iid=2)
2008-10-14
17:54:38,955 [ODEServerImpl-7] WARN memdao.ProcessDaoImpl - Discarding
in-memory instance 1 because it exceeded its time-to-live: null
2008-10-14
17:54:38,967 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,046 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
55ae7e32474557b0fcf2eb2f799aadf9e33774a3acc2e952fb2bee9defd666c9 is not loaded
in the blackboard.
2008-10-14
17:54:43,051 [ODEServerImpl-9] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,056 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
8ff7ab985d98fce1fada878d7e963b6dfa875ef425d1276be875f811878b1898 is not loaded
in the blackboard.
2008-10-14
17:54:43,061 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,067 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
4d5b7c48ee5d592f50130c1adcc97aed630c52d9db655ecd7b9fa82d4df124 is not loaded in
the blackboard.
2008-10-14
17:54:43,071 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,078 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
75264fad2731bfe3eff94ffd92c6ff749036fc2526f85c2615cd18695e4bf is not loaded in
the blackboard.
2008-10-14
17:54:43,085 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,089 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
367e113d1d9529bbda1a2e8cc5a16eadbb9eb467be375f1fbdde57393dc347 is not loaded in
the blackboard.
2008-10-14
17:54:43,092 [ODEServerImpl-9] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,098 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
b46bfb67fe1433714dcdc414665f99b71d4d297db883c9cedccad31e5921 is not loaded in
the blackboard.
2008-10-14
17:54:43,105 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,114 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash = ff4ff4c3f72d1d6d890a5624fbe5f20d464eec27f35a16d7b8974f0b6a0e4
is not loaded in the blackboard.
2008-10-14
17:54:43,121 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,127 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
64549315d65a93f8982fa6cb161cce5231e2c6d391f6c4a64fcdcf23cf6377 is not loaded in
the blackboard.
2008-10-14
17:54:43,133 [ODEServerImpl-9] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,136 [main] WARN impl.BlackboardServiceImpl - Error while invalidating
record: Record with idHash =
8e5b2147fb7c8ac713e3995671077c82fa7a2efcf17218b52afe861991aaa83 is not loaded
in the blackboard.
2008-10-14
17:54:43,139 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,145 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,145 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,145 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,145 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id null
2008-10-14
17:54:43,198 [ODEServerImpl-9] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,206 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager - SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35:
invoking service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,216 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,224 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,234 [ODEServerImpl-9] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,242 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,269 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,282 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,288 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,294 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,303 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,309 [ODEServerImpl-8] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,317 [ODEServerImpl-7] INFO bpel.ProcessingServiceManager -
SimpleMimeTypeIdentifierPipeline/extensionActivity-activity-line-35: invoking
service SimpleMimeTypeIdentifier, processing request -> request
2008-10-14
17:54:43,325 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,325 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,325 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id because no extension is specified [null]
2008-10-14
17:54:43,325 [main] ERROR mimetype.SimpleMimeTypeIdentifier - Could not detect
mimetype for Id null
2008-10-14
17:54:43,453 [main] INFO bpel.ODEWorkflowProcessor - Have lost processing
service SplitterService
2008-10-14
17:54:43,454 [main] INFO bpel.ODEWorkflowProcessor - Have lost processing
service ErrorService
2008-10-14
17:54:43,454 [main] INFO bpel.SimplePipeletManager - SimplePipelets have been
removed: [org.eclipse.smila.processing.bpel.test.ErrorPipelet,
org.eclipse.smila.processing.bpel.test.SplitterPipelet,
org.eclipse.smila.processing.bpel.test.SimpleTestPipelet]
2008-10-14
17:54:43,454 [main] INFO bpel.SimplePipeletManager - SimplePipelets have been
removed: [org.eclipse.smila.processing.test.Test1Pipelet,
org.eclipse.smila.processing.test.Test2Pipelet]
2008-10-14
17:54:43,455 [main] INFO engine.BpelServerImpl - BPEL Server Stopped.
2008-10-14
17:54:43,458 [main] INFO bpel.ODEWorkflowProcessor - Have lost processing
service SimpleMimeTypeIdentifier
Kind regards,
Georg