talk@lists.collectionspace.org

WE HAVE SUNSET THIS LISTSERV - Join us at collectionspace@lyrasislists.org

Re: [Talk] Can't add people

Aron Roberts

Fri, Mar 25, 2016 1:52 AM

Forwarding the conversation that Toni Hanna and I have been having about
this issue, to the Talk list, so any others with insights can respond as
well ...

On Thu, Mar 24, 2016 at 6:50 PM, Aron Roberts aron@socrates.berkeley.edu
wrote:

Hi Tony,

Re your questions 1 & 2 in reverse order.

From a quick look, most if not all of these messages are
informational and expected, regardless of their severity level. (There's
still some cleanup needed around this.)
While it's great that you now see authorities listed, after visiting
the relevant URL to initialize these, it's disconcerting that your currency
options disappeared from the Acquisitions record.

On its face, this sounds very much like an instance of this bug, slated
to be fixed in v4.4:

https://issues.collectionspace.org/browse/CSPACE-6391

When there are multiple instances of a vocabulary, such as the
"currency" vocabulary - as a result of the circumstances mentioned in the
Description of this issue - the active instance of the vocabulary can
sometimes have no terms present within it.

It's a bit painful, but a workaround is to find the empty currency
vocabularies (those that have no items), and remove them, using the
CollectionSpace REST API. After doing so, and after restarting the
CollectionSpace server, you should once again see those terms.

https://issues.collectionspace.org/browse/PAHMA-923?focusedCommentId=40448&page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel#comment-40448

Aron

A sample of how you might delete the empty currency vocabularies, using
cURL (an HTTP/multiprotocol client avaialble for Windows, etc.) at
https://curl.haxx.se/download.html) ... I'm entering the following
commands on a Mac:

Show me all the vocabularies

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies?pgSz=200

(The above example uses the default 'core' tenant and the default
administrator account and password; you can change whichever of these may
be relevant to your own installation.)

Find the CSIDs of all the vocabularies (entries returned by the above
command) whose shortIdentifier field contains "currency" (its refName field
will likely also contain "(currency)".

Hypothetically, your query will return two or more entries for currency
vocabularies, each one identified by its own CSID (ID number).

For each CSID returned (using '0357dec4-4db6-436e-86a2' here as just a
placeholder example for one of the CSIDs returned by the command above - be
sure to substitute its actual CSID for this placeholder value), find out
how many items it has:

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86a2/items

If the totalItems field contains "0", that currency vocabulary is empty.
(I.e. it was one of the empty, duplicate vocabularies created by the
aforementioned bug.) You can delete it via:

curl -i -u admin@core.collectionspace.org:Administrator -X DELETE
http:/localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86a2

Keep deleting empty vocabularies until the only remaining currency
vocabulary is one that contains terms.
Restart the CollectionSpace server.
Check the Acquisition record.
If you still don't see terms there, clear your browser's caches, per
https://wiki.collectionspace.org/display/DOC/Clearing+cached+content+from+browsers

On Thu, Mar 24, 2016 at 4:51 PM, toni hanna toni@creyasoft.com wrote:

Thanks Aron: that did fix it. Now, I can see tons of people and
organizations. However, this initialization messed up some other things.

When I do an Acquisition, the dropdown list of currency type does not
contain anything whereas before I had a list of different currencies.
I see the following message repeatedly in the command line screen:
"2016-03-25 01:36:23,736 WARN [http-apr-8180-exec-4]
[org.collectionspace.services.common.security.SecurityInterceptor:359]
Attempt to logout when Nuxeo login context was null"

Could these be because of the initialization? or is there something else I
need to do.

I also see other messages like:
"AcquisitionValidatorHandler executed.
2016-03-25 01:45:36,986 WARN [http-apr-8180-exec-6]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143]
Call failed to getRefnameDisplayName() for class

org.collectionspace.services.acquisition.nuxeo.AcquisitionDocumentModelHandler"

and also:

"2016-03-25 01:49:51,513 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143]
Call failed to getRefnameDisplayName() for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler
setCharset(): UTF-8
2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:115]
Could not obtain CSID for Movement record from document event.
2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:116]
This event listener will not continue processing this event ...
setCharset(): UTF-8
2016-03-25 01:49:51,636 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143]
Call failed to getRefnameDisplayName() for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler
2016-03-25 01:49:51,688 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:115]
Could not obtain CSID for Movement record from document event.
2016-03-25 01:49:51,689 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:116]
This event listener will not continue processing this event ...
2016-03-25 01:49:51,707 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:166]
Could not get document handler params from config bindings for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler
2016-03-25 01:49:52,717 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:52,743 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying 'cause'
exception.
2016-03-25 01:49:52,746 ERROR [http-apr-8180-exec-5]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP 500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

at

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152)

at

org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:52,754 ERROR [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
setCharset(): UTF-8
setCharset(): UTF-8
setCharset(): UTF-8
2016-03-25 01:49:53,113 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,143 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying 'cause'
exception.
2016-03-25 01:49:53,144 ERROR [http-apr-8180-exec-5]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP 500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

at

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152)

at

org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,149 ERROR [http-apr-8180-exec-4]

[org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
2016-03-25 01:49:53,335 WARN [http-apr-8180-exec-1]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,362 WARN [http-apr-8180-exec-1]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying 'cause'
exception.
2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-1]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP 500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

at

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152)

at

org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
2016-03-25 01:49:53,705 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,721 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying 'cause'
exception.
2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-3]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP 500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

at

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152)

at

org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-4]

[org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'."

Should I worry about these?

Thanks for your help.
Toni.

On Thu, March 24, 2016 12:38 pm, Aron Roberts wrote:

Hi Toni,

Delighted to learn of your progress!

First thing you might check: have you already initialized the various
authorities (including Person)? That's a manual process, after the
installation of CollectionSpace itself:

https://wiki.collectionspace.org/display/DOC/Initializing+data

Best,
Aron

On Thu, Mar 24, 2016 at 9:59 AM, toni hanna toni@creyasoft.com wrote:

Hi all.
I installed CS on my windows box and was able to login.
I am able to create various transactions, and save them. But when I try
to add people names, i get the spinning wheel and nothing happen. I am
obliged to cancel. I tried to create "people" from myworkspace, and I
get the following error: "Connection exceptionCreate request failed: on
org.collectionspace.services.person.PersonAuthorityResource csid="

Anyone

knows how I can recover from this problem? Thanks. Toni.

Here's the log from Tomcat screen:

Setting NUXEO_HOME
Setting JAVA_OPTS
Using JAVA_OPTS=""-Dslf4j.detectLoggerNameMismatch=true
-Dlog4j.debug=true
-Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log
-Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server
-Dfile.encoding=UTF-8 -Xms512m -Xmx1024m -XX:MaxPermSize=256m
-Dfile.encoding=UTF-8""

-Djava.util.logging.config.file="C:\apache-tomcat-7.0.57\conf\logging.p
roperties"
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager to
launch Tomcat Using CATALINA_BASE: "C:\apache-tomcat-7.0.57"
Using CATALINA_HOME: "C:\apache-tomcat-7.0.57"
Using CATALINA_TMPDIR: "C:\apache-tomcat-7.0.57\temp"
Using JRE_HOME: "C:\Java\jdk1.7.0_79"
Using CLASSPATH:

"C:\apache-tomcat-7.0.57\bin\bootstrap.jar;C:\apache-tomcat-7.0.57\bin
tomcat-juli.jar"

"JPDA_OPTS=-agentlib:jdwp=transport=dt_socket,address=8000,server=y,sus
pend=n" Listening for transport dt_socket at address: 8000
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server
version: Apache Tomcat/7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server

built:

Nov 3 2014 08:39:16 UTC
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server
number: 7.0.57.0
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: OS Name:
Windows 7
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: OS Version:
6.1
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:

Architecture:

amd64 Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: JAVA_HOME:
C:\Java\jdk1.7.0_79\jre
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: JVM

Version:

1.7.0_79-b15
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: JVM Vendor:
Oracle Corporation
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
CATALINA_BASE: C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
CATALINA_HOME: C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dslf4j.detectLoggerNameMismatch=true
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dlog4j.debug=true
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:
-Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:
-Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dfile.encoding=UTF-8
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Xms512m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Xmx1024m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -XX:MaxPermSize=256m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dfile.encoding=UTF-8
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:

-Djava.util.logging.config.file=C:\apache-tomcat-7.0.57\conf\

logging.pr

operties Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Xmx1024m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -XX:MaxPermSize=384m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:
-agentlib:jdwp=transport=dt_socket,address=8000,server=y,suspend=n
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument:
-Djava.endorsed.dirs=C:\apache-tomcat-7.0.57\endorsed
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dcatalina.base=C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Dcatalina.home=C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Command

line

argument: -Djava.io.tmpdir=C:\apache-tomcat-7.0.57\temp
Mar 24, 2016 6:27:47 PM org.apache.catalina.core.AprLifecycleListener
lifecycleEvent INFO: Loaded APR based Apache Tomcat Native library

1.1.32

using APR version 1.5.1. Mar 24, 2016 6:27:47 PM
org.apache.catalina.core.AprLifecycleListener lifecycleEvent INFO: APR
capabilities: IPv6 [true], sendfile [true], accept filters
[false], random [true].
Mar 24, 2016 6:27:48 PM org.apache.catalina.core.AprLifecycleListener
initializeSSL INFO: OpenSSL successfully initialized (OpenSSL 1.0.1j 15
Oct 2014)
Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8180"]
Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
Mar 24, 2016 6:27:48 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1946 ms
Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardService
startInternal INFO: Starting service Catalina
Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardEngine
startInternal INFO: Starting Servlet Engine: Apache Tomcat/7.0.57
Mar 24, 2016 6:27:49 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\collectionspace.war
Mar 24, 2016 6:27:54 PM org.apache.catalina.util.SessionIdGenerator
createSecureRandom INFO: Creation of SecureRandom instance for session

generation using [SHA1PRNG] took [156] milliseconds.
log4j: Trying to find [log4j.xml] using context classloader
WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 .
log4j: Trying to find [log4j.xml] using WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 class loader.

log4j:

Trying to find [log4j.xml] using ClassLoader.getSystemResource().
log4j: Trying to find [log4j.properties] using context classloader
WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 .
log4j: Using URL

[file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/classes/
log4j.properties] for automatic log4j configuration. log4j: Reading
configuration from URL

file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/classes/l
og4j.properties log4j: Parsing for [root] with value=[ERROR, stdout,

R].

log4j: Level token is [ERROR].
log4j: Category root set to ERROR
log4j: Parsing appender named "stdout".
log4j: Parsing layout options for "stdout".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "stdout".
log4j: Setting property [target] to [System.out].
log4j: Parsed "stdout" options.
log4j: Parsing appender named "R".
log4j: Parsing layout options for "R".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "R".
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-app.log].
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: setFile called: C:\apache-tomcat-7.0.57/logs/cspace-app.log,

true

log4j: setFile ended
log4j: Parsed "R" options.
log4j: Parsing for
[org.collectionspace.chain.controller.AppConfigDeployFileFilter] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category
org.collectionspace.chain.controller.AppConfigDeployFileFilter set to
ERROR
log4j: Handling

log4j.additivity.org.collectionspace.chain.controller.AppConfigDeployFi
leFilter=[null] log4j: Parsing for

[org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHandl

er] with value=[INFO]. log4j: Level token is [INFO].
log4j: Category

org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHandle

r set to INFO log4j: Handling

log4j.additivity.org.collectionspace.chain.csp.config.impl.parser.Assem
blingContentHandler=[null] log4j: Parsing for
[org.collectionspace.chain.controller.CommandLine] with
value=[ERROR, commandline]. log4j: Level token is [ERROR].
log4j: Category org.collectionspace.chain.controller.CommandLine set to
ERROR
log4j: Parsing appender named "commandline".
log4j: Parsing layout options for "commandline".
log4j: Setting property [conversionPattern] to [%d %p: %m%n].
log4j: End of parsing for "commandline".
log4j: Setting property [target] to [System.err].
log4j: Parsed "commandline" options.
log4j: Handling

log4j.additivity.org.collectionspace.chain.controller.CommandLine=[false

]
log4j: Setting additivity for
"org.collectionspace.chain.controller.CommandLine" to false
log4j: Parsing for
[org.collectionspace.chain.installation.XsdGeneration]
with value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.collectionspace.chain.installation.XsdGeneration

set

to ERROR log4j: Handling

log4j.additivity.org.collectionspace.chain.installation.XsdGeneration=[
null] log4j: Parsing for [org.collectionspace.chain.installation] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.collectionspace.chain.installation set to ERROR
log4j: Handling
log4j.additivity.org.collectionspace.chain.installation=[null] log4j:
Parsing for [org.collectionspace.chain.csp.webui.misc] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.collectionspace.chain.csp.webui.misc set to ERROR
log4j: Handling
log4j.additivity.org.collectionspace.chain.csp.webui.misc=[null] log4j:
Parsing for [org.apache.commons.httpclient.auth] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.apache.commons.httpclient.auth set to WARN
log4j: Handling
log4j.additivity.org.apache.commons.httpclient.auth=[null] log4j:
Parsing for [org.collectionspace.csp.helper.core.ConfigFinder] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.collectionspace.csp.helper.core.ConfigFinder set to
ERROR
log4j: Handling

log4j.additivity.org.collectionspace.csp.helper.core.ConfigFinder=[null]

log4j: Parsing for [org.collectionspace.perflog] with value=[INFO,
perflogappend]. log4j: Level token is [INFO].
log4j: Category org.collectionspace.perflog set to INFO
log4j: Parsing appender named "perflogappend".
log4j: Parsing layout options for "perflogappend".
log4j: Setting property [conversionPattern] to ["%d",%m%n].
log4j: End of parsing for "perflogappend".
log4j: Setting property [file] to [/tmp/cspace-app-perflog.csv].
log4j: Setting property [maxFileSize] to [10MB].
log4j: Setting property [maxBackupIndex] to [1].
log4j: setFile called: /tmp/cspace-app-perflog.csv, true
log4j: setFile ended
log4j: Parsed "perflogappend" options.
log4j: Handling log4j.additivity.org.collectionspace.perflog=[false]
log4j: Setting additivity for "org.collectionspace.perflog" to false
log4j: Parsing for [org.collectionspace.chain.installation.Services]
with value=[DEBUG]. log4j: Level token is [DEBUG].
log4j: Category org.collectionspace.chain.installation.Services set to
DEBUG
log4j: Handling
log4j.additivity.org.collectionspace.chain.installation.Services=[null]
log4j: Finished configuring.
Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\collectionspace.war has finished in
5,564
ms Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig
deployWAR INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-services.war
log4j: Trying to find [log4j.xml] using context classloader
WebappClassLoader
context: /cspace-services
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 .
log4j: Trying to find [log4j.xml] using
org.apache.catalina.loader.StandardClassLoader@344986 class loader.
log4j: Trying to find [log4j.xml] using
ClassLoader.getSystemResource().
log4j: Trying to find [log4j.properties] using context classloader
WebappClassLoader
context: /cspace-services
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 .
log4j: Using URL

[file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/classes/
log4j.properties] for automatic log4j configuration. log4j: Reading
configuration from URL

file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/classes/l
og4j.properties log4j: Parsing for [root] with value=[WARN, error,
cspace_appender]. log4j: Level token is [WARN].
log4j: Category root set to WARN
log4j: Parsing appender named "error".
log4j: Parsing layout options for "error".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "error".
log4j: Setting property [threshold] to [WARN].
log4j: Parsed "error" options.
log4j: Parsing appender named "cspace_appender".
log4j: Parsing layout options for "cspace_appender".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "cspace_appender".
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-services.log].
log4j: setFile called:

C:\apache-tomcat-7.0.57/logs/cspace-services.log,

true log4j: setFile ended
log4j: Parsed "cspace_appender" options.
log4j: Parsing for [org.apache] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.apache set to WARN
log4j: Handling log4j.additivity.org.apache=[null]
log4j: Parsing for [org.jboss.resteasy] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.jboss.resteasy set to ERROR
log4j: Handling log4j.additivity.org.jboss.resteasy=[null]
log4j: Parsing for [perf.collectionspace] with value=[WARN,
cspace_perf_appender, stdout]. log4j: Level token is [WARN].
log4j: Category perf.collectionspace set to WARN
log4j: Parsing appender named "cspace_perf_appender".
log4j: Parsing layout options for "cspace_perf_appender".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "cspace_perf_appender".
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log].
log4j: setFile called:
C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log, true
log4j: setFile ended
log4j: Parsed "cspace_perf_appender" options.
log4j: Parsing appender named "stdout".
log4j: Parsing layout options for "stdout".
log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L]
%m%n].
log4j: End of parsing for "stdout".
log4j: Parsed "stdout" options.
log4j: Handling log4j.additivity.perf.collectionspace=[false]
log4j: Setting additivity for "perf.collectionspace" to false
log4j: Parsing for [ch.elca.el4j.services.xmlmerge] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category ch.elca.el4j.services.xmlmerge set to WARN
log4j: Handling log4j.additivity.ch.elca.el4j.services.xmlmerge=[null]
log4j: Parsing for [org.nuxeo] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.nuxeo set to WARN
log4j: Handling log4j.additivity.org.nuxeo=[null]
log4j: Parsing for [org.springframework.security] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.springframework.security set to ERROR
log4j: Handling log4j.additivity.org.springframework.security=[null]
log4j: Parsing for [org.apache.catalina.realm] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.apache.catalina.realm set to ERROR
log4j: Handling log4j.additivity.org.apache.catalina.realm=[null]
log4j: Parsing for [org.collectionspace] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.collectionspace set to WARN
log4j: Handling log4j.additivity.org.collectionspace=[null]
log4j: Parsing for [org.hibernate] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.hibernate set to ERROR
log4j: Handling log4j.additivity.org.hibernate=[null]
log4j: Parsing for
[org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded]
with value=[TRACE]. log4j: Level token is [TRACE].
log4j: Category
org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded set
to TRACE
log4j: Handling

log4j.additivity.org.collectionspace.services.nuxeo.client.java.NuxeoCl
ientEmbedded=[null] log4j: Parsing for [org.springframework] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.springframework set to ERROR
log4j: Handling log4j.additivity.org.springframework=[null]
log4j: Parsing for [org.jboss.security] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.jboss.security set to ERROR
log4j: Handling log4j.additivity.org.jboss.security=[null]
log4j: Parsing for [httpclient] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category httpclient set to WARN
log4j: Handling log4j.additivity.httpclient=[null]
log4j: Parsing for [com.mchange.v2.resourcepool.BasicResourcePool] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category com.mchange.v2.resourcepool.BasicResourcePool set to
ERROR
log4j: Handling
log4j.additivity.com.mchange.v2.resourcepool.BasicResourcePool=[null]
log4j: Parsing for [net.sf.jmimemagic.MagicParser] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category net.sf.jmimemagic.MagicParser set to WARN
log4j: Handling log4j.additivity.net.sf.jmimemagic.MagicParser=[null]
log4j: Parsing for [org.nuxeo.elasticsearch] with value=[INFO].
log4j: Level token is [INFO].
log4j: Category org.nuxeo.elasticsearch set to INFO
log4j: Handling log4j.additivity.org.nuxeo.elasticsearch=[null]
log4j: Parsing for [org.apache.catalina.core] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.apache.catalina.core set to WARN
log4j: Handling log4j.additivity.org.apache.catalina.core=[null]
log4j: Finished configuring.
2016-03-24 18:28:10,690 WARN [localhost-startStop-1]

