[Bug] Library scan fails due to unaccessible file

[mccaan]

Komga environment

• OS: Synology DSM 6.2
• Komga version: 0.63.2
• I am running Komga with Docker
  • Docker image tag [e.g. latest, beta]:
• I am running Komga from the jar
  • Java version:
    java -version
    openjdk version "1.8.0_212"
    OpenJDK Runtime Environment (IcedTea 3.12.0) (linux-gnu build 1.8.0_212-b04)
    OpenJDK 64-Bit Server VM (build 25.212-b04, mixed mode)
• I have a problem in the web interface
  • Browser (with version):
• I have a problem with an OPDS client application
  • OPDS Application (with version):
• I have a problem with the Tachiyomi extension
  • Tachiyomi version:
  • Tachiyomi extension version:

Describe the bug

Library is never updated due to a permission error in an internal Synology Directory.

I use this application.yml to exclude internal synology directories ( "#recycle" "@eadir" "[email protected]" )

Attached full apllication.yml

komga:
  libraries-scan-cron: "* */15 * * * ?" #periodic scan every 15 minutes
  libraries-scan-startup: true #scan libraries at startup
  libraries-scan-directory-exclusions: #patterns to exclude directories from the
 scan
    - "#recycle" #synology NAS recycle bin
    - "@eaDir"   #synology NAS index/metadata folders
    - "[email protected]" #Error detected
  remember-me:
    key: 8926827 #required to activate the remember-me auto-login via cookies
    validity: 2592000 #validity of the cookie in seconds, here 1 month
server:
  port: 8080
  servlet.context-path: /

with this file, during start makes a library scan with this result:

2020-10-18 10:45:30.880  INFO 29999 --- [main] org.gotson.komga.ApplicationKt           : Starting ApplicationKt on Nosferatu with PID 29999 (/volume1/homes/admin/Tasks/ComicOrg/komga-0.63.2.jar started by admin in /volume1/homes/admin/Tasks/ComicOrg)
2020-10-18 10:45:30.895  INFO 29999 --- [main] org.gotson.komga.ApplicationKt           : No active profile set, falling back to default profiles: default
2020-10-18 10:45:40.947  INFO 29999 --- [main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JDBC repositories in DEFAULT mode.
2020-10-18 10:45:41.696  INFO 29999 --- [main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 657ms. Found 0 JDBC repository interfaces.
2020-10-18 10:45:46.612  INFO 29999 --- [main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.security.access.expression.method.DefaultMethodSecurityExpressionHandler@cd1e646' of type [org.springframework.security.access.expression.method.DefaultMethodSecurityExpressionHandler] is not eligible
for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2020-10-18 10:45:46.632  INFO 29999 --- [main] trationDelegate$BeanPostProcessorChecker : Bean 'methodSecurityMetadataSource' of type [org.springframework.security.access.method.DelegatingMethodSecurityMetadataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto
-proxying)
2020-10-18 10:45:49.663  INFO 29999 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 8080 (http)
2020-10-18 10:45:49.824  INFO 29999 --- [main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2020-10-18 10:45:49.825  INFO 29999 --- [main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.37]
2020-10-18 10:45:50.313  INFO 29999 --- [main] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
2020-10-18 10:45:50.314  INFO 29999 --- [main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 18907 ms
2020-10-18 10:45:52.566  INFO 29999 --- [main] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Starting...
2020-10-18 10:45:52.964  INFO 29999 --- [main] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Start completed.
2020-10-18 10:45:52.987  INFO 29999 --- [main] o.s.b.a.h2.H2ConsoleAutoConfiguration    : H2 console available at '/h2-console'. Database available at 'jdbc:sqlite:/var/services/homes/admin/.komga/database.sqlite?foreign_keys=on;'
2020-10-18 10:45:54.084  INFO 29999 --- [main] o.s.b.a.e.web.ServletEndpointRegistrar   : Registered '/actuator/jolokia' to jolokia-actuator-endpoint
2020-10-18 10:45:54.186  INFO 29999 --- [main] io.hawt.HawtioContextListener            : Initialising hawtio services
2020-10-18 10:45:54.662  INFO 29999 --- [main] io.hawt.system.ConfigManager             : Configuration will be discovered via system properties
2020-10-18 10:45:54.666  INFO 29999 --- [main] io.hawt.jmx.JmxTreeWatcher               : Welcome to Hawtio 2.10.1
2020-10-18 10:45:54.708  INFO 29999 --- [main] i.h.w.auth.AuthenticationConfiguration   : Starting hawtio authentication filter, JAAS realm: "karaf" authorized role(s): "admin,manager,viewer" role principal classes: ""
2020-10-18 10:45:55.594  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221000: live Message Broker is starting with configuration Broker Configuration (clustered=false,journalDirectory=/var/services/homes/admin/.komga/artemis/journal,bindingsDirectory=/var/services/homes/admin/.komga/artemis/bi
ndings,largeMessagesDirectory=/var/services/homes/admin/.komga/artemis/largemessages,pagingDirectory=/var/services/homes/admin/.komga/artemis/paging)
2020-10-18 10:45:55.725  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221013: Using NIO Journal
2020-10-18 10:45:56.176  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221057: Global Max Size is being adjusted to 1/2 of the JVM max size (-Xmx). being defined as 213,647,360
2020-10-18 10:45:56.341  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221043: Protocol module found: [artemis-server]. Adding protocol support for: CORE
2020-10-18 10:45:56.453  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601138: User anonymous is getting notification info on target resource: null []
2020-10-18 10:45:56.466  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.ActiveMQServerControlImpl@b6b1987 []
2020-10-18 10:45:56.470  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601138: User anonymous is getting notification info on target resource: ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11eb-8655-001132876a45 []
2020-10-18 10:45:56.732  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221034: Waiting indefinitely to obtain live lock
2020-10-18 10:45:56.733  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221035: Live Server Obtained live lock
2020-10-18 10:45:57.389  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.AddressControlImpl@3eeb318f []
2020-10-18 10:45:57.396  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.AddressControlImpl@20a14b55 []
2020-10-18 10:45:57.401  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.AddressControlImpl@39ad977d []
2020-10-18 10:45:57.403  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.AddressControlImpl@6da00fb9 []
2020-10-18 10:45:57.684  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.QueueControlImpl@3fa2213 []
2020-10-18 10:45:57.709  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.QueueControlImpl@3e7634b9 []
2020-10-18 10:45:57.717  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.QueueControlImpl@6f0b0a5e []
2020-10-18 10:45:58.720  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221080: Deploying address DLQ supporting [ANYCAST]
2020-10-18 10:45:58.736  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221003: Deploying ANYCAST queue DLQ on address DLQ
2020-10-18 10:45:58.737  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221080: Deploying address ExpiryQueue supporting [ANYCAST]
2020-10-18 10:45:58.738  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221003: Deploying ANYCAST queue ExpiryQueue on address ExpiryQueue
2020-10-18 10:45:58.739  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221003: Deploying ANYCAST queue tasks.background on address tasks.background
2020-10-18 10:45:58.922  INFO 29999 --- [main] org.apache.activemq.audit.base           : AMQ601019: User anonymous is getting mbean info on target resource: org.apache.activemq.artemis.core.management.impl.AcceptorControlImpl@29df4d43 []
2020-10-18 10:45:59.076  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221007: Server is now live
2020-10-18 10:45:59.077  INFO 29999 --- [main] org.apache.activemq.artemis.core.server  : AMQ221001: Apache ActiveMQ Artemis Message Broker version 2.12.0 [localhost, nodeID=f5ea392a-0a19-11eb-8655-001132876a45]
2020-10-18 10:46:04.484  INFO 29999 --- [main] o.g.k.i.image.ImageConverter             : Supported read formats: [JPG, JPEG 2000, tiff, bmp, bigtiff, PCX, gif, WBMP, PNG, RAW, JPEG, PNM, BigTIFF, tif, TIFF, jpeg, wbmp, jpeg-lossless, jbig2, jpg, JPEG2000, BMP, pcx, GIF, png, BIGTIFF, raw, JPEG-LOSSLESS, webp, JBIG2
, pnm, TIF, jpeg2000, jpeg 2000]
2020-10-18 10:46:04.485  INFO 29999 --- [main] o.g.k.i.image.ImageConverter             : Supported read mediaTypes: [, image/x-jb2, image/png, image/vnd.wap.wbmp, image/jpeg, image/x-portable-graymap, image/bmp, image/pcx, image/x-windows-bmp, image/gif, image/x-windows-pcx, image/jpeg2000, image/x-pc-paintbrush, i
mage/webp, image/x-bmp, image/jp2, image/x-pcx, image/x-png, image/x-portable-bitmap, image/x-portable-pixmap, image/x-jbig2, image/tiff, image/x-tiff, image/x-portable-anymap]
2020-10-18 10:46:04.487  INFO 29999 --- [main] o.g.k.i.image.ImageConverter             : Supported write formats: [JPG, JPEG 2000, tiff, bmp, PCX, gif, WBMP, PNG, RAW, JPEG, PNM, tif, TIFF, wbmp, jpeg, jpg, JPEG2000, BMP, pcx, GIF, png, raw, pnm, TIF, jpeg2000, jpeg 2000]
2020-10-18 10:46:04.488  INFO 29999 --- [main] o.g.k.i.image.ImageConverter             : Supported write mediaTypes: [, image/vnd.wap.wbmp, image/png, image/jpeg, image/x-portable-graymap, image/bmp, image/pcx, image/x-windows-bmp, image/gif, image/x-windows-pcx, image/x-pc-paintbrush, image/jpeg2000, image/x-bmp,
image/x-pcx, image/jp2, image/x-png, image/x-portable-bitmap, image/x-portable-pixmap, image/tiff, image/x-tiff, image/x-portable-anymap]
2020-10-18 10:46:04.802  INFO 29999 --- [main] o.g.k.i.datasource.DatabaseMigration     : Initiating database migration from H2 to SQLite
2020-10-18 10:46:04.804  INFO 29999 --- [main] o.g.k.i.datasource.DatabaseMigration     : H2 url: jdbc:h2:~/.komga/database.h2
2020-10-18 10:46:04.822  INFO 29999 --- [main] o.g.k.i.datasource.DatabaseMigration     : H2 database file: /var/services/homes/admin/.komga/database.h2.mv.db
2020-10-18 10:46:04.860  WARN 29999 --- [main] o.g.k.i.datasource.DatabaseMigration     : The H2 database file does not exists: /var/services/homes/admin/.komga/database.h2.mv.db, skipping migration
2020-10-18 10:46:06.759  INFO 29999 --- [main] o.f.c.internal.license.VersionPrinter    : Flyway Community Edition 6.4.4 by Redgate
2020-10-18 10:46:06.854  INFO 29999 --- [main] o.f.c.internal.database.DatabaseFactory  : Database: jdbc:sqlite:/var/services/homes/admin/.komga/database.sqlite (SQLite 3.32)
2020-10-18 10:46:07.118  INFO 29999 --- [main] o.f.core.internal.command.DbValidate     : Successfully validated 14 migrations (execution time 00:00.104s)
2020-10-18 10:46:07.131  INFO 29999 --- [main] o.f.core.internal.command.DbMigrate      : Current version of schema "main": 20200906115600
2020-10-18 10:46:07.134  INFO 29999 --- [main] o.f.core.internal.command.DbMigrate      : Schema "main" is up to date. No migration necessary.
2020-10-18 10:46:08.063  INFO 29999 --- [main] o.g.k.i.security.SecurityConfiguration   : RememberMe is active, validity: 2592000s
2020-10-18 10:46:08.074  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/error**'], []
2020-10-18 10:46:08.075  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/css/**'], []
2020-10-18 10:46:08.075  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/img/**'], []
2020-10-18 10:46:08.075  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/js/**'], []
2020-10-18 10:46:08.076  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/favicon.ico'], []
2020-10-18 10:46:08.076  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/'], []
2020-10-18 10:46:08.076  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: Ant [pattern='/index.html'], []
2020-10-18 10:46:08.592  INFO 29999 --- [main] o.s.b.a.w.s.WelcomePageHandlerMapping    : Adding welcome page: class path resource [public/index.html]
2020-10-18 10:46:11.158  INFO 29999 --- [main] o.s.b.a.e.web.EndpointLinksResolver      : Exposing 18 endpoint(s) beneath base path '/actuator'
2020-10-18 10:46:11.264  INFO 29999 --- [main] o.s.s.web.DefaultSecurityFilterChain     : Creating filter chain: any request, [org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@76075d65, org.springframework.security.web.context.SecurityContextPersistenceFilter@1d01dfa5, org.spri
ngframework.security.web.header.HeaderWriterFilter@7a94b64e, org.springframework.web.filter.CorsFilter@3a4ba480, org.springframework.security.web.authentication.logout.LogoutFilter@aed0151, org.springframework.security.web.session.ConcurrentSessionFilter@73d69c0f, org.springframework.security.web.authentication.www.
BasicAuthenticationFilter@7b2a3ff8, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@d400943, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@31ff1390, org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter@460b6d54, org.spri
ngframework.security.web.authentication.AnonymousAuthenticationFilter@27b71f50, org.springframework.security.web.session.SessionManagementFilter@12477988, org.springframework.security.web.access.ExceptionTranslationFilter@400d912a, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@5f404594]
2020-10-18 10:46:11.525  INFO 29999 --- [main] o.s.s.concurrent.ThreadPoolTaskExecutor  : Initializing ExecutorService 'applicationTaskExecutor'
2020-10-18 10:46:13.121  INFO 29999 --- [main] o.s.s.c.ThreadPoolTaskScheduler          : Initializing ExecutorService 'taskScheduler'
2020-10-18 10:46:13.596  INFO 29999 --- [main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat started on port(s): 8080 (http) with context path ''
2020-10-18 10:46:13.961  INFO 29999 --- [Thread-0 (ActiveMQ-remoting-threads-ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11eb-8655-001132876a45-1765702)] org.apache.activemq.audit.base           : AMQ601267: User anonymous is creating a core session on target resource ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11
eb-8655-001132876a45 [with parameters: [6104fd07-111e-11eb-be1c-001132876a45, null, ****, 102400, RemotingConnectionImpl [ID=60db2de4-111e-11eb-be1c-001132876a45, clientID=null, nodeID=f5ea392a-0a19-11eb-8655-001132876a45, transportConnection=InVMConnection [serverID=0, id=60db2de4-111e-11eb-be1c-001132876a45]], fal
se, false, false, false, null, org.apache.activemq.artemis.core.protocol.core.impl.CoreSessionCallback@fb1624c, true, OperationContextImpl [840684436] [minimalStore=9223372036854775807, storeLineUp=0, stored=0, minimalReplicated=9223372036854775807, replicationLineUp=0, replicated=0, paged=0, minimalPage=92233720368
54775807, pageLineUp=0, errorCode=-1, errorMessage=null, executorsPending=0, executor=OrderedExecutor(tasks=[])], anonymous]]
2020-10-18 10:46:14.280  INFO 29999 --- [Thread-0 (ActiveMQ-remoting-threads-ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11eb-8655-001132876a45-1765702)] org.apache.activemq.audit.base           : AMQ601267: User anonymous is creating a core session on target resource ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11
eb-8655-001132876a45 [with parameters: [61386918-111e-11eb-be1c-001132876a45, null, ****, 102400, RemotingConnectionImpl [ID=60db2de4-111e-11eb-be1c-001132876a45, clientID=null, nodeID=f5ea392a-0a19-11eb-8655-001132876a45, transportConnection=InVMConnection [serverID=0, id=60db2de4-111e-11eb-be1c-001132876a45]], fal
se, false, false, false, null, org.apache.activemq.artemis.core.protocol.core.impl.CoreSessionCallback@75c35fe5, true, OperationContextImpl [318873174] [minimalStore=9223372036854775807, storeLineUp=0, stored=0, minimalReplicated=9223372036854775807, replicationLineUp=0, replicated=0, paged=0, minimalPage=9223372036
854775807, pageLineUp=0, errorCode=-1, errorMessage=null, executorsPending=0, executor=OrderedExecutor(tasks=[])], anonymous]]
2020-10-18 10:46:14.475  INFO 29999 --- [main] org.gotson.komga.ApplicationKt           : Started ApplicationKt in 48.056 seconds (JVM running for 50.98)
2020-10-18 10:46:14.489  INFO 29999 --- [Thread-1 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$6@e98770d)] org.apache.activemq.audit.base           : AMQ601265: User anonymous is creating a core consumer on target resource ServerSessionImpl(jms-session=*N/A*) [with parameters: [0,
 tasks.background, type = 'task', 0, false, true, null]]
2020-10-18 10:46:14.558  INFO 29999 --- [main] o.g.k.i.s.PeriodicScannerController      : Periodic libraries scan starting
2020-10-18 10:46:15.955  INFO 29999 --- [main] o.g.k.application.tasks.TaskReceiver     : Sending task: ScanLibrary(libraryId=02TX1BQKFBMMF)
2020-10-18 10:46:15.959  INFO 29999 --- [Thread-0 (ActiveMQ-remoting-threads-ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11eb-8655-001132876a45-1765702)] org.apache.activemq.audit.base           : AMQ601267: User anonymous is creating a core session on target resource ActiveMQServerImpl::serverUUID=f5ea392a-0a19-11
eb-8655-001132876a45 [with parameters: [6239d389-111e-11eb-be1c-001132876a45, null, ****, 102400, RemotingConnectionImpl [ID=60db2de4-111e-11eb-be1c-001132876a45, clientID=null, nodeID=f5ea392a-0a19-11eb-8655-001132876a45, transportConnection=InVMConnection [serverID=0, id=60db2de4-111e-11eb-be1c-001132876a45]], tru
e, true, false, false, null, org.apache.activemq.artemis.core.protocol.core.impl.CoreSessionCallback@47c9ff05, true, OperationContextImpl [1084066096] [minimalStore=9223372036854775807, storeLineUp=0, stored=0, minimalReplicated=9223372036854775807, replicationLineUp=0, replicated=0, paged=0, minimalPage=92233720368
54775807, pageLineUp=0, errorCode=-1, errorMessage=null, executorsPending=0, executor=OrderedExecutor(tasks=[])], anonymous]]
2020-10-18 10:46:16.548  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.komga.application.tasks.TaskHandler  : Executing task: ScanLibrary(libraryId=02TX1BQKFBMMF)
2020-10-18 10:46:16.767  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.komga.domain.service.LibraryScanner  : Updating library: Library(name=Comics en el Atico, root=file:/volume1/Comics/, importComicInfoBook=true, importComicInfoSeries=true, importComicInfoCollection=true, importComicInfoReadList=true, imp
ortEpubBook=true, importEpubSeries=true, importLocalArtwork=true, scanForceModifiedTime=false, scanDeep=false, id=02TX1BQKFBMMF, createdDate=2020-10-09T12:33:39, lastModifiedDate=2020-10-09T17:38:20.036)
2020-10-18 10:46:16.787  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.k.domain.service.FileSystemScanner   : Scanning folder: /volume1/Comics
2020-10-18 10:46:16.789  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.k.domain.service.FileSystemScanner   : Supported extensions: [cbz, zip, cbr, rar, pdf, epub]
2020-10-18 10:46:16.792  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.k.domain.service.FileSystemScanner   : Excluded patterns: [#recycle, @eaDir, [email protected]]
2020-10-18 10:46:16.794  INFO 29999 --- [DefaultMessageListenerContainer-1] o.g.k.domain.service.FileSystemScanner   : Force directory modified time: false
2020-10-18 10:46:17.035 ERROR 29999 --- [DefaultMessageListenerContainer-1] o.g.komga.application.tasks.TaskHandler  : Task ScanLibrary(libraryId=02TX1BQKFBMMF) execution failed

java.io.UncheckedIOException: java.nio.file.AccessDeniedException: /volume1/Comics/@eaDir/[email protected]
        at java.nio.file.FileTreeIterator.fetchNextIfNeeded(FileTreeIterator.java:88) ~[na:1.8.0_212]
        at java.nio.file.FileTreeIterator.hasNext(FileTreeIterator.java:104) ~[na:1.8.0_212]
        at java.util.Spliterators$IteratorSpliterator.tryAdvance(Spliterators.java:1811) ~[na:1.8.0_212]
        at java.util.stream.StreamSpliterators$WrappingSpliterator.lambda$initPartialTraversalState$0(StreamSpliterators.java:294) ~[na:1.8.0_212]
        at java.util.stream.StreamSpliterators$AbstractWrappingSpliterator.fillBuffer(StreamSpliterators.java:206) ~[na:1.8.0_212]
        at java.util.stream.StreamSpliterators$AbstractWrappingSpliterator.doAdvance(StreamSpliterators.java:169) ~[na:1.8.0_212]
        at java.util.stream.StreamSpliterators$WrappingSpliterator.tryAdvance(StreamSpliterators.java:300) ~[na:1.8.0_212]
        at java.util.Spliterators$1Adapter.hasNext(Spliterators.java:681) ~[na:1.8.0_212]
        at kotlin.sequences.TransformingSequence$iterator$1.hasNext(Sequences.kt:176) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.calcNext(Sequences.kt:131) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.hasNext(Sequences.kt:156) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.calcNext(Sequences.kt:131) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.hasNext(Sequences.kt:156) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.calcNext(Sequences.kt:131) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.hasNext(Sequences.kt:156) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.TransformingSequence$iterator$1.hasNext(Sequences.kt:176) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.calcNext(Sequences.kt:131) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.sequences.FilteringSequence$iterator$1.hasNext(Sequences.kt:156) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.collections.MapsKt__MapsKt.putAll(Maps.kt:419) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.collections.MapsKt__MapsKt.toMap(Maps.kt:587) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at kotlin.collections.MapsKt__MapsKt.toMap(Maps.kt:581) ~[kotlin-stdlib-1.3.72.jar!/:1.3.72-release-468 (1.3.72)]
        at org.gotson.komga.domain.service.FileSystemScanner.scanRootFolder(FileSystemScanner.kt:76) ~[classes!/:na]
        at org.gotson.komga.domain.service.LibraryScanner.scanRootFolder(LibraryScanner.kt:30) ~[classes!/:na]
        at org.gotson.komga.application.tasks.TaskHandler.handleTask(TaskHandler.kt:38) ~[classes!/:na]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_212]
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_212]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_212]
        at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_212]
        at org.springframework.messaging.handler.invocation.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:171) [spring-messaging-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.messaging.handler.invocation.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:120) [spring-messaging-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.adapter.MessagingMessageListenerAdapter.invokeHandler(MessagingMessageListenerAdapter.java:114) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.adapter.MessagingMessageListenerAdapter.onMessage(MessagingMessageListenerAdapter.java:77) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.AbstractMessageListenerContainer.doInvokeListener(AbstractMessageListenerContainer.java:736) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.AbstractMessageListenerContainer.invokeListener(AbstractMessageListenerContainer.java:696) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.AbstractMessageListenerContainer.doExecuteListener(AbstractMessageListenerContainer.java:674) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.AbstractPollingMessageListenerContainer.doReceiveAndExecute(AbstractPollingMessageListenerContainer.java:318) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.AbstractPollingMessageListenerContainer.receiveAndExecute(AbstractPollingMessageListenerContainer.java:257) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.invokeListener(DefaultMessageListenerContainer.java:1189) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.executeOngoingLoop(DefaultMessageListenerContainer.java:1179) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.run(DefaultMessageListenerContainer.java:1076) [spring-jms-5.2.8.RELEASE.jar!/:5.2.8.RELEASE]
        at java.lang.Thread.run(Thread.java:748) [na:1.8.0_212]
Caused by: java.nio.file.AccessDeniedException: /volume1/Comics/@eaDir/[email protected]
        at sun.nio.fs.UnixException.translateToIOException(UnixException.java:84) ~[na:1.8.0_212]
        at sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:102) ~[na:1.8.0_212]
        at sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:107) ~[na:1.8.0_212]
        at sun.nio.fs.UnixFileSystemProvider.newDirectoryStream(UnixFileSystemProvider.java:427) ~[na:1.8.0_212]
        at java.nio.file.Files.newDirectoryStream(Files.java:457) ~[na:1.8.0_212]
        at java.nio.file.FileTreeWalker.visit(FileTreeWalker.java:300) ~[na:1.8.0_212]
        at java.nio.file.FileTreeWalker.next(FileTreeWalker.java:372) ~[na:1.8.0_212]
        at java.nio.file.FileTreeIterator.fetchNextIfNeeded(FileTreeIterator.java:95) ~[na:1.8.0_212]
        ... 40 common frames omitted

2020-10-18 10:46:25.590  INFO 29999 --- [SpringContextShutdownHook] o.s.b.w.e.tomcat.GracefulShutdown        : Commencing graceful shutdown. Waiting for active requests to complete
2020-10-18 10:46:25.746  INFO 29999 --- [tomcat-shutdown] o.s.b.w.e.tomcat.GracefulShutdown        : Graceful shutdown complete
2020-10-18 10:46:26.404  INFO 29999 --- [SpringContextShutdownHook] io.hawt.web.auth.AuthenticationFilter    : Destroying hawtio authentication filter
2020-10-18 10:46:26.405  INFO 29999 --- [SpringContextShutdownHook] io.hawt.HawtioContextListener            : Destroying hawtio services
2020-10-18 10:46:26.490  INFO 29999 --- [SpringContextShutdownHook] o.s.s.c.ThreadPoolTaskScheduler          : Shutting down ExecutorService 'taskScheduler'
2020-10-18 10:46:26.499  INFO 29999 --- [SpringContextShutdownHook] o.s.s.concurrent.ThreadPoolTaskExecutor  : Shutting down ExecutorService 'applicationTaskExecutor'
2020-10-18 10:46:28.026  INFO 29999 --- [SpringContextShutdownHook] org.apache.activemq.artemis.core.server  : AMQ221002: Apache ActiveMQ Artemis Message Broker version 2.12.0 [f5ea392a-0a19-11eb-8655-001132876a45] stopped, uptime 32.486 seconds
2020-10-18 10:46:28.041  INFO 29999 --- [SpringContextShutdownHook] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Shutdown initiated...
2020-10-18 10:46:28.049  INFO 29999 --- [SpringContextShutdownHook] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Shutdown completed.

Steps to reproduce

1. Include libraries-scan-startup: true in application.yml
2. start the app

Expected behavior

A full library scanned

Actual behavior

The apps start, but no comic in the library due to the error

Additional context

the [email protected] is owned by root, so if not skiped, the error will continue.

ls -la
total 0
drwxrwxrwx+ 1 root root  42 Oct 18 10:36 .
drwxrwxrwx+ 1 http root 262 Oct 18 10:36 ..
drwx------  1 root root 566 Oct 18 10:42 [email protected]
drwxrwxrwt  1 root root  56 Oct  9 12:40 @tmp

Screenshots

If applicable, add screenshots to help explain your problem.

Log file

If applicable, add an excerpt of the log file (max 20 lines), or a link to a gist containing the log file.

[gotson]

That was a tough one, the Java method to walk a file tree cannot handle unreadable folders, and will throw an exception with no way of catching it in the user code T_T

[gotson]

🎉 This issue has been resolved in version 0.63.3 🎉

The release is available on:

• v0.63.3
• GitHub release

Your semantic-release bot 📦🚀