Hello,
I recently added a license file into a module that I developed. When installing the module, I checked the accept license button and finished the install. The module never appeared in the list of modules so I started to investigate.
First I attempted to reinstall the module. It didn’t prompt again with the license and it didn’t show up.
Second, I removed the license from the module. It installed and showed up.
Then I added the license back in, and it again didn’t show me the license prompt screen, and it didn’t show up.
I renamed the module and installed it, then the license prompt showed back up, but it didn’t really install.
Next I increased the trace level for ModuleMananger and ran through the above steps again.
Without a license I got the following results:
INFO | jvm 1 | 2016/06/03 10:41:41 | DEBUG [ModuleManager ] [10:41:41,900]: Installing module from file: Workshop-Connection-Driver-Snap.modl
INFO | jvm 1 | 2016/06/03 10:41:42 | INFO [ModuleManager ] [10:41:41,910]: Installing module: "com.mwes.gfms.wsc-snap"
INFO | jvm 1 | 2016/06/03 10:41:42 | DEBUG [ModuleManager ] [10:41:41,927]: Loading module "user-lib\modules\Workshop-Connection-Driver-Snap.modl"
INFO | jvm 1 | 2016/06/03 10:41:42 | DEBUG [ModuleManager ] [10:41:42,440]: certificates.p7b not found in module Workshop-Connection-Driver-Snap.modl
INFO | jvm 1 | 2016/06/03 10:41:42 | java.io.IOException: Entry: "certificates.p7b" not found.
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.util.GatewayUtils.unzipFile(GatewayUtils.java:426)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.util.GatewayUtils.unzipFile(GatewayUtils.java:385)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.getCertsFromFile(ModuleManagerImpl.java:2173)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.loadModule(ModuleManagerImpl.java:1701)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$4.call(ModuleManagerImpl.java:1117)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.executeModuleOperation(ModuleManagerImpl.java:1262)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.installModuleInternal(ModuleManagerImpl.java:1099)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.access$1500(ModuleManagerImpl.java:155)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$InstallCommand.execute(ModuleManagerImpl.java:2301)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$Receiver.receiveCall(ModuleManagerImpl.java:2242)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.redundancy.QueueableMessageReceiver.receiveCall(QueueableMessageReceiver.java:45)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.redundancy.RedundancyManagerImpl.dispatchMessage(RedundancyManagerImpl.java:658)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.gateway.redundancy.RedundancyManagerImpl$ExecuteTask.run(RedundancyManagerImpl.java:678)
INFO | jvm 1 | 2016/06/03 10:41:42 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$ThrowableCatchingRunnable.run(BasicExecutionEngine.java:537)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.FutureTask.run(FutureTask.java:266)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
INFO | jvm 1 | 2016/06/03 10:41:42 | at java.lang.Thread.run(Thread.java:745)
INFO | jvm 1 | 2016/06/03 10:41:42 | INFO [ModuleManager ] [10:41:42,458]: Starting up module 'com.mwes.gfms.wsc-snap' (v1.5.0 (b0))...
INFO | jvm 1 | 2016/06/03 10:41:44 | DEBUG [ModuleManager ] [10:41:44,058]: Loading hook class "com.mwes.gfms.wsc.driver.GatewayHook" for module "com.mwes.gfms.wsc-snap".
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [GatewayHook ] [10:41:44,122]: InitMenu Called
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [GatewayHook ] [10:41:44,128]: GetDriverTypes Called
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [ModuleManager ] [10:41:44,128]: Starting up module 'com.mwes.gfms.wsc-snap' v1.5.0 (b0)...
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [GatewayHook ] [10:41:44,128]: Startup Called
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [GatewayHook ] [10:41:44,129]: GetExpectedAPIVersion Called
INFO | jvm 1 | 2016/06/03 10:41:44 | INFO [GatewayHook ] [10:41:44,129]: ServiceReady Called for interface com.inductiveautomation.xopc.driver.api.configuration.DriverManager
With a license I got the following results:
INFO | jvm 1 | 2016/06/03 10:45:40 | DEBUG [ModuleManager ] [10:45:40,813]: Installing module from file: Workshop-Connection-Driver-Snap.modl
INFO | jvm 1 | 2016/06/03 10:45:40 | INFO [ModuleManager ] [10:45:40,824]: Installing module: "com.mwes.gfms.wsc-snap"
INFO | jvm 1 | 2016/06/03 10:45:40 | DEBUG [ModuleManager ] [10:45:40,824]: Shutting down existing module instance...
INFO | jvm 1 | 2016/06/03 10:45:40 | INFO [ModuleManager ] [10:45:40,824]: Shutting down module 'com.mwes.gfms.wsc-snap' v1.5.0 (b0)...
INFO | jvm 1 | 2016/06/03 10:45:40 | INFO [GatewayHook ] [10:45:40,824]: Shutdown Called
INFO | jvm 1 | 2016/06/03 10:45:40 | INFO [ModuleManager ] [10:45:40,826]: Shutdown of module "com.mwes.gfms.wsc-snap" completed in 2 ms
INFO | jvm 1 | 2016/06/03 10:45:40 | DEBUG [ModuleManager ] [10:45:40,848]: Loading module "user-lib\modules\Workshop-Connection-Driver-Snap.modl"
INFO | jvm 1 | 2016/06/03 10:45:41 | DEBUG [ModuleManager ] [10:45:41,437]: certificates.p7b not found in module Workshop-Connection-Driver-Snap.modl
INFO | jvm 1 | 2016/06/03 10:45:41 | java.io.IOException: Entry: "certificates.p7b" not found.
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.util.GatewayUtils.unzipFile(GatewayUtils.java:426)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.util.GatewayUtils.unzipFile(GatewayUtils.java:385)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.getCertsFromFile(ModuleManagerImpl.java:2173)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.loadModule(ModuleManagerImpl.java:1701)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$4.call(ModuleManagerImpl.java:1117)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.executeModuleOperation(ModuleManagerImpl.java:1262)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.installModuleInternal(ModuleManagerImpl.java:1099)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl.access$1500(ModuleManagerImpl.java:155)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$InstallCommand.execute(ModuleManagerImpl.java:2301)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.modules.ModuleManagerImpl$Receiver.receiveCall(ModuleManagerImpl.java:2242)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.redundancy.QueueableMessageReceiver.receiveCall(QueueableMessageReceiver.java:45)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.redundancy.RedundancyManagerImpl.dispatchMessage(RedundancyManagerImpl.java:658)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.gateway.redundancy.RedundancyManagerImpl$ExecuteTask.run(RedundancyManagerImpl.java:678)
INFO | jvm 1 | 2016/06/03 10:45:41 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$ThrowableCatchingRunnable.run(BasicExecutionEngine.java:537)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.FutureTask.run(FutureTask.java:266)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
INFO | jvm 1 | 2016/06/03 10:45:41 | at java.lang.Thread.run(Thread.java:745)
INFO | jvm 1 | 2016/06/03 10:45:41 | WARN [ModuleManager ] [10:45:41,438]: Moving module Workshop Connection Driver-Snap to quarantine because license not yet accepted.
INFO | jvm 1 | 2016/06/03 10:45:41 | ERROR [ModuleManager ] [10:45:41,438]: Cannot start up module "com.mwes.gfms.wsc-snap", it doesn't exist.
In both cases it is complaining about a certificates.p7b file which is slightly confusing. But more confusing is the fact that I DID accept the license!
In the past I’ve been told by the support line that I shouldn’t ask them questions regarding module development, so I’m asking here.
Any suggestions?
Thank you,
Bill