[org.nuxeo.ecm.platform.commandline.executor.service.CommandLineExecuto
rComponent:127]
Command not available: pdftohtml (command pdftohtml not found in system
path. You need to install pdftohtml) 2016-03-24 18:28:10,705 WARN
[localhost-startStop-1]

[org.nuxeo.ecm.platform.commandline.executor.service.CommandLineExecuto
rComponent:127]
Command not available: wpd2text (command wpd2text not found in system
path. You need to install wpd2text (deb: libwpd-tools)
http://libwpd.sourceforge.net/download.html)
2016-03-24 18:28:12,421 ERROR [localhost-startStop-1]
[org.nuxeo.runtime.osgi.OSGiRuntimeService:231] Unknown component
'OSGI-INF/layouts-contrib.xml' referenced by bundle
'org.collectionspace.publicitem'. Check the MANIFEST.MF
2016-03-24 18:28:12,421 ERROR [localhost-startStop-1]
[org.nuxeo.runtime.api.Framework:496]
2016-03-24 18:28:17,041 ERROR [localhost-startStop-1]
[org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl:223] Failed to
connect to elasticsearch, check addressList and clusterName: No node
available 2016-03-24 18:28:17,057 ERROR [localhost-startStop-1]
[org.nuxeo.runtime.model.impl.RegistrationInfoImpl:338] Component
notification of application started failed. java.lang.RuntimeException:
Failed to connect to elasticsearch, check
addressList and clusterName: No node available at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.checkClusterHealth(
ElasticSearchAdminImpl.java:224)
at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.connect(ElasticSear
chAdminImpl.java:118)
at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.<init>(ElasticSearc
hAdminImpl.java:102)
at

org.nuxeo.elasticsearch.ElasticSearchComponent.applicationStarted(Elast
icSearchComponent.java:174)
at

org.nuxeo.runtime.model.impl.RegistrationInfoImpl.notifyApplicationStar
ted(RegistrationInfoImpl.java:336)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.notifyComponentsOnStarted(OSG
iRuntimeService.java:494)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.fireApplicationStarted(OSGiRu
ntimeService.java:532)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.frameworkEvent(OSGiRuntimeSer
vice.java:542)
at org.nuxeo.osgi.OSGiAdapter.fireFrameworkEvent(OSGiAdapter.java:238)
at

org.nuxeo.osgi.application.loader.FrameworkLoader.doStart(FrameworkLoad
er.java:232)
at

org.nuxeo.osgi.application.loader.FrameworkLoader.start(FrameworkLoader
.java:112)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at

sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.ja
va:57)
at

sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccesso
rImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606) at

org.nuxeo.osgi.application.FrameworkBootstrap.start(FrameworkBootstrap.
java:132)
at

org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbedded.s
tartNuxeoEP(NuxeoConnectorEmbedded.java:115)
at

org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbedded.i
nitialize(NuxeoConnectorEmbedded.java:142)
at

org.collectionspace.services.common.ServiceMain.initialize(ServiceMain.
java:182)
at

org.collectionspace.services.common.ServiceMain.getInstance(ServiceMain
.java:124)
at

org.collectionspace.services.common.ServiceMain.getInstance(ServiceMain
.java:108)
at

org.collectionspace.services.common.CollectionSpaceServiceContextListen
er.contextInitialized(CollectionSpaceServiceContextListener.java:25)
at

org.apache.catalina.core.StandardContext.listenerStart(StandardContext.
java:4994)
at

org.apache.catalina.core.StandardContext.startInternal(StandardContext.
java:5492)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at

org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.j
ava:901)
at
org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
at
org.apache.catalina.core.StandardHost.addChild(StandardHost.java:649)
at

org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081)

at
org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:18
77)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262) at

java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.ja
va:1145)
at

java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.j
ava:615)
at java.lang.Thread.run(Thread.java:745) 2016-03-24 18:28:21,659 WARN
[Thread-5]
[org.nuxeo.ecm.platform.convert.ooomanager.OOoManagerComponent:226]
OpenOffice was not found, JOD Converter won't be available: officeHome
doesn't exist or is not a directory: 2016-03-24 18:28:21,831 ERROR
[localhost-startStop-1]
[org.nuxeo.runtime.osgi.OSGiRuntimeService:552] Nuxeo Platform Started

---====
= Component Loading Errors:

Unknown component 'OSGI-INF/layouts-contrib.xml' referenced by bundle
'org.collectionspace.publicitem'

---====
= Component Loading Status: Pending: 5 / Unstarted: 0 / Total: 323

service:org.nuxeo.ecm.platform.picture.web.preview.adapter.contrib
requires [service:org.nuxeo.ecm.platform.preview.adapter.contrib] *
service:org.nuxeo.ecm.automation.io.services.IOComponent requires
[service:org.nuxeo.ecm.webengine.core.service.json]
service:org.nuxeo.logs.viewer.theme requires
[service:org.nuxeo.theme.nuxeo.default]
service:com.collectionspace.query.model.override requires
[service:org.nuxeo.ecm.webapp.querymodel.DefaultQueryModels]
service:org.nuxeo.ecm.login.token.authentication.contrib requires
[service:org.nuxeo.ecm.automation.server.auth.config]

---====
Mar 24, 2016 6:28:22 PM net.sf.ehcache.config.ConfigurationFactory
parseConfiguration WARNING: No configuration found. Configuring ehcache
from ehcache-failsafe.xml found in the classpath:

jar:file:/C:/apache-tomcat-7.0.57/lib/ehcache-1.6.2.jar!/ehcache-failsa
fe.xml 2016-03-24 18:28:25,720 WARN [localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 2 2016-03-24 18:28:25,736 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from: id with
tenant ID = 2 2016-03-24 18:28:25,829 WARN [localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 2 2016-03-24 18:28:25,954 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from: Imports
with tenant ID = 2 2016-03-24 18:28:25,970 WARN

[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 2 2016-03-24 18:28:27,233 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 1000 2016-03-24 18:28:27,233 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from: id with
tenant ID = 1000 2016-03-24 18:28:27,280 WARN [localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 1000 2016-03-24 18:28:27,389 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 1000 2016-03-24 18:28:29,573 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 1 2016-03-24 18:28:29,573 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from: id with
tenant ID = 1 2016-03-24 18:28:29,682 WARN [localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 1 2016-03-24 18:28:29,854 WARN
[localhost-startStop-1]

[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.AuthorizationCom
mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 1 [INFO] Starting up the CollectionSpace Services'
JAX-RS application.
Static initialization of:
org.collectionspace.services.common.security.SecurityInterceptor [INFO]
CollectionSpace Services' JAX-RS application started.
Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-services.war has finished in
42,946
ms Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig
deployWAR INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-ui.war
Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-ui.war has finished in 2,948 ms
Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\docs
Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\docs has finished in 1,887 ms
Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\examples
Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\examples has finished in 2,582 ms
Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\host-manager
Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\host-manager has finished in 1,903 ms
Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\manager
Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\manager has finished in 2,043 ms
Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\ROOT
Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\ROOT has finished in 1,826 ms
Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-8180"]
Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-8009"]
Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 61877 ms
2016-03-24 18:29:10,509 WARN [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand
ler:412]
Source file for "Include" tag could not be found:
local-core-settings.xml 2016-03-24 18:29:10,587 INFO
[http-apr-8180-exec-7]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand
ler:172]
XMLMerge results were written to file:

C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\merged-
settings.xml_local-core-settings.xml-.xml 2016-03-24 18:29:13,706 WARN
[http-apr-8180-exec-8]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand
ler:172]
XMLMerge results were written to file:

C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\merged-
settings.xml_local-core-settings.xml-.xml Could not get session from
CSPACESESSID cookie with value:
1060fbf7c4f3c3ffe5f1694482b05019
2016-03-24 18:29:34,371 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.security.SecurityInterceptor:359]
Attempt to logout when Nuxeo login context was null
setCharset(): UTF-8
2016-03-24 18:29:36,262 WARN [http-apr-8180-exec-9]
[org.collectionspace.services.common.security.SecurityInterceptor:359]
Attempt to logout when Nuxeo login context was null
setCharset(): UTF-8

Talk mailing list
Talk@lists.collectionspace.org

http://lists.collectionspace.org/mailman/listinfo/talk_lists.collection

space.org

Forwarding the conversation that Toni Hanna and I have been having about this issue, to the Talk list, so any others with insights can respond as well ... On Thu, Mar 24, 2016 at 6:50 PM, Aron Roberts <aron@socrates.berkeley.edu> wrote: > Hi Tony, > > Re your questions 1 & 2 in reverse order. > > 2. From a quick look, most if not all of these messages are > informational and expected, regardless of their severity level. (There's > still some cleanup needed around this.) > > 1. While it's great that you now see authorities listed, after visiting > the relevant URL to initialize these, it's disconcerting that your currency > options disappeared from the Acquisitions record. > > On its face, this sounds very much like an instance of this bug, slated > to be fixed in v4.4: > > https://issues.collectionspace.org/browse/CSPACE-6391 > > When there are multiple instances of a vocabulary, such as the > "currency" vocabulary - as a result of the circumstances mentioned in the > Description of this issue - the active instance of the vocabulary can > sometimes have no terms present within it. > > It's a bit painful, but a workaround is to find the empty currency > vocabularies (those that have no items), and remove them, using the > CollectionSpace REST API. After doing so, and after restarting the > CollectionSpace server, you should once again see those terms. > > > https://issues.collectionspace.org/browse/PAHMA-923?focusedCommentId=40448&page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel#comment-40448 > > Aron > > -- > > A sample of how you might delete the empty currency vocabularies, using > cURL (an HTTP/multiprotocol client avaialble for Windows, etc.) at > https://curl.haxx.se/download.html) ... I'm entering the following > commands on a Mac: > > - Show me all the vocabularies > > curl -i -u admin@core.collectionspace.org:Administrator > http://localhost:8180/cspace-services/vocabularies?pgSz=200 > > (The above example uses the default 'core' tenant and the default > administrator account and password; you can change whichever of these may > be relevant to your own installation.) > > - Find the CSIDs of all the vocabularies (entries returned by the above > command) whose shortIdentifier field contains "currency" (its refName field > will likely also contain "(currency)". > > Hypothetically, your query will return two or more entries for currency > vocabularies, each one identified by its own CSID (ID number). > > For each CSID returned (using '0357dec4-4db6-436e-86a2' here as just a > placeholder example for one of the CSIDs returned by the command above - be > sure to substitute its actual CSID for this placeholder value), find out > how many items it has: > > curl -i -u admin@core.collectionspace.org:Administrator > http://localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86a2/items > > - If the totalItems field contains "0", that currency vocabulary is empty. > (I.e. it was one of the empty, duplicate vocabularies created by the > aforementioned bug.) You can delete it via: > > curl -i -u admin@core.collectionspace.org:Administrator -X DELETE > http:/localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86a2 > > - Keep deleting *empty* vocabularies until the only remaining currency > vocabulary is one that contains terms. > > - Restart the CollectionSpace server. > > - Check the Acquisition record. > > - If you still don't see terms there, clear your browser's caches, per > https://wiki.collectionspace.org/display/DOC/Clearing+cached+content+from+browsers > > On Thu, Mar 24, 2016 at 4:51 PM, toni hanna <toni@creyasoft.com> wrote: > >> Thanks Aron: that did fix it. Now, I can see tons of people and >> organizations. However, this initialization messed up some other things. >> 1. When I do an Acquisition, the dropdown list of currency type does not >> contain anything whereas before I had a list of different currencies. >> 2. I see the following message repeatedly in the command line screen: >> "2016-03-25 01:36:23,736 WARN [http-apr-8180-exec-4] >> [org.collectionspace.services.common.security.SecurityInterceptor:359] >> Attempt to logout when Nuxeo login context was null" >> >> Could these be because of the initialization? or is there something else I >> need to do. >> >> I also see other messages like: >> "AcquisitionValidatorHandler executed. >> 2016-03-25 01:45:36,986 WARN [http-apr-8180-exec-6] >> >> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143] >> Call failed to getRefnameDisplayName() for class >> >> org.collectionspace.services.acquisition.nuxeo.AcquisitionDocumentModelHandler" >> >> and also: >> >> "2016-03-25 01:49:51,513 WARN [http-apr-8180-exec-10] >> >> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143] >> Call failed to getRefnameDisplayName() for class >> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler >> setCharset(): UTF-8 >> 2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10] >> >> [org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:115] >> Could not obtain CSID for Movement record from document event. >> 2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10] >> >> [org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:116] >> This event listener will not continue processing this event ... >> setCharset(): UTF-8 >> 2016-03-25 01:49:51,636 WARN [http-apr-8180-exec-10] >> >> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:166] >> Could not get document handler params from config bindings for class >> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler >> 2016-03-25 01:49:51,641 WARN [http-apr-8180-exec-10] >> [org.collectionspace.services.common.security.SecurityInterceptor:359] >> Attempt to logout when Nuxeo login context was null >> 2016-03-25 01:49:51,671 WARN [http-apr-8180-exec-3] >> >> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:143] >> Call failed to getRefnameDisplayName() for class >> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler >> 2016-03-25 01:49:51,688 WARN [http-apr-8180-exec-3] >> >> [org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:115] >> Could not obtain CSID for Movement record from document event. >> 2016-03-25 01:49:51,689 WARN [http-apr-8180-exec-3] >> >> [org.collectionspace.services.listener.AbstractUpdateObjectLocationValues:116] >> This event listener will not continue processing this event ... >> 2016-03-25 01:49:51,707 WARN [http-apr-8180-exec-3] >> >> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHandlerImpl:166] >> Could not get document handler params from config bindings for class >> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandler >> 2016-03-25 01:49:52,717 WARN [http-apr-8180-exec-5] >> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >> Could not retrieve document blob for Nuxeo document ID = >> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607' >> 2016-03-25 01:49:52,743 WARN [http-apr-8180-exec-5] >> [org.collectionspace.services.common.CSWebApplicationException:30] >> CSWebApplicationException instance created without an underlying 'cause' >> exception. >> 2016-03-25 01:49:52,746 ERROR [http-apr-8180-exec-5] >> [org.collectionspace.services.blob.BlobResource:499] >> org.collectionspace.services.blob.BlobResource detail: >> org.collectionspace.services.common.CSWebApplicationException: HTTP 500 >> Internal Server Error >> -- message: HTTP 500 Internal Server Error >> -- Stack Trace: >> -- org.collectionspace.services.common.CSWebApplicationException: >> HTTP 500 Internal Server Error >> >> at >> >> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152) >> >> at >> >> org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339) >> >> ...first 4 lines. 54 more. >> >> 2016-03-25 01:49:52,754 ERROR [http-apr-8180-exec-7] >> >> [org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38] >> Index failed. Could not get the contents for the Blob with CSID = >> '49cbc098-17ab-4537-b152'. >> setCharset(): UTF-8 >> setCharset(): UTF-8 >> setCharset(): UTF-8 >> 2016-03-25 01:49:53,113 WARN [http-apr-8180-exec-5] >> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >> Could not retrieve document blob for Nuxeo document ID = >> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607' >> 2016-03-25 01:49:53,143 WARN [http-apr-8180-exec-5] >> [org.collectionspace.services.common.CSWebApplicationException:30] >> CSWebApplicationException instance created without an underlying 'cause' >> exception. >> 2016-03-25 01:49:53,144 ERROR [http-apr-8180-exec-5] >> [org.collectionspace.services.blob.BlobResource:499] >> org.collectionspace.services.blob.BlobResource detail: >> org.collectionspace.services.common.CSWebApplicationException: HTTP 500 >> Internal Server Error >> -- message: HTTP 500 Internal Server Error >> -- Stack Trace: >> -- org.collectionspace.services.common.CSWebApplicationException: >> HTTP 500 Internal Server Error >> >> at >> >> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152) >> >> at >> >> org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339) >> >> ...first 4 lines. 54 more. >> >> 2016-03-25 01:49:53,149 ERROR [http-apr-8180-exec-4] >> >> [org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38] >> Index failed. Could not get the contents for the Blob with CSID = >> '49cbc098-17ab-4537-b152'. >> 2016-03-25 01:49:53,335 WARN [http-apr-8180-exec-1] >> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >> Could not retrieve document blob for Nuxeo document ID = >> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607' >> 2016-03-25 01:49:53,362 WARN [http-apr-8180-exec-1] >> [org.collectionspace.services.common.CSWebApplicationException:30] >> CSWebApplicationException instance created without an underlying 'cause' >> exception. >> 2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-1] >> [org.collectionspace.services.blob.BlobResource:499] >> org.collectionspace.services.blob.BlobResource detail: >> org.collectionspace.services.common.CSWebApplicationException: HTTP 500 >> Internal Server Error >> -- message: HTTP 500 Internal Server Error >> -- Stack Trace: >> -- org.collectionspace.services.common.CSWebApplicationException: >> HTTP 500 Internal Server Error >> >> at >> >> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152) >> >> at >> >> org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339) >> >> ...first 4 lines. 54 more. >> >> 2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-7] >> >> [org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38] >> Index failed. Could not get the contents for the Blob with CSID = >> '49cbc098-17ab-4537-b152'. >> 2016-03-25 01:49:53,705 WARN [http-apr-8180-exec-3] >> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >> Could not retrieve document blob for Nuxeo document ID = >> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = 'IMG_1781.JPG.1458863385607' >> 2016-03-25 01:49:53,721 WARN [http-apr-8180-exec-3] >> [org.collectionspace.services.common.CSWebApplicationException:30] >> CSWebApplicationException instance created without an underlying 'cause' >> exception. >> 2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-3] >> [org.collectionspace.services.blob.BlobResource:499] >> org.collectionspace.services.blob.BlobResource detail: >> org.collectionspace.services.common.CSWebApplicationException: HTTP 500 >> Internal Server Error >> -- message: HTTP 500 Internal Server Error >> -- Stack Trace: >> -- org.collectionspace.services.common.CSWebApplicationException: >> HTTP 500 Internal Server Error >> >> at >> >> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobResource.java:152) >> >> at >> >> org.collectionspace.services.blob.BlobResource.getDerivativeContent(BlobResource.java:339) >> >> ...first 4 lines. 54 more. >> >> 2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-4] >> >> [org.collectionspace.chain.csp.persistence.services.connection.ReturnedDocument:38] >> Index failed. Could not get the contents for the Blob with CSID = >> '49cbc098-17ab-4537-b152'." >> >> Should I worry about these? >> >> Thanks for your help. >> Toni. >> >> On Thu, March 24, 2016 12:38 pm, Aron Roberts wrote: >> > Hi Toni, >> > >> > >> > Delighted to learn of your progress! >> > >> > >> > First thing you might check: have you already initialized the various >> > authorities (including Person)? That's a manual process, after the >> > installation of CollectionSpace itself: >> > >> > https://wiki.collectionspace.org/display/DOC/Initializing+data >> > >> > >> > Best, >> > Aron >> > >> > >> > On Thu, Mar 24, 2016 at 9:59 AM, toni hanna <toni@creyasoft.com> wrote: >> > >> > >> >> Hi all. >> >> I installed CS on my windows box and was able to login. >> >> I am able to create various transactions, and save them. But when I try >> >> to add people names, i get the spinning wheel and nothing happen. I am >> >> obliged to cancel. I tried to create "people" from myworkspace, and I >> >> get the following error: "Connection exceptionCreate request failed: on >> >> org.collectionspace.services.person.PersonAuthorityResource csid=" >> Anyone >> >> knows how I can recover from this problem? Thanks. Toni. >> >> >> >> >> >> Here's the log from Tomcat screen: >> >> >> >> >> >> Setting NUXEO_HOME >> >> Setting JAVA_OPTS >> >> Using JAVA_OPTS=""-Dslf4j.detectLoggerNameMismatch=true >> >> -Dlog4j.debug=true >> >> -Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log >> >> -Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server >> >> -Dfile.encoding=UTF-8 -Xms512m -Xmx1024m -XX:MaxPermSize=256m >> >> -Dfile.encoding=UTF-8"" >> >> >> >> >> >> -Djava.util.logging.config.file="C:\apache-tomcat-7.0.57\conf\logging.p >> >> roperties" >> >> -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager to >> >> launch Tomcat Using CATALINA_BASE: "C:\apache-tomcat-7.0.57" >> >> Using CATALINA_HOME: "C:\apache-tomcat-7.0.57" >> >> Using CATALINA_TMPDIR: "C:\apache-tomcat-7.0.57\temp" >> >> Using JRE_HOME: "C:\Java\jdk1.7.0_79" >> >> Using CLASSPATH: >> >> >> >> >> >> "C:\apache-tomcat-7.0.57\bin\bootstrap.jar;C:\apache-tomcat-7.0.57\bin\ >> >> tomcat-juli.jar" >> >> >> >> "JPDA_OPTS=-agentlib:jdwp=transport=dt_socket,address=8000,server=y,sus >> >> pend=n" Listening for transport dt_socket at address: 8000 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >> >> version: Apache Tomcat/7.0.57 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >> built: >> >> Nov 3 2014 08:39:16 UTC >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >> >> number: 7.0.57.0 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: OS Name: >> >> Windows 7 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: OS Version: >> >> 6.1 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: >> Architecture: >> >> amd64 Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: JAVA_HOME: >> >> C:\Java\jdk1.7.0_79\jre >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: JVM >> Version: >> >> 1.7.0_79-b15 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: JVM Vendor: >> >> Oracle Corporation >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: >> >> CATALINA_BASE: C:\apache-tomcat-7.0.57 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: >> >> CATALINA_HOME: C:\apache-tomcat-7.0.57 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dslf4j.detectLoggerNameMismatch=true >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dlog4j.debug=true >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> -Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> -Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dfile.encoding=UTF-8 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Xms512m >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Xmx1024m >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -XX:MaxPermSize=256m >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dfile.encoding=UTF-8 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> >> >> >> >> -Djava.util.logging.config.file=C:\apache-tomcat-7.0.57\conf\ >> logging.pr >> >> operties Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Xmx1024m >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -XX:MaxPermSize=384m >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> -agentlib:jdwp=transport=dt_socket,address=8000,server=y,suspend=n >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: >> >> -Djava.endorsed.dirs=C:\apache-tomcat-7.0.57\endorsed >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dcatalina.base=C:\apache-tomcat-7.0.57 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Dcatalina.home=C:\apache-tomcat-7.0.57 >> >> Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.startup.VersionLoggerListener log INFO: Command >> line >> >> argument: -Djava.io.tmpdir=C:\apache-tomcat-7.0.57\temp >> >> Mar 24, 2016 6:27:47 PM org.apache.catalina.core.AprLifecycleListener >> >> lifecycleEvent INFO: Loaded APR based Apache Tomcat Native library >> 1.1.32 >> >> using APR version 1.5.1. Mar 24, 2016 6:27:47 PM >> >> org.apache.catalina.core.AprLifecycleListener lifecycleEvent INFO: APR >> >> capabilities: IPv6 [true], sendfile [true], accept filters >> >> [false], random [true]. >> >> Mar 24, 2016 6:27:48 PM org.apache.catalina.core.AprLifecycleListener >> >> initializeSSL INFO: OpenSSL successfully initialized (OpenSSL 1.0.1j 15 >> >> Oct 2014) >> >> Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init >> >> INFO: Initializing ProtocolHandler ["http-apr-8180"] >> >> Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init >> >> INFO: Initializing ProtocolHandler ["ajp-apr-8009"] >> >> Mar 24, 2016 6:27:48 PM org.apache.catalina.startup.Catalina load >> >> INFO: Initialization processed in 1946 ms >> >> Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardService >> >> startInternal INFO: Starting service Catalina >> >> Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardEngine >> >> startInternal INFO: Starting Servlet Engine: Apache Tomcat/7.0.57 >> >> Mar 24, 2016 6:27:49 PM org.apache.catalina.startup.HostConfig >> deployWAR >> >> INFO: Deploying web application archive >> >> C:\apache-tomcat-7.0.57\webapps\collectionspace.war >> >> Mar 24, 2016 6:27:54 PM org.apache.catalina.util.SessionIdGenerator >> >> createSecureRandom INFO: Creation of SecureRandom instance for session >> ID >> >> generation using [SHA1PRNG] took [156] milliseconds. >> >> log4j: Trying to find [log4j.xml] using context classloader >> >> WebappClassLoader >> >> context: /collectionspace >> >> delegate: false >> >> repositories: >> >> /WEB-INF/classes/ >> >> ----------> Parent Classloader: >> >> org.apache.catalina.loader.StandardClassLoader@344986 . >> >> log4j: Trying to find [log4j.xml] using WebappClassLoader >> >> context: /collectionspace >> >> delegate: false >> >> repositories: >> >> /WEB-INF/classes/ >> >> ----------> Parent Classloader: >> >> org.apache.catalina.loader.StandardClassLoader@344986 class loader. >> log4j: >> >> Trying to find [log4j.xml] using ClassLoader.getSystemResource(). >> >> log4j: Trying to find [log4j.properties] using context classloader >> >> WebappClassLoader >> >> context: /collectionspace >> >> delegate: false >> >> repositories: >> >> /WEB-INF/classes/ >> >> ----------> Parent Classloader: >> >> org.apache.catalina.loader.StandardClassLoader@344986 . >> >> log4j: Using URL >> >> >> >> >> >> [file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/classes/ >> >> log4j.properties] for automatic log4j configuration. log4j: Reading >> >> configuration from URL >> >> >> >> file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/classes/l >> >> og4j.properties log4j: Parsing for [root] with value=[ERROR, stdout, >> R]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category root set to ERROR >> >> log4j: Parsing appender named "stdout". >> >> log4j: Parsing layout options for "stdout". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "stdout". >> >> log4j: Setting property [target] to [System.out]. >> >> log4j: Parsed "stdout" options. >> >> log4j: Parsing appender named "R". >> >> log4j: Parsing layout options for "R". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "R". >> >> log4j: Setting property [file] to >> >> [C:\apache-tomcat-7.0.57/logs/cspace-app.log]. >> >> log4j: Setting property [maxBackupIndex] to [10]. >> >> log4j: Setting property [maxFileSize] to [5000KB]. >> >> log4j: setFile called: C:\apache-tomcat-7.0.57/logs/cspace-app.log, >> true >> >> log4j: setFile ended >> >> log4j: Parsed "R" options. >> >> log4j: Parsing for >> >> [org.collectionspace.chain.controller.AppConfigDeployFileFilter] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category >> >> org.collectionspace.chain.controller.AppConfigDeployFileFilter set to >> >> ERROR >> >> log4j: Handling >> >> >> >> >> >> log4j.additivity.org.collectionspace.chain.controller.AppConfigDeployFi >> >> leFilter=[null] log4j: Parsing for >> >> >> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHandl >> >> er] with value=[INFO]. log4j: Level token is [INFO]. >> >> log4j: Category >> >> >> org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHandle >> >> r set to INFO log4j: Handling >> >> >> >> >> >> log4j.additivity.org.collectionspace.chain.csp.config.impl.parser.Assem >> >> blingContentHandler=[null] log4j: Parsing for >> >> [org.collectionspace.chain.controller.CommandLine] with >> >> value=[ERROR, commandline]. log4j: Level token is [ERROR]. >> >> log4j: Category org.collectionspace.chain.controller.CommandLine set to >> >> ERROR >> >> log4j: Parsing appender named "commandline". >> >> log4j: Parsing layout options for "commandline". >> >> log4j: Setting property [conversionPattern] to [%d %p: %m%n]. >> >> log4j: End of parsing for "commandline". >> >> log4j: Setting property [target] to [System.err]. >> >> log4j: Parsed "commandline" options. >> >> log4j: Handling >> >> >> log4j.additivity.org.collectionspace.chain.controller.CommandLine=[false >> >> ] >> >> log4j: Setting additivity for >> >> "org.collectionspace.chain.controller.CommandLine" to false >> >> log4j: Parsing for >> >> [org.collectionspace.chain.installation.XsdGeneration] >> >> with value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category org.collectionspace.chain.installation.XsdGeneration >> set >> >> to ERROR log4j: Handling >> >> >> >> >> >> log4j.additivity.org.collectionspace.chain.installation.XsdGeneration=[ >> >> null] log4j: Parsing for [org.collectionspace.chain.installation] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category org.collectionspace.chain.installation set to ERROR >> >> log4j: Handling >> >> log4j.additivity.org.collectionspace.chain.installation=[null] log4j: >> >> Parsing for [org.collectionspace.chain.csp.webui.misc] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category org.collectionspace.chain.csp.webui.misc set to ERROR >> >> log4j: Handling >> >> log4j.additivity.org.collectionspace.chain.csp.webui.misc=[null] log4j: >> >> Parsing for [org.apache.commons.httpclient.auth] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category org.apache.commons.httpclient.auth set to WARN >> >> log4j: Handling >> >> log4j.additivity.org.apache.commons.httpclient.auth=[null] log4j: >> >> Parsing for [org.collectionspace.csp.helper.core.ConfigFinder] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category org.collectionspace.csp.helper.core.ConfigFinder set to >> >> ERROR >> >> log4j: Handling >> >> >> log4j.additivity.org.collectionspace.csp.helper.core.ConfigFinder=[null] >> >> log4j: Parsing for [org.collectionspace.perflog] with value=[INFO, >> >> perflogappend]. log4j: Level token is [INFO]. >> >> log4j: Category org.collectionspace.perflog set to INFO >> >> log4j: Parsing appender named "perflogappend". >> >> log4j: Parsing layout options for "perflogappend". >> >> log4j: Setting property [conversionPattern] to ["%d",%m%n]. >> >> log4j: End of parsing for "perflogappend". >> >> log4j: Setting property [file] to [/tmp/cspace-app-perflog.csv]. >> >> log4j: Setting property [maxFileSize] to [10MB]. >> >> log4j: Setting property [maxBackupIndex] to [1]. >> >> log4j: setFile called: /tmp/cspace-app-perflog.csv, true >> >> log4j: setFile ended >> >> log4j: Parsed "perflogappend" options. >> >> log4j: Handling log4j.additivity.org.collectionspace.perflog=[false] >> >> log4j: Setting additivity for "org.collectionspace.perflog" to false >> >> log4j: Parsing for [org.collectionspace.chain.installation.Services] >> >> with value=[DEBUG]. log4j: Level token is [DEBUG]. >> >> log4j: Category org.collectionspace.chain.installation.Services set to >> >> DEBUG >> >> log4j: Handling >> >> log4j.additivity.org.collectionspace.chain.installation.Services=[null] >> >> log4j: Finished configuring. >> >> Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig >> deployWAR >> >> INFO: Deployment of web application archive >> >> C:\apache-tomcat-7.0.57\webapps\collectionspace.war has finished in >> >> 5,564 >> >> ms Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig >> >> deployWAR INFO: Deploying web application archive >> >> C:\apache-tomcat-7.0.57\webapps\cspace-services.war >> >> log4j: Trying to find [log4j.xml] using context classloader >> >> WebappClassLoader >> >> context: /cspace-services >> >> delegate: false >> >> repositories: >> >> /WEB-INF/classes/ >> >> ----------> Parent Classloader: >> >> org.apache.catalina.loader.StandardClassLoader@344986 . >> >> log4j: Trying to find [log4j.xml] using >> >> org.apache.catalina.loader.StandardClassLoader@344986 class loader. >> >> log4j: Trying to find [log4j.xml] using >> >> ClassLoader.getSystemResource(). >> >> log4j: Trying to find [log4j.properties] using context classloader >> >> WebappClassLoader >> >> context: /cspace-services >> >> delegate: false >> >> repositories: >> >> /WEB-INF/classes/ >> >> ----------> Parent Classloader: >> >> org.apache.catalina.loader.StandardClassLoader@344986 . >> >> log4j: Using URL >> >> >> >> >> >> [file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/classes/ >> >> log4j.properties] for automatic log4j configuration. log4j: Reading >> >> configuration from URL >> >> >> >> file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/classes/l >> >> og4j.properties log4j: Parsing for [root] with value=[WARN, error, >> >> cspace_appender]. log4j: Level token is [WARN]. >> >> log4j: Category root set to WARN >> >> log4j: Parsing appender named "error". >> >> log4j: Parsing layout options for "error". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "error". >> >> log4j: Setting property [threshold] to [WARN]. >> >> log4j: Parsed "error" options. >> >> log4j: Parsing appender named "cspace_appender". >> >> log4j: Parsing layout options for "cspace_appender". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "cspace_appender". >> >> log4j: Setting property [maxBackupIndex] to [10]. >> >> log4j: Setting property [maxFileSize] to [5000KB]. >> >> log4j: Setting property [file] to >> >> [C:\apache-tomcat-7.0.57/logs/cspace-services.log]. >> >> log4j: setFile called: >> C:\apache-tomcat-7.0.57/logs/cspace-services.log, >> >> true log4j: setFile ended >> >> log4j: Parsed "cspace_appender" options. >> >> log4j: Parsing for [org.apache] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category org.apache set to WARN >> >> log4j: Handling log4j.additivity.org.apache=[null] >> >> log4j: Parsing for [org.jboss.resteasy] with value=[ERROR]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category org.jboss.resteasy set to ERROR >> >> log4j: Handling log4j.additivity.org.jboss.resteasy=[null] >> >> log4j: Parsing for [perf.collectionspace] with value=[WARN, >> >> cspace_perf_appender, stdout]. log4j: Level token is [WARN]. >> >> log4j: Category perf.collectionspace set to WARN >> >> log4j: Parsing appender named "cspace_perf_appender". >> >> log4j: Parsing layout options for "cspace_perf_appender". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "cspace_perf_appender". >> >> log4j: Setting property [maxBackupIndex] to [10]. >> >> log4j: Setting property [maxFileSize] to [5000KB]. >> >> log4j: Setting property [file] to >> >> [C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log]. >> >> log4j: setFile called: >> >> C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log, true >> >> log4j: setFile ended >> >> log4j: Parsed "cspace_perf_appender" options. >> >> log4j: Parsing appender named "stdout". >> >> log4j: Parsing layout options for "stdout". >> >> log4j: Setting property [conversionPattern] to [%d %-5p [%t] [%c:%L] >> >> %m%n]. >> >> log4j: End of parsing for "stdout". >> >> log4j: Parsed "stdout" options. >> >> log4j: Handling log4j.additivity.perf.collectionspace=[false] >> >> log4j: Setting additivity for "perf.collectionspace" to false >> >> log4j: Parsing for [ch.elca.el4j.services.xmlmerge] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category ch.elca.el4j.services.xmlmerge set to WARN >> >> log4j: Handling log4j.additivity.ch.elca.el4j.services.xmlmerge=[null] >> >> log4j: Parsing for [org.nuxeo] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category org.nuxeo set to WARN >> >> log4j: Handling log4j.additivity.org.nuxeo=[null] >> >> log4j: Parsing for [org.springframework.security] with value=[ERROR]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category org.springframework.security set to ERROR >> >> log4j: Handling log4j.additivity.org.springframework.security=[null] >> >> log4j: Parsing for [org.apache.catalina.realm] with value=[ERROR]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category org.apache.catalina.realm set to ERROR >> >> log4j: Handling log4j.additivity.org.apache.catalina.realm=[null] >> >> log4j: Parsing for [org.collectionspace] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category org.collectionspace set to WARN >> >> log4j: Handling log4j.additivity.org.collectionspace=[null] >> >> log4j: Parsing for [org.hibernate] with value=[ERROR]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category org.hibernate set to ERROR >> >> log4j: Handling log4j.additivity.org.hibernate=[null] >> >> log4j: Parsing for >> >> [org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded] >> >> with value=[TRACE]. log4j: Level token is [TRACE]. >> >> log4j: Category >> >> org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded set >> >> to TRACE >> >> log4j: Handling >> >> >> >> >> >> log4j.additivity.org.collectionspace.services.nuxeo.client.java.NuxeoCl >> >> ientEmbedded=[null] log4j: Parsing for [org.springframework] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category org.springframework set to ERROR >> >> log4j: Handling log4j.additivity.org.springframework=[null] >> >> log4j: Parsing for [org.jboss.security] with value=[ERROR]. >> >> log4j: Level token is [ERROR]. >> >> log4j: Category org.jboss.security set to ERROR >> >> log4j: Handling log4j.additivity.org.jboss.security=[null] >> >> log4j: Parsing for [httpclient] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category httpclient set to WARN >> >> log4j: Handling log4j.additivity.httpclient=[null] >> >> log4j: Parsing for [com.mchange.v2.resourcepool.BasicResourcePool] with >> >> value=[ERROR]. log4j: Level token is [ERROR]. >> >> log4j: Category com.mchange.v2.resourcepool.BasicResourcePool set to >> >> ERROR >> >> log4j: Handling >> >> log4j.additivity.com.mchange.v2.resourcepool.BasicResourcePool=[null] >> >> log4j: Parsing for [net.sf.jmimemagic.MagicParser] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category net.sf.jmimemagic.MagicParser set to WARN >> >> log4j: Handling log4j.additivity.net.sf.jmimemagic.MagicParser=[null] >> >> log4j: Parsing for [org.nuxeo.elasticsearch] with value=[INFO]. >> >> log4j: Level token is [INFO]. >> >> log4j: Category org.nuxeo.elasticsearch set to INFO >> >> log4j: Handling log4j.additivity.org.nuxeo.elasticsearch=[null] >> >> log4j: Parsing for [org.apache.catalina.core] with value=[WARN]. >> >> log4j: Level token is [WARN]. >> >> log4j: Category org.apache.catalina.core set to WARN >> >> log4j: Handling log4j.additivity.org.apache.catalina.core=[null] >> >> log4j: Finished configuring. >> >> 2016-03-24 18:28:10,690 WARN [localhost-startStop-1] >> >> >> >> >> >> [org.nuxeo.ecm.platform.commandline.executor.service.CommandLineExecuto >> >> rComponent:127] >> >> Command not available: pdftohtml (command pdftohtml not found in system >> >> path. You need to install pdftohtml) 2016-03-24 18:28:10,705 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.nuxeo.ecm.platform.commandline.executor.service.CommandLineExecuto >> >> rComponent:127] >> >> Command not available: wpd2text (command wpd2text not found in system >> >> path. You need to install wpd2text (deb: libwpd-tools) >> >> http://libwpd.sourceforge.net/download.html) >> >> 2016-03-24 18:28:12,421 ERROR [localhost-startStop-1] >> >> [org.nuxeo.runtime.osgi.OSGiRuntimeService:231] Unknown component >> >> 'OSGI-INF/layouts-contrib.xml' referenced by bundle >> >> 'org.collectionspace.publicitem'. Check the MANIFEST.MF >> >> 2016-03-24 18:28:12,421 ERROR [localhost-startStop-1] >> >> [org.nuxeo.runtime.api.Framework:496] >> >> 2016-03-24 18:28:17,041 ERROR [localhost-startStop-1] >> >> [org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl:223] Failed to >> >> connect to elasticsearch, check addressList and clusterName: No node >> >> available 2016-03-24 18:28:17,057 ERROR [localhost-startStop-1] >> >> [org.nuxeo.runtime.model.impl.RegistrationInfoImpl:338] Component >> >> notification of application started failed. java.lang.RuntimeException: >> >> Failed to connect to elasticsearch, check >> >> addressList and clusterName: No node available at >> >> >> >> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.checkClusterHealth( >> >> ElasticSearchAdminImpl.java:224) >> >> at >> >> >> >> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.connect(ElasticSear >> >> chAdminImpl.java:118) >> >> at >> >> >> >> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.<init>(ElasticSearc >> >> hAdminImpl.java:102) >> >> at >> >> >> >> org.nuxeo.elasticsearch.ElasticSearchComponent.applicationStarted(Elast >> >> icSearchComponent.java:174) >> >> at >> >> >> >> org.nuxeo.runtime.model.impl.RegistrationInfoImpl.notifyApplicationStar >> >> ted(RegistrationInfoImpl.java:336) >> >> at >> >> >> >> org.nuxeo.runtime.osgi.OSGiRuntimeService.notifyComponentsOnStarted(OSG >> >> iRuntimeService.java:494) >> >> at >> >> >> >> org.nuxeo.runtime.osgi.OSGiRuntimeService.fireApplicationStarted(OSGiRu >> >> ntimeService.java:532) >> >> at >> >> >> >> org.nuxeo.runtime.osgi.OSGiRuntimeService.frameworkEvent(OSGiRuntimeSer >> >> vice.java:542) >> >> at org.nuxeo.osgi.OSGiAdapter.fireFrameworkEvent(OSGiAdapter.java:238) >> >> at >> >> >> >> org.nuxeo.osgi.application.loader.FrameworkLoader.doStart(FrameworkLoad >> >> er.java:232) >> >> at >> >> >> >> org.nuxeo.osgi.application.loader.FrameworkLoader.start(FrameworkLoader >> >> .java:112) >> >> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at >> >> >> >> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.ja >> >> va:57) >> >> at >> >> >> >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccesso >> >> rImpl.java:43) >> >> at java.lang.reflect.Method.invoke(Method.java:606) at >> >> >> >> org.nuxeo.osgi.application.FrameworkBootstrap.start(FrameworkBootstrap. >> >> java:132) >> >> at >> >> >> >> org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbedded.s >> >> tartNuxeoEP(NuxeoConnectorEmbedded.java:115) >> >> at >> >> >> >> org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbedded.i >> >> nitialize(NuxeoConnectorEmbedded.java:142) >> >> at >> >> >> >> org.collectionspace.services.common.ServiceMain.initialize(ServiceMain. >> >> java:182) >> >> at >> >> >> >> org.collectionspace.services.common.ServiceMain.getInstance(ServiceMain >> >> .java:124) >> >> at >> >> >> >> org.collectionspace.services.common.ServiceMain.getInstance(ServiceMain >> >> .java:108) >> >> at >> >> >> >> org.collectionspace.services.common.CollectionSpaceServiceContextListen >> >> er.contextInitialized(CollectionSpaceServiceContextListener.java:25) >> >> at >> >> >> >> org.apache.catalina.core.StandardContext.listenerStart(StandardContext. >> >> java:4994) >> >> at >> >> >> >> org.apache.catalina.core.StandardContext.startInternal(StandardContext. >> >> java:5492) >> >> at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150) >> >> at >> >> >> >> org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.j >> >> ava:901) >> >> at >> >> org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877) >> >> at >> >> org.apache.catalina.core.StandardHost.addChild(StandardHost.java:649) >> >> at >> org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081) >> >> at >> >> org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:18 >> >> 77) >> >> at >> >> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) >> >> at java.util.concurrent.FutureTask.run(FutureTask.java:262) at >> >> >> >> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.ja >> >> va:1145) >> >> at >> >> >> >> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.j >> >> ava:615) >> >> at java.lang.Thread.run(Thread.java:745) 2016-03-24 18:28:21,659 WARN >> >> [Thread-5] >> >> [org.nuxeo.ecm.platform.convert.ooomanager.OOoManagerComponent:226] >> >> OpenOffice was not found, JOD Converter won't be available: officeHome >> >> doesn't exist or is not a directory: 2016-03-24 18:28:21,831 ERROR >> >> [localhost-startStop-1] >> >> [org.nuxeo.runtime.osgi.OSGiRuntimeService:552] Nuxeo Platform Started >> >> ====================================================================== >> >> = Component Loading Errors: >> >> * Unknown component 'OSGI-INF/layouts-contrib.xml' referenced by bundle >> >> 'org.collectionspace.publicitem' >> >> ====================================================================== >> >> = Component Loading Status: Pending: 5 / Unstarted: 0 / Total: 323 >> >> * service:org.nuxeo.ecm.platform.picture.web.preview.adapter.contrib >> >> requires [service:org.nuxeo.ecm.platform.preview.adapter.contrib] * >> >> service:org.nuxeo.ecm.automation.io.services.IOComponent requires >> >> [service:org.nuxeo.ecm.webengine.core.service.json] >> >> * service:org.nuxeo.logs.viewer.theme requires >> >> [service:org.nuxeo.theme.nuxeo.default] >> >> * service:com.collectionspace.query.model.override requires >> >> [service:org.nuxeo.ecm.webapp.querymodel.DefaultQueryModels] >> >> * service:org.nuxeo.ecm.login.token.authentication.contrib requires >> >> [service:org.nuxeo.ecm.automation.server.auth.config] >> >> ====================================================================== >> >> Mar 24, 2016 6:28:22 PM net.sf.ehcache.config.ConfigurationFactory >> >> parseConfiguration WARNING: No configuration found. Configuring ehcache >> >> from ehcache-failsafe.xml found in the classpath: >> >> >> >> jar:file:/C:/apache-tomcat-7.0.57/lib/ehcache-1.6.2.jar!/ehcache-failsa >> >> fe.xml 2016-03-24 18:28:25,720 WARN [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> idgenerators with tenant ID = 2 2016-03-24 18:28:25,736 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: id with >> >> tenant ID = 2 2016-03-24 18:28:25,829 WARN [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> servicegroups with tenant ID = 2 2016-03-24 18:28:25,954 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: Imports >> >> with tenant ID = 2 2016-03-24 18:28:25,970 WARN >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> Workflow >> >> with tenant ID = 2 2016-03-24 18:28:27,233 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> idgenerators with tenant ID = 1000 2016-03-24 18:28:27,233 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: id with >> >> tenant ID = 1000 2016-03-24 18:28:27,280 WARN [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> servicegroups with tenant ID = 1000 2016-03-24 18:28:27,389 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: Imports >> >> with tenant ID = 1000 2016-03-24 18:28:27,389 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> Workflow >> >> with tenant ID = 1000 2016-03-24 18:28:29,573 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> idgenerators with tenant ID = 1 2016-03-24 18:28:29,573 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: id with >> >> tenant ID = 1 2016-03-24 18:28:29,682 WARN [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> >> servicegroups with tenant ID = 1 2016-03-24 18:28:29,854 WARN >> >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: Imports >> >> with tenant ID = 1 2016-03-24 18:28:29,885 WARN >> [localhost-startStop-1] >> >> >> >> >> >> [org.collectionspace.services.common.authorization_mgt.AuthorizationCom >> >> mon:1042] >> >> Could not retrieve a lifecycle transition definition list from: >> Workflow >> >> with tenant ID = 1 [INFO] Starting up the CollectionSpace Services' >> >> JAX-RS application. >> >> Static initialization of: >> >> org.collectionspace.services.common.security.SecurityInterceptor [INFO] >> >> CollectionSpace Services' JAX-RS application started. >> >> Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig >> deployWAR >> >> INFO: Deployment of web application archive >> >> C:\apache-tomcat-7.0.57\webapps\cspace-services.war has finished in >> >> 42,946 >> >> ms Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig >> >> deployWAR INFO: Deploying web application archive >> >> C:\apache-tomcat-7.0.57\webapps\cspace-ui.war >> >> Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig >> deployWAR >> >> INFO: Deployment of web application archive >> >> C:\apache-tomcat-7.0.57\webapps\cspace-ui.war has finished in 2,948 ms >> >> Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deploying web application directory >> >> C:\apache-tomcat-7.0.57\webapps\docs >> >> Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deployment of web application directory >> >> C:\apache-tomcat-7.0.57\webapps\docs has finished in 1,887 ms >> >> Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deploying web application directory >> >> C:\apache-tomcat-7.0.57\webapps\examples >> >> Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deployment of web application directory >> >> C:\apache-tomcat-7.0.57\webapps\examples has finished in 2,582 ms >> >> Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deploying web application directory >> >> C:\apache-tomcat-7.0.57\webapps\host-manager >> >> Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deployment of web application directory >> >> C:\apache-tomcat-7.0.57\webapps\host-manager has finished in 1,903 ms >> >> Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deploying web application directory >> >> C:\apache-tomcat-7.0.57\webapps\manager >> >> Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deployment of web application directory >> >> C:\apache-tomcat-7.0.57\webapps\manager has finished in 2,043 ms >> >> Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deploying web application directory >> >> C:\apache-tomcat-7.0.57\webapps\ROOT >> >> Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.HostConfig >> >> deployDirectory INFO: Deployment of web application directory >> >> C:\apache-tomcat-7.0.57\webapps\ROOT has finished in 1,826 ms >> >> Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start >> >> INFO: Starting ProtocolHandler ["http-apr-8180"] >> >> Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start >> >> INFO: Starting ProtocolHandler ["ajp-apr-8009"] >> >> Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.Catalina start >> >> INFO: Server startup in 61877 ms >> >> 2016-03-24 18:29:10,509 WARN [http-apr-8180-exec-7] >> >> >> >> >> >> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand >> >> ler:412] >> >> Source file for "Include" tag could not be found: >> >> local-core-settings.xml 2016-03-24 18:29:10,587 INFO >> >> [http-apr-8180-exec-7] >> >> >> >> >> >> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand >> >> ler:172] >> >> XMLMerge results were written to file: >> >> >> >> >> >> C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\merged- >> >> settings.xml_local-core-settings.xml-.xml 2016-03-24 18:29:13,706 WARN >> >> [http-apr-8180-exec-8] >> >> >> >> >> >> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand >> >> ler:412] >> >> Source file for "Include" tag could not be found: >> >> local-core-settings.xml 2016-03-24 18:29:13,716 INFO >> >> [http-apr-8180-exec-8] >> >> >> >> >> >> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHand >> >> ler:172] >> >> XMLMerge results were written to file: >> >> >> >> >> >> C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\merged- >> >> settings.xml_local-core-settings.xml-.xml Could not get session from >> >> CSPACESESSID cookie with value: >> >> 1060fbf7c4f3c3ffe5f1694482b05019 >> >> 2016-03-24 18:29:34,371 WARN [http-apr-8180-exec-3] >> >> [org.collectionspace.services.common.security.SecurityInterceptor:359] >> >> Attempt to logout when Nuxeo login context was null >> >> setCharset(): UTF-8 >> >> 2016-03-24 18:29:36,262 WARN [http-apr-8180-exec-9] >> >> [org.collectionspace.services.common.security.SecurityInterceptor:359] >> >> Attempt to logout when Nuxeo login context was null >> >> setCharset(): UTF-8 >> >> >> >> >> >> >> >> >> >> _______________________________________________ >> >> Talk mailing list >> >> Talk@lists.collectionspace.org >> >> >> >> >> >> >> http://lists.collectionspace.org/mailman/listinfo/talk_lists.collection >> >> space.org >> >> >> > >> >> >> >

toni hanna

Fri, Mar 25, 2016 6:08 AM

Aron,

I did follow the process you described below and I see only one set of
currencies: the original/default 7 currencies.
But yet from within CS, the dropdown list for currency does not show any
values. I traced these values to the postgres table, and all 7 records
exist in there too. Any ideas?

I just tried another procedure, InTake, just to test other dropdowns,
"Entry Reason" shows a list of values, but "Entry Method", "Field
collection method", "Condition Check Method", and "Condition Check Reason"
do not show any values. Not sure if these are supposed to be empty to
start with... just trying to figure things out.

Thnks for all your help!

On Thu, March 24, 2016 8:52 pm, Aron Roberts wrote:

Forwarding the conversation that Toni Hanna and I have been having about
this issue, to the Talk list, so any others with insights can respond as
well ...

On Thu, Mar 24, 2016 at 6:50 PM, Aron Roberts
aron@socrates.berkeley.edu
wrote:

Hi Tony,

Re your questions 1 & 2 in reverse order.

From a quick look, most if not all of these messages are
informational and expected, regardless of their severity level. (There's
still some cleanup needed around this.)
While it's great that you now see authorities listed, after visiting
the relevant URL to initialize these, it's disconcerting that your
currency options disappeared from the Acquisitions record.

On its face, this sounds very much like an instance of this bug, slated
to be fixed in v4.4:

https://issues.collectionspace.org/browse/CSPACE-6391

When there are multiple instances of a vocabulary, such as the
"currency" vocabulary - as a result of the circumstances mentioned in
the Description of this issue - the active instance of the vocabulary
can sometimes have no terms present within it.

https://issues.collectionspace.org/browse/PAHMA-923?focusedCommentId=40
448&page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpan
el#comment-40448

Aron

Show me all the vocabularies

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies?pgSz=200

(The above example uses the default 'core' tenant and the default
administrator account and password; you can change whichever of these
may be relevant to your own installation.)

Find the CSIDs of all the vocabularies (entries returned by the above
command) whose shortIdentifier field contains "currency" (its refName
field will likely also contain "(currency)".

Hypothetically, your query will return two or more entries for currency
vocabularies, each one identified by its own CSID (ID number).

For each CSID returned (using '0357dec4-4db6-436e-86a2' here as just a
placeholder example for one of the CSIDs returned by the command above -
be sure to substitute its actual CSID for this placeholder value), find
out how many items it has:

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-8
6a2/items

If the totalItems field contains "0", that currency vocabulary is
empty. (I.e. it was one of the empty, duplicate vocabularies created by
the aforementioned bug.) You can delete it via:

curl -i -u admin@core.collectionspace.org:Administrator -X DELETE
http:/localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86
a2

Keep deleting empty vocabularies until the only remaining currency
vocabulary is one that contains terms.
Restart the CollectionSpace server.
Check the Acquisition record.
If you still don't see terms there, clear your browser's caches, per
https://wiki.collectionspace.org/display/DOC/Clearing+cached+content+fro
m+browsers

On Thu, Mar 24, 2016 at 4:51 PM, toni hanna toni@creyasoft.com wrote:

Thanks Aron: that did fix it. Now, I can see tons of people and
organizations. However, this initialization messed up some other
things. 1. When I do an Acquisition, the dropdown list of currency
type does not contain anything whereas before I had a list of
different currencies. 2. I see the following message repeatedly in the
command line screen: "2016-03-25 01:36:23,736 WARN
[http-apr-8180-exec-4]
[org.collectionspace.services.common.security.SecurityInterceptor:359]
Attempt to logout when Nuxeo login context was null"

Could these be because of the initialization? or is there something
else I need to do.

I also see other messages like:
"AcquisitionValidatorHandler executed.
2016-03-25 01:45:36,986 WARN [http-apr-8180-exec-6]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa
ndlerImpl:143]
Call failed to getRefnameDisplayName() for class

org.collectionspace.services.acquisition.nuxeo.AcquisitionDocumentMod
elHandler"

and also:

"2016-03-25 01:49:51,513 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa
ndlerImpl:143]
Call failed to getRefnameDisplayName() for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl
er setCharset(): UTF-8
2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationVa
lues:115]
Could not obtain CSID for Movement record from document event.
2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationVa
lues:116]
This event listener will not continue processing this event ...
setCharset(): UTF-8
2016-03-25 01:49:51,636 WARN [http-apr-8180-exec-10]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa
ndlerImpl:143]
Call failed to getRefnameDisplayName() for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl
er 2016-03-25 01:49:51,688 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationVa
lues:115]
Could not obtain CSID for Movement record from document event.
2016-03-25 01:49:51,689 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.listener.AbstractUpdateObjectLocationVa
lues:116]
This event listener will not continue processing this event ...
2016-03-25 01:49:51,707 WARN [http-apr-8180-exec-3]

[org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa
ndlerImpl:166]
Could not get document handler params from config bindings for class
org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl
er 2016-03-25 01:49:52,717 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID =
'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:52,743 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying
'cause'
exception. 2016-03-25 01:49:52,746 ERROR [http-apr-8180-exec-5]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP
500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes
ource.java:152)

org.collectionspace.services.blob.BlobResource.getDerivativeContent(B
lobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:52,754 ERROR [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.persistence.services.connection.Return
edDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
setCharset(): UTF-8
setCharset(): UTF-8
setCharset(): UTF-8
2016-03-25 01:49:53,113 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID =
'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,143 WARN [http-apr-8180-exec-5]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying
'cause'
exception. 2016-03-25 01:49:53,144 ERROR [http-apr-8180-exec-5]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP
500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes
ource.java:152)

org.collectionspace.services.blob.BlobResource.getDerivativeContent(B
lobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,149 ERROR [http-apr-8180-exec-4]

[org.collectionspace.chain.csp.persistence.services.connection.Return
edDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
2016-03-25 01:49:53,335 WARN [http-apr-8180-exec-1]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID =
'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,362 WARN [http-apr-8180-exec-1]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying
'cause'
exception. 2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-1]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP
500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes
ource.java:152)

org.collectionspace.services.blob.BlobResource.getDerivativeContent(B
lobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.persistence.services.connection.Return
edDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'.
2016-03-25 01:49:53,705 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994]
Could not retrieve document blob for Nuxeo document ID =
'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID =
'IMG_1781.JPG.1458863385607'
2016-03-25 01:49:53,721 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.CSWebApplicationException:30]
CSWebApplicationException instance created without an underlying
'cause'
exception. 2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-3]
[org.collectionspace.services.blob.BlobResource:499]
org.collectionspace.services.blob.BlobResource detail:
org.collectionspace.services.common.CSWebApplicationException: HTTP
500
Internal Server Error
-- message: HTTP 500 Internal Server Error
-- Stack Trace:
-- org.collectionspace.services.common.CSWebApplicationException:
HTTP 500 Internal Server Error

org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes
ource.java:152)

org.collectionspace.services.blob.BlobResource.getDerivativeContent(B
lobResource.java:339)

...first 4 lines. 54 more.

2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-4]

[org.collectionspace.chain.csp.persistence.services.connection.Return
edDocument:38]
Index failed. Could not get the contents for the Blob with CSID =
'49cbc098-17ab-4537-b152'."

Should I worry about these?

Thanks for your help.
Toni.

On Thu, March 24, 2016 12:38 pm, Aron Roberts wrote:

Hi Toni,

Delighted to learn of your progress!

First thing you might check: have you already initialized the
various authorities (including Person)? That's a manual process,
after the installation of CollectionSpace itself:

https://wiki.collectionspace.org/display/DOC/Initializing+data

Best,
Aron

On Thu, Mar 24, 2016 at 9:59 AM, toni hanna toni@creyasoft.com
wrote:

Hi all.
I installed CS on my windows box and was able to login.
I am able to create various transactions, and save them. But when
I try
to add people names, i get the spinning wheel and nothing happen.
I am
obliged to cancel. I tried to create "people" from myworkspace,
and I get the following error: "Connection exceptionCreate request
failed: on
org.collectionspace.services.person.PersonAuthorityResource csid="

Anyone

knows how I can recover from this problem? Thanks. Toni.

Here's the log from Tomcat screen:

-Djava.util.logging.config.file="C:\apache-tomcat-7.0.57\conf\log
ging.p roperties"
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
to launch Tomcat Using CATALINA_BASE: "C:\apache-tomcat-7.0.57"
Using CATALINA_HOME: "C:\apache-tomcat-7.0.57"
Using CATALINA_TMPDIR: "C:\apache-tomcat-7.0.57\temp"
Using JRE_HOME: "C:\Java\jdk1.7.0_79"
Using CLASSPATH:

"C:\apache-tomcat-7.0.57\bin\bootstrap.jar;C:\apache-tomcat-7.0.5
7\bin
tomcat-juli.jar"

"JPDA_OPTS=-agentlib:jdwp=transport=dt_socket,address=8000,server
=y,sus
pend=n" Listening for transport dt_socket at address: 8000 Mar 24,
2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server
version: Apache Tomcat/7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server

built:

Nov 3 2014 08:39:16 UTC
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: Server
number: 7.0.57.0
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: OS
Name:
Windows 7
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: OS
Version:
6.1
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:

Architecture:

amd64 Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
JAVA_HOME:
C:\Java\jdk1.7.0_79\jre
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: JVM

Version:

1.7.0_79-b15
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO: JVM
Vendor:
Oracle Corporation
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
CATALINA_BASE: C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
CATALINA_HOME: C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dslf4j.detectLoggerNameMismatch=true
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dlog4j.debug=true
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:
-Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:
-Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dfile.encoding=UTF-8
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Xms512m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Xmx1024m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -XX:MaxPermSize=256m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dfile.encoding=UTF-8
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:

-Djava.util.logging.config.file=C:\apache-tomcat-7.0.57\conf\

logging.pr

operties Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Xmx1024m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -XX:MaxPermSize=384m
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:
-agentlib:jdwp=transport=dt_socket,address=8000,server=y,suspend=n
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument:
-Djava.endorsed.dirs=C:\apache-tomcat-7.0.57\endorsed
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dcatalina.base=C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Dcatalina.home=C:\apache-tomcat-7.0.57
Mar 24, 2016 6:27:47 PM
org.apache.catalina.startup.VersionLoggerListener log INFO:
Command

line

argument: -Djava.io.tmpdir=C:\apache-tomcat-7.0.57\temp
Mar 24, 2016 6:27:47 PM
org.apache.catalina.core.AprLifecycleListener lifecycleEvent INFO:
Loaded APR based Apache Tomcat Native library

1.1.32

using APR version 1.5.1. Mar 24, 2016 6:27:47 PM
org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: APR
capabilities: IPv6 [true], sendfile [true], accept filters
[false], random [true].
Mar 24, 2016 6:27:48 PM
org.apache.catalina.core.AprLifecycleListener initializeSSL INFO:
OpenSSL successfully initialized (OpenSSL 1.0.1j 15
Oct 2014)
Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8180"]
Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
Mar 24, 2016 6:27:48 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1946 ms
Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardService
startInternal INFO: Starting service Catalina Mar 24, 2016 6:27:48
PM org.apache.catalina.core.StandardEngine
startInternal INFO: Starting Servlet Engine: Apache Tomcat/7.0.57
Mar 24, 2016 6:27:49 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\collectionspace.war
Mar 24, 2016 6:27:54 PM
org.apache.catalina.util.SessionIdGenerator createSecureRandom
INFO: Creation of SecureRandom instance for session

generation using [SHA1PRNG] took [156] milliseconds. log4j: Trying
to find [log4j.xml] using context classloader WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 . log4j:
Trying to find [log4j.xml] using WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 class
loader.

log4j:

Trying to find [log4j.xml] using ClassLoader.getSystemResource().
log4j: Trying to find [log4j.properties] using context
classloader WebappClassLoader
context: /collectionspace
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 . log4j:
Using URL

[file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/cl
asses/ log4j.properties] for automatic log4j configuration. log4j:
Reading
configuration from URL

file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/cla
sses/l og4j.properties log4j: Parsing for [root] with
value=[ERROR, stdout,

R].

log4j: Level token is [ERROR].
log4j: Category root set to ERROR
log4j: Parsing appender named "stdout".
log4j: Parsing layout options for "stdout".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "stdout".
log4j: Setting property [target] to [System.out].
log4j: Parsed "stdout" options.
log4j: Parsing appender named "R".
log4j: Parsing layout options for "R".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "R".
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-app.log].
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: setFile called:
C:\apache-tomcat-7.0.57/logs/cspace-app.log,

true

log4j: setFile ended
log4j: Parsed "R" options.
log4j: Parsing for
[org.collectionspace.chain.controller.AppConfigDeployFileFilter]
with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.collectionspace.chain.controller.AppConfigDeployFileFilter set
to ERROR
log4j: Handling

log4j.additivity.org.collectionspace.chain.controller.AppConfigDe
ployFi leFilter=[null] log4j: Parsing for

[org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHa
ndl

er] with value=[INFO]. log4j: Level token is [INFO]. log4j:
Category

org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHan
dle

r set to INFO log4j: Handling

log4j.additivity.org.collectionspace.chain.csp.config.impl.parser
.Assem
blingContentHandler=[null] log4j: Parsing for
[org.collectionspace.chain.controller.CommandLine] with
value=[ERROR, commandline]. log4j: Level token is [ERROR]. log4j:
Category org.collectionspace.chain.controller.CommandLine set to
ERROR
log4j: Parsing appender named "commandline".
log4j: Parsing layout options for "commandline".
log4j: Setting property [conversionPattern] to [%d %p: %m%n].
log4j: End of parsing for "commandline".
log4j: Setting property [target] to [System.err].
log4j: Parsed "commandline" options.
log4j: Handling

log4j.additivity.org.collectionspace.chain.controller.CommandLine=[fa
lse

]
log4j: Setting additivity for
"org.collectionspace.chain.controller.CommandLine" to false
log4j: Parsing for
[org.collectionspace.chain.installation.XsdGeneration]
with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.collectionspace.chain.installation.XsdGeneration

set

to ERROR log4j: Handling

log4j.additivity.org.collectionspace.chain.installation.XsdGenera
tion=[ null] log4j: Parsing for
[org.collectionspace.chain.installation] with
value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.collectionspace.chain.installation set to ERROR log4j:
Handling
log4j.additivity.org.collectionspace.chain.installation=[null]
log4j:
Parsing for [org.collectionspace.chain.csp.webui.misc] with
value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.collectionspace.chain.csp.webui.misc set to ERROR log4j:
Handling
log4j.additivity.org.collectionspace.chain.csp.webui.misc=[null]
log4j:
Parsing for [org.apache.commons.httpclient.auth] with
value=[WARN]. log4j: Level token is [WARN].
log4j: Category org.apache.commons.httpclient.auth set to WARN
log4j: Handling
log4j.additivity.org.apache.commons.httpclient.auth=[null] log4j:
Parsing for [org.collectionspace.csp.helper.core.ConfigFinder]
with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.collectionspace.csp.helper.core.ConfigFinder set to ERROR
log4j: Handling

log4j.additivity.org.collectionspace.csp.helper.core.ConfigFinder=[nu
ll]

log4j: Parsing for [org.collectionspace.perflog] with
value=[INFO, perflogappend]. log4j: Level token is [INFO]. log4j:
Category org.collectionspace.perflog set to INFO
log4j: Parsing appender named "perflogappend".
log4j: Parsing layout options for "perflogappend".
log4j: Setting property [conversionPattern] to ["%d",%m%n].
log4j: End of parsing for "perflogappend".
log4j: Setting property [file] to [/tmp/cspace-app-perflog.csv].
log4j: Setting property [maxFileSize] to [10MB].
log4j: Setting property [maxBackupIndex] to [1].
log4j: setFile called: /tmp/cspace-app-perflog.csv, true
log4j: setFile ended
log4j: Parsed "perflogappend" options.
log4j: Handling
log4j.additivity.org.collectionspace.perflog=[false] log4j:
Setting additivity for "org.collectionspace.perflog" to false
log4j: Parsing for
[org.collectionspace.chain.installation.Services]
with value=[DEBUG]. log4j: Level token is [DEBUG]. log4j: Category
org.collectionspace.chain.installation.Services set to DEBUG
log4j: Handling
log4j.additivity.org.collectionspace.chain.installation.Services=[
null] log4j: Finished configuring.
Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\collectionspace.war has finished
in 5,564
ms Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig
deployWAR INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-services.war
log4j: Trying to find [log4j.xml] using context classloader
WebappClassLoader
context: /cspace-services
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 . log4j:
Trying to find [log4j.xml] using
org.apache.catalina.loader.StandardClassLoader@344986 class
loader. log4j: Trying to find [log4j.xml] using
ClassLoader.getSystemResource().
log4j: Trying to find [log4j.properties] using context classloader
WebappClassLoader
context: /cspace-services
delegate: false
repositories:
/WEB-INF/classes/
----------> Parent Classloader:
org.apache.catalina.loader.StandardClassLoader@344986 . log4j:
Using URL

[file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/cl
asses/ log4j.properties] for automatic log4j configuration. log4j:
Reading
configuration from URL

file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/cla
sses/l og4j.properties log4j: Parsing for [root] with value=[WARN,
error, cspace_appender]. log4j: Level token is [WARN]. log4j:
Category root set to WARN
log4j: Parsing appender named "error".
log4j: Parsing layout options for "error".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "error".
log4j: Setting property [threshold] to [WARN].
log4j: Parsed "error" options.
log4j: Parsing appender named "cspace_appender".
log4j: Parsing layout options for "cspace_appender".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "cspace_appender".
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-services.log].
log4j: setFile called:

C:\apache-tomcat-7.0.57/logs/cspace-services.log,

true log4j: setFile ended log4j: Parsed "cspace_appender" options.
log4j: Parsing for [org.apache] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.apache set to WARN
log4j: Handling log4j.additivity.org.apache=[null]
log4j: Parsing for [org.jboss.resteasy] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.jboss.resteasy set to ERROR
log4j: Handling log4j.additivity.org.jboss.resteasy=[null]
log4j: Parsing for [perf.collectionspace] with value=[WARN,
cspace_perf_appender, stdout]. log4j: Level token is [WARN]. log4j:
Category perf.collectionspace set to WARN
log4j: Parsing appender named "cspace_perf_appender".
log4j: Parsing layout options for "cspace_perf_appender".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "cspace_perf_appender".
log4j: Setting property [maxBackupIndex] to [10].
log4j: Setting property [maxFileSize] to [5000KB].
log4j: Setting property [file] to
[C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log].
log4j: setFile called:
C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log, true
log4j: setFile ended
log4j: Parsed "cspace_perf_appender" options.
log4j: Parsing appender named "stdout".
log4j: Parsing layout options for "stdout".
log4j: Setting property [conversionPattern] to [%d %-5p [%t]
[%c:%L]
%m%n].
log4j: End of parsing for "stdout".
log4j: Parsed "stdout" options.
log4j: Handling log4j.additivity.perf.collectionspace=[false]
log4j: Setting additivity for "perf.collectionspace" to false
log4j: Parsing for [ch.elca.el4j.services.xmlmerge] with
value=[WARN]. log4j: Level token is [WARN].
log4j: Category ch.elca.el4j.services.xmlmerge set to WARN
log4j: Handling
log4j.additivity.ch.elca.el4j.services.xmlmerge=[null] log4j:
Parsing for [org.nuxeo] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.nuxeo set to WARN
log4j: Handling log4j.additivity.org.nuxeo=[null]
log4j: Parsing for [org.springframework.security] with
value=[ERROR]. log4j: Level token is [ERROR].
log4j: Category org.springframework.security set to ERROR
log4j: Handling
log4j.additivity.org.springframework.security=[null] log4j:
Parsing for [org.apache.catalina.realm] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.apache.catalina.realm set to ERROR
log4j: Handling log4j.additivity.org.apache.catalina.realm=[null]
log4j: Parsing for [org.collectionspace] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.collectionspace set to WARN
log4j: Handling log4j.additivity.org.collectionspace=[null]
log4j: Parsing for [org.hibernate] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.hibernate set to ERROR
log4j: Handling log4j.additivity.org.hibernate=[null]
log4j: Parsing for
[org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedde
d] with value=[TRACE]. log4j: Level token is [TRACE]. log4j:
Category
org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded
set to TRACE log4j: Handling

log4j.additivity.org.collectionspace.services.nuxeo.client.java.N
uxeoCl ientEmbedded=[null] log4j: Parsing for
[org.springframework] with
value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
org.springframework set to ERROR log4j: Handling
log4j.additivity.org.springframework=[null] log4j: Parsing for
[org.jboss.security] with value=[ERROR].
log4j: Level token is [ERROR].
log4j: Category org.jboss.security set to ERROR
log4j: Handling log4j.additivity.org.jboss.security=[null]
log4j: Parsing for [httpclient] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category httpclient set to WARN
log4j: Handling log4j.additivity.httpclient=[null]
log4j: Parsing for [com.mchange.v2.resourcepool.BasicResourcePool]
with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category
com.mchange.v2.resourcepool.BasicResourcePool set to ERROR
log4j: Handling
log4j.additivity.com.mchange.v2.resourcepool.BasicResourcePool=[nu
ll] log4j: Parsing for [net.sf.jmimemagic.MagicParser] with
value=[WARN]. log4j: Level token is [WARN].
log4j: Category net.sf.jmimemagic.MagicParser set to WARN
log4j: Handling
log4j.additivity.net.sf.jmimemagic.MagicParser=[null] log4j:
Parsing for [org.nuxeo.elasticsearch] with value=[INFO].
log4j: Level token is [INFO].
log4j: Category org.nuxeo.elasticsearch set to INFO
log4j: Handling log4j.additivity.org.nuxeo.elasticsearch=[null]
log4j: Parsing for [org.apache.catalina.core] with value=[WARN].
log4j: Level token is [WARN].
log4j: Category org.apache.catalina.core set to WARN
log4j: Handling log4j.additivity.org.apache.catalina.core=[null]
log4j: Finished configuring.
2016-03-24 18:28:10,690 WARN [localhost-startStop-1]

[org.nuxeo.ecm.platform.commandline.executor.service.CommandLineE
xecuto rComponent:127]
Command not available: pdftohtml (command pdftohtml not found in
system path. You need to install pdftohtml) 2016-03-24
18:28:10,705 WARN
[localhost-startStop-1]

[org.nuxeo.ecm.platform.commandline.executor.service.CommandLineE
xecuto rComponent:127]
Command not available: wpd2text (command wpd2text not found in
system path. You need to install wpd2text (deb: libwpd-tools)
http://libwpd.sourceforge.net/download.html)
2016-03-24 18:28:12,421 ERROR [localhost-startStop-1]
[org.nuxeo.runtime.osgi.OSGiRuntimeService:231] Unknown component
'OSGI-INF/layouts-contrib.xml' referenced by bundle
'org.collectionspace.publicitem'. Check the MANIFEST.MF
2016-03-24 18:28:12,421 ERROR [localhost-startStop-1]
[org.nuxeo.runtime.api.Framework:496]
2016-03-24 18:28:17,041 ERROR [localhost-startStop-1]
[org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl:223] Failed
to connect to elasticsearch, check addressList and clusterName: No
node available 2016-03-24 18:28:17,057 ERROR
[localhost-startStop-1]
[org.nuxeo.runtime.model.impl.RegistrationInfoImpl:338] Component
notification of application started failed.
java.lang.RuntimeException:
Failed to connect to elasticsearch, check
addressList and clusterName: No node available at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.checkClusterH
ealth( ElasticSearchAdminImpl.java:224)
at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.connect(Elast
icSear chAdminImpl.java:118)
at

org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.<init>(Elasti
cSearc hAdminImpl.java:102)
at

org.nuxeo.elasticsearch.ElasticSearchComponent.applicationStarted
(Elast
icSearchComponent.java:174)
at

org.nuxeo.runtime.model.impl.RegistrationInfoImpl.notifyApplicati
onStar ted(RegistrationInfoImpl.java:336)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.notifyComponentsOnStart
ed(OSG iRuntimeService.java:494)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.fireApplicationStarted(
OSGiRu
ntimeService.java:532)
at

org.nuxeo.runtime.osgi.OSGiRuntimeService.frameworkEvent(OSGiRunt
imeSer vice.java:542)
at
org.nuxeo.osgi.OSGiAdapter.fireFrameworkEvent(OSGiAdapter.java:23
8)
at

org.nuxeo.osgi.application.loader.FrameworkLoader.doStart(Framewo
rkLoad er.java:232)
at

org.nuxeo.osgi.application.loader.FrameworkLoader.start(Framework
Loader
.java:112)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at

sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorI
mpl.ja va:57)
at

sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodA
ccesso rImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606) at

org.nuxeo.osgi.application.FrameworkBootstrap.start(FrameworkBoot
strap. java:132)
at

org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbe
dded.s tartNuxeoEP(NuxeoConnectorEmbedded.java:115)
at

org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbe
dded.i nitialize(NuxeoConnectorEmbedded.java:142)
at

org.collectionspace.services.common.ServiceMain.initialize(Servic
eMain. java:182)
at

org.collectionspace.services.common.ServiceMain.getInstance(Servi
ceMain .java:124)
at

org.collectionspace.services.common.ServiceMain.getInstance(Servi
ceMain .java:108)
at

org.collectionspace.services.common.CollectionSpaceServiceContext
Listen
er.contextInitialized(CollectionSpaceServiceContextListener.java:2
5)
at

org.apache.catalina.core.StandardContext.listenerStart(StandardCo
ntext. java:4994)
at

org.apache.catalina.core.StandardContext.startInternal(StandardCo
ntext. java:5492)
at
org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:1
50)
at

org.apache.catalina.core.ContainerBase.addChildInternal(Container
Base.j
ava:901)
at
org.apache.catalina.core.ContainerBase.addChild(ContainerBase.jav
a:877)
at
org.apache.catalina.core.StandardHost.addChild(StandardHost.java:
649)
at

org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081
)

at
org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.j
ava:18
77)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.jav
a:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262) at

java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecu
tor.ja va:1145)
at

java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExec
utor.j ava:615)
at java.lang.Thread.run(Thread.java:745) 2016-03-24 18:28:21,659
WARN
[Thread-5]
[org.nuxeo.ecm.platform.convert.ooomanager.OOoManagerComponent:226
]
OpenOffice was not found, JOD Converter won't be available:
officeHome doesn't exist or is not a directory: 2016-03-24
18:28:21,831 ERROR
[localhost-startStop-1]
[org.nuxeo.runtime.osgi.OSGiRuntimeService:552] Nuxeo Platform
Started

====
= Component Loading Errors:

Unknown component 'OSGI-INF/layouts-contrib.xml' referenced by
bundle 'org.collectionspace.publicitem'

====
= Component Loading Status: Pending: 5 / Unstarted: 0 / Total: 323
*
service:org.nuxeo.ecm.platform.picture.web.preview.adapter.contri
b requires
[service:org.nuxeo.ecm.platform.preview.adapter.contrib] *
service:org.nuxeo.ecm.automation.io.services.IOComponent requires
[service:org.nuxeo.ecm.webengine.core.service.json]

service:org.nuxeo.logs.viewer.theme requires
[service:org.nuxeo.theme.nuxeo.default]
service:com.collectionspace.query.model.override requires
[service:org.nuxeo.ecm.webapp.querymodel.DefaultQueryModels]
service:org.nuxeo.ecm.login.token.authentication.contrib
requires [service:org.nuxeo.ecm.automation.server.auth.config]

====
Mar 24, 2016 6:28:22 PM net.sf.ehcache.config.ConfigurationFactory
parseConfiguration WARNING: No configuration found. Configuring
ehcache from ehcache-failsafe.xml found in the classpath:

jar:file:/C:/apache-tomcat-7.0.57/lib/ehcache-1.6.2.jar!/ehcache-
failsa fe.xml 2016-03-24 18:28:25,720 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 2 2016-03-24 18:28:25,736 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from: id
with tenant ID = 2 2016-03-24 18:28:25,829 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 2 2016-03-24 18:28:25,954 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
Imports
with tenant ID = 2 2016-03-24 18:28:25,970 WARN

[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 2 2016-03-24 18:28:27,233 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 1000 2016-03-24 18:28:27,233 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from: id
with tenant ID = 1000 2016-03-24 18:28:27,280 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 1000 2016-03-24 18:28:27,389 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
Imports
with tenant ID = 1000 2016-03-24 18:28:27,389 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 1000 2016-03-24 18:28:29,573 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
idgenerators with tenant ID = 1 2016-03-24 18:28:29,573 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from: id
with tenant ID = 1 2016-03-24 18:28:29,682 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
servicegroups with tenant ID = 1 2016-03-24 18:28:29,854 WARN
[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:
Imports
with tenant ID = 1 2016-03-24 18:28:29,885 WARN

[localhost-startStop-1]

[org.collectionspace.services.common.authorization_mgt.Authorizat
ionCom mon:1042]
Could not retrieve a lifecycle transition definition list from:

Workflow

with tenant ID = 1 [INFO] Starting up the CollectionSpace
Services'
JAX-RS application.
Static initialization of:
org.collectionspace.services.common.security.SecurityInterceptor
[INFO]
CollectionSpace Services' JAX-RS application started.
Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-services.war has finished
in 42,946
ms Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig
deployWAR INFO: Deploying web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-ui.war
Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig

deployWAR

INFO: Deployment of web application archive
C:\apache-tomcat-7.0.57\webapps\cspace-ui.war has finished in
2,948 ms
Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\docs
Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\docs has finished in 1,887 ms
Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\examples
Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\examples has finished in 2,582 ms
Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\host-manager
Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\host-manager has finished in
1,903 ms
Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\manager
Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\manager has finished in 2,043 ms
Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deploying web application directory
C:\apache-tomcat-7.0.57\webapps\ROOT
Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.HostConfig
deployDirectory INFO: Deployment of web application directory
C:\apache-tomcat-7.0.57\webapps\ROOT has finished in 1,826 ms
Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-8180"]
Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-8009"]
Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 61877 ms
2016-03-24 18:29:10,509 WARN [http-apr-8180-exec-7]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingConte
ntHand ler:412]
Source file for "Include" tag could not be found:
local-core-settings.xml 2016-03-24 18:29:10,587 INFO
[http-apr-8180-exec-7]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingConte
ntHand ler:172]
XMLMerge results were written to file:

C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\m
erged- settings.xml_local-core-settings.xml-.xml 2016-03-24
18:29:13,706 WARN
[http-apr-8180-exec-8]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingConte
ntHand ler:412]
Source file for "Include" tag could not be found:
local-core-settings.xml 2016-03-24 18:29:13,716 INFO
[http-apr-8180-exec-8]

[org.collectionspace.chain.csp.config.impl.parser.AssemblingConte
ntHand ler:172]
XMLMerge results were written to file:

C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\m
erged- settings.xml_local-core-settings.xml-.xml Could not get
session from CSPACESESSID cookie with value:
1060fbf7c4f3c3ffe5f1694482b05019
2016-03-24 18:29:34,371 WARN [http-apr-8180-exec-3]
[org.collectionspace.services.common.security.SecurityInterceptor:
359]
Attempt to logout when Nuxeo login context was null
setCharset(): UTF-8
2016-03-24 18:29:36,262 WARN [http-apr-8180-exec-9]
[org.collectionspace.services.common.security.SecurityInterceptor:
359]
Attempt to logout when Nuxeo login context was null
setCharset(): UTF-8

Talk mailing list
Talk@lists.collectionspace.org

http://lists.collectionspace.org/mailman/listinfo/talk_lists.collecti
on

space.org

Aron, I did follow the process you described below and I see only one set of currencies: the original/default 7 currencies. But yet from within CS, the dropdown list for currency does not show any values. I traced these values to the postgres table, and all 7 records exist in there too. Any ideas? I just tried another procedure, InTake, just to test other dropdowns, "Entry Reason" shows a list of values, but "Entry Method", "Field collection method", "Condition Check Method", and "Condition Check Reason" do not show any values. Not sure if these are supposed to be empty to start with... just trying to figure things out. Thnks for all your help! On Thu, March 24, 2016 8:52 pm, Aron Roberts wrote: > Forwarding the conversation that Toni Hanna and I have been having about > this issue, to the Talk list, so any others with insights can respond as > well ... > > On Thu, Mar 24, 2016 at 6:50 PM, Aron Roberts > <aron@socrates.berkeley.edu> > wrote: > > >> Hi Tony, >> >> >> Re your questions 1 & 2 in reverse order. >> >> >> 2. From a quick look, most if not all of these messages are >> informational and expected, regardless of their severity level. (There's >> still some cleanup needed around this.) >> >> 1. While it's great that you now see authorities listed, after visiting >> the relevant URL to initialize these, it's disconcerting that your >> currency options disappeared from the Acquisitions record. >> >> On its face, this sounds very much like an instance of this bug, slated >> to be fixed in v4.4: >> >> https://issues.collectionspace.org/browse/CSPACE-6391 >> >> >> When there are multiple instances of a vocabulary, such as the >> "currency" vocabulary - as a result of the circumstances mentioned in >> the Description of this issue - the active instance of the vocabulary >> can sometimes have no terms present within it. >> >> It's a bit painful, but a workaround is to find the empty currency >> vocabularies (those that have no items), and remove them, using the >> CollectionSpace REST API. After doing so, and after restarting the >> CollectionSpace server, you should once again see those terms. >> >> >> >> https://issues.collectionspace.org/browse/PAHMA-923?focusedCommentId=40 >> 448&page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpan >> el#comment-40448 >> >> Aron >> >> >> -- >> >> >> A sample of how you might delete the empty currency vocabularies, using >> cURL (an HTTP/multiprotocol client avaialble for Windows, etc.) at >> https://curl.haxx.se/download.html) ... I'm entering the following >> commands on a Mac: >> >> - Show me all the vocabularies >> >> >> curl -i -u admin@core.collectionspace.org:Administrator >> http://localhost:8180/cspace-services/vocabularies?pgSz=200 >> >> >> (The above example uses the default 'core' tenant and the default >> administrator account and password; you can change whichever of these >> may be relevant to your own installation.) >> >> - Find the CSIDs of all the vocabularies (entries returned by the above >> command) whose shortIdentifier field contains "currency" (its refName >> field will likely also contain "(currency)". >> >> Hypothetically, your query will return two or more entries for currency >> vocabularies, each one identified by its own CSID (ID number). >> >> For each CSID returned (using '0357dec4-4db6-436e-86a2' here as just a >> placeholder example for one of the CSIDs returned by the command above - >> be sure to substitute its actual CSID for this placeholder value), find >> out how many items it has: >> >> curl -i -u admin@core.collectionspace.org:Administrator >> http://localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-8 >> 6a2/items >> >> >> - If the totalItems field contains "0", that currency vocabulary is >> empty. (I.e. it was one of the empty, duplicate vocabularies created by >> the aforementioned bug.) You can delete it via: >> >> curl -i -u admin@core.collectionspace.org:Administrator -X DELETE >> http:/localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86 >> a2 >> >> - Keep deleting *empty* vocabularies until the only remaining currency >> vocabulary is one that contains terms. >> >> - Restart the CollectionSpace server. >> >> >> - Check the Acquisition record. >> >> >> - If you still don't see terms there, clear your browser's caches, per >> https://wiki.collectionspace.org/display/DOC/Clearing+cached+content+fro >> m+browsers >> >> On Thu, Mar 24, 2016 at 4:51 PM, toni hanna <toni@creyasoft.com> wrote: >> >> >>> Thanks Aron: that did fix it. Now, I can see tons of people and >>> organizations. However, this initialization messed up some other >>> things. 1. When I do an Acquisition, the dropdown list of currency >>> type does not contain anything whereas before I had a list of >>> different currencies. 2. I see the following message repeatedly in the >>> command line screen: "2016-03-25 01:36:23,736 WARN >>> [http-apr-8180-exec-4] >>> [org.collectionspace.services.common.security.SecurityInterceptor:359] >>> Attempt to logout when Nuxeo login context was null" >>> >>> >>> Could these be because of the initialization? or is there something >>> else I need to do. >>> >>> I also see other messages like: >>> "AcquisitionValidatorHandler executed. >>> 2016-03-25 01:45:36,986 WARN [http-apr-8180-exec-6] >>> >>> >>> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa >>> ndlerImpl:143] >>> Call failed to getRefnameDisplayName() for class >>> >>> >>> org.collectionspace.services.acquisition.nuxeo.AcquisitionDocumentMod >>> elHandler" >>> >>> and also: >>> >>> "2016-03-25 01:49:51,513 WARN [http-apr-8180-exec-10] >>> >>> >>> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa >>> ndlerImpl:143] >>> Call failed to getRefnameDisplayName() for class >>> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl >>> er setCharset(): UTF-8 >>> 2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10] >>> >>> >>> [org.collectionspace.services.listener.AbstractUpdateObjectLocationVa >>> lues:115] >>> Could not obtain CSID for Movement record from document event. >>> 2016-03-25 01:49:51,584 WARN [http-apr-8180-exec-10] >>> >>> >>> [org.collectionspace.services.listener.AbstractUpdateObjectLocationVa >>> lues:116] >>> This event listener will not continue processing this event ... >>> setCharset(): UTF-8 >>> 2016-03-25 01:49:51,636 WARN [http-apr-8180-exec-10] >>> >>> >>> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa >>> ndlerImpl:166] >>> Could not get document handler params from config bindings for class >>> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl >>> er 2016-03-25 01:49:51,641 WARN [http-apr-8180-exec-10] >>> [org.collectionspace.services.common.security.SecurityInterceptor:359] >>> Attempt to logout when Nuxeo login context was null >>> 2016-03-25 01:49:51,671 WARN [http-apr-8180-exec-3] >>> >>> >>> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa >>> ndlerImpl:143] >>> Call failed to getRefnameDisplayName() for class >>> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl >>> er 2016-03-25 01:49:51,688 WARN [http-apr-8180-exec-3] >>> >>> >>> [org.collectionspace.services.listener.AbstractUpdateObjectLocationVa >>> lues:115] >>> Could not obtain CSID for Movement record from document event. >>> 2016-03-25 01:49:51,689 WARN [http-apr-8180-exec-3] >>> >>> >>> [org.collectionspace.services.listener.AbstractUpdateObjectLocationVa >>> lues:116] >>> This event listener will not continue processing this event ... >>> 2016-03-25 01:49:51,707 WARN [http-apr-8180-exec-3] >>> >>> >>> [org.collectionspace.services.nuxeo.client.java.RemoteDocumentModelHa >>> ndlerImpl:166] >>> Could not get document handler params from config bindings for class >>> org.collectionspace.services.relation.nuxeo.RelationDocumentModelHandl >>> er 2016-03-25 01:49:52,717 WARN [http-apr-8180-exec-5] >>> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >>> Could not retrieve document blob for Nuxeo document ID = >>> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = >>> 'IMG_1781.JPG.1458863385607' >>> 2016-03-25 01:49:52,743 WARN [http-apr-8180-exec-5] >>> [org.collectionspace.services.common.CSWebApplicationException:30] >>> CSWebApplicationException instance created without an underlying >>> 'cause' >>> exception. 2016-03-25 01:49:52,746 ERROR [http-apr-8180-exec-5] >>> [org.collectionspace.services.blob.BlobResource:499] >>> org.collectionspace.services.blob.BlobResource detail: >>> org.collectionspace.services.common.CSWebApplicationException: HTTP >>> 500 >>> Internal Server Error >>> -- message: HTTP 500 Internal Server Error >>> -- Stack Trace: >>> -- org.collectionspace.services.common.CSWebApplicationException: >>> HTTP 500 Internal Server Error >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes >>> ource.java:152) >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getDerivativeContent(B >>> lobResource.java:339) >>> >>> >>> ...first 4 lines. 54 more. >>> >>> >>> 2016-03-25 01:49:52,754 ERROR [http-apr-8180-exec-7] >>> >>> >>> [org.collectionspace.chain.csp.persistence.services.connection.Return >>> edDocument:38] >>> Index failed. Could not get the contents for the Blob with CSID = >>> '49cbc098-17ab-4537-b152'. >>> setCharset(): UTF-8 >>> setCharset(): UTF-8 >>> setCharset(): UTF-8 >>> 2016-03-25 01:49:53,113 WARN [http-apr-8180-exec-5] >>> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >>> Could not retrieve document blob for Nuxeo document ID = >>> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = >>> 'IMG_1781.JPG.1458863385607' >>> 2016-03-25 01:49:53,143 WARN [http-apr-8180-exec-5] >>> [org.collectionspace.services.common.CSWebApplicationException:30] >>> CSWebApplicationException instance created without an underlying >>> 'cause' >>> exception. 2016-03-25 01:49:53,144 ERROR [http-apr-8180-exec-5] >>> [org.collectionspace.services.blob.BlobResource:499] >>> org.collectionspace.services.blob.BlobResource detail: >>> org.collectionspace.services.common.CSWebApplicationException: HTTP >>> 500 >>> Internal Server Error >>> -- message: HTTP 500 Internal Server Error >>> -- Stack Trace: >>> -- org.collectionspace.services.common.CSWebApplicationException: >>> HTTP 500 Internal Server Error >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes >>> ource.java:152) >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getDerivativeContent(B >>> lobResource.java:339) >>> >>> >>> ...first 4 lines. 54 more. >>> >>> >>> 2016-03-25 01:49:53,149 ERROR [http-apr-8180-exec-4] >>> >>> >>> [org.collectionspace.chain.csp.persistence.services.connection.Return >>> edDocument:38] >>> Index failed. Could not get the contents for the Blob with CSID = >>> '49cbc098-17ab-4537-b152'. >>> 2016-03-25 01:49:53,335 WARN [http-apr-8180-exec-1] >>> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >>> Could not retrieve document blob for Nuxeo document ID = >>> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = >>> 'IMG_1781.JPG.1458863385607' >>> 2016-03-25 01:49:53,362 WARN [http-apr-8180-exec-1] >>> [org.collectionspace.services.common.CSWebApplicationException:30] >>> CSWebApplicationException instance created without an underlying >>> 'cause' >>> exception. 2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-1] >>> [org.collectionspace.services.blob.BlobResource:499] >>> org.collectionspace.services.blob.BlobResource detail: >>> org.collectionspace.services.common.CSWebApplicationException: HTTP >>> 500 >>> Internal Server Error >>> -- message: HTTP 500 Internal Server Error >>> -- Stack Trace: >>> -- org.collectionspace.services.common.CSWebApplicationException: >>> HTTP 500 Internal Server Error >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes >>> ource.java:152) >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getDerivativeContent(B >>> lobResource.java:339) >>> >>> >>> ...first 4 lines. 54 more. >>> >>> >>> 2016-03-25 01:49:53,362 ERROR [http-apr-8180-exec-7] >>> >>> >>> [org.collectionspace.chain.csp.persistence.services.connection.Return >>> edDocument:38] >>> Index failed. Could not get the contents for the Blob with CSID = >>> '49cbc098-17ab-4537-b152'. >>> 2016-03-25 01:49:53,705 WARN [http-apr-8180-exec-3] >>> [org.collectionspace.services.common.imaging.nuxeo.NuxeoBlobUtils:994] >>> Could not retrieve document blob for Nuxeo document ID = >>> 'dc696ef4-0697-498c-90e8-69cd607ab51c' CSID = >>> 'IMG_1781.JPG.1458863385607' >>> 2016-03-25 01:49:53,721 WARN [http-apr-8180-exec-3] >>> [org.collectionspace.services.common.CSWebApplicationException:30] >>> CSWebApplicationException instance created without an underlying >>> 'cause' >>> exception. 2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-3] >>> [org.collectionspace.services.blob.BlobResource:499] >>> org.collectionspace.services.blob.BlobResource detail: >>> org.collectionspace.services.common.CSWebApplicationException: HTTP >>> 500 >>> Internal Server Error >>> -- message: HTTP 500 Internal Server Error >>> -- Stack Trace: >>> -- org.collectionspace.services.common.CSWebApplicationException: >>> HTTP 500 Internal Server Error >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getBlobContent(BlobRes >>> ource.java:152) >>> >>> >>> at >>> >>> org.collectionspace.services.blob.BlobResource.getDerivativeContent(B >>> lobResource.java:339) >>> >>> >>> ...first 4 lines. 54 more. >>> >>> >>> 2016-03-25 01:49:53,721 ERROR [http-apr-8180-exec-4] >>> >>> >>> [org.collectionspace.chain.csp.persistence.services.connection.Return >>> edDocument:38] >>> Index failed. Could not get the contents for the Blob with CSID = >>> '49cbc098-17ab-4537-b152'." >>> >>> >>> Should I worry about these? >>> >>> >>> Thanks for your help. >>> Toni. >>> >>> >>> On Thu, March 24, 2016 12:38 pm, Aron Roberts wrote: >>> >>>> Hi Toni, >>>> >>>> >>>> >>>> Delighted to learn of your progress! >>>> >>>> >>>> >>>> First thing you might check: have you already initialized the >>>> various authorities (including Person)? That's a manual process, >>>> after the installation of CollectionSpace itself: >>>> >>>> https://wiki.collectionspace.org/display/DOC/Initializing+data >>>> >>>> >>>> >>>> Best, >>>> Aron >>>> >>>> >>>> >>>> On Thu, Mar 24, 2016 at 9:59 AM, toni hanna <toni@creyasoft.com> >>>> wrote: >>>> >>>> >>>> >>>>> Hi all. >>>>> I installed CS on my windows box and was able to login. >>>>> I am able to create various transactions, and save them. But when >>>>> I try >>>>> to add people names, i get the spinning wheel and nothing happen. >>>>> I am >>>>> obliged to cancel. I tried to create "people" from myworkspace, >>>>> and I get the following error: "Connection exceptionCreate request >>>>> failed: on >>>>> org.collectionspace.services.person.PersonAuthorityResource csid=" >>>>> >>> Anyone >>> >>>>> knows how I can recover from this problem? Thanks. Toni. >>>>> >>>>> >>>>> Here's the log from Tomcat screen: >>>>> >>>>> >>>>> >>>>> Setting NUXEO_HOME >>>>> Setting JAVA_OPTS >>>>> Using JAVA_OPTS=""-Dslf4j.detectLoggerNameMismatch=true >>>>> -Dlog4j.debug=true >>>>> -Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log >>>>> -Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server >>>>> -Dfile.encoding=UTF-8 -Xms512m -Xmx1024m -XX:MaxPermSize=256m >>>>> -Dfile.encoding=UTF-8"" >>>>> >>>>> >>>>> >>>>> -Djava.util.logging.config.file="C:\apache-tomcat-7.0.57\conf\log >>>>> ging.p roperties" >>>>> -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager >>>>> to launch Tomcat Using CATALINA_BASE: "C:\apache-tomcat-7.0.57" >>>>> Using CATALINA_HOME: "C:\apache-tomcat-7.0.57" >>>>> Using CATALINA_TMPDIR: "C:\apache-tomcat-7.0.57\temp" >>>>> Using JRE_HOME: "C:\Java\jdk1.7.0_79" >>>>> Using CLASSPATH: >>>>> >>>>> >>>>> >>>>> "C:\apache-tomcat-7.0.57\bin\bootstrap.jar;C:\apache-tomcat-7.0.5 >>>>> 7\bin\ >>>>> tomcat-juli.jar" >>>>> >>>>> "JPDA_OPTS=-agentlib:jdwp=transport=dt_socket,address=8000,server >>>>> =y,sus >>>>> pend=n" Listening for transport dt_socket at address: 8000 Mar 24, >>>>> 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >>>>> version: Apache Tomcat/7.0.57 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >>>>> >>> built: >>> >>>>> Nov 3 2014 08:39:16 UTC >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: Server >>>>> number: 7.0.57.0 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: OS >>>>> Name: >>>>> Windows 7 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: OS >>>>> Version: >>>>> 6.1 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>> Architecture: >>> >>>>> amd64 Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> JAVA_HOME: >>>>> C:\Java\jdk1.7.0_79\jre >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: JVM >>> Version: >>> >>>>> 1.7.0_79-b15 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: JVM >>>>> Vendor: >>>>> Oracle Corporation >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> CATALINA_BASE: C:\apache-tomcat-7.0.57 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> CATALINA_HOME: C:\apache-tomcat-7.0.57 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dslf4j.detectLoggerNameMismatch=true >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dlog4j.debug=true >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> -Dnuxeo.log.dir=C:\apache-tomcat-7.0.57\nuxeo-server\log >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> -Dnuxeo.home.dir=C:\apache-tomcat-7.0.57\nuxeo-server >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dfile.encoding=UTF-8 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Xms512m >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Xmx1024m >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -XX:MaxPermSize=256m >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dfile.encoding=UTF-8 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> >>>>> >>>>> >>>>> -Djava.util.logging.config.file=C:\apache-tomcat-7.0.57\conf\ >>>>> >>> logging.pr >>>>> operties Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Xmx1024m >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -XX:MaxPermSize=384m >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> -agentlib:jdwp=transport=dt_socket,address=8000,server=y,suspend=n >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: >>>>> -Djava.endorsed.dirs=C:\apache-tomcat-7.0.57\endorsed >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dcatalina.base=C:\apache-tomcat-7.0.57 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Dcatalina.home=C:\apache-tomcat-7.0.57 >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.startup.VersionLoggerListener log INFO: >>>>> Command >>>>> >>> line >>>>> argument: -Djava.io.tmpdir=C:\apache-tomcat-7.0.57\temp >>>>> Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.core.AprLifecycleListener lifecycleEvent INFO: >>>>> Loaded APR based Apache Tomcat Native library >>>>> >>> 1.1.32 >>> >>>>> using APR version 1.5.1. Mar 24, 2016 6:27:47 PM >>>>> org.apache.catalina.core.AprLifecycleListener lifecycleEvent >>>>> INFO: APR >>>>> capabilities: IPv6 [true], sendfile [true], accept filters >>>>> [false], random [true]. >>>>> Mar 24, 2016 6:27:48 PM >>>>> org.apache.catalina.core.AprLifecycleListener initializeSSL INFO: >>>>> OpenSSL successfully initialized (OpenSSL 1.0.1j 15 >>>>> Oct 2014) >>>>> Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init >>>>> INFO: Initializing ProtocolHandler ["http-apr-8180"] >>>>> Mar 24, 2016 6:27:48 PM org.apache.coyote.AbstractProtocol init >>>>> INFO: Initializing ProtocolHandler ["ajp-apr-8009"] >>>>> Mar 24, 2016 6:27:48 PM org.apache.catalina.startup.Catalina load >>>>> INFO: Initialization processed in 1946 ms >>>>> Mar 24, 2016 6:27:48 PM org.apache.catalina.core.StandardService >>>>> startInternal INFO: Starting service Catalina Mar 24, 2016 6:27:48 >>>>> PM org.apache.catalina.core.StandardEngine >>>>> startInternal INFO: Starting Servlet Engine: Apache Tomcat/7.0.57 >>>>> Mar 24, 2016 6:27:49 PM org.apache.catalina.startup.HostConfig >>>>> >>> deployWAR >>>>> INFO: Deploying web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\collectionspace.war >>>>> Mar 24, 2016 6:27:54 PM >>>>> org.apache.catalina.util.SessionIdGenerator createSecureRandom >>>>> INFO: Creation of SecureRandom instance for session >>>>> >>> ID >>> >>>>> generation using [SHA1PRNG] took [156] milliseconds. log4j: Trying >>>>> to find [log4j.xml] using context classloader WebappClassLoader >>>>> context: /collectionspace >>>>> delegate: false >>>>> repositories: >>>>> /WEB-INF/classes/ >>>>> ----------> Parent Classloader: >>>>> org.apache.catalina.loader.StandardClassLoader@344986 . log4j: >>>>> Trying to find [log4j.xml] using WebappClassLoader >>>>> context: /collectionspace >>>>> delegate: false >>>>> repositories: >>>>> /WEB-INF/classes/ >>>>> ----------> Parent Classloader: >>>>> org.apache.catalina.loader.StandardClassLoader@344986 class >>>>> loader. >>> log4j: >>> >>>>> Trying to find [log4j.xml] using ClassLoader.getSystemResource(). >>>>> log4j: Trying to find [log4j.properties] using context >>>>> classloader WebappClassLoader >>>>> context: /collectionspace >>>>> delegate: false >>>>> repositories: >>>>> /WEB-INF/classes/ >>>>> ----------> Parent Classloader: >>>>> org.apache.catalina.loader.StandardClassLoader@344986 . log4j: >>>>> Using URL >>>>> >>>>> >>>>> >>>>> [file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/cl >>>>> asses/ log4j.properties] for automatic log4j configuration. log4j: >>>>> Reading >>>>> configuration from URL >>>>> >>>>> file:/C:/apache-tomcat-7.0.57/webapps/collectionspace/WEB-INF/cla >>>>> sses/l og4j.properties log4j: Parsing for [root] with >>>>> value=[ERROR, stdout, >>> R]. >>> >>>>> log4j: Level token is [ERROR]. >>>>> log4j: Category root set to ERROR >>>>> log4j: Parsing appender named "stdout". >>>>> log4j: Parsing layout options for "stdout". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "stdout". >>>>> log4j: Setting property [target] to [System.out]. >>>>> log4j: Parsed "stdout" options. >>>>> log4j: Parsing appender named "R". >>>>> log4j: Parsing layout options for "R". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "R". >>>>> log4j: Setting property [file] to >>>>> [C:\apache-tomcat-7.0.57/logs/cspace-app.log]. >>>>> log4j: Setting property [maxBackupIndex] to [10]. >>>>> log4j: Setting property [maxFileSize] to [5000KB]. >>>>> log4j: setFile called: >>>>> C:\apache-tomcat-7.0.57/logs/cspace-app.log, >>>>> >>> true >>>>> log4j: setFile ended >>>>> log4j: Parsed "R" options. >>>>> log4j: Parsing for >>>>> [org.collectionspace.chain.controller.AppConfigDeployFileFilter] >>>>> with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.collectionspace.chain.controller.AppConfigDeployFileFilter set >>>>> to ERROR >>>>> log4j: Handling >>>>> >>>>> >>>>> >>>>> log4j.additivity.org.collectionspace.chain.controller.AppConfigDe >>>>> ployFi leFilter=[null] log4j: Parsing for >>>>> >>> [org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHa >>> ndl >>>>> er] with value=[INFO]. log4j: Level token is [INFO]. log4j: >>>>> Category >>>>> >>>>> >>> org.collectionspace.chain.csp.config.impl.parser.AssemblingContentHan >>> dle >>>>> r set to INFO log4j: Handling >>>>> >>>>> >>>>> log4j.additivity.org.collectionspace.chain.csp.config.impl.parser >>>>> .Assem >>>>> blingContentHandler=[null] log4j: Parsing for >>>>> [org.collectionspace.chain.controller.CommandLine] with >>>>> value=[ERROR, commandline]. log4j: Level token is [ERROR]. log4j: >>>>> Category org.collectionspace.chain.controller.CommandLine set to >>>>> ERROR >>>>> log4j: Parsing appender named "commandline". >>>>> log4j: Parsing layout options for "commandline". >>>>> log4j: Setting property [conversionPattern] to [%d %p: %m%n]. >>>>> log4j: End of parsing for "commandline". >>>>> log4j: Setting property [target] to [System.err]. >>>>> log4j: Parsed "commandline" options. >>>>> log4j: Handling >>>>> >>>>> >>> log4j.additivity.org.collectionspace.chain.controller.CommandLine=[fa >>> lse >>>>> ] >>>>> log4j: Setting additivity for >>>>> "org.collectionspace.chain.controller.CommandLine" to false >>>>> log4j: Parsing for >>>>> [org.collectionspace.chain.installation.XsdGeneration] >>>>> with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.collectionspace.chain.installation.XsdGeneration >>> set >>>>> to ERROR log4j: Handling >>>>> >>>>> >>>>> log4j.additivity.org.collectionspace.chain.installation.XsdGenera >>>>> tion=[ null] log4j: Parsing for >>>>> [org.collectionspace.chain.installation] with >>>>> value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.collectionspace.chain.installation set to ERROR log4j: >>>>> Handling >>>>> log4j.additivity.org.collectionspace.chain.installation=[null] >>>>> log4j: >>>>> Parsing for [org.collectionspace.chain.csp.webui.misc] with >>>>> value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.collectionspace.chain.csp.webui.misc set to ERROR log4j: >>>>> Handling >>>>> log4j.additivity.org.collectionspace.chain.csp.webui.misc=[null] >>>>> log4j: >>>>> Parsing for [org.apache.commons.httpclient.auth] with >>>>> value=[WARN]. log4j: Level token is [WARN]. >>>>> log4j: Category org.apache.commons.httpclient.auth set to WARN >>>>> log4j: Handling >>>>> log4j.additivity.org.apache.commons.httpclient.auth=[null] log4j: >>>>> Parsing for [org.collectionspace.csp.helper.core.ConfigFinder] >>>>> with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.collectionspace.csp.helper.core.ConfigFinder set to ERROR >>>>> log4j: Handling >>>>> >>>>> >>> log4j.additivity.org.collectionspace.csp.helper.core.ConfigFinder=[nu >>> ll] >>>>> log4j: Parsing for [org.collectionspace.perflog] with >>>>> value=[INFO, perflogappend]. log4j: Level token is [INFO]. log4j: >>>>> Category org.collectionspace.perflog set to INFO >>>>> log4j: Parsing appender named "perflogappend". >>>>> log4j: Parsing layout options for "perflogappend". >>>>> log4j: Setting property [conversionPattern] to ["%d",%m%n]. >>>>> log4j: End of parsing for "perflogappend". >>>>> log4j: Setting property [file] to [/tmp/cspace-app-perflog.csv]. >>>>> log4j: Setting property [maxFileSize] to [10MB]. >>>>> log4j: Setting property [maxBackupIndex] to [1]. >>>>> log4j: setFile called: /tmp/cspace-app-perflog.csv, true >>>>> log4j: setFile ended >>>>> log4j: Parsed "perflogappend" options. >>>>> log4j: Handling >>>>> log4j.additivity.org.collectionspace.perflog=[false] log4j: >>>>> Setting additivity for "org.collectionspace.perflog" to false >>>>> log4j: Parsing for >>>>> [org.collectionspace.chain.installation.Services] >>>>> with value=[DEBUG]. log4j: Level token is [DEBUG]. log4j: Category >>>>> org.collectionspace.chain.installation.Services set to DEBUG >>>>> log4j: Handling >>>>> log4j.additivity.org.collectionspace.chain.installation.Services=[ >>>>> null] log4j: Finished configuring. >>>>> Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig >>>>> >>> deployWAR >>>>> INFO: Deployment of web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\collectionspace.war has finished >>>>> in 5,564 >>>>> ms Mar 24, 2016 6:27:54 PM org.apache.catalina.startup.HostConfig >>>>> deployWAR INFO: Deploying web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\cspace-services.war >>>>> log4j: Trying to find [log4j.xml] using context classloader >>>>> WebappClassLoader >>>>> context: /cspace-services >>>>> delegate: false >>>>> repositories: >>>>> /WEB-INF/classes/ >>>>> ----------> Parent Classloader: >>>>> org.apache.catalina.loader.StandardClassLoader@344986 . log4j: >>>>> Trying to find [log4j.xml] using >>>>> org.apache.catalina.loader.StandardClassLoader@344986 class >>>>> loader. log4j: Trying to find [log4j.xml] using >>>>> ClassLoader.getSystemResource(). >>>>> log4j: Trying to find [log4j.properties] using context classloader >>>>> WebappClassLoader >>>>> context: /cspace-services >>>>> delegate: false >>>>> repositories: >>>>> /WEB-INF/classes/ >>>>> ----------> Parent Classloader: >>>>> org.apache.catalina.loader.StandardClassLoader@344986 . log4j: >>>>> Using URL >>>>> >>>>> >>>>> >>>>> [file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/cl >>>>> asses/ log4j.properties] for automatic log4j configuration. log4j: >>>>> Reading >>>>> configuration from URL >>>>> >>>>> file:/C:/apache-tomcat-7.0.57/webapps/cspace-services/WEB-INF/cla >>>>> sses/l og4j.properties log4j: Parsing for [root] with value=[WARN, >>>>> error, cspace_appender]. log4j: Level token is [WARN]. log4j: >>>>> Category root set to WARN >>>>> log4j: Parsing appender named "error". >>>>> log4j: Parsing layout options for "error". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "error". >>>>> log4j: Setting property [threshold] to [WARN]. >>>>> log4j: Parsed "error" options. >>>>> log4j: Parsing appender named "cspace_appender". >>>>> log4j: Parsing layout options for "cspace_appender". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "cspace_appender". >>>>> log4j: Setting property [maxBackupIndex] to [10]. >>>>> log4j: Setting property [maxFileSize] to [5000KB]. >>>>> log4j: Setting property [file] to >>>>> [C:\apache-tomcat-7.0.57/logs/cspace-services.log]. >>>>> log4j: setFile called: >>>>> >>> C:\apache-tomcat-7.0.57/logs/cspace-services.log, >>> >>>>> true log4j: setFile ended log4j: Parsed "cspace_appender" options. >>>>> log4j: Parsing for [org.apache] with value=[WARN]. >>>>> log4j: Level token is [WARN]. >>>>> log4j: Category org.apache set to WARN >>>>> log4j: Handling log4j.additivity.org.apache=[null] >>>>> log4j: Parsing for [org.jboss.resteasy] with value=[ERROR]. >>>>> log4j: Level token is [ERROR]. >>>>> log4j: Category org.jboss.resteasy set to ERROR >>>>> log4j: Handling log4j.additivity.org.jboss.resteasy=[null] >>>>> log4j: Parsing for [perf.collectionspace] with value=[WARN, >>>>> cspace_perf_appender, stdout]. log4j: Level token is [WARN]. log4j: >>>>> Category perf.collectionspace set to WARN >>>>> log4j: Parsing appender named "cspace_perf_appender". >>>>> log4j: Parsing layout options for "cspace_perf_appender". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "cspace_perf_appender". >>>>> log4j: Setting property [maxBackupIndex] to [10]. >>>>> log4j: Setting property [maxFileSize] to [5000KB]. >>>>> log4j: Setting property [file] to >>>>> [C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log]. >>>>> log4j: setFile called: >>>>> C:\apache-tomcat-7.0.57/logs/cspace-services-perf.log, true >>>>> log4j: setFile ended >>>>> log4j: Parsed "cspace_perf_appender" options. >>>>> log4j: Parsing appender named "stdout". >>>>> log4j: Parsing layout options for "stdout". >>>>> log4j: Setting property [conversionPattern] to [%d %-5p [%t] >>>>> [%c:%L] >>>>> %m%n]. >>>>> log4j: End of parsing for "stdout". >>>>> log4j: Parsed "stdout" options. >>>>> log4j: Handling log4j.additivity.perf.collectionspace=[false] >>>>> log4j: Setting additivity for "perf.collectionspace" to false >>>>> log4j: Parsing for [ch.elca.el4j.services.xmlmerge] with >>>>> value=[WARN]. log4j: Level token is [WARN]. >>>>> log4j: Category ch.elca.el4j.services.xmlmerge set to WARN >>>>> log4j: Handling >>>>> log4j.additivity.ch.elca.el4j.services.xmlmerge=[null] log4j: >>>>> Parsing for [org.nuxeo] with value=[WARN]. >>>>> log4j: Level token is [WARN]. >>>>> log4j: Category org.nuxeo set to WARN >>>>> log4j: Handling log4j.additivity.org.nuxeo=[null] >>>>> log4j: Parsing for [org.springframework.security] with >>>>> value=[ERROR]. log4j: Level token is [ERROR]. >>>>> log4j: Category org.springframework.security set to ERROR >>>>> log4j: Handling >>>>> log4j.additivity.org.springframework.security=[null] log4j: >>>>> Parsing for [org.apache.catalina.realm] with value=[ERROR]. >>>>> log4j: Level token is [ERROR]. >>>>> log4j: Category org.apache.catalina.realm set to ERROR >>>>> log4j: Handling log4j.additivity.org.apache.catalina.realm=[null] >>>>> log4j: Parsing for [org.collectionspace] with value=[WARN]. >>>>> log4j: Level token is [WARN]. >>>>> log4j: Category org.collectionspace set to WARN >>>>> log4j: Handling log4j.additivity.org.collectionspace=[null] >>>>> log4j: Parsing for [org.hibernate] with value=[ERROR]. >>>>> log4j: Level token is [ERROR]. >>>>> log4j: Category org.hibernate set to ERROR >>>>> log4j: Handling log4j.additivity.org.hibernate=[null] >>>>> log4j: Parsing for >>>>> [org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedde >>>>> d] with value=[TRACE]. log4j: Level token is [TRACE]. log4j: >>>>> Category >>>>> org.collectionspace.services.nuxeo.client.java.NuxeoClientEmbedded >>>>> set to TRACE log4j: Handling >>>>> >>>>> >>>>> >>>>> log4j.additivity.org.collectionspace.services.nuxeo.client.java.N >>>>> uxeoCl ientEmbedded=[null] log4j: Parsing for >>>>> [org.springframework] with >>>>> value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> org.springframework set to ERROR log4j: Handling >>>>> log4j.additivity.org.springframework=[null] log4j: Parsing for >>>>> [org.jboss.security] with value=[ERROR]. >>>>> log4j: Level token is [ERROR]. >>>>> log4j: Category org.jboss.security set to ERROR >>>>> log4j: Handling log4j.additivity.org.jboss.security=[null] >>>>> log4j: Parsing for [httpclient] with value=[WARN]. >>>>> log4j: Level token is [WARN]. >>>>> log4j: Category httpclient set to WARN >>>>> log4j: Handling log4j.additivity.httpclient=[null] >>>>> log4j: Parsing for [com.mchange.v2.resourcepool.BasicResourcePool] >>>>> with value=[ERROR]. log4j: Level token is [ERROR]. log4j: Category >>>>> com.mchange.v2.resourcepool.BasicResourcePool set to ERROR >>>>> log4j: Handling >>>>> log4j.additivity.com.mchange.v2.resourcepool.BasicResourcePool=[nu >>>>> ll] log4j: Parsing for [net.sf.jmimemagic.MagicParser] with >>>>> value=[WARN]. log4j: Level token is [WARN]. >>>>> log4j: Category net.sf.jmimemagic.MagicParser set to WARN >>>>> log4j: Handling >>>>> log4j.additivity.net.sf.jmimemagic.MagicParser=[null] log4j: >>>>> Parsing for [org.nuxeo.elasticsearch] with value=[INFO]. >>>>> log4j: Level token is [INFO]. >>>>> log4j: Category org.nuxeo.elasticsearch set to INFO >>>>> log4j: Handling log4j.additivity.org.nuxeo.elasticsearch=[null] >>>>> log4j: Parsing for [org.apache.catalina.core] with value=[WARN]. >>>>> log4j: Level token is [WARN]. >>>>> log4j: Category org.apache.catalina.core set to WARN >>>>> log4j: Handling log4j.additivity.org.apache.catalina.core=[null] >>>>> log4j: Finished configuring. >>>>> 2016-03-24 18:28:10,690 WARN [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.nuxeo.ecm.platform.commandline.executor.service.CommandLineE >>>>> xecuto rComponent:127] >>>>> Command not available: pdftohtml (command pdftohtml not found in >>>>> system path. You need to install pdftohtml) 2016-03-24 >>>>> 18:28:10,705 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.nuxeo.ecm.platform.commandline.executor.service.CommandLineE >>>>> xecuto rComponent:127] >>>>> Command not available: wpd2text (command wpd2text not found in >>>>> system path. You need to install wpd2text (deb: libwpd-tools) >>>>> http://libwpd.sourceforge.net/download.html) >>>>> 2016-03-24 18:28:12,421 ERROR [localhost-startStop-1] >>>>> [org.nuxeo.runtime.osgi.OSGiRuntimeService:231] Unknown component >>>>> 'OSGI-INF/layouts-contrib.xml' referenced by bundle >>>>> 'org.collectionspace.publicitem'. Check the MANIFEST.MF >>>>> 2016-03-24 18:28:12,421 ERROR [localhost-startStop-1] >>>>> [org.nuxeo.runtime.api.Framework:496] >>>>> 2016-03-24 18:28:17,041 ERROR [localhost-startStop-1] >>>>> [org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl:223] Failed >>>>> to connect to elasticsearch, check addressList and clusterName: No >>>>> node available 2016-03-24 18:28:17,057 ERROR >>>>> [localhost-startStop-1] >>>>> [org.nuxeo.runtime.model.impl.RegistrationInfoImpl:338] Component >>>>> notification of application started failed. >>>>> java.lang.RuntimeException: >>>>> Failed to connect to elasticsearch, check >>>>> addressList and clusterName: No node available at >>>>> >>>>> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.checkClusterH >>>>> ealth( ElasticSearchAdminImpl.java:224) >>>>> at >>>>> >>>>> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.connect(Elast >>>>> icSear chAdminImpl.java:118) >>>>> at >>>>> >>>>> org.nuxeo.elasticsearch.core.ElasticSearchAdminImpl.<init>(Elasti >>>>> cSearc hAdminImpl.java:102) >>>>> at >>>>> >>>>> org.nuxeo.elasticsearch.ElasticSearchComponent.applicationStarted >>>>> (Elast >>>>> icSearchComponent.java:174) >>>>> at >>>>> >>>>> org.nuxeo.runtime.model.impl.RegistrationInfoImpl.notifyApplicati >>>>> onStar ted(RegistrationInfoImpl.java:336) >>>>> at >>>>> >>>>> org.nuxeo.runtime.osgi.OSGiRuntimeService.notifyComponentsOnStart >>>>> ed(OSG iRuntimeService.java:494) >>>>> at >>>>> >>>>> org.nuxeo.runtime.osgi.OSGiRuntimeService.fireApplicationStarted( >>>>> OSGiRu >>>>> ntimeService.java:532) >>>>> at >>>>> >>>>> org.nuxeo.runtime.osgi.OSGiRuntimeService.frameworkEvent(OSGiRunt >>>>> imeSer vice.java:542) >>>>> at >>>>> org.nuxeo.osgi.OSGiAdapter.fireFrameworkEvent(OSGiAdapter.java:23 >>>>> 8) >>>>> at >>>>> >>>>> org.nuxeo.osgi.application.loader.FrameworkLoader.doStart(Framewo >>>>> rkLoad er.java:232) >>>>> at >>>>> >>>>> org.nuxeo.osgi.application.loader.FrameworkLoader.start(Framework >>>>> Loader >>>>> .java:112) >>>>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at >>>>> >>>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorI >>>>> mpl.ja va:57) >>>>> at >>>>> >>>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodA >>>>> ccesso rImpl.java:43) >>>>> at java.lang.reflect.Method.invoke(Method.java:606) at >>>>> >>>>> org.nuxeo.osgi.application.FrameworkBootstrap.start(FrameworkBoot >>>>> strap. java:132) >>>>> at >>>>> >>>>> org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbe >>>>> dded.s tartNuxeoEP(NuxeoConnectorEmbedded.java:115) >>>>> at >>>>> >>>>> org.collectionspace.services.nuxeo.client.java.NuxeoConnectorEmbe >>>>> dded.i nitialize(NuxeoConnectorEmbedded.java:142) >>>>> at >>>>> >>>>> org.collectionspace.services.common.ServiceMain.initialize(Servic >>>>> eMain. java:182) >>>>> at >>>>> >>>>> org.collectionspace.services.common.ServiceMain.getInstance(Servi >>>>> ceMain .java:124) >>>>> at >>>>> >>>>> org.collectionspace.services.common.ServiceMain.getInstance(Servi >>>>> ceMain .java:108) >>>>> at >>>>> >>>>> org.collectionspace.services.common.CollectionSpaceServiceContext >>>>> Listen >>>>> er.contextInitialized(CollectionSpaceServiceContextListener.java:2 >>>>> 5) >>>>> at >>>>> >>>>> org.apache.catalina.core.StandardContext.listenerStart(StandardCo >>>>> ntext. java:4994) >>>>> at >>>>> >>>>> org.apache.catalina.core.StandardContext.startInternal(StandardCo >>>>> ntext. java:5492) >>>>> at >>>>> org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:1 >>>>> 50) >>>>> at >>>>> >>>>> org.apache.catalina.core.ContainerBase.addChildInternal(Container >>>>> Base.j >>>>> ava:901) >>>>> at >>>>> org.apache.catalina.core.ContainerBase.addChild(ContainerBase.jav >>>>> a:877) >>>>> at >>>>> org.apache.catalina.core.StandardHost.addChild(StandardHost.java: >>>>> 649) >>>>> at >>> org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081 >>> ) >>> >>>>> at >>>>> org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.j >>>>> ava:18 >>>>> 77) >>>>> at >>>>> java.util.concurrent.Executors$RunnableAdapter.call(Executors.jav >>>>> a:471) >>>>> at java.util.concurrent.FutureTask.run(FutureTask.java:262) at >>>>> >>>>> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecu >>>>> tor.ja va:1145) >>>>> at >>>>> >>>>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExec >>>>> utor.j ava:615) >>>>> at java.lang.Thread.run(Thread.java:745) 2016-03-24 18:28:21,659 >>>>> WARN >>>>> [Thread-5] >>>>> [org.nuxeo.ecm.platform.convert.ooomanager.OOoManagerComponent:226 >>>>> ] >>>>> OpenOffice was not found, JOD Converter won't be available: >>>>> officeHome doesn't exist or is not a directory: 2016-03-24 >>>>> 18:28:21,831 ERROR >>>>> [localhost-startStop-1] >>>>> [org.nuxeo.runtime.osgi.OSGiRuntimeService:552] Nuxeo Platform >>>>> Started >>>>> ================================================================== >>>>> ==== >>>>> = Component Loading Errors: >>>>> * Unknown component 'OSGI-INF/layouts-contrib.xml' referenced by >>>>> bundle 'org.collectionspace.publicitem' >>>>> ================================================================== >>>>> ==== >>>>> = Component Loading Status: Pending: 5 / Unstarted: 0 / Total: 323 >>>>> * >>>>> service:org.nuxeo.ecm.platform.picture.web.preview.adapter.contri >>>>> b requires >>>>> [service:org.nuxeo.ecm.platform.preview.adapter.contrib] * >>>>> service:org.nuxeo.ecm.automation.io.services.IOComponent requires >>>>> [service:org.nuxeo.ecm.webengine.core.service.json] >>>>> * service:org.nuxeo.logs.viewer.theme requires >>>>> [service:org.nuxeo.theme.nuxeo.default] >>>>> * service:com.collectionspace.query.model.override requires >>>>> [service:org.nuxeo.ecm.webapp.querymodel.DefaultQueryModels] >>>>> * service:org.nuxeo.ecm.login.token.authentication.contrib >>>>> requires [service:org.nuxeo.ecm.automation.server.auth.config] >>>>> ================================================================== >>>>> ==== >>>>> Mar 24, 2016 6:28:22 PM net.sf.ehcache.config.ConfigurationFactory >>>>> parseConfiguration WARNING: No configuration found. Configuring >>>>> ehcache from ehcache-failsafe.xml found in the classpath: >>>>> >>>>> jar:file:/C:/apache-tomcat-7.0.57/lib/ehcache-1.6.2.jar!/ehcache- >>>>> failsa fe.xml 2016-03-24 18:28:25,720 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> idgenerators with tenant ID = 2 2016-03-24 18:28:25,736 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: id >>>>> with tenant ID = 2 2016-03-24 18:28:25,829 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> servicegroups with tenant ID = 2 2016-03-24 18:28:25,954 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> Imports >>>>> with tenant ID = 2 2016-03-24 18:28:25,970 WARN >>> [localhost-startStop-1] >>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> >>> Workflow >>> >>>>> with tenant ID = 2 2016-03-24 18:28:27,233 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> idgenerators with tenant ID = 1000 2016-03-24 18:28:27,233 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: id >>>>> with tenant ID = 1000 2016-03-24 18:28:27,280 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> servicegroups with tenant ID = 1000 2016-03-24 18:28:27,389 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> Imports >>>>> with tenant ID = 1000 2016-03-24 18:28:27,389 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> >>> Workflow >>> >>>>> with tenant ID = 1000 2016-03-24 18:28:29,573 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> idgenerators with tenant ID = 1 2016-03-24 18:28:29,573 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: id >>>>> with tenant ID = 1 2016-03-24 18:28:29,682 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> servicegroups with tenant ID = 1 2016-03-24 18:28:29,854 WARN >>>>> [localhost-startStop-1] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> Imports >>>>> with tenant ID = 1 2016-03-24 18:28:29,885 WARN >>> [localhost-startStop-1] >>> >>>>> >>>>> >>>>> [org.collectionspace.services.common.authorization_mgt.Authorizat >>>>> ionCom mon:1042] >>>>> Could not retrieve a lifecycle transition definition list from: >>>>> >>> Workflow >>> >>>>> with tenant ID = 1 [INFO] Starting up the CollectionSpace >>>>> Services' >>>>> JAX-RS application. >>>>> Static initialization of: >>>>> org.collectionspace.services.common.security.SecurityInterceptor >>>>> [INFO] >>>>> CollectionSpace Services' JAX-RS application started. >>>>> Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig >>>>> >>> deployWAR >>>>> INFO: Deployment of web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\cspace-services.war has finished >>>>> in 42,946 >>>>> ms Mar 24, 2016 6:28:37 PM org.apache.catalina.startup.HostConfig >>>>> deployWAR INFO: Deploying web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\cspace-ui.war >>>>> Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig >>>>> >>> deployWAR >>>>> INFO: Deployment of web application archive >>>>> C:\apache-tomcat-7.0.57\webapps\cspace-ui.war has finished in >>>>> 2,948 ms >>>>> Mar 24, 2016 6:28:40 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deploying web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\docs >>>>> Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deployment of web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\docs has finished in 1,887 ms >>>>> Mar 24, 2016 6:28:42 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deploying web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\examples >>>>> Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deployment of web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\examples has finished in 2,582 ms >>>>> Mar 24, 2016 6:28:45 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deploying web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\host-manager >>>>> Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deployment of web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\host-manager has finished in >>>>> 1,903 ms >>>>> Mar 24, 2016 6:28:46 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deploying web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\manager >>>>> Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deployment of web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\manager has finished in 2,043 ms >>>>> Mar 24, 2016 6:28:48 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deploying web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\ROOT >>>>> Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.HostConfig >>>>> deployDirectory INFO: Deployment of web application directory >>>>> C:\apache-tomcat-7.0.57\webapps\ROOT has finished in 1,826 ms >>>>> Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start >>>>> INFO: Starting ProtocolHandler ["http-apr-8180"] >>>>> Mar 24, 2016 6:28:50 PM org.apache.coyote.AbstractProtocol start >>>>> INFO: Starting ProtocolHandler ["ajp-apr-8009"] >>>>> Mar 24, 2016 6:28:50 PM org.apache.catalina.startup.Catalina start >>>>> INFO: Server startup in 61877 ms >>>>> 2016-03-24 18:29:10,509 WARN [http-apr-8180-exec-7] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.chain.csp.config.impl.parser.AssemblingConte >>>>> ntHand ler:412] >>>>> Source file for "Include" tag could not be found: >>>>> local-core-settings.xml 2016-03-24 18:29:10,587 INFO >>>>> [http-apr-8180-exec-7] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.chain.csp.config.impl.parser.AssemblingConte >>>>> ntHand ler:172] >>>>> XMLMerge results were written to file: >>>>> >>>>> >>>>> >>>>> C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\m >>>>> erged- settings.xml_local-core-settings.xml-.xml 2016-03-24 >>>>> 18:29:13,706 WARN >>>>> [http-apr-8180-exec-8] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.chain.csp.config.impl.parser.AssemblingConte >>>>> ntHand ler:412] >>>>> Source file for "Include" tag could not be found: >>>>> local-core-settings.xml 2016-03-24 18:29:13,716 INFO >>>>> [http-apr-8180-exec-8] >>>>> >>>>> >>>>> >>>>> [org.collectionspace.chain.csp.config.impl.parser.AssemblingConte >>>>> ntHand ler:172] >>>>> XMLMerge results were written to file: >>>>> >>>>> >>>>> >>>>> C:\apache-tomcat-7.0.57\temp\merged-app-config-3847424086770026\m >>>>> erged- settings.xml_local-core-settings.xml-.xml Could not get >>>>> session from CSPACESESSID cookie with value: >>>>> 1060fbf7c4f3c3ffe5f1694482b05019 >>>>> 2016-03-24 18:29:34,371 WARN [http-apr-8180-exec-3] >>>>> [org.collectionspace.services.common.security.SecurityInterceptor: >>>>> 359] >>>>> Attempt to logout when Nuxeo login context was null >>>>> setCharset(): UTF-8 >>>>> 2016-03-24 18:29:36,262 WARN [http-apr-8180-exec-9] >>>>> [org.collectionspace.services.common.security.SecurityInterceptor: >>>>> 359] >>>>> Attempt to logout when Nuxeo login context was null >>>>> setCharset(): UTF-8 >>>>> >>>>> >>>>> >>>>> >>>>> >>>>> _______________________________________________ >>>>> Talk mailing list >>>>> Talk@lists.collectionspace.org >>>>> >>>>> >>>>> >>>>> >>> http://lists.collectionspace.org/mailman/listinfo/talk_lists.collecti >>> on >>>>> space.org >>>>> >>>> >>> >>> >>> >> >

Aron Roberts

Fri, Mar 25, 2016 4:32 PM

Hi Toni,

I might not be understanding your report correctly, but AFAIK, there
should only be one instance of the currency vocabulary, not seven.
(Additional, duplicate instances of that vocabulary might be created, up to
one vocabulary for each currency vocabulary-using field, as a result of the
CSPACE-6391 bug.)

I just tried another procedure, InTake, just to test other dropdowns,

"Entry Reason" shows a list of values, but "Entry Method", "Field
collection method", "Condition Check Method", and "Condition Check Reason"
do not show any values. Not sure if these are supposed to be empty to
start with... just trying to figure things out.

If I recall correctly, all of CollectionSpace's dropdown menus that draw
from controlled vocabulary terms are populated through the process of
initializing authorities. That process reads configuration files and
ultimately, associated entries in the database are created, based on that
configuration.

As I understand the CSPACE-6391 bug, if you install a CollectionSpace
server but then don't yet perform the additional step of initializing
authorities, if someone then - in CollectionSpace's web UI - visits one or
more types of records containing dropdown fields that draw from various
vocabularies, empty vocabularies will be auto-created. And because
duplicate vocabularies with the same string identifier (in contrast with
unique CSID/UUID values) exist, one or more of which are likely to be
empty, there's some probability that the values in some dropdown menus will
likely be empty as a result, even after you initialize authorities later
on. (The probabilistic nature of which vocabulary - of multiple
vocabularies bearing the same string identifier - is drawn from to populate
a dropdown in the UI might also help explain here why Entry Reason's
dropdown is populated in the UI, after initializing authorities, but those
of other fields in the same record are not.)

We've recently devoted some effort to finding squelching authorities
initialization bugs - a fair number of these were resolved by work that my
colleague Ray Lee did in one or more recent releases - but this one remains
to be addressed in v4.4. From Richard Millet's notes on this topic, it
might be a fairly simple fix, but that remains to be seen.

So the workaround remains: where two or more vocabulary records exist
with the same short identifier / refName, delete all of those records that
have zero vocabulary items associated with them.

(And to colleagues and others, I welcome correction here, if I'm not
characterizing this issue accurately.)

Aron

On Thu, Mar 24, 2016 at 11:08 PM, toni hanna toni@creyasoft.com wrote:

Aron,

Thnks for all your help!

On Thu, March 24, 2016 8:52 pm, Aron Roberts wrote:

Forwarding the conversation that Toni Hanna and I have been having about
this issue, to the Talk list, so any others with insights can respond as
well ...

On Thu, Mar 24, 2016 at 6:50 PM, Aron Roberts
aron@socrates.berkeley.edu
wrote:

Hi Tony,

Re your questions 1 & 2 in reverse order.

From a quick look, most if not all of these messages are
informational and expected, regardless of their severity level. (There's
still some cleanup needed around this.)
While it's great that you now see authorities listed, after visiting
the relevant URL to initialize these, it's disconcerting that your
currency options disappeared from the Acquisitions record.

On its face, this sounds very much like an instance of this bug, slated
to be fixed in v4.4:

https://issues.collectionspace.org/browse/CSPACE-6391

When there are multiple instances of a vocabulary, such as the
"currency" vocabulary - as a result of the circumstances mentioned in
the Description of this issue - the active instance of the vocabulary
can sometimes have no terms present within it.

https://issues.collectionspace.org/browse/PAHMA-923?focusedCommentId=40
448&page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpan
el#comment-40448

Aron

Show me all the vocabularies

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies?pgSz=200

(The above example uses the default 'core' tenant and the default
administrator account and password; you can change whichever of these
may be relevant to your own installation.)

Find the CSIDs of all the vocabularies (entries returned by the above
command) whose shortIdentifier field contains "currency" (its refName
field will likely also contain "(currency)".

Hypothetically, your query will return two or more entries for currency
vocabularies, each one identified by its own CSID (ID number).

For each CSID returned (using '0357dec4-4db6-436e-86a2' here as just a
placeholder example for one of the CSIDs returned by the command above -
be sure to substitute its actual CSID for this placeholder value), find
out how many items it has:

curl -i -u admin@core.collectionspace.org:Administrator
http://localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-8
6a2/items

If the totalItems field contains "0", that currency vocabulary is
empty. (I.e. it was one of the empty, duplicate vocabularies created by
the aforementioned bug.) You can delete it via:

curl -i -u admin@core.collectionspace.org:Administrator -X DELETE
http:/localhost:8180/cspace-services/vocabularies/0357dec4-4db6-436e-86
a2

Keep deleting empty vocabularies until the only remaining currency
vocabulary is one that contains terms.
Restart the CollectionSpace server.
Check the Acquisition record.
If you still don't see terms there, clear your browser's caches, per

https://wiki.collectionspace.org/display/DOC/Clearing+cached+content+fro

m+browsers