OHDSI / Arachne

Arachne Data Node web application
Apache License 2.0
1 stars 1 forks source link

App is not able to access the saved data (database connections, past analyses) #69

Open ablack3 opened 4 weeks ago

ablack3 commented 4 weeks ago

When using Arachne sometimes I'm not able to see the databases or past analyses. The only way to fix this is to restart the application.

Here are my docker logs.


Last login: Thu Aug 15 09:30:16 on ttys004
ablack@mi-black ArachneInstall % docker ps
CONTAINER ID   IMAGE                                   COMMAND                  CREATED          STATUS          PORTS                      NAMES
5e51ab32f6c8   odysseusinc/arachne-datanode-ce:2.0.2   "/bin/sh -c 'java -j…"   34 minutes ago   Up 34 minutes   127.0.0.1:8082->8080/tcp   arachne-datanode
32c481a7ebb6   postgres:15.5-alpine                    "docker-entrypoint.s…"   34 minutes ago   Up 34 minutes   127.0.0.1:5434->5432/tcp   arachne-datanode-postgres
22b581bbc79f   odysseusinc/execution_engine:2.2.1      "/bin/bash /__cacert…"   34 minutes ago   Up 34 minutes   127.0.0.1:8888->8888/tcp   arachne-execution-engine
ablack@mi-black ArachneInstall % docker logs arachne-execution-engine
/usr/bin/systemctl:1541: SyntaxWarning: invalid escape sequence '\w'
  expanded = re.sub("[$](\w+)", lambda m: get_env1(m), cmd.replace("\\\n",""))
/usr/bin/systemctl:1543: SyntaxWarning: invalid escape sequence '\w'
  new_text = re.sub("[$][{](\w+)[}]", lambda m: get_env2(m), expanded)
/usr/bin/systemctl:1628: SyntaxWarning: invalid escape sequence '\w'
  cmd3 = re.sub("[$](\w+)", lambda m: get_env1(m), cmd2)
/usr/bin/systemctl:1631: SyntaxWarning: invalid escape sequence '\w'
  newcmd += [ re.sub("[$][{](\w+)[}]", lambda m: get_env2(m), part) ]
/usr/bin/systemctl:1541: SyntaxWarning: invalid escape sequence '\w'
  expanded = re.sub("[$](\w+)", lambda m: get_env1(m), cmd.replace("\\\n",""))
/usr/bin/systemctl:1543: SyntaxWarning: invalid escape sequence '\w'
  new_text = re.sub("[$][{](\w+)[}]", lambda m: get_env2(m), expanded)
/usr/bin/systemctl:1628: SyntaxWarning: invalid escape sequence '\w'
  cmd3 = re.sub("[$](\w+)", lambda m: get_env1(m), cmd2)
/usr/bin/systemctl:1631: SyntaxWarning: invalid escape sequence '\w'
  newcmd += [ re.sub("[$][{](\w+)[}]", lambda m: get_env2(m), part) ]
 * Starting periodic command scheduler cron
   ...done.

  .   ____          _            __ _ _
 /\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
 \\/  ___)| |_)| | | | | || (_| |  ) ) ) )
  '  |____| .__|_| |_|_| |_\__, | / / / /
 =========|_|==============|___/=/_/_/_/
 :: Spring Boot ::               (v2.7.18)

2024-08-15 07:07:44.277  INFO 47 --- [           main] c.o.a.e.ExecutionEngineStarter           : Starting ExecutionEngineStarter v2.2.1 using Java 1.8.0_422 on 22b581bbc79f with PID 47 (/execution-engine.jar started by root in /)
2024-08-15 07:07:44.293  INFO 47 --- [           main] c.o.a.e.ExecutionEngineStarter           : No active profile set, falling back to 1 default profile: "default"
2024-08-15 07:07:54.130  INFO 47 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 8888 (https)
2024-08-15 07:07:54.185  INFO 47 --- [           main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2024-08-15 07:07:54.186  INFO 47 --- [           main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.83]
2024-08-15 07:07:54.636  INFO 47 --- [           main] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
2024-08-15 07:07:54.637  INFO 47 --- [           main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 9354 ms
2024-08-15 07:07:57.450  INFO 47 --- [           main] c.o.a.e.s.impl.DescriptorServiceImpl     : Scanning archive filder [/runtimes] for available descriptors
2024-08-15 07:07:58.000  INFO 47 --- [           main] c.o.a.e.s.impl.DescriptorServiceImpl     : Found descriptor [Default] (Default runtime) -> [r_base_focal_amd64.tar.gz]
2024-08-15 07:07:59.596  INFO 47 --- [           main] c.o.a.e.execution.r.DockerService        : Initialized Docker interface [unix:///var/run/docker.sock]
2024-08-15 07:08:01.667  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: org.postgresql.Driver. Version: 42.3
2024-08-15 07:08:01.670  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: net.sourceforge.jtds.jdbc.Driver. Version: 1.3
2024-08-15 07:08:01.679  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: com.amazon.redshift.Driver. Version: 2.1
2024-08-15 07:08:01.693  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: com.mysql.cj.jdbc.Driver. Version: 8.0
2024-08-15 07:08:01.694  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: com.microsoft.sqlserver.jdbc.SQLServerDriver. Version: 4.0
2024-08-15 07:08:01.716  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: oracle.jdbc.OracleDriver. Version: 12.2
2024-08-15 07:08:01.807  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: com.simba.spark.jdbc.Driver. Version: 2.6
2024-08-15 07:08:01.808  INFO 47 --- [           main] c.o.a.e.config.DriverManagerConfig       : Loaded JDBC driver: net.snowflake.client.jdbc.SnowflakeDriver. Version: 3.13
2024-08-15 07:08:07.367  INFO 47 --- [           main] o.a.t.util.net.NioEndpoint.certificate   : Connector [https-jsse-nio-8888], TLS virtual host [_default_], certificate type [UNDEFINED] configured from keystore [jar:file:/execution-engine.jar!/BOOT-INF/classes!/keystore.jks] using alias [arachne] with trust store [null]
2024-08-15 07:08:07.425  INFO 47 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat started on port(s): 8888 (https) with context path ''
2024-08-15 07:08:07.955  INFO 47 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 9999 (https)
2024-08-15 07:08:07.957  INFO 47 --- [           main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2024-08-15 07:08:07.958  INFO 47 --- [           main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.83]
2024-08-15 07:08:07.978  INFO 47 --- [           main] o.a.c.c.C.[Tomcat-1].[localhost].[/]     : Initializing Spring embedded WebApplicationContext
2024-08-15 07:08:07.979  INFO 47 --- [           main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 513 ms
2024-08-15 07:08:08.049  INFO 47 --- [           main] o.s.b.a.e.web.EndpointLinksResolver      : Exposing 1 endpoint(s) beneath base path '/actuator'
2024-08-15 07:08:08.314  INFO 47 --- [           main] o.a.t.util.net.NioEndpoint.certificate   : Connector [https-jsse-nio-9999], TLS virtual host [_default_], certificate type [UNDEFINED] configured from keystore [jar:file:/execution-engine.jar!/BOOT-INF/classes!/keystore.jks] using alias [arachne] with trust store [null]
2024-08-15 07:08:08.325  INFO 47 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat started on port(s): 9999 (https) with context path ''
2024-08-15 07:08:08.425  INFO 47 --- [           main] c.o.a.e.ExecutionEngineStarter           : Started ExecutionEngineStarter in 26.78 seconds (JVM running for 29.748)
2024-08-15 07:08:29.143  INFO 47 --- [nio-8888-exec-5] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring DispatcherServlet 'dispatcherServlet'
2024-08-15 07:08:29.145  INFO 47 --- [nio-8888-exec-5] o.s.web.servlet.DispatcherServlet        : Initializing Servlet 'dispatcherServlet'
2024-08-15 07:08:29.154  INFO 47 --- [nio-8888-exec-5] o.s.web.servlet.DispatcherServlet        : Completed initialization in 8 ms
2024-08-15 07:30:53.765  INFO 47 --- [nio-8888-exec-8] c.o.a.e.api.v1.AnalysisController        : Request [19] for [http://host.docker.internal:8082/api/v1/submissions/{id}/result/{password}] received
2024-08-15 07:30:54.195  INFO 47 --- [nio-8888-exec-8] c.o.a.e.api.v1.AnalysisController        : Request [19] extracted 1 files to [/etc/executions/exec-607101924808354433]
2024-08-15 07:30:54.256  INFO 47 --- [nio-8888-exec-8] c.o.a.e.execution.r.RService             : Execution [19] checking connection to [jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5]
2024-08-15 07:30:54.267  INFO 47 --- [nio-8888-exec-8] c.o.a.e.service.ConnectionPoolService    : Using JDBC: jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5
2024-08-15 07:30:54.406  INFO 47 --- [nio-8888-exec-8] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Starting...
2024-08-15 07:30:56.348  INFO 47 --- [nio-8888-exec-8] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Start completed.
2024-08-15 07:30:56.382  INFO 47 --- [nio-8888-exec-8] c.o.a.e.execution.r.RService             : Execution [19] connection verified, engine: [PostgreSQL]
2024-08-15 07:30:56.418  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [19] use Docker image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:30:56.420  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [19] pull skipped,  no docker registry configured
2024-08-15 07:30:56.445  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [19] creating container with image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:30:56.461  INFO 47 --- [nio-8888-exec-8] c.o.a.e.execution.r.RService             : Execution [19] started in R Runtime Service
2024-08-15 07:30:56.503  INFO 47 --- [nio-8888-exec-8] c.o.a.e.api.v1.AnalysisController        : Request [19] of type [R] accepted into processing
2024-08-15 07:30:56.975  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Execution [19] sending status [INITIALIZE], 45 chars of log
2024-08-15 07:30:59.289  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [19] created container [4b804b0f51ea8992a09dfb1851845ecd6964afc2f4c3d85891892541ddacafb8]
2024-08-15 07:30:59.293  INFO 47 --- [sTaskExecutor-3] c.o.a.e.execution.CallbackService        : Execution [19] sending status [INITIALIZE], 155 chars of log
2024-08-15 07:31:00.730 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: Error: This project does not contain a lockfile.
2024-08-15 07:31:00.732 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: Have you called `snapshot()` yet?
2024-08-15 07:31:00.738 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: Traceback (most recent calls last):
2024-08-15 07:31:00.739 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: 5: renv::restore()
2024-08-15 07:31:00.739 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: 4: lockfile %||% renv_lockfile_load(project = project, strict = TRUE)
2024-08-15 07:31:00.739 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: 3: renv_lockfile_load(project = project, strict = TRUE)
2024-08-15 07:31:00.739 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: 2: abort(c("This project does not contain a lockfile.", i = "Have you called `snapshot()` yet?"))
2024-08-15 07:31:00.739 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: 1: stop(fallback)
2024-08-15 07:31:00.740 DEBUG 47 --- [tream-745079073] c.o.a.e.execution.r.DockerOverseer       : Execution [19] STDOUT: Execution halted
2024-08-15 07:31:00.869  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerOverseer       : Execution [19] Rscript exit code 1
2024-08-15 07:31:04.949  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.AnalysisService        : Execution [19] completed, sending results...
2024-08-15 07:31:04.992  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [19] produced 119 result files
2024-08-15 07:31:04.992  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Adding folder [/etc/executions/exec-607101924808354433] to zip [/tmp/1723707064956-0/19_result.zip] with chunk size = 10485760
2024-08-15 07:31:05.314  WARN 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [19] send result: EXECUTE - Exit code 1
2024-08-15 07:31:05.566  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [19] result status sent, response HTTP 200 OK
2024-08-15 07:31:09.433  INFO 47 --- [sTaskExecutor-4] c.o.a.e.execution.CallbackService        : Execution [19] sending status [EXECUTE], 552 chars of log
2024-08-15 07:32:50.112  INFO 47 --- [nio-8888-exec-9] c.o.a.e.api.v1.AnalysisController        : Request [20] for [http://host.docker.internal:8082/api/v1/submissions/{id}/result/{password}] received
2024-08-15 07:32:50.271  INFO 47 --- [nio-8888-exec-9] c.o.a.e.api.v1.AnalysisController        : Request [20] extracted 1 files to [/etc/executions/exec-2958154622157349975]
2024-08-15 07:32:50.272  INFO 47 --- [nio-8888-exec-9] c.o.a.e.execution.r.RService             : Execution [20] checking connection to [jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5]
2024-08-15 07:32:50.273  INFO 47 --- [nio-8888-exec-9] c.o.a.e.service.ConnectionPoolService    : Using JDBC: jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5
2024-08-15 07:32:50.379  INFO 47 --- [nio-8888-exec-9] c.o.a.e.execution.r.RService             : Execution [20] connection verified, engine: [PostgreSQL]
2024-08-15 07:32:50.384  INFO 47 --- [nio-8888-exec-9] c.o.a.e.execution.r.RService             : Execution [20] started in R Runtime Service
2024-08-15 07:32:50.384  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.r.DockerService        : Execution [20] use Docker image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:32:50.384  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.r.DockerService        : Execution [20] pull skipped,  no docker registry configured
2024-08-15 07:32:50.385  INFO 47 --- [nio-8888-exec-9] c.o.a.e.api.v1.AnalysisController        : Request [20] of type [R] accepted into processing
2024-08-15 07:32:50.386  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.r.DockerService        : Execution [20] creating container with image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:32:50.386  INFO 47 --- [sTaskExecutor-3] c.o.a.e.execution.CallbackService        : Execution [20] sending status [INITIALIZE], 45 chars of log
2024-08-15 07:32:50.708  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.r.DockerService        : Execution [20] created container [c2fa0b416999663fa65a622d6636d9d09a130b91d1763ff9f4ef3fa6f865790b]
2024-08-15 07:32:50.826  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [20] sending status [INITIALIZE], 156 chars of log
2024-08-15 07:32:54.859 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: Error in `value[[3L]]()`:
2024-08-15 07:32:54.861 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: ! Unable to evaluate the 'port' argument of the connection details. Most likely this is because the connection is being established in a separate R thread that has no access to variables in the main thread. This problem will not occur when using a secure approach to credentials such as keyring. See ?createConnectionDetails for more information.
2024-08-15 07:32:54.862 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: Backtrace:
2024-08-15 07:32:54.863 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: ▆
2024-08-15 07:32:54.864 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 1. └─DatabaseConnector::connect(connectionDetails)
2024-08-15 07:32:54.864 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 2.   └─DatabaseConnector:::assertDetailsCanBeValidated(connectionDetails)
2024-08-15 07:32:54.865 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 3.     └─DatabaseConnector:::checkDetailValidation(...)
2024-08-15 07:32:54.865 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 4.       └─base::tryCatch(...)
2024-08-15 07:32:54.865 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 5.         └─base (local) tryCatchList(expr, classes, parentenv, handlers)
2024-08-15 07:32:54.866 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 6.           └─base (local) tryCatchOne(expr, names, parentenv, handlers[[1L]])
2024-08-15 07:32:54.866 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 7.             └─value[[3L]](cond)
2024-08-15 07:32:54.867 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: 8.               └─rlang::abort(...)
2024-08-15 07:32:55.029 DEBUG 47 --- [stream-14207231] c.o.a.e.execution.r.DockerOverseer       : Execution [20] STDOUT: Execution halted
2024-08-15 07:32:55.144  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.r.DockerOverseer       : Execution [20] Rscript exit code 1
2024-08-15 07:32:59.180  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.AnalysisService        : Execution [20] completed, sending results...
2024-08-15 07:32:59.224  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Execution [20] produced 119 result files
2024-08-15 07:32:59.225  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Adding folder [/etc/executions/exec-2958154622157349975] to zip [/tmp/1723707179181-0/20_result.zip] with chunk size = 10485760
2024-08-15 07:32:59.444  WARN 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Execution [20] send result: EXECUTE - Exit code 1
2024-08-15 07:32:59.527  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Execution [20] result status sent, response HTTP 200 OK
2024-08-15 07:33:01.042  INFO 47 --- [sTaskExecutor-4] c.o.a.e.execution.CallbackService        : Execution [20] sending status [EXECUTE], 1055 chars of log
2024-08-15 07:33:59.516  INFO 47 --- [nio-8888-exec-1] c.o.a.e.api.v1.AnalysisController        : Request [21] for [http://host.docker.internal:8082/api/v1/submissions/{id}/result/{password}] received
2024-08-15 07:33:59.682  INFO 47 --- [nio-8888-exec-1] c.o.a.e.api.v1.AnalysisController        : Request [21] extracted 1 files to [/etc/executions/exec-6283200093015850147]
2024-08-15 07:33:59.684  INFO 47 --- [nio-8888-exec-1] c.o.a.e.execution.r.RService             : Execution [21] checking connection to [jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5]
2024-08-15 07:33:59.685  INFO 47 --- [nio-8888-exec-1] c.o.a.e.service.ConnectionPoolService    : Using JDBC: jdbc:postgresql://pgsqltest.cqnqzwtn5s1q.us-east-1.rds.amazonaws.com:5432/vocabularyv5
2024-08-15 07:33:59.788  INFO 47 --- [nio-8888-exec-1] c.o.a.e.execution.r.RService             : Execution [21] connection verified, engine: [PostgreSQL]
2024-08-15 07:33:59.791  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [21] use Docker image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:33:59.792  INFO 47 --- [nio-8888-exec-1] c.o.a.e.execution.r.RService             : Execution [21] started in R Runtime Service
2024-08-15 07:33:59.792  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [21] pull skipped,  no docker registry configured
2024-08-15 07:33:59.794  INFO 47 --- [nio-8888-exec-1] c.o.a.e.api.v1.AnalysisController        : Request [21] of type [R] accepted into processing
2024-08-15 07:33:59.795  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [21] creating container with image [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:33:59.796  INFO 47 --- [sTaskExecutor-3] c.o.a.e.execution.CallbackService        : Execution [21] sending status [INITIALIZE], 45 chars of log
2024-08-15 07:33:59.844  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerService        : Execution [21] created container [79739bdfa47b19f88c2b11c5bf318b41db65ed0e2e91813aee29b0f65c686782]
2024-08-15 07:33:59.845  INFO 47 --- [sTaskExecutor-2] c.o.a.e.execution.CallbackService        : Execution [21] sending status [INITIALIZE], 156 chars of log
2024-08-15 07:34:03.471 DEBUG 47 --- [ream--559630471] c.o.a.e.execution.r.DockerOverseer       : Execution [21] STDOUT: Connecting using PostgreSQL driver
2024-08-15 07:34:06.033 DEBUG 47 --- [ream--559630471] c.o.a.e.execution.r.DockerOverseer       : Execution [21] STDOUT: Error in is(connection, "Pool") : object 'con' not found
2024-08-15 07:34:06.033 DEBUG 47 --- [ream--559630471] c.o.a.e.execution.r.DockerOverseer       : Execution [21] STDOUT: Calls: <Anonymous> -> is
2024-08-15 07:34:06.033 DEBUG 47 --- [ream--559630471] c.o.a.e.execution.r.DockerOverseer       : Execution [21] STDOUT: Execution halted
2024-08-15 07:34:06.132  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.r.DockerOverseer       : Execution [21] Rscript exit code 1
2024-08-15 07:34:09.970  INFO 47 --- [sTaskExecutor-4] c.o.a.e.execution.CallbackService        : Execution [21] sending status [EXECUTE], 335 chars of log
2024-08-15 07:34:10.001  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.AnalysisService        : Execution [21] completed, sending results...
2024-08-15 07:34:10.037  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [21] produced 119 result files
2024-08-15 07:34:10.037  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Adding folder [/etc/executions/exec-6283200093015850147] to zip [/tmp/1723707250001-0/21_result.zip] with chunk size = 10485760
2024-08-15 07:34:10.216  WARN 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [21] send result: EXECUTE - Exit code 1
2024-08-15 07:34:10.301  INFO 47 --- [sTaskExecutor-1] c.o.a.e.execution.CallbackService        : Execution [21] result status sent, response HTTP 200 OK
ablack3 commented 4 weeks ago
ablack@mi-black ArachneInstall % docker logs arachne-datanode        

  .   ____          _            __ _ _
 /\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
 \\/  ___)| |_)| | | | | || (_| |  ) ) ) )
  '  |____| .__|_| |_|_| |_\__, | / / / /
 =========|_|==============|___/=/_/_/_/
 :: Spring Boot ::               (v2.7.18)

2024-08-15 07:07:41.695  INFO 1 --- [           main] c.o.a.datanode.WebApplicationStarter     : Starting WebApplicationStarter v2.x-SNAPSHOT using Java 1.8.0_412 on 5e51ab32f6c8 with PID 1 (/datanode.jar started by root in /)
2024-08-15 07:07:41.712  INFO 1 --- [           main] c.o.a.datanode.WebApplicationStarter     : No active profile set, falling back to 1 default profile: "default"
2024-08-15 07:07:48.409  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2024-08-15 07:07:49.215  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 749 ms. Found 8 JPA repository interfaces.
2024-08-15 07:07:53.203  INFO 1 --- [           main] o.s.c.a.ConfigurationClassEnhancer       : @Bean method SpringPropertiesConfig.propertySourcesPlaceholderConfigurer is non-static and returns an object assignable to Spring's BeanFactoryPostProcessor interface. This will result in a failure to process annotations such as @Autowired, @Resource and @PostConstruct within the method's declaring @Configuration class. Add the 'static' modifier to this method to avoid these container lifecycle issues; see @Bean javadoc for complete details.
2024-08-15 07:07:53.239  INFO 1 --- [           main] c.u.j.r.DefaultLazyPropertyResolver      : Property Resolver custom Bean not found with name 'encryptablePropertyResolver'. Initializing Default Property Resolver
2024-08-15 07:07:53.277  INFO 1 --- [           main] c.u.j.d.DefaultLazyPropertyDetector      : Property Detector custom Bean not found with name 'encryptablePropertyDetector'. Initializing Default Property Detector
2024-08-15 07:07:56.074  INFO 1 --- [           main] ptablePropertiesBeanFactoryPostProcessor : Post-processing PropertySource instances
2024-08-15 07:07:56.257  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource configurationProperties [org.springframework.boot.context.properties.source.ConfigurationPropertySourcesPropertySource] to AOP Proxy
2024-08-15 07:07:56.259  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource servletConfigInitParams [org.springframework.core.env.PropertySource$StubPropertySource] to EncryptablePropertySourceWrapper
2024-08-15 07:07:56.260  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource servletContextInitParams [org.springframework.core.env.PropertySource$StubPropertySource] to EncryptablePropertySourceWrapper
2024-08-15 07:07:56.260  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource systemProperties [org.springframework.core.env.PropertiesPropertySource] to EncryptableMapPropertySourceWrapper
2024-08-15 07:07:56.261  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource systemEnvironment [org.springframework.boot.env.SystemEnvironmentPropertySourceEnvironmentPostProcessor$OriginAwareSystemEnvironmentPropertySource] to EncryptableSystemEnvironmentPropertySourceWrapper
2024-08-15 07:07:56.261  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource random [org.springframework.boot.env.RandomValuePropertySource] to EncryptablePropertySourceWrapper
2024-08-15 07:07:56.261  INFO 1 --- [           main] c.u.j.EncryptablePropertySourceConverter : Converting PropertySource Config resource 'class path resource [application.yml]' via location 'optional:classpath:/' [org.springframework.boot.env.OriginTrackedMapPropertySource] to EncryptableMapPropertySourceWrapper
2024-08-15 07:07:57.542  INFO 1 --- [           main] c.u.j.filter.DefaultLazyPropertyFilter   : Property Filter custom Bean not found with name 'encryptablePropertyFilter'. Initializing Default Property Filter
2024-08-15 07:07:58.014  INFO 1 --- [           main] trationDelegate$BeanPostProcessorChecker : Bean 'webConfig' of type [com.odysseusinc.arachne.datanode.config.WebConfig$$EnhancerBySpringCGLIB$$3f06e386] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2024-08-15 07:08:00.242  INFO 1 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 8080 (http)
2024-08-15 07:08:00.288  INFO 1 --- [           main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2024-08-15 07:08:00.289  INFO 1 --- [           main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.83]
2024-08-15 07:08:00.565  INFO 1 --- [           main] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
2024-08-15 07:08:00.566  INFO 1 --- [           main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 18355 ms
2024-08-15 07:08:01.017  WARN 1 --- [           main] JpaBaseConfiguration$JpaWebConfiguration : spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning
2024-08-15 07:08:02.032  INFO 1 --- [           main] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Starting...
2024-08-15 07:08:02.296  INFO 1 --- [           main] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Start completed.
2024-08-15 07:08:02.787  INFO 1 --- [           main] o.f.c.internal.license.VersionPrinter    : Flyway Community Edition 8.5.13 by Redgate
2024-08-15 07:08:02.788  INFO 1 --- [           main] o.f.c.internal.license.VersionPrinter    : See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2024-08-15 07:08:02.788  INFO 1 --- [           main] o.f.c.internal.license.VersionPrinter    : 
2024-08-15 07:08:03.943  INFO 1 --- [           main] o.f.c.i.database.base.BaseDatabaseType   : Database: jdbc:postgresql://arachne-datanode-postgres:5432/arachne_datanode (PostgreSQL 15.5)
2024-08-15 07:08:04.006  WARN 1 --- [           main] o.f.c.internal.database.base.Database    : Flyway upgrade recommended: PostgreSQL 15.5 is newer than this version of Flyway and support has not been tested. The latest supported version of PostgreSQL is 14.
2024-08-15 07:08:04.316  INFO 1 --- [           main] o.f.core.internal.command.DbMigrate      : Current version of schema "public": 20240719000000
2024-08-15 07:08:04.317  WARN 1 --- [           main] o.f.core.internal.command.DbMigrate      : outOfOrder mode is active. Migration of schema "public" may not be reproducible.
2024-08-15 07:08:04.319  INFO 1 --- [           main] o.f.core.internal.command.DbMigrate      : Schema "public" is up to date. No migration necessary.
2024-08-15 07:08:05.394  INFO 1 --- [           main] o.hibernate.jpa.internal.util.LogHelper  : HHH000204: Processing PersistenceUnitInfo [name: default]
2024-08-15 07:08:05.867  INFO 1 --- [           main] org.hibernate.Version                    : HHH000412: Hibernate ORM core version 5.6.15.Final
2024-08-15 07:08:06.820  INFO 1 --- [           main] o.hibernate.annotations.common.Version   : HCANN000001: Hibernate Commons Annotations {5.1.2.Final}
2024-08-15 07:08:07.472  INFO 1 --- [           main] org.hibernate.dialect.Dialect            : HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL95Dialect
2024-08-15 07:08:12.712  INFO 1 --- [           main] o.h.e.t.j.p.i.JtaPlatformInitiator       : HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2024-08-15 07:08:12.762  INFO 1 --- [           main] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default'
2024-08-15 07:08:18.085  INFO 1 --- [           main] o.s.boot.web.servlet.RegistrationBean    : Filter authenticationTokenFilter was not registered (disabled)
2024-08-15 07:08:19.786  INFO 1 --- [           main] o.a.c.s.p.AnnotationPreprocessorRegistry : Initialize code generators
2024-08-15 07:08:19.796  INFO 1 --- [           main] o.a.c.s.p.AnnotationPreprocessorRegistry : Registered code generator: strategusPreprocessor for type: strategusjson
2024-08-15 07:08:22.102  INFO 1 --- [           main] c.o.a.d.c.BuildNumberController          : Version [2.0.2], build [qa] @ [2024-08-09T09:09:05Z]
2024-08-15 07:08:23.217  INFO 1 --- [           main] o.s.s.web.DefaultSecurityFilterChain     : Will secure any request with [org.springframework.security.web.session.DisableEncodeUrlFilter@8c46918, org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@226b143b, org.springframework.security.web.context.SecurityContextPersistenceFilter@6c37bd27, org.springframework.security.web.header.HeaderWriterFilter@4455f57d, org.springframework.security.web.authentication.logout.LogoutFilter@40ee0a22, com.odysseusinc.arachne.datanode.security.AuthenticationTokenFilter@138a7441, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@30331109, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@74fe5966, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@682bd3c4, org.springframework.security.web.session.SessionManagementFilter@4d0b0fd4, org.springframework.security.web.access.ExceptionTranslationFilter@ccd1bc3, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@55cff952]
2024-08-15 07:08:24.022  INFO 1 --- [           main] o.s.b.a.w.s.WelcomePageHandlerMapping    : Adding welcome page: class path resource [public/index.html]
2024-08-15 07:08:26.312  INFO 1 --- [           main] o.s.l.c.support.AbstractContextSource    : Property 'userDn' not set - anonymous context will be used for read-write operations
2024-08-15 07:08:26.791  INFO 1 --- [           main] o.s.b.a.e.web.EndpointLinksResolver      : Exposing 1 endpoint(s) beneath base path '/actuator'
2024-08-15 07:08:27.009  INFO 1 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat started on port(s): 8080 (http) with context path ''
2024-08-15 07:08:27.103  INFO 1 --- [           main] c.o.a.datanode.WebApplicationStarter     : Started WebApplicationStarter in 48.666 seconds (JVM running for 51.376)
2024-08-15 07:08:27.379  INFO 1 --- [           main] c.o.a.d.security.UserAccountInitializer  : Verifying 1 service accounts
2024-08-15 07:08:30.971  INFO 1 --- [NodeScheduler-2] c.o.a.d.e.EnvironmentDescriptorService   : Validated descriptor #1 [Default] - [Default runtime], 8064 bytes
2024-08-15 07:08:31.040  INFO 1 --- [NodeScheduler-1] c.o.a.d.e.ExecutionEngineSyncService     : EE status: CONNECTED
2024-08-15 07:08:31.428  INFO 1 --- [NodeScheduler-1] c.o.a.d.service.AnalysisStateService     : Analysis [10] state updated to DEAD (UNAVAILABLE)
2024-08-15 07:28:42.696  INFO 1 --- [nio-8080-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring DispatcherServlet 'dispatcherServlet'
2024-08-15 07:28:42.698  INFO 1 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet        : Initializing Servlet 'dispatcherServlet'
2024-08-15 07:28:42.707  INFO 1 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet        : Completed initialization in 8 ms
2024-08-15 07:28:46.970  INFO 1 --- [nio-8080-exec-9] com.zaxxer.hikari.HikariDataSource       : HikariPool-2 - Starting...
2024-08-15 07:28:47.114  INFO 1 --- [nio-8080-exec-9] com.zaxxer.hikari.HikariDataSource       : HikariPool-2 - Start completed.
2024-08-15 07:30:50.782  INFO 1 --- [nio-8080-exec-5] c.o.a.d.service.AnalysisStateService     : Analysis [19] state updated to CREATED (Created by [Datanode Admin])
2024-08-15 07:30:50.788  INFO 1 --- [nio-8080-exec-5] c.o.a.datanode.service.AnalysisService   : Request [19] sending to engine for DS [1] (manual upload by [Datanode Admin])
2024-08-15 07:30:53.146  INFO 1 --- [nio-8080-exec-5] .i.ExecutionEngineIntegrationServiceImpl : Request [19] with files for [1723707050356-0], sending now
2024-08-15 07:30:57.348  INFO 1 --- [nio-8080-exec-5] c.o.a.datanode.service.AnalysisService   : Request [19] of type [R] sent successfully, descriptor in use [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:30:57.460  INFO 1 --- [nio-8080-exec-5] c.o.a.d.service.AnalysisStateService     : Analysis [19] state updated to EXECUTING (Accepted by engine as R type)
2024-08-15 07:31:05.529  INFO 1 --- [nio-8080-exec-2] c.o.a.d.service.AnalysisStateService     : Analysis [19] state updated to EXECUTION_FAILURE (Exit code 1)
2024-08-15 07:32:49.094  INFO 1 --- [nio-8080-exec-1] c.o.a.d.service.AnalysisStateService     : Analysis [20] state updated to CREATED (Created by [Datanode Admin])
2024-08-15 07:32:49.103  INFO 1 --- [nio-8080-exec-1] c.o.a.datanode.service.AnalysisService   : Request [20] sending to engine for DS [1] (manual upload by [Datanode Admin])
2024-08-15 07:32:50.043  INFO 1 --- [nio-8080-exec-1] .i.ExecutionEngineIntegrationServiceImpl : Request [20] with files for [1723707168950-0], sending now
2024-08-15 07:32:50.519  INFO 1 --- [nio-8080-exec-1] c.o.a.datanode.service.AnalysisService   : Request [20] of type [R] sent successfully, descriptor in use [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:32:50.573  INFO 1 --- [nio-8080-exec-1] c.o.a.d.service.AnalysisStateService     : Analysis [20] state updated to EXECUTING (Accepted by engine as R type)
2024-08-15 07:32:53.469 ERROR 1 --- [nio-8080-exec-4] c.o.a.d.c.ExceptionHandlingAdvice        : An error has occurred. Please contact system administrator

com.odysseusinc.arachne.datanode.exception.IllegalOperationException: ZIP archive is not found in analysis [20]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService.lambda$getAnalysisResults$2(AnalysisResultsService.java:84) ~[classes!/:2.x-SNAPSHOT]
    at java.util.Optional.orElseThrow(Optional.java:290) ~[na:1.8.0_412]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService.lambda$getAnalysisResults$3(AnalysisResultsService.java:84) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService.analysisFiles(AnalysisResultsService.java:121) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService.getAnalysisResults(AnalysisResultsService.java:81) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService$$FastClassBySpringCGLIB$$3cea5018.invoke(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218) ~[spring-core-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:792) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:123) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:388) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:707) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at com.odysseusinc.arachne.datanode.service.AnalysisResultsService$$EnhancerBySpringCGLIB$$179fbffd.getAnalysisResults(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.controller.analysis.AnalysisResultsController.listResultFiles(AnalysisResultsController.java:47) ~[classes!/:2.x-SNAPSHOT]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_412]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_412]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_412]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_412]
    at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:205) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:150) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:117) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:895) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:808) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1072) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:965) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:209) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:51) [tomcat-embed-websocket-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:337) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:115) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:122) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:116) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:126) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:109) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:149) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at com.odysseusinc.arachne.datanode.security.AuthenticationTokenFilter.doFilter(AuthenticationTokenFilter.java:74) [classes!/:2.x-SNAPSHOT]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:103) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:89) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doHeadersAfter(HeaderWriterFilter.java:90) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:75) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:112) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:82) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:55) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.DisableEncodeUrlFilter.doFilterInternal(DisableEncodeUrlFilter.java:42) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:221) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:186) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:354) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:267) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:96) [spring-boot-actuator-2.7.18.jar!/:2.7.18]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:168) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:481) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:342) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:390) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:928) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1794) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-embed-core-9.0.83.jar!/:na]
    at java.lang.Thread.run(Thread.java:750) [na:1.8.0_412]

2024-08-15 07:32:59.501  INFO 1 --- [nio-8080-exec-8] c.o.a.d.service.AnalysisStateService     : Analysis [20] state updated to EXECUTION_FAILURE (Exit code 1)
2024-08-15 07:33:58.539  INFO 1 --- [nio-8080-exec-6] c.o.a.d.service.AnalysisStateService     : Analysis [21] state updated to CREATED (Created by [Datanode Admin])
2024-08-15 07:33:58.544  INFO 1 --- [nio-8080-exec-6] c.o.a.datanode.service.AnalysisService   : Request [21] sending to engine for DS [1] (manual upload by [Datanode Admin])
2024-08-15 07:33:59.445  INFO 1 --- [nio-8080-exec-6] .i.ExecutionEngineIntegrationServiceImpl : Request [21] with files for [1723707238350-0], sending now
2024-08-15 07:33:59.827  INFO 1 --- [nio-8080-exec-6] c.o.a.datanode.service.AnalysisService   : Request [21] of type [R] sent successfully, descriptor in use [executionengine.azurecr.io/darwin-cohort-diagnostics:v0.1]
2024-08-15 07:34:00.141 ERROR 1 --- [nio-8080-exec-7] c.o.a.d.c.ExceptionHandlingAdvice        : Submission [21] not found or password invalid

com.odysseusinc.arachne.datanode.exception.ValidationException: Submission [21] not found or password invalid
    at com.odysseusinc.arachne.datanode.service.AnalysisService.lambda$updateStatus$4(AnalysisService.java:235) ~[classes!/:2.x-SNAPSHOT]
    at java.util.Optional.orElseThrow(Optional.java:290) ~[na:1.8.0_412]
    at com.odysseusinc.arachne.datanode.service.AnalysisService.updateStatus(AnalysisService.java:234) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.service.AnalysisService$$FastClassBySpringCGLIB$$6caff69c.invoke(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218) ~[spring-core-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:792) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:123) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:388) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:707) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at com.odysseusinc.arachne.datanode.service.AnalysisService$$EnhancerBySpringCGLIB$$20dae609.updateStatus(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.controller.analysis.AnalysisCallbackController.doUpdateSubmission(AnalysisCallbackController.java:65) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.controller.analysis.AnalysisCallbackController.updateSubmission(AnalysisCallbackController.java:57) ~[classes!/:2.x-SNAPSHOT]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_412]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_412]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_412]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_412]
    at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:205) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:150) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:117) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:895) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:808) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1072) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:965) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:555) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:209) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:51) [tomcat-embed-websocket-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:337) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:115) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:122) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:116) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:126) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:109) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:149) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at com.odysseusinc.arachne.datanode.security.AuthenticationTokenFilter.doFilter(AuthenticationTokenFilter.java:74) [classes!/:2.x-SNAPSHOT]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:103) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:89) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doHeadersAfter(HeaderWriterFilter.java:90) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:75) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:112) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:82) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:55) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.DisableEncodeUrlFilter.doFilterInternal(DisableEncodeUrlFilter.java:42) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:221) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:186) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:354) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:267) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:96) [spring-boot-actuator-2.7.18.jar!/:2.7.18]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:168) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:481) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:342) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:390) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:928) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1794) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-embed-core-9.0.83.jar!/:na]
    at java.lang.Thread.run(Thread.java:750) [na:1.8.0_412]

2024-08-15 07:34:00.134  INFO 1 --- [nio-8080-exec-6] c.o.a.d.service.AnalysisStateService     : Analysis [21] state updated to EXECUTING (Accepted by engine as R type)
2024-08-15 07:34:00.146 ERROR 1 --- [nio-8080-exec-2] c.o.a.d.c.ExceptionHandlingAdvice        : Submission [21] not found or password invalid

com.odysseusinc.arachne.datanode.exception.ValidationException: Submission [21] not found or password invalid
    at com.odysseusinc.arachne.datanode.service.AnalysisService.lambda$updateStatus$4(AnalysisService.java:235) ~[classes!/:2.x-SNAPSHOT]
    at java.util.Optional.orElseThrow(Optional.java:290) ~[na:1.8.0_412]
    at com.odysseusinc.arachne.datanode.service.AnalysisService.updateStatus(AnalysisService.java:234) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.service.AnalysisService$$FastClassBySpringCGLIB$$6caff69c.invoke(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218) ~[spring-core-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:792) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:123) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:388) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) ~[spring-tx-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:762) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:707) ~[spring-aop-5.3.31.jar!/:5.3.31]
    at com.odysseusinc.arachne.datanode.service.AnalysisService$$EnhancerBySpringCGLIB$$20dae609.updateStatus(<generated>) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.controller.analysis.AnalysisCallbackController.doUpdateSubmission(AnalysisCallbackController.java:65) ~[classes!/:2.x-SNAPSHOT]
    at com.odysseusinc.arachne.datanode.controller.analysis.AnalysisCallbackController.updateSubmission(AnalysisCallbackController.java:57) ~[classes!/:2.x-SNAPSHOT]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_412]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_412]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_412]
    at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_412]
    at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:205) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:150) ~[spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:117) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:895) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:808) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1072) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:965) ~[spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:555) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) [spring-webmvc-5.3.31.jar!/:5.3.31]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:209) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:51) [tomcat-embed-websocket-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:337) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:115) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:122) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:116) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:126) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:81) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:109) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:149) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at com.odysseusinc.arachne.datanode.security.AuthenticationTokenFilter.doFilter(AuthenticationTokenFilter.java:74) [classes!/:2.x-SNAPSHOT]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:103) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:89) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doHeadersAfter(HeaderWriterFilter.java:90) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:75) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:112) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:82) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:55) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.session.DisableEncodeUrlFilter.doFilterInternal(DisableEncodeUrlFilter.java:42) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:346) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:221) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:186) [spring-security-web-5.7.11.jar!/:5.7.11]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:354) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:267) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:96) [spring-boot-actuator-2.7.18.jar!/:2.7.18]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) [spring-web-5.3.31.jar!/:5.3.31]
    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:117) [spring-web-5.3.31.jar!/:5.3.31]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:178) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:153) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:168) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:481) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:342) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:390) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:928) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1794) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) [tomcat-embed-core-9.0.83.jar!/:na]
    at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-embed-core-9.0.83.jar!/:na]
    at java.lang.Thread.run(Thread.java:750) [na:1.8.0_412]

2024-08-15 07:34:10.279  INFO 1 --- [nio-8080-exec-9] c.o.a.d.service.AnalysisStateService     : Analysis [21] state updated to EXECUTION_FAILURE (Exit code 1)
ablack@mi-black ArachneInstall % docker ps                           
CONTAINER ID   IMAGE                                   COMMAND                  CREATED          STATUS          PORTS                      NAMES
5e51ab32f6c8   odysseusinc/arachne-datanode-ce:2.0.2   "/bin/sh -c 'java -j…"   37 minutes ago   Up 37 minutes   127.0.0.1:8082->8080/tcp   arachne-datanode
32c481a7ebb6   postgres:15.5-alpine                    "docker-entrypoint.s…"   37 minutes ago   Up 37 minutes   127.0.0.1:5434->5432/tcp   arachne-datanode-postgres
22b581bbc79f   odysseusinc/execution_engine:2.2.1      "/bin/bash /__cacert…"   37 minutes ago   Up 37 minutes   127.0.0.1:8888->8888/tcp   arachne-execution-engine
ablack@mi-black ArachneInstall % docker logs arachne-datanode-postgres

PostgreSQL Database directory appears to contain a database; Skipping initialization

2024-08-15 07:07:35.594 UTC [1] LOG:  starting PostgreSQL 15.5 on aarch64-unknown-linux-musl, compiled by gcc (Alpine 13.2.1_git20231014) 13.2.1 20231014, 64-bit
2024-08-15 07:07:35.594 UTC [1] LOG:  listening on IPv4 address "0.0.0.0", port 5432
2024-08-15 07:07:35.594 UTC [1] LOG:  listening on IPv6 address "::", port 5432
2024-08-15 07:07:35.595 UTC [1] LOG:  listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432"
2024-08-15 07:07:35.596 UTC [24] LOG:  database system was shut down at 2024-08-14 15:02:53 UTC
2024-08-15 07:07:35.601 UTC [1] LOG:  database system is ready to accept connections
2024-08-15 07:22:30.591 UTC [22] LOG:  checkpoint starting: time
2024-08-15 07:22:31.432 UTC [22] LOG:  checkpoint complete: wrote 11 buffers (0.1%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.825 s, sync=0.008 s, total=0.841 s; sync files=10, longest=0.005 s, average=0.001 s; distance=21 kB, estimate=21 kB
2024-08-15 07:27:30.456 UTC [22] LOG:  checkpoint starting: time
2024-08-15 07:27:30.566 UTC [22] LOG:  checkpoint complete: wrote 2 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.103 s, sync=0.003 s, total=0.110 s; sync files=2, longest=0.002 s, average=0.002 s; distance=2 kB, estimate=19 kB
2024-08-15 07:32:30.643 UTC [22] LOG:  checkpoint starting: time
2024-08-15 07:32:31.911 UTC [22] LOG:  checkpoint complete: wrote 13 buffers (0.1%); 0 WAL file(s) added, 0 removed, 0 recycled; write=1.254 s, sync=0.007 s, total=1.269 s; sync files=13, longest=0.005 s, average=0.001 s; distance=25 kB, estimate=25 kB
2024-08-15 07:37:31.015 UTC [22] LOG:  checkpoint starting: time
2024-08-15 07:37:32.757 UTC [22] LOG:  checkpoint complete: wrote 18 buffers (0.1%); 0 WAL file(s) added, 0 removed, 0 recycled; write=1.735 s, sync=0.004 s, total=1.742 s; sync files=16, longest=0.003 s, average=0.001 s; distance=55 kB, estimate=55 kB
ablack@mi-black ArachneInstall % 
ablack3 commented 4 weeks ago

data source dropdown does not work

image