|
I occasionally (and randomly) receive the
following error when retrieving large (100-2000) numbers of
managed datastreams in succession: ERROR 2010-10-21 09:00:59.934 [TP-Processor11] (FilterSetup) Can't do next doFilter() java.io.IOException: Bad file descriptor at java.io.FileInputStream.readBytes(Native Method) [na:1.6.0_22] at java.io.FileInputStream.read(FileInputStream.java:199) [na:1.6.0_22] at java.io.FilterInputStream.read(FilterInputStream.java:116) [na:1.6.0_22] at java.io.FilterInputStream.read(FilterInputStream.java:116) [na:1.6.0_22] at java.io.FilterInputStream.read(FilterInputStream.java:90) [na:1.6.0_22] (The full error log is attached.) I've seen this error in FedoraCommons versions from 3.0 up to the latest 3.4.1. The error this morning occurred in a 3.4.1 repository using the Akubra storage module, the FC supplied Tomcat running under (RHEL's) Java 1.6.0_22 on an up to date RHEL 5.5 system. It can happen if I'm retrieving a succession of (managed) descMedatata datastreams (MODS) using the REST API; it can also happen if I'm retrieving a succession of (managed) PDF2TEXT datastreams when I'm updating a Solr index - again via the REST API. I've been totally unable to force the error to occur. In most cases, I'm the only user accessing the FC repository. It's more of a nuisance than a show-stopper; I just have to remember to check my application's error log each time. Is this a Fedora problem or a REST API problem or a Java problem or a RHEL+Java problem or ??? Thanks muchly! Janna Wemekamp Toldark Pty Limited |
INFO 2010-10-21 02:25:11.330 [main] (AuthFilterJAAS) using FEDORA_HOME:
/opt/fedoracommons/nrm/3.4/dev
INFO 2010-10-21 02:25:11.337 [main] (AuthFilterJAAS) initialised servlet
filter: org.fcrepo.server.security.jaas.AuthFilterJAAS
INFO 2010-10-21 02:25:11.407 [main] (Server) Starting up server
INFO 2010-10-21 02:25:11.553 [main] (Server) Server home is
/opt/fedoracommons/nrm/3.4/dev/server
INFO 2010-10-21 02:25:11.572 [main] (BasicServer) Fedora Version: 3.4.1
INFO 2010-10-21 02:25:11.572 [main] (BasicServer) Fedora Build Date: 2010-10-15
01:46:40 UTC-0400
INFO 2010-10-21 02:25:11.572 [main] (BasicServer) Fedora Build Number: 8817
INFO 2010-10-21 02:25:11.582 [main] (Server) Initializing
org.fcrepo.server.storage.DefaultDOManager
INFO 2010-10-21 02:25:11.596 [main] (Server) Initializing
org.fcrepo.server.oai.FedoraOAIProviderModule
INFO 2010-10-21 02:25:11.598 [main] (Server) Initializing
org.fcrepo.server.security.DefaultBackendSecurity
INFO 2010-10-21 02:25:11.600 [main] (Server) Initializing
org.fcrepo.server.access.DefaultAccess
INFO 2010-10-21 02:25:11.605 [main] (Server) Initializing
org.fcrepo.server.storage.translation.DOTranslatorModule
INFO 2010-10-21 02:25:12.085 [main] (Server) Initializing
org.fcrepo.server.search.FieldSearchSQLModule
INFO 2010-10-21 02:25:12.086 [main] (Server) Initializing
org.fcrepo.server.management.ManagementModule
INFO 2010-10-21 02:25:12.109 [main] (Server) Initializing
org.fcrepo.server.security.DefaultAuthorization
INFO 2010-10-21 02:25:12.683 [main] (Server) Initializing
org.fcrepo.server.storage.ConnectionPoolManagerImpl
INFO 2010-10-21 02:25:12.788 [main] (Server) Initializing
org.fcrepo.server.validation.DOValidatorModule
INFO 2010-10-21 02:25:12.790 [main] (Server) Initializing
org.fcrepo.server.access.DynamicAccessModule
INFO 2010-10-21 02:25:12.801 [main] (Server) Initializing
org.fcrepo.server.messaging.MessagingModule
INFO 2010-10-21 02:25:12.804 [main] (MessagingModule) Messaging Module is
disabled.
INFO 2010-10-21 02:25:12.804 [main] (Server) Initializing
org.fcrepo.server.storage.DefaultExternalContentManager
INFO 2010-10-21 02:25:13.024 [main] (Server) Initializing
org.fcrepo.server.resourceIndex.ResourceIndexModule
INFO 2010-10-21 02:25:13.093 [main] (Server) Initializing
org.fcrepo.server.storage.lowlevel.akubra.AkubraLowlevelStorageModule
INFO 2010-10-21 02:25:13.111 [main] (Server) Initializing
org.fcrepo.server.management.BasicPIDGenerator
INFO 2010-10-21 02:25:13.113 [main] (Server) Post-Initializing
org.fcrepo.server.storage.DefaultDOManager
INFO 2010-10-21 02:25:13.530 [main] (Server) Post-Initializing
org.fcrepo.server.oai.FedoraOAIProviderModule
INFO 2010-10-21 02:25:13.541 [main] (Server) Post-Initializing
org.fcrepo.server.security.DefaultBackendSecurity
INFO 2010-10-21 02:25:13.586 [main] (Server) Post-Initializing
org.fcrepo.server.access.DefaultAccess
INFO 2010-10-21 02:25:13.587 [main] (Server) Post-Initializing
org.fcrepo.server.storage.translation.DOTranslatorModule
INFO 2010-10-21 02:25:13.587 [main] (Server) Post-Initializing
org.fcrepo.server.search.FieldSearchSQLModule
INFO 2010-10-21 02:25:13.589 [main] (Server) Post-Initializing
org.fcrepo.server.management.ManagementModule
INFO 2010-10-21 02:25:13.796 [main] (Server) Post-Initializing
org.fcrepo.server.security.DefaultAuthorization
INFO 2010-10-21 02:25:17.033 [main] (PolicyFinderModule) Loading repository
policies...
INFO 2010-10-21 02:25:17.048 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/permit-anything-to-administrator.xml
INFO 2010-10-21 02:25:17.278 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-policy-management-if-not-administrator.xml
INFO 2010-10-21 02:25:17.332 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/permit-oai-unrestricted.xml
INFO 2010-10-21 02:25:17.432 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-purge-datastream-if-active-or-inactive.xml
INFO 2010-10-21 02:25:17.457 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-purge-object-if-active-or-inactive.xml
INFO 2010-10-21 02:25:17.462 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-unallowed-file-resolution.xml
INFO 2010-10-21 02:25:17.466 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/permit-serverStatus-unrestricted.xml
INFO 2010-10-21 02:25:17.486 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/permit-apia-unrestricted.xml
INFO 2010-10-21 02:25:17.489 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-reloadPolicies-if-not-localhost.xml
INFO 2010-10-21 02:25:17.495 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/permit-dsstate-check-unrestricted.xml
INFO 2010-10-21 02:25:17.530 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-apim-if-not-localhost.xml
INFO 2010-10-21 02:25:17.535 [main] (PolicyFinderModule) Loading policy:
/data/fedoracommons/nrm/3.4/dev/fedora-xacml-policies/repository-policies/default/deny-inactive-or-deleted-objects-or-datastreams-if-not-administrator.xml
INFO 2010-10-21 02:25:17.597 [main] (PolicyFinderModule) Loading policy:
/opt/fedoracommons/nrm/3.4/dev/server/fedora-internal-use/fedora-internal-use-backend-service-policies/callback-by_default.xml
INFO 2010-10-21 02:25:17.605 [main] (PolicyFinderModule) Loading policy:
/opt/fedoracommons/nrm/3.4/dev/server/fedora-internal-use/fedora-internal-use-backend-service-policies/callback-by_fedoraInternalCall-1-other-methods.xml
INFO 2010-10-21 02:25:17.614 [main] (PolicyFinderModule) Loading policy:
/opt/fedoracommons/nrm/3.4/dev/server/fedora-internal-use/fedora-internal-use-backend-service-policies/callback-by_fedoraInternalCall-2-other-methods.xml
INFO 2010-10-21 02:25:17.627 [main] (Server) Post-Initializing
org.fcrepo.server.storage.ConnectionPoolManagerImpl
INFO 2010-10-21 02:25:17.628 [main] (Server) Post-Initializing
org.fcrepo.server.validation.DOValidatorModule
INFO 2010-10-21 02:25:17.630 [main] (Server) Post-Initializing
org.fcrepo.server.access.DynamicAccessModule
INFO 2010-10-21 02:25:17.636 [main] (Server) Post-Initializing
org.fcrepo.server.messaging.MessagingModule
INFO 2010-10-21 02:25:17.637 [main] (Server) Post-Initializing
org.fcrepo.server.storage.DefaultExternalContentManager
INFO 2010-10-21 02:25:17.637 [main] (Server) Post-Initializing
org.fcrepo.server.resourceIndex.ResourceIndexModule
INFO 2010-10-21 02:25:25.371 [main] (Server) Post-Initializing
org.fcrepo.server.storage.lowlevel.akubra.AkubraLowlevelStorageModule
INFO 2010-10-21 02:25:26.832 [main] (Server) Post-Initializing
org.fcrepo.server.management.BasicPIDGenerator
INFO 2010-10-21 02:25:26.839 [main] (Server) Server startup complete
ERROR 2010-10-21 09:00:59.934 [TP-Processor11] (FilterSetup) Can't do next
doFilter()
java.io.IOException: Bad file descriptor
at java.io.FileInputStream.readBytes(Native Method) [na:1.6.0_22]
at java.io.FileInputStream.read(FileInputStream.java:199) [na:1.6.0_22]
at java.io.FilterInputStream.read(FilterInputStream.java:116)
[na:1.6.0_22]
at java.io.FilterInputStream.read(FilterInputStream.java:116)
[na:1.6.0_22]
at java.io.FilterInputStream.read(FilterInputStream.java:90)
[na:1.6.0_22]
at
com.sun.jersey.core.provider.AbstractMessageReaderWriterProvider.writeTo(AbstractMessageReaderWriterProvider.java:72)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.core.impl.provider.entity.InputStreamProvider.writeTo(InputStreamProvider.java:95)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.core.impl.provider.entity.InputStreamProvider.writeTo(InputStreamProvider.java:58)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.spi.container.ContainerResponse.write(ContainerResponse.java:254)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.server.impl.application.WebApplicationImpl._handleRequest(WebApplicationImpl.java:724)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:647)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:638)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.spi.container.servlet.WebComponent.service(WebComponent.java:309)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:425)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at
com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:590)
[jersey-bundle-1.0.3.1.jar:1.0.3.1]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
[servlet-api.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.fcrepo.server.security.servletfilters.FilterRestApiFlash.doFilter(FilterRestApiFlash.java:79)
[fcrepo-server-3.4.1.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.fcrepo.server.security.servletfilters.FilterSetup.doFilter(FilterSetup.java:235)
[fcrepo-server-3.4.1.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.fcrepo.server.security.servletfilters.FilterSetup.doFilter(FilterSetup.java:235)
[fcrepo-server-3.4.1.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.fcrepo.server.security.servletfilters.FilterSetup.doFilter(FilterSetup.java:235)
[fcrepo-server-3.4.1.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.fcrepo.server.security.servletfilters.FilterSetup.doFilter(FilterSetup.java:235)
[fcrepo-server-3.4.1.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
[catalina.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
[catalina.jar:na]
at
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
[catalina.jar:na]
at
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
[catalina.jar:na]
at
org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:525)
[catalina.jar:na]
at
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:128)
[catalina.jar:na]
at
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
[catalina.jar:na]
at
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
[catalina.jar:na]
at
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
[catalina.jar:na]
at
org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:190)
[tomcat-coyote.jar:na]
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:291)
[tomcat-coyote.jar:na]
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:769)
[tomcat-coyote.jar:na]
at
org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:698)
[tomcat-coyote.jar:na]
at
org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:891)
[tomcat-coyote.jar:na]
at
org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:690)
[tomcat-coyote.jar:na]
at java.lang.Thread.run(Thread.java:662) [na:1.6.0_22]
------------------------------------------------------------------------------ Nokia and AT&T present the 2010 Calling All Innovators-North America contest Create new apps & games for the Nokia N8 for consumers in U.S. and Canada $10 million total in prizes - $4M cash, 500 devices, nearly $6M in marketing Develop with Nokia Qt SDK, Web Runtime, or Java and Publish to Ovi Store http://p.sf.net/sfu/nokia-dev2dev
_______________________________________________ Fedora-commons-users mailing list Fedora-commons-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/fedora-commons-users
