s Sean
on

 

Hello,

I have developed a CLI tool to validate SDTM and ADaM datasets from SAS. The tool works about 50% of the time, but often fails with warnings output to the java log. However, the command / java code is identical with each case. What could be causing this fail sometimes with "Failed to process encrypted file" and "Failed to process eTag file" warnings?

 

NOTE: internal paths below were replaced with "<path>"

 

Here is the java command used in order to validate ADAM.ADLB (including cross-validation checks with adam.adsl and sdtm.ae/dm/ex:

 

java -jar "<path>\resources\app.asar.unpacked\components\lib\p21-client-1.0.2.jar" --engine.version="FDA 1903.1" --standard.version=1.1 --standard=ADAM

--config="<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\ADaM-IG 1.1 (FDA).xml"

--cdisc.ct.sdtm.version=2020-06-26

--source.sdtm="<path>\SDTM\XPT\ae.xpt;<path>\SDTM\XPT\dm.xpt;<path>\SDTM\XPT\ex.xpt"

--source.adam="<path>\ADaM\XPT\adlb.xpt;<path>\ADaM\XPT\adsl.xpt"

--cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1

--report="<path>\P21 v3.0.2, ADLB, 2021-03-23T14_00.xlsx" --report.cutoff=1000 > Z:\myjavalog.txt
 

 

Here is the log containing the warning (fail points bolded):

13:53:10,521 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
13:53:10,521 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
13:53:10,521 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:<path>/resources/app.asar.unpacked/components/lib/p21-client-1.0.2.jar!/logback.xml]
13:53:10,537 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3439f68d - URL [jar:file:<path>/resources/app.asar.unpacked/components/lib/p21-client-1.0.2.jar!/logback.xml] is not of type file
13:53:10,631 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
13:53:10,709 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.JarNameDefiner]
13:53:10,709 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [jarName] from the object stack
13:53:10,818 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogLevelDefiner]
13:53:10,818 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [logLevel] from the object stack
13:53:10,818 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogAppendFlagDefiner]
13:53:10,818 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [appendFlag] from the object stack
13:53:10,818 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
13:53:10,834 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CLI-APPENDER]
13:53:10,849 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
13:53:10,959 |-INFO in ch.qos.logback.core.FileAppender[CLI-APPENDER] - File property is set to [<path>\resources\app.asar.unpacked\components\lib\p21-client-1.0.2.log]
13:53:10,974 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.pinnacle21.oce.services.RemoteAppender]
13:53:11,021 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [REMOTE]
13:53:11,021 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
13:53:11,021 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
13:53:11,021 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - This appender no longer admits a layout as a sub-component, set an encoder instead.
13:53:11,021 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - To ensure compatibility, wrapping your layout in LayoutWrappingEncoder.
13:53:11,021 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also http://logback.qos.ch/codes.html#layoutInsteadOfEncoder for details
13:53:11,021 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
13:53:11,021 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [REMOTE] to Logger[ROOT]
13:53:11,037 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CLI-APPENDER] to Logger[ROOT]
13:53:11,037 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
13:53:11,037 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
13:53:11,037 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dbd940d - Registering current configuration as safe fallback point

2021-03-23 13:53:20 [main] INFO  net.pinnacle21.oce.model.input.Input - Use default value 2
2021-03-23 13:53:22 [RxIoScheduler-3] INFO  net.bootstrap.core.AbstractCommand - command='cmd-aws-healthCheck', runTime=1094
2021-03-23 13:53:22 [RxIoScheduler-3] INFO  net.bootstrap.utils.S3Loader - Services are healthy
2021-03-23 13:53:22 [main] ERROR n.b.c.i.EncryptedFileProvider - Failed to process encrypted file <path>\resources\app.asar.unpacked\components\lib\app.data
net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file <path>\resources\app.asar.unpacked\components\lib\app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:80) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.core.integrity.EncryptedFileProvider.verify(EncryptedFileProvider.java:26) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.ExpirationUtils.readExpirationDate(ExpirationUtils.java:58) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.api.iq.filters.ExpirationFilter.qualify(ExpirationFilter.java:29) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.api.iq.QualificationChain.filter(QualificationChain.java:33) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:22) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:120) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:111) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:248) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:309) [p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:117) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:60) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:160) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:148) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.2.jar:1.0.2]
Caused by: net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:100) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:78) ~[p21-client-1.0.2.jar:1.0.2]
    ... 16 common frames omitted
Caused by: java.io.EOFException: null
    at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2681) ~[na:1.8.0_181]
    at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:3156) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:862) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.<init>(ObjectInputStream.java:358) ~[na:1.8.0_181]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:89) ~[p21-client-1.0.2.jar:1.0.2]
    ... 17 common frames omitted
2021-03-23 13:53:23 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\resources\app.asar.unpacked\components\lib\app.data
2021-03-23 13:53:23 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::System installation qualification error::Failed to process input=--engine.version=FDA 1903.1 --standard.version=1.1 --standard=ADAM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\ADaM-IG 1.1 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\SDTM\XPT\ae.xpt;<path>\SDTM\XPT\dm.xpt;<path>\SDTM\XPT\ex.xpt --source.adam=<path>\ADaM\XPT\adlb.xpt;<path>\ADaM\XPT\adsl.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\P21 v3.0.2, ADLB, 2021-03-23T13_52.xlsx --report.cutoff=1000
net.pinnacle21.oce.exceptions.CLIException: Failed to process input=--engine.version=FDA 1903.1 --standard.version=1.1 --standard=ADAM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\ADaM-IG 1.1 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\SDTM\XPT\ae.xpt;<path>\SDTM\XPT\dm.xpt;<path>\SDTM\XPT\ex.xpt --source.adam=<path>\ADaM\XPT\adlb.xpt;<path>\ADaM\XPT\adsl.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\P21 v3.0.2, ADLB, 2021-03-23T13_52.xlsx --report.cutoff=1000
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:137) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.2.jar:1.0.2]
Caused by: net.bootstrap.api.iq.IqException: Installation qualification check Expiration date check failed for GLOBAL
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:24) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:120) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:111) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:248) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:309) ~[p21-client-1.0.2.jar:1.0.2]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:117) ~[p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:60) ~[p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) ~[p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:160) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:148) [p21-client-1.0.2.jar:1.0.2]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.2.jar:1.0.2]
    ... 1 common frames omitted

 

Forums: Troubleshooting and Problems

s Sean
on March 23, 2021

Some additional info:

When the tools run successfully (and the p21 report is generated) without the above warnings, the warning "2021-03-23 13:53:22 [main] ERROR n.b.c.i.EncryptedFileProvider - Failed to process encrypted file" does not appear, and instead the log prints this line:

 

"2021-03-23 14:00:39 [main] INFO  n.p.oce.model.input.ParseResults - Loaded parameters | Command line: [<my java command is printed here>]"

 

So it seems like the CLI is failing with the above "model.input.ParseResults" step... 

 

Thank you in advance for any help with this issue,

Sean

Philipp
on March 25, 2021

Hello Sean,

Please try using the CLI that comes with the latest available Community 3.1.0.

You also need to update your configs folder with latest files available in 3.1.0.

Community 3.1.0 can be downloaded here: https://www.pinnacle21.com/downloads

Thanks,

Philipp

s Sean
on March 25, 2021

Thanks, I will give that a try

Philipp
on May 3, 2021

Hi Sean,

Thank you, please let us know if you experience any issues with running the CLI. 

Philipp

s Sean
on May 12, 2021

Hi Phillip,

 

I have installed pinnalce 21 v3.1, and now I am experiencing a new error:

 

2021-05-12 16:38:20 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\resources\app.asar.unpacked\components\lib\app.data
2021-05-12 16:38:20 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::Pinnacle 21 Community has expired due to an extended period with no internet connection. Connect to the internet to continue using your application

Here is the full log:

 

16:38:15,122 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
16:38:15,122 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
16:38:15,122 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/<path>resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml]
16:38:15,137 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71d15f18 - URL [jar:file:/<path>resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml] is not of type file
16:38:15,231 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
16:38:15,434 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.JarNameDefiner]
16:38:15,434 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [jarName] from the object stack
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogLevelDefiner]
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [logLevel] from the object stack
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogAppendFlagDefiner]
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [appendFlag] from the object stack
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
16:38:15,528 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CLI-APPENDER]
16:38:15,544 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
16:38:15,669 |-INFO in ch.qos.logback.core.FileAppender[CLI-APPENDER] - File property is set to [<path>\resources\app.asar.unpacked\components\lib\p21-client-1.0.3.log]
16:38:15,700 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.pinnacle21.oce.services.RemoteAppender]
16:38:15,731 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [REMOTE]
16:38:15,731 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
16:38:15,731 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
16:38:15,747 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - This appender no longer admits a layout as a sub-component, set an encoder instead.
16:38:15,747 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - To ensure compatibility, wrapping your layout in LayoutWrappingEncoder.
16:38:15,747 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also http://logback.qos.ch/codes.html#layoutInsteadOfEncoder for details
16:38:15,747 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
16:38:15,747 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [REMOTE] to Logger[ROOT]
16:38:15,747 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CLI-APPENDER] to Logger[ROOT]
16:38:15,747 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
16:38:15,747 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [net.pinnacle21.validator.data.SourceProvider] to OFF
16:38:15,747 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
16:38:15,747 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@17695df3 - Registering current configuration as safe fallback point

2021-05-12 16:38:18 [main] INFO  net.pinnacle21.oce.model.input.Input - Use default value 2
2021-05-12 16:38:20 [RxIoScheduler-3] INFO  net.bootstrap.core.AbstractCommand - command='cmd-aws-healthCheck', runTime=453
2021-05-12 16:38:20 [RxIoScheduler-3] INFO  net.bootstrap.utils.S3Loader - Services are healthy
2021-05-12 16:38:20 [main] ERROR n.b.c.i.EncryptedFileProvider - Failed to process encrypted file <path>\resources\app.asar.unpacked\components\lib\app.data
net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file <path>\resources\app.asar.unpacked\components\lib\app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:80) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFileProvider.verify(EncryptedFileProvider.java:26) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.ExpirationUtils.readExpirationDate(ExpirationUtils.java:58) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.filters.ExpirationFilter.qualify(ExpirationFilter.java:29) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.QualificationChain.filter(QualificationChain.java:33) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:22) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:78) ~[p21-client-1.0.3.jar:1.0.3]
    ... 16 common frames omitted
Caused by: java.io.EOFException: null
    at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2681) ~[na:1.8.0_181]
    at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:3156) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:862) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.<init>(ObjectInputStream.java:358) ~[na:1.8.0_181]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:89) ~[p21-client-1.0.3.jar:1.0.3]
    ... 17 common frames omitted
2021-05-12 16:38:20 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\resources\app.asar.unpacked\components\lib\app.data
2021-05-12 16:38:20 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::Pinnacle 21 Community has expired due to an extended period with no internet connection. Connect to the internet to continue using your application
.::Failed to process input=--engine.version=FDA 1907.2 --standard.version=3.2 --standard=SDTM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\SDTM-IG 3.2 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\Datasets\SDTM\XPT\ae.xpt;<path>\Datasets\SDTM\XPT\dm.xpt;<path>\Datasets\SDTM\XPT\ex.xpt;<path>\Datasets\SDTM\XPT\sv.xpt;<path>\Datasets\SDTM\XPT\tu.xpt --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\Output\P21\P21 v3.1, TU, 2021-05-12T16_38.xlsx --report.cutoff=1000
net.pinnacle21.oce.exceptions.CLIException: Failed to process input=--engine.version=FDA 1907.2 --standard.version=3.2 --standard=SDTM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\SDTM-IG 3.2 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\Datasets\SDTM\XPT\ae.xpt;<path>\Datasets\SDTM\XPT\dm.xpt;<path>\Datasets\SDTM\XPT\ex.xpt;<path>\Datasets\SDTM\XPT\sv.xpt;<path>\Datasets\SDTM\XPT\tu.xpt --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\Output\P21\P21 v3.1, TU, 2021-05-12T16_38.xlsx --report.cutoff=1000
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:137) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.api.iq.IqException: Installation qualification check Expiration date check failed for GLOBAL
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:24) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    ... 1 common frames omitted
 

 

 

Do you have any suggestions for how to get this working again? What "expiration date" is being referenced by the line: "Failed to verify expiration date from file <path>\resources\app.asar.unpacked\components\lib\app.data"

I have uninstalled and reinstall P21 v3.1 twice but it still gives me the same warning when running through CLI.

 

Thanks

Sean

Philipp
on May 14, 2021

Hello Sean,

Could you please tell, if the app.data file is present in the mentioned CLI location?
<path>\resources\app.asar.unpacked\components\lib\app.data

It looks like CLI fails to update this file, this could be caused by lack of edit permissions or antivirus blocking it.

A possible solution is to move the CLI jar file into the recommended location next to your Community configs folder.

Here is the default path for it:
C:\Users\%USERPROFILE%\Documents\Pinnacle 21 Community

Please try running CLI from there and let us know if you experience any further issues.

Thanks,

Philipp

s Sean
on May 21, 2021

Hi Phillip,

 

the app.data is present in same subfolder as the .jar file: <path>\resources\app.asar.unpacked\components\lib\

I am unable to move the CLI jar file to the C Drive, as I am running SAS through a terminal server which does not have access to my local C drive.

 

Any other suggestions?

 

 

here is the log when i run it again:

 

10:48:26,066 |-INFO in ch.qos.logback.<path>.LoggerContext[default] - Could NOT find resource [logback.groovy]
10:48:26,066 |-INFO in ch.qos.logback.<path>.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:48:26,066 |-INFO in ch.qos.logback.<path>.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/<path>/resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml]
10:48:26,082 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71d15f18 - URL [jar:file:/<path>/resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml] is not of type file
10:48:26,175 |-INFO in ch.qos.logback.<path>.joran.action.ConfigurationAction - debug attribute not set
10:48:26,347 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.JarNameDefiner]
10:48:26,347 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [jarName] from the object stack
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogLevelDefiner]
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [logLevel] from the object stack
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogAppendFlagDefiner]
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [appendFlag] from the object stack
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
10:48:26,441 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CLI-APPENDER]
10:48:26,457 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.<path>.encoder.PatternLayoutEncoder] for [encoder] property
10:48:26,613 |-INFO in ch.qos.logback.core.FileAppender[CLI-APPENDER] - File property is set to [<path>\resources\app.asar.unpacked\components\lib\p21-client-1.0.3.log]
10:48:26,660 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.pinnacle21.oce.services.RemoteAppender]
10:48:26,691 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [REMOTE]
10:48:26,707 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
10:48:26,707 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
10:48:26,707 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - This appender no longer admits a layout as a sub-component, set an encoder instead.
10:48:26,707 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - To ensure compatibility, wrapping your layout in LayoutWrappingEncoder.
10:48:26,707 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also http://logback.qos.ch/codes.html#layoutInsteadOfEncoder for details
10:48:26,707 |-INFO in ch.qos.logback.<path>.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
10:48:26,707 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [REMOTE] to Logger[ROOT]
10:48:26,707 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CLI-APPENDER] to Logger[ROOT]
10:48:26,707 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
10:48:26,707 |-INFO in ch.qos.logback.<path>.joran.action.LoggerAction - Setting level of logger [net.pinnacle21.validator.data.SourceProvider] to OFF
10:48:26,707 |-INFO in ch.qos.logback.<path>.joran.action.ConfigurationAction - End of configuration.
10:48:26,707 |-INFO in ch.qos.logback.<path>.joran.JoranConfigurator@17695df3 - Registering current configuration as safe fallback point

2021-05-21 10:48:30 [main] INFO  net.pinnacle21.oce.model.input.Input - Use default value 2
2021-05-21 10:48:35 [RxIoScheduler-3] INFO  net.bootstrap.core.AbstractCommand - command='cmd-aws-healthCheck', runTime=3141
2021-05-21 10:48:35 [RxIoScheduler-3] INFO  net.bootstrap.utils.S3Loader - Services are healthy
2021-05-21 10:48:35 [main] ERROR n.b.c.i.EncryptedFileProvider - Failed to process encrypted file <path>\resources\app.asar.unpacked\components\lib\app.data
net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file <path>\resources\app.asar.unpacked\components\lib\app.data

    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:80) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFileProvider.verify(EncryptedFileProvider.java:26) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.ExpirationUtils.readExpirationDate(ExpirationUtils.java:58) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.filters.ExpirationFilter.qualify(ExpirationFilter.java:29) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.QualificationChain.filter(QualificationChain.java:33) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:22) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:78) ~[p21-client-1.0.3.jar:1.0.3]
    ... 16 common frames omitted
Caused by: java.io.EOFException: null
    at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2681) ~[na:1.8.0_181]
    at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:3156) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:862) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.<init>(ObjectInputStream.java:358) ~[na:1.8.0_181]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:89) ~[p21-client-1.0.3.jar:1.0.3]
    ... 17 common frames omitted
2021-05-21 10:48:36 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\resources\app.asar.unpacked\components\lib\app.data
2021-05-21 10:48:36 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::Pinnacle 21 Community has expired due to an extended period with no internet connection. Connect to the internet to continue using
your application.::Failed to process input=--engine.version=FDA 1907.2 --standard.version=3.2 --standard=SDTM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\SDTM-IG 3.2 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\Datasets\SDTM\XPT --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\P21\P21 v3.1, SDTM-XPT, 2021-05-21T10_48.xlsx --report.cutoff=1000
net.pinnacle21.oce.exceptions.CLIException: Failed to process input=--engine.version=FDA 1907.2 --standard.version=3.2 --standard=SDTM --config=<path>\resources\app.asar.unpacked\components\lib\configs\1903.1\SDTM-IG 3.2 (FDA).xml --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\Datasets\SDTM\XPT --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\P21\P21 v3.1, SDTM-XPT, 2021-05-21T10_48.xlsx --report.cutoff=1000
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:137) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.api.iq.IqException: Installation qualification check Expiration date check failed for GLOBAL
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:24) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    ... 1 common frames omitted
 

 

 

thanks,

Sean

Philipp
on May 24, 2021

Hello Sean,

Thank you for providing extra details here!
Most likely this error is caused by CLI using an outdated configs directory with unsupported engines.

Please try to install the latest Community 3.1.1. It can be downloaded here.

During the installation you can set the Configs and Terminology directory to any desired location and then use it with Community CLI 1.0.4 (also bundled with the app).

Also you might want to remove the --config parameter from your validation command. CLI will automatically pick the necessary config XML file when it's placed next to the configs folder.
CLI config file is determined based on --engine.version and --standard.
If you provide both --config and --engine.version pointing at different engines, this might cause a validation error.

Thanks,

Philipp

s Sean
on July 15, 2021

Hi Phillip,

Installing the newest community version and removing the --config parameter seems to help, but the issue persists. Sometimes CLI will run successfully on the first try. However, most of the time, CLI will fail mutliple times before it will run succesfully.

Each time it fails, i get the same warning:

2021-07-15 11:09:38 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\P21_3.1\resources\app.asar.unpacked\components\lib\app.data
2021-07-15 11:09:38 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::Pinnacle 21 Community has expired due to an extended period with no internet connection. Connect to the internet to continue using your application.::Failed to process input=--engine.version=FDA 1907.2 --standard.version=1.1 --standard=ADAM --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\SDTM\XPT\ae.xpt;<path>\SDTM\XPT\dm.xpt;<path>\SDTM\XPT\ex.xpt --source.adam=<path>\ADaM\XPT\adsl.xpt;<path>\ADaM\XPT\adtte.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\P21 v3.1, ADTTE, 2021-07-15T11_09.xlsx --report.cutoff=1000
 

Do you have any further advice to prevent the CLI from failing this way?

 

Thanks for all your help so far,

Sean

 

Philipp
on July 19, 2021

Hi Sean,

Thank you for providing extra context! 

Unfortunately, we still weren't able to reproduce this issue. 

Such error could be reported either if the app.data file is missing and CLI stayed offline or if the file cannot be written due to lack of permissions or antivirus interruption. 

Could you please also try to run the CLI with debug level logging and send us the console output?
This can be done by adding -Dcli.log.level=debug parameter before calling the jar, i.e. java -Dcli.log.level=debug -jar p21-client-1.0.4.jar ...

Thanks,

Philipp

s Sean
on July 19, 2021

Hi Phillip,

 

Below is the more detailed log output for a failed run when using the "-Dcli.log.level=debug" option:

 

please note that the tool runs successfully about 25% of the time

 

Log output:

17:56:21,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
17:56:21,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
17:56:21,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/<path>/openCDISC/P21_3.1/resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml]
17:56:21,641 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@17695df3 - URL [jar:file:/<path>/openCDISC/P21_3.1/resources/app.asar.unpacked/components/lib/p21-client-1.0.3.jar!/logback.xml] is not of type file
17:56:21,719 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
17:56:21,875 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.JarNameDefiner]
17:56:21,875 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [jarName] from the object stack
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogLevelDefiner]
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [logLevel] from the object stack
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - About to instantiate property definer of type [net.pinnacle21.oce.logging.LogAppendFlagDefiner]
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.DefinePropertyAction - Popping property definer for property named [appendFlag] from the object stack
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
17:56:21,969 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CLI-APPENDER]
17:56:22,000 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
17:56:22,187 |-INFO in ch.qos.logback.core.FileAppender[CLI-APPENDER] - File property is set to [<path>\openCDISC\P21_3.1\resources\app.asar.unpacked\components\lib\p21-client-1.0.3.log]
17:56:22,219 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [net.pinnacle21.oce.services.RemoteAppender]
17:56:22,250 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [REMOTE]
17:56:22,266 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
17:56:22,266 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
17:56:22,266 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - This appender no longer admits a layout as a sub-component, set an encoder instead.
17:56:22,266 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - To ensure compatibility, wrapping your layout in LayoutWrappingEncoder.
17:56:22,266 |-WARN in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also http://logback.qos.ch/codes.html#layoutInsteadOfEncoder for details
17:56:22,266 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to DEBUG
17:56:22,266 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [REMOTE] to Logger[ROOT]
17:56:22,266 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CLI-APPENDER] to Logger[ROOT]
17:56:22,266 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
17:56:22,266 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [net.pinnacle21.validator.data.SourceProvider] to OFF
17:56:22,266 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
17:56:22,266 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6c9f5c0d - Registering current configuration as safe fallback point

2021-07-19 17:56:22 [main] DEBUG o.s.o.windows.WindowsOSVersionInfoEx - Initialized OSVersionInfoEx
2021-07-19 17:56:24 [main] DEBUG net.bootstrap.core.utils.OSUtils - Determined OS: Windows Server 2016 and Version: 10.0
2021-07-19 17:56:24 [main] DEBUG n.pinnacle21.oce.utils.ProcessUtils - jvm argument: -Dcli.log.level=debug
2021-07-19 17:56:24 [main] DEBUG o.h.common.AbstractCentralProcessor - Oracle MXBean detected.
2021-07-19 17:56:25 [main] DEBUG o.d.windows.PerfCounterWildcardQuery - Localized Processor to Processor
2021-07-19 17:56:25 [main] DEBUG o.h.p.w.WindowsCentralProcessor - Initialized Processor
2021-07-19 17:56:25 [main] INFO  net.pinnacle21.oce.model.input.Input - Use default value 2
2021-07-19 17:56:25 [main] DEBUG n.p.oce.model.input.ParseResults - Config: '{
    # system properties
    "awt" : {
        # system properties
        "toolkit" : "sun.awt.windows.WToolkit"
    },
    # system properties
    "cli" : {
        # system properties
        "log" : {
            # system properties
            "level" : "debug"
        }
    },
    # application.conf: 3
    "create" : {},
    # hardcoded value
    "download" : {
        # hardcoded value
        "config" : false
    },
    # hardcoded value
    "engine" : {
        # hardcoded value
        "autoDisplayDomainKeys" : false,
        # hardcoded value
        "generateRuleMetrics" : true,
        # hardcoded value
        "threadcount" : 2,
        # hardcoded value
        "useEnhancedSas" : true
    },
    # application.conf: 4
    "engines" : {
        # application.conf: 4
        "ignore" : {
            # application.conf: 4
            "list" : [
                # application.conf: 4
                "All 1808.0",
                # application.conf: 4
                "FDA 1803.1"
            ]
        }
    },
    # system properties
    "file" : {
        # system properties
        "encoding" : {
            # system properties
            "pkg" : "sun.io"
        },
        # system properties
        "separator" : "\\"
    },
    # system properties
    "java" : {
        # system properties
        "awt" : {
            # system properties
            "graphicsenv" : "sun.awt.Win32GraphicsEnvironment",
            # system properties
            "printerjob" : "sun.awt.windows.WPrinterJob"
        },
        # system properties
        "class" : {
            # system properties
            "path" : "<path>\\openCDISC\\P21_3.1\\resources\\app.asar.unpacked\\components\\lib\\p21-client-1.0.3.jar",
            # system properties
            "version" : "52.0"
        },
        # system properties
        "endorsed" : {
            # system properties
            "dirs" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\endorsed"
        },
        # system properties
        "ext" : {
            # system properties
            "dirs" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\ext;C:\\Windows\\Sun\\Java\\lib\\ext"
        },
        # system properties
        "home" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64",
        # system properties
        "io" : {
            # system properties
            "tmpdir" : "C:\\Users\\<myname>\\AppData\\Local\\Temp\\55\\"
        },
        # system properties
        "library" : {
            # system properties
            "path" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\bin;C:\\Windows\\Sun\\Java\\bin;C:\\Windows\\system32;C:\\Windows;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\lib;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\bin;<path>\\openCDISC\\P21_3.0\\resources\\app.asar.unpacked\\components\\lib;<path>\\openCDISC\\P21_3.0\\resources\\app.asar.unpacked\\components\\java64\\bin;<path>\\openCDISC\\P21\\components\\lib;<path>\\openCDISC\\P21\\java64\\bin;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\security;<path>\\openCDISC\\P21_3.0\\resources\\app.asar.unpacked\\components\\java64\\lib\\security;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib;<path>\\openCDISC\\P21_3.0\\resources\\app.asar.unpacked\\components\\java64\\lib;C:\\Program Files\\SASHome\\SASFoundation\\9.4;C:\\Windows\\system32;C:\\Windows;C:\\Windows\\System32\\Wbem;C:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\Program Files\\\\SUT\\bin;C:\\Program Files\\SASHome\\SASFoundation\\9.4\\core\\sasexe;C:\\Program Files\\SASHome\\Secure\\ccme4;C:\\Users\\<firstname.lastname>\\AppData\\Local\\Microsoft\\WindowsApps; ;."
        },
        # system properties
        "runtime" : {
            # system properties
            "name" : "Java(TM) SE Runtime Environment",
            # system properties
            "version" : "1.8.0_181-b13"
        },
        # system properties
        "specification" : {
            # system properties
            "name" : "Java Platform API Specification",
            # system properties
            "vendor" : "Oracle Corporation",
            # system properties
            "version" : "1.8"
        },
        # system properties
        "vendor" : {
            # system properties
            "url" : {
                # system properties
                "bug" : "http://bugreport.sun.com/bugreport/"
            }
        },
        # system properties
        "version" : "1.8.0_181",
        # system properties
        "vm" : {
            # system properties
            "info" : "mixed mode",
            # system properties
            "name" : "Java HotSpot(TM) 64-Bit Server VM",
            # system properties
            "specification" : {
                # system properties
                "name" : "Java Virtual Machine Specification",
                # system properties
                "vendor" : "Oracle Corporation",
                # system properties
                "version" : "1.8"
            },
            # system properties
            "vendor" : "Oracle Corporation",
            # system properties
            "version" : "25.181-b13"
        }
    },
    # system properties
    "line" : {
        # system properties
        "separator" : "\r\n"
    },
    # application.conf: 1
    "memory" : {
        # application.conf: 1
        "max" : 2048
    },
    # system properties
    "os" : {
        # system properties
        "arch" : "amd64",
        # system properties
        "name" : "Windows Server 2016",
        # system properties
        "version" : "10.0"
    },
    # system properties
    "path" : {
        # system properties
        "separator" : ";"
    },
    # hardcoded value
    "s3" : {
        # hardcoded value
        "root" : "release"
    },
    # system properties
    "sun" : {
        # system properties
        "arch" : {
            # system properties
            "data" : {
                # system properties
                "model" : "64"
            }
        },
        # system properties
        "boot" : {
            # system properties
            "class" : {
                # system properties
                "path" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\resources.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\rt.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\sunrsasign.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\jsse.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\jce.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\charsets.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\lib\\jfr.jar;<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\classes"
            },
            # system properties
            "library" : {
                # system properties
                "path" : "<path>\\openCDISC\\P21_3.0.1\\resources\\app.asar.unpacked\\components\\java64\\bin"
            }
        },
        # system properties
        "cpu" : {
            # system properties
            "endian" : "little",
            # system properties
            "isalist" : "amd64"
        },
        # system properties
        "desktop" : "windows",
        # system properties
        "io" : {
            # system properties
            "unicode" : {
                # system properties
                "encoding" : "UnicodeLittle"
            }
        },
        # system properties
        "java" : {
            # system properties
            "command" : "<path>\\openCDISC\\P21_3.1\\resources\\app.asar.unpacked\\components\\lib\\p21-client-1.0.3.jar --engine.version=FDA 1907.2 --standard.version=1.1 --standard=ADAM --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\\DATASETS\\SDTM\\XPT\\ae.xpt;<path>\\DATASETS\\SDTM\\XPT\\dm.xpt;<path>\\DATASETS\\SDTM\\XPT\\ex.xpt --source.adam=<path>\\Datasets\\ADaM\\XPT\\adsl.xpt;<path>\\Datasets\\ADaM\\XPT\\adtte.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\\Output\\P21\\P21 v3.1, ADTTE, 2021-07-19T17_56.xlsx --report.cutoff=1000",
            # system properties
            "launcher" : "SUN_STANDARD"
        },
        # system properties
        "jnu" : {
            # system properties
            "encoding" : "Cp1252"
        },
        # system properties
        "management" : {
            # system properties
            "compiler" : "HotSpot 64-Bit Tiered Compilers"
        },
        # system properties
        "os" : {
            # system properties
            "patch" : {
                # system properties
                "level" : ""
            }
        },
        # system properties
        "stderr" : {
            # system properties
            "encoding" : "cp437"
        }
    },
    # system properties
    "user" : {
        # system properties
        "country" : "US",
        # system properties
        "dir" : "C:\\Windows",
        # system properties
        "home" : "C:\\Users\\<firstname.lastname>",
        # system properties
        "language" : "en",
        # system properties
        "name" : "<firstname.lastname>",
        # system properties
        "script" : "",
        # system properties
        "timezone" : "America/Los_Angeles",
        # system properties
        "variant" : ""
    },
    # application.conf: 6
    "ws" : {
        # application.conf: 14
        "endpoints" : {
            # application.conf: 15
            "log" : "/log"
        },
        # application.conf: 11
        "prod" : {
            # application.conf: 12
            "url" : "https://ws.pinnacle21.com/community"
        },
        # application.conf: 8
        "test" : {
            # application.conf: 9
            "url" : "https://p3pn4zxuhf.execute-api.us-east-1.amazonaws.com/test"
        },
        # application.conf: 7
        "timeout" : 5000
    }
}
'
2021-07-19 17:56:26 [RxIoScheduler-3] INFO  net.bootstrap.core.AbstractCommand - command='cmd-aws-healthCheck', runTime=500
2021-07-19 17:56:26 [RxIoScheduler-3] INFO  net.bootstrap.utils.S3Loader - Services are healthy
2021-07-19 17:56:26 [main] ERROR n.b.c.i.EncryptedFileProvider - Failed to process encrypted file <path>\openCDISC\P21_3.1\resources\app.asar.unpacked\components\lib\app.data
net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file <path>\openCDISC\P21_3.1\resources\app.asar.unpacked\components\lib\app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:80) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFileProvider.verify(EncryptedFileProvider.java:26) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.ExpirationUtils.readExpirationDate(ExpirationUtils.java:58) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.filters.ExpirationFilter.qualify(ExpirationFilter.java:29) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.QualificationChain.filter(QualificationChain.java:33) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:22) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) [p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.core.exceptions.BootstrapException: Failed to process eTag file app.data
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:78) ~[p21-client-1.0.3.jar:1.0.3]
    ... 16 common frames omitted
Caused by: java.io.EOFException: null
    at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2681) ~[na:1.8.0_181]
    at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:3156) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:862) ~[na:1.8.0_181]
    at java.io.ObjectInputStream.<init>(ObjectInputStream.java:358) ~[na:1.8.0_181]
    at net.bootstrap.core.integrity.EncryptedFile.read(EncryptedFile.java:89) ~[p21-client-1.0.3.jar:1.0.3]
    ... 17 common frames omitted
2021-07-19 17:56:26 [main] WARN  net.bootstrap.utils.ExpirationUtils - Failed to verify expiration date from file <path>\openCDISC\P21_3.1\resources\app.asar.unpacked\components\lib\app.data
2021-07-19 17:56:26 [main] ERROR n.pinnacle21.oce.utils.ProcessUtils - CLI.3.17::Pinnacle 21 Community has expired due to an extended period with no internet connection. Connect to the internet to continue using your application.::Failed to process input=--engine.version=FDA 1907.2 --standard.version=1.1 --standard=ADAM --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\DATASETS\SDTM\XPT\ae.xpt;<path>\DATASETS\SDTM\XPT\dm.xpt;<path>\DATASETS\SDTM\XPT\ex.xpt --source.adam=<path>\Datasets\ADaM\XPT\adsl.xpt;<path>\Datasets\ADaM\XPT\adtte.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\Output\P21\P21 v3.1, ADTTE, 2021-07-19T17_56.xlsx --report.cutoff=1000
net.pinnacle21.oce.exceptions.CLIException: Failed to process input=--engine.version=FDA 1907.2 --standard.version=1.1 --standard=ADAM --cdisc.ct.sdtm.version=2020-06-26 --source.sdtm=<path>\DATASETS\SDTM\XPT\ae.xpt;<path>\DATASETS\SDTM\XPT\dm.xpt;<path>\DATASETS\SDTM\XPT\ex.xpt --source.adam=<path>\Datasets\ADaM\XPT\adsl.xpt;<path>\Datasets\ADaM\XPT\adtte.xpt --cdisc.ct.adam.version=2020-06-26 --unii.version=2019-07-12 --ndf-rt.version=2018-02-05 --meddra.version=19.1 --report=<path>\Output\P21\P21 v3.1, ADTTE, 2021-07-19T17_56.xlsx --report.cutoff=1000
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:137) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.Main.main(Main.java:16) [p21-client-1.0.3.jar:1.0.3]
Caused by: net.bootstrap.api.iq.IqException: Installation qualification check Expiration date check failed for GLOBAL
    at net.bootstrap.api.iq.advices.GlobalAdvice.iqGlobal(GlobalAdvice.java:24) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.loadLibMap(Libs.java:100) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.refreshMap(Libs.java:95) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngines(Libs.java:236) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.Libs.getEngineOverrides(Libs.java:297) ~[p21-client-1.0.3.jar:1.0.3]
    at net.bootstrap.utils.S3Loader.loadClients(S3Loader.java:122) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.model.input.ParseResults.parseArgs(ParseResults.java:62) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.InputUtils.from(InputUtils.java:49) ~[p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.start(ProcessUtils.java:161) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:149) [p21-client-1.0.3.jar:1.0.3]
    at net.pinnacle21.oce.utils.ProcessUtils.startFromCommandLine(ProcessUtils.java:118) [p21-client-1.0.3.jar:1.0.3]
    ... 1 common frames omitted
 

 

 

Thanks,

Sean

Philipp
on July 20, 2021

Hi Sean,

Thank you for attaching the debug log!

It appears that the jar file you are running is still p21-client-1.0.3, while the latest version is p21-client-1.0.4 (bundled with Community 3.1.2).
Please replace the CLI jar file with the newer version, delete app.data file and retry validations.

Also could you please explain, is the CLI located on the server's own drive or in some remote network drive that the server has to reach?

Thanks,

Philipp

s Sean
on July 20, 2021

Hi Phillip,

Thanks, I will try that.

Question: Is the p21-client-1.0.4 client compatible with Pinnacle 21 Community version v3.1? Or is the p21-client-1.0.4 client only compatible with P21 v3.1.2?

 

To answer your question: The CLI/P21 resources are located on a separate shared server which is reached by the separate SAS server.

 

Thanks,

Sean  

Philipp
on July 20, 2021

Community CLI 1.0.4 is compatible with Community 3.1.1 and 3.1.2. This means that these app versions were bundled with CLI 1.0.4 and it matches their functionality.

Community 3.1.0 used CLI 1.0.3.

Thanks,

Philipp

Want a demo?

Let’s Talk.

We're eager to share and ready to listen.

Cookie Policy

Pinnacle 21 uses cookies to make our site easier for you to use. By continuing to use this website, you agree to our use of cookies. For more info visit our Privacy Policy.