Что означает «Не удалось обработать запрос на загрузку: не удалось загрузить свойства для» в журналах Artifactory?

Мы видим много этих ошибок в наших журналах Artifactory:Что означает «Не удалось обработать запрос на загрузку: не удалось загрузить свойства для» в журналах Artifactory?

20161228 121638 [http-nio-8081-exec-22933] [WARN ] 
(o.a.r.ArtifactoryResponseBase:107) - Sending HTTP error code 500: Could not 
process download request: Failed to load properties for 314050135

что это значит?

При взгляде на предупреждения мы видим, что в случаях появляется предупреждение после попытки прочитать метаданные-xml.

cat artifactory.log | grep http-nio-8081-exec-2441 | grep -A 2 -B 5 "Sending HTTP error code 500"

Подобно ниже: Обновление

2017-01-04 09:02:48,788 [http-nio-8081-exec-2419] [DEBUG] (o.a.w.s.RepoFilter :98) - Entering request GET (10.67.6.51) /internal-release-rhel6/repodata/repomd.xml. 
2017-01-04 09:03:48,791 [http-nio-8081-exec-2419] [WARN ] (o.a.r.ArtifactoryResponseBase:107) - Sending HTTP error code 500: Could not process download request: Failed to load properties for 335095695

Мы повысили уровень журнала, чтобы получить некоторый контекст:

2017-01-04 09:01:05,955 [http-nio-8081-exec-2445] [DEBUG] (o.a.w.s.RepoFilter :98) - Entering request GET (10.67.7.101) /core-release/com/jeppesen/jcms/airport/maven-metadata. 
xml. 
2017-01-04 09:01:06,187 [http-nio-8081-exec-2443] [DEBUG] (o.a.w.s.RepoFilter :98) - Entering request HEAD (10.67.7.101) /ots-release/com/jeppesen/jcms/atriumorc/maven-metadat 
a.xml. 
2017-01-04 09:01:12,143 [http-nio-8081-exec-2373] [ERROR] (o.a.r.c.e.GlobalExceptionMapper:48) - Failed to load properties for 165931919 
org.artifactory.storage.StorageException: Failed to load properties for 165931919 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:113) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.getProperties(DbPropertiesServiceImpl.java:84) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.repo.service.RepositoryServiceImpl.getProperties(RepositoryServiceImpl.java:1046) ~[artifactory-core-4.15.0.jar:na] 
..... 

2017-01-04 09:01:12,143 [http-nio-8081-exec-2359] [ERROR] (o.a.r.c.e.GlobalExceptionMapper:48) - Failed to load properties for 59628724 
org.artifactory.storage.StorageException: Failed to load properties for 59628724 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:113) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.getProperties(DbPropertiesServiceImpl.java:84) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.repo.service.RepositoryServiceImpl.getProperties(RepositoryServiceImpl.java:1046) ~[artifactory-core-4.15.0.jar: 
...... 
2017-01-04 09:01:12,143 [http-nio-8081-exec-2422] [ERROR] (o.a.r.c.e.GlobalExceptionMapper:48) - Failed to load properties for 26449553 
org.artifactory.storage.StorageException: Failed to load properties for 26449553 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:113) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.getProperties(DbPropertiesServiceImpl.java:84) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.repo.service.RepositoryServiceImpl.getProperties(RepositoryServiceImpl.java:104 
..... 
..... 
..... 
2017-01-04 09:01:12,180 [http-nio-8081-exec-2428] [DEBUG] (o.a.w.s.RepoFilter :204) - Exiting request GET (10.67.20.240) /api/npm/npm-all/grunt-contrib-copy/-/grunt-contrib-copy-1.0.0.tgz 
2017-01-04 09:01:12,943 [http-nio-8081-exec-2416] [WARN ] (o.a.r.ArtifactoryResponseBase:107) - Sending HTTP error code 500: Could not process download request: Failed to load properties for 59815778 
2017-01-04 09:01:12,948 [http-nio-8081-exec-2416] [DEBUG] (o.a.w.s.RepoFilter :283) - Could not process download request: Failed to load properties for 59815778 
org.artifactory.storage.StorageException: Failed to load properties for 59815778 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:113) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.getProperties(DbPropertiesServiceImpl.java:84) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.repo.service.RepositoryServiceImpl.getProperties(RepositoryServiceImpl.java:1046) ~[artifactory-core-4.15.0.jar:na] 
     at sun.reflect.GeneratedMethodAccessor99.invoke(Unknown Source) ~[na:na]

источник

2016-12-28 Christer Eriksson

в stacktraces предусмотренные подрезаны. можете ли вы предоставить полный стек, особенно если он содержит основную причину (SQLException)? –

Основной причиной является SQL ошибка при попытке загрузить свойства артефакта при попытке g, чтобы загрузить артефакт. Это может указывать на какой-то коррупционный эффект в базе данных.
Для получения более подробной информации об ошибке установите уровень регистрации в org.artifactory.webapp.servlet.RepoFilter для отладки. Это должно обеспечить полную трассировку стека в журнале.

источник

2017-01-02 17:34:17

Трассировка стека был большой для комментария здесь

2017-01-04 09:01:12,943 [http-nio-8081-exec-2416] [WARN ] (o.a.r.ArtifactoryResponseBase:107) - Sending HTTP error code 500: Could not process download request: Failed to load properties for 59815778 
2017-01-04 09:01:12,948 [http-nio-8081-exec-2416] [DEBUG] (o.a.w.s.RepoFilter :283) - Could not process download request: Failed to load properties for 59815778 
org.artifactory.storage.StorageException: Failed to load properties for 59815778 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:113) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.getProperties(DbPropertiesServiceImpl.java:84) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.repo.service.RepositoryServiceImpl.getProperties(RepositoryServiceImpl.java:1046) ~[artifactory-core-4.15.0.jar:na] 
     at sun.reflect.GeneratedMethodAccessor99.invoke(Unknown Source) ~[na:na] 
     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_91] 
     at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_91] 
     at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:201) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at com.sun.proxy.$Proxy50.getProperties(Unknown Source) ~[na:na] 
     at org.artifactory.repo.db.DbStoringRepoMixin.getInfo(DbStoringRepoMixin.java:427) ~[artifactory-core-4.15.0.jar:na] 
     at org.artifactory.repo.db.DbLocalRepo.getInfo(DbLocalRepo.java:103) ~[artifactory-core-4.15.0.jar:na] 
     at org.artifactory.engine.DownloadServiceImpl.process(DownloadServiceImpl.java:198) ~[artifactory-core-4.15.0.jar:na] 
     at sun.reflect.GeneratedMethodAccessor92.invoke(Unknown Source) ~[na:na] 
     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_91] 
     at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_91] 
     at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at org.artifactory.request.aop.RequestAdvice.invoke(RequestAdvice.java:67) ~[artifactory-core-4.15.0.jar:na] 
     at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207) ~[spring-aop-4.1.5.RELEASE.jar:4.1.5.RELEASE] 
     at com.sun.proxy.$Proxy73.process(Unknown Source) ~[na:na] 
     at org.artifactory.webapp.servlet.RepoFilter.doDownload(RepoFilter.java:250) [artifactory-web-application-4.15.0.jar:na] 
     at org.artifactory.webapp.servlet.RepoFilter.execute(RepoFilter.java:175) [artifactory-web-application-4.15.0.jar:na] 
     at org.artifactory.webapp.servlet.RepoFilter.doFilter(RepoFilter.java:91) [artifactory-web-application-4.15.0.jar:na] 
     at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:240) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.32] 
     at org.artifactory.webapp.servlet.AccessFilter.useAuthentication(AccessFilter.java:391) [artifactory-web-application-4.15.0.jar:na] 
     at org.artifactory.webapp.servlet.AccessFilter.authenticateAndExecute(AccessFilter.java:270) [artifactory-web-application-4.15.0.jar:na] 
     at org.artifactory.webapp.servlet.AccessFilter.doFilterInternal(AccessFilter.java:200) [artifactory-web-application-4.15.0.jar:na] 
     at org.artifactory.webapp.servlet.AccessFilter.doFilter(AccessFilter.java:160) [artifactory-web-application-4.15.0.jar:na] 
     at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:240) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.32] 
     at org.artifactory.webapp.servlet.RequestFilter.doFilter(RequestFilter.java:61) [artifactory-web-application-4.15.0.jar:na] 
     at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:240) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.32] 
     at org.artifactory.webapp.servlet.ArtifactoryFilter.doFilter(ArtifactoryFilter.java:111) [artifactory-web-application-4.15.0.jar:na] 
     at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:240) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:212) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:106) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:141) [catalina.jar:8.0.32] 
     at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79) [catalina.jar:8.0.32] 
     at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:88) [catalina.jar:8.0.32] 
     at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:522) [catalina.jar:8.0.32] 
     at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1095) [tomcat-coyote.jar:8.0.32] 
     at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:672) [tomcat-coyote.jar:8.0.32] 
     at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1500) [tomcat-coyote.jar:8.0.32] 
     at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEndpoint.java:1456) [tomcat-coyote.jar:8.0.32] 
     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0_91] 
     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_91] 
     at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util.jar:8.0.32] 
     at java.lang.Thread.run(Thread.java:745) [na:1.8.0_91] 
Caused by: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested 
     at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.Util.generateCsSQLException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.TransactionResourceImpl.wrapInSQLException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.EmbedConnection.handleException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.ConnectionChild.handleException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeQuery(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.artifactory.storage.db.util.JdbcHelper.executeSelect(JdbcHelper.java:106) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.util.JdbcHelper.executeSelect(JdbcHelper.java:79) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.dao.PropertiesDao.getNodeProperties(PropertiesDao.java:83) ~[artifactory-storage-db-4.15.0.jar:na] 
     at org.artifactory.storage.db.fs.service.DbPropertiesServiceImpl.loadProperties(DbPropertiesServiceImpl.java:110) ~[artifactory-storage-db-4.15.0.jar:na] 
     ... 52 common frames omitted 
Caused by: org.apache.derby.iapi.error.StandardException: A lock could not be obtained within the time requested 
     at org.apache.derby.iapi.error.StandardException.newException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.iapi.error.StandardException.newException(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.services.locks.ConcurrentLockSet.lockObject(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.services.locks.AbstractPool.lockObject(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.services.locks.ConcurrentPool.lockObject(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.raw.xact.RowLocking2.lockContainer(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.raw.data.BaseContainerHandle.useContainer(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.raw.data.BaseDataFileFactory.openContainer(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.raw.data.BaseDataFileFactory.openContainer(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.raw.xact.Xact.openContainer(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.conglomerate.OpenConglomerate.init(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.heap.Heap.open(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.RAMTransaction.openConglomerate(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.RAMTransaction.openCompiledConglomerate(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.btree.index.B2IForwardScan.init(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.btree.index.B2I.openScan(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.RAMTransaction.openScan(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.store.access.RAMTransaction.openCompiledScan(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.execute.BulkTableScanResultSet.openScanController(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.execute.TableScanResultSet.openCore(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.execute.BulkTableScanResultSet.openCore(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.execute.IndexRowToBaseRowResultSet.openCore(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.execute.BasicNoPutResultSetImpl.open(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.GenericPreparedStatement.executeStmt(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     at org.apache.derby.impl.sql.GenericPreparedStatement.execute(Unknown Source) ~[derby-10.11.1.1.jar:na] 
     ... 59 common frames omitted

источник

2017-01-24 12:24:48

Что означает «Не удалось обработать запрос на загрузку: не удалось загрузить свойства для» в журналах Artifactory?

ответ

Смежные вопросы