Project

General

Profile

Actions
Copy link

Bug #16466

closed

Policy generation impossible after fresh install on Ubuntu 16.04 (due to ubuntu's Java 9 package)

Added by Félix DALLIDET almost 5 years ago. Updated almost 5 years ago.

Status:
Released
Priority:
N/A
Assignee:
Benoît PECCATTE
Category:
Server components
Target version:
6.0.2
Pull Request:
https://github.com/Normation/rudder-p...
Severity:
Critical - prevents main use of Rudder | no workaround | data loss | security
UX impact:
User visibility:
Getting started - demo | first install | Technique editor and level 1 Techniques
Effort required:
Priority:
94
Name check:
Reviewed
Fix check:
Checked
Regression:

Description

This only appeared on Ubuntu16.04, installation went flowless, but the webapp can not end the generation.
It seems to be stuck on some certificate related errors.
See the log dump below:

root@server:/var/log/rudder/webapp# vim 2019_12_31.stderrout.log
root@server:/var/log/rudder/webapp# cat 2019_12_31.stderrout.log
2019-12-31 10:46:31.042:INFO:oejs.SetUIDListener:main: Setting umask=07
2019-12-31 10:46:31.044:INFO:oejs.Server:main: jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 9-internal+0-2016-04-14-195246.buildd.src
2019-12-31 10:46:31.070:INFO:oejdp.ScanningAppProvider:main: Deployment monitor [file:///opt/rudder/share/webapps/] at interval 1
2019-12-31 10:46:32.730:INFO:oejw.StandardDescriptorProcessor:main: NO JSP Support for /rudder, did not find org.eclipse.jetty.jsp.JettyJspServlet
Use configuration file defined by JVM property -Dlogback.configurationFile : /opt/rudder/etc/logback.xml
2019-12-31 10:46:33.266:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0
2019-12-31 10:46:33.266:INFO:oejs.session:main: No SessionScavenger set, using defaults
2019-12-31 10:46:33.266:INFO:oejs.session:main: node0 Scavenging every 660000ms
[2019-12-31 10:46:33+0100] INFO  application - Rudder starts with PID 13310 on 2 cores
[2019-12-31 10:46:34+0100] INFO  application - Use configuration file defined by JVM property -Drudder.configFile : /opt/rudder/etc/rudder-web.properties
[2019-12-31 10:46:34+0100] INFO  application - Global exception handler configured to stop Rudder on: java.lang.Error
[2019-12-31 10:46:34+0100] INFO  application - Property 'rudder.batch.delete.software.interval' is missing or empty in rudder.configFile. Default to 24 hours.
[2019-12-31 10:46:34+0100] INFO  application - Starting Rudder 6.0.2-SNAPSHOT web application [build timestamp: 2019-12-27T16:31:19Z]
[2019-12-31 10:46:40+0100] INFO  report - Disable automatic archive since archive maximum age is older than delete maximum age
[2019-12-31 10:46:40+0100] INFO  application - Starting [Store Agent Run Times] scheduler with a period of 5 s
2019-12-31 10:46:40.578:INFO:oejshC.rudder:main: Initializing Spring root WebApplicationContext
[2019-12-31 10:46:40+0100] INFO  application - List of registered properties:
[2019-12-31 10:46:40+0100] INFO  application - registered property: awt.toolkit="sun.awt.X11.XToolkit" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: file.encoding.pkg="sun.io" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: file.separator="/" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: history.inventories.rootdir="/var/rudder/inventories/historical" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: inventories.root.directory="/var/rudder/inventories" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: inventories.watcher.waitForSignatureDuration="10" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: inventory.parse.parallelization="0.5x" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.awt.graphicsenv="sun.awt.X11GraphicsEnvironment" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.awt.printerjob="sun.print.PSPrinterJob" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.class.path="/opt/rudder/jetty/start.jar" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.class.version="53.0" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.home="/usr/lib/jvm/java-9-openjdk-amd64" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.io.tmpdir="/var/rudder/tmp/jetty" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.library.path="/usr/java/packages/lib/amd64:/usr/lib/x86_64-linux-gnu/jni:/lib/x86_64-linux-gnu:/usr/lib/x86_64-linux-gnu:/usr/lib/jni:/lib:/usr/lib" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.runtime.name="OpenJDK Runtime Environment" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.runtime.version="9-internal+0-2016-04-14-195246.buildd.src" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.specification.name="Java Platform API Specification" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.specification.vendor="Oracle Corporation" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.specification.version="9" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vendor.url.bug="http://bugreport.java.com/bugreport/" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.version="9-internal" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.compressedOopsMode="32-bit" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.info="mixed mode" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.name="OpenJDK 64-Bit Server VM" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.specification.name="Java Virtual Machine Specification" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.specification.vendor="Oracle Corporation" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.specification.version="9" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.vendor="Oracle Corporation" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: java.vm.version="9-internal+0-2016-04-14-195246.buildd.src" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jdk.debug="release" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jetty.base="/opt/rudder/etc/rudder-jetty-base" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jetty.git.hash="d5fc0523cfa96bfebfbda19606cad384d772f04c" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jetty.home="/opt/rudder/jetty" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jetty.tag.version="master" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: jetty.version="9.4.11.v20180605" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldap.authdn="cn=manager,cn=rudder-configuration" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldap.authpw=**********
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldap.host="localhost" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldap.maxPoolSize="2" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldap.port="389" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: ldif.tracelog.rootdir="/var/rudder/inventories/debug" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: line.separator="\n" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: logback.configurationFile="/opt/rudder/etc/logback.xml" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: os.arch="amd64" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: os.name="Linux" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: os.version="4.4.0-131-generic" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: path.separator=":" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.auth.provider="file" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.authFile="/opt/rudder/etc/rudder-users.xml" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.autoArchiveItems="true" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.databasecleaner.runtime.day="sunday" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.databasecleaner.runtime.hour="0" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.databasecleaner.runtime.minute="0" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.dyngroup.updateInterval="5" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.purge.inventories.delete.TTL="7" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.purge.inventories.delete.interval="24" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reports.logInterval="1" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reportsCleaner.deleteLogReport.TTL="2x" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reportscleaner.archive.TTL="4" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reportscleaner.compliancelevels.delete.TTL="8" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reportscleaner.delete.TTL="4" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.reportscleaner.frequency="daily" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.storeAgentRunTimes.maxBatchSize="5" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.storeAgentRunTimes.maxDays="0" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.storeAgentRunTimes.maxMinutes="30" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.storeAgentRunTimes.updateInterval="5" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.batch.techniqueLibrary.updateInterval="5" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.community.port="5309" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.configFile="/opt/rudder/etc/rudder-web.properties" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.debug.nodeconfiguration.path="/var/log/rudder/nodeConfigurations" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.dir.backup="/var/rudder/share/backup/" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.dir.dependencies="/var/rudder/tools" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.dir.gitRoot="/var/rudder/configuration-repository" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.dir.lock="/var/rudder/lock/" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.dir.shared.files.folder="/var/rudder/configuration-repository/shared-files" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.endpoint.cmdb="http://localhost:8080/endpoint/upload/" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.hooks.ignore-suffixes=".swp, ~, .bak, .cfnew   , .cfsaved  , .cfedited, .cfdisabled, .cfmoved,.dpkg-old, .dpkg-dist, .dpkg-new, .dpkg-tmp,.disable , .disabled , _disable , _disabled,.ucf-old , .ucf-dist , .ucf-new ,.rpmnew  , .rpmsave  , .rpmorig" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.batch.max.size="500" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.driver="org.postgresql.Driver" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.maxPoolSize="25" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.password=**********
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.url="jdbc:postgresql://localhost:5432/rudder" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jdbc.username="rudder" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.jvm.fatal.exceptions="" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.relayd.reload="/opt/rudder/bin/rudder relay reload -p" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.rest.allowNonAuthenticatedUser="true" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.cfengine-mission-portal="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.db="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.inventory-endpoint="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.ldap="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.relay-promises-only="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.relay-top="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server-roles.web="autodetect" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.server.relay.api="https://localhost/rudder/relay-api" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.syslog.port="514" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.webdav.password=**********
[2019-12-31 10:46:40+0100] INFO  application - registered property: rudder.webdav.user="rudder" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: run.mode="production" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.arch.data.model="64" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.boot.library.path="/usr/lib/jvm/java-9-openjdk-amd64/lib/amd64" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.cpu.endian="little" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.cpu.isalist="" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.io.unicode.encoding="UnicodeLittle" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.java.command="/opt/rudder/jetty/start.jar OPTIONS=Server jetty.state=/opt/rudder/etc/rudder-jetty-base/rudder-jetty.state jetty-started.xml start-log-file=/var/log/rudder/webapp/java.log" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.java.launcher="SUN_STANDARD" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.jnu.encoding="ANSI_X3.4-1968" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.management.compiler="HotSpot 64-Bit Tiered Compilers" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: sun.os.patch.level="unknown" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.country="US" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.dir="/opt/rudder/etc/rudder-jetty-base" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.home="/root" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.language="en" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.name="root" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: user.timezone="Europe/Paris" 
[2019-12-31 10:46:40+0100] INFO  application - registered property: waiting.inventory.queue.size="50" 
[2019-12-31 10:46:40+0100] INFO  application - Plugin's license directory: '/opt/rudder/etc/plugins/licenses/'
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check LDAP and PostgreSQL connection
[2019-12-31 10:46:40+0100] INFO  bootchecks - LDAP and PostgreSQL connection are OK
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check mandatory DIT entries
[2019-12-31 10:46:40+0100] INFO  bootchecks - All the required DIT entries are present in the LDAP directory
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check initialization of User Technique Library
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check event log migration format 5 -> 6
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check existence of at least one archive of the configuration
[2019-12-31 10:46:40+0100] INFO  migration - No migration detected by migration script (table 'migrationeventlog' is empty or does not exist)
[2019-12-31 10:46:40+0100] INFO  bootchecks - First full archive of configuration-repository items done
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check rules archive directory in configuration-repository
[2019-12-31 10:46:40+0100] INFO  bootchecks - Creating directory '/var/rudder/configuration-repository/ruleCategories' exists, done
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check for force reload of Techniques library
[2019-12-31 10:46:40+0100] INFO  bootchecks - Flag file '/opt/rudder/etc/force_technique_reload' does not exist, do not Technique library will not be reloaded
[2019-12-31 10:46:40+0100] INFO  bootchecks - Check that system group / directive / rules for Rudder 4.2 are agent-specific
[2019-12-31 10:46:41+0100] INFO  bootchecks - Regenerate all ncf techniques
[2019-12-31 10:46:41+0100] INFO  bootchecks - Flag file '/opt/rudder/etc/force_ncf_technique_update' does not exist, do not regenerate ncf Techniques
[2019-12-31 10:46:41+0100] INFO  bootchecks - Resume policy update if it was running before shutdown
[2019-12-31 10:46:41+0100] INFO  bootchecks - Flag file '/opt/rudder/etc/policy-update-running' does not exist, No need to start a new policy update
[2019-12-31 10:46:41+0100] INFO  bootchecks - Trigger policy update if it was requested during shutdown
[2019-12-31 10:46:41+0100] INFO  bootchecks - Create system api token
[2019-12-31 10:46:41+0100] INFO  bootchecks - System api token file created in /var/rudder/run/api-token
[2019-12-31 10:46:41+0100] INFO  bootchecks - Update existing API token to 'RW' autorization level.
[2019-12-31 10:46:41+0100] INFO  bootchecks - Check NashHorn JS engine for warning
[2019-12-31 10:46:41+0100] WARN  bootchecks - Unable to remove NashHorn deprecation warning, exception was: For input string: "9-internal" 
[2019-12-31 10:46:41+0100] INFO  application - Configured authentication provider(s): [rootAdmin, file]
[2019-12-31 10:46:42+0100] INFO  application - No master admin account is defined. You can define one with 'rudder.auth.admin.login' and 'rudder.auth.admin.password' properties in the configuration file
[2019-12-31 10:46:42+0100] INFO  application - Add backend providers 'Default authentication backends provider: 'file','rootAdmin'
[2019-12-31 10:46:42+0100] INFO  application - Using configuration file defined by JVM property -Drudder.authFile : /opt/rudder/etc/rudder-users.xml
[2019-12-31 10:46:42+0100] INFO  bootstrap.liftweb.Boot - classpath
[2019-12-31 10:46:42+0100] INFO  org.reflections.Reflections - Reflections took 56 ms to scan 113 urls, producing 0 keys and 0 values 
INFO Configure inventory processing with parallelism of '1' and queue size of '50'
[2019-12-31 10:46:42+0100] INFO  inventory-processing - Incoming inventory watcher started - process existing inventories
[2019-12-31 10:46:42+0100] INFO  application - Application Rudder started
2019-12-31 10:46:42.999:INFO:oejsh.ContextHandler:main: Started o.e.j.w.WebAppContext@4a7f959b{/rudder,file:///var/rudder/tmp/jetty/jetty-rudder.war.dir/webapp/,AVAILABLE}{/rudder.war}
2019-12-31 10:46:43.010:INFO:oejs.AbstractConnector:main: Started ServerConnector@70f9d581{HTTP/1.1,[http/1.1]}{127.0.0.1:8080}
2019-12-31 10:46:43.010:INFO:oejs.Server:main: Started @17806ms
[2019-12-31 10:46:56+0100] INFO  inventory-processing - Watch new inventory file 'server-root.ocs' with signature available: process.
[2019-12-31 10:47:00+0100] INFO  inventory-processing - Report 'server-root.ocs' for node 'server.rudder.local' [root] (signature:certified) processed in 2 seconds and 229 milliseconds ms
[2019-12-31 10:47:10+0100] INFO  scheduledJob - Update in node inventories main information detected: triggering a policy generation
[2019-12-31 10:47:10+0100] INFO  policy.generation - Start policy generation, checking updated rules
[2019-12-31 10:47:10+0100] INFO  policy.generation - [metrics] Xmx:1007 MB nodes:1 (cached:0) rules:5 (enabled:4) techniques:43 (enabled:43) directives:4 (enabled:4) groups:2 (dynamic:2) parameters:1
Fiber failed.
An unchecked error was produced.
java.lang.ExceptionInInitializerError
    at com.zaxxer.nuprocess.internal.BasePosixProcess.<clinit>(BasePosixProcess.java:94)
    at com.normation.rudder.hooks.RunNuCommand$.<init>(RunNuCommand.scala:109)
    at com.normation.rudder.hooks.RunNuCommand$.<clinit>(RunNuCommand.scala)
    at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.execHook(WriteNodeCertificatesPem.scala:145)
    at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.$anonfun$writeCertificates$7(WriteNodeCertificatesPem.scala:99)
    at zio.internal.FiberContext.evaluateNow(FiberContext.scala:710)
    at zio.internal.FiberContext.$anonfun$evaluateLater$1(FiberContext.scala:602)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@9-internal/ThreadPoolExecutor.java:1158)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@9-internal/ThreadPoolExecutor.java:632)
    at java.lang.Thread.run(java.base@9-internal/Thread.java:804)
Caused by: java.lang.NumberFormatException: For input string: "9-internal" 
    at java.lang.NumberFormatException.forInputString(java.base@9-internal/NumberFormatException.java:65)
    at java.lang.Integer.parseInt(java.base@9-internal/Integer.java:695)
    at java.lang.Integer.valueOf(java.base@9-internal/Integer.java:1026)
    at com.zaxxer.nuprocess.internal.Constants.<clinit>(Constants.java:18)
    ... 10 more

Fiber:566 was supposed to continue to:
  a future continuation at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCerticatesAsync(WriteNodeCertificatesPem.scala:85)

Fiber:566 execution trace:
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificates(WriteNodeCertificatesPem.scala:99)
  at com.normation.errors$IOResult$.effect(ZioCommons.scala:96)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:157)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.ZIOFunctions.bracketExit(ZIO.scala:1702)
  at zio.internal.FiberContext.evaluateNow(FiberContext.scala:475)
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.ZIO.run(ZIO.scala:1123)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:147)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:157)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.ZIO.ensuring(ZIO.scala:320)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:123)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:146)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:107)
  at zio.ZIO.ensuring(ZIO.scala:318)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:146)
  at zio.ZIO.flatten(ZIO.scala:402)
  at zio.ZIO$ZipLeftFn.apply(ZIO.scala:2673)
  at zio.UIO$.effectSuspendTotal(UIO.scala:183)
  at zio.Fiber.join(Fiber.scala:69)
  at zio.Fiber.join(Fiber.scala:69)
  at zio.internal.FiberContext.await(FiberContext.scala:619)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:145)
  at zio.ZIOFunctions.effectSuspendTotal(ZIO.scala:1943)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificates(WriteNodeCertificatesPem.scala:98)
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.internal.FiberContext.evaluateNow(FiberContext.scala:471)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificates(WriteNodeCertificatesPem.scala:98)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificatesToNew(WriteNodeCertificatesPem.scala:113)
  at zio.ZIOFunctions.foreach(ZIO.scala:2020)
  at zio.ZIOFunctions.foreach(ZIO.scala:2019)
  at zio.ZIO.zipWith(ZIO.scala:1493)
  at com.normation.errors$IOResult$.effect(ZioCommons.scala:96)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:157)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.ZIOFunctions.bracketExit(ZIO.scala:1702)
  at zio.internal.FiberContext.evaluateNow(FiberContext.scala:475)
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.ZIO.run(ZIO.scala:1123)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:147)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:157)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.ZIO.ensuring(ZIO.scala:320)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:123)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:146)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:107)
  at zio.ZIO.ensuring(ZIO.scala:318)
  at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:148)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:146)
  at zio.ZIO.flatten(ZIO.scala:402)
  at zio.ZIO$ZipLeftFn.apply(ZIO.scala:2673)
  at zio.UIO$.effectSuspendTotal(UIO.scala:183)
  at zio.Fiber.join(Fiber.scala:69)
  at zio.Fiber.join(Fiber.scala:69)
  at zio.internal.FiberContext.await(FiberContext.scala:619)
  at zio.blocking.Blocking$Service.effectBlocking(Blocking.scala:145)
  at zio.ZIOFunctions.effectSuspendTotal(ZIO.scala:1943)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificatesToNew(WriteNodeCertificatesPem.scala:114)
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.internal.FiberContext.evaluateNow(FiberContext.scala:471)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificatesToNew(WriteNodeCertificatesPem.scala:113)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificates(WriteNodeCertificatesPem.scala:92)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.writeCertificates(WriteNodeCertificatesPem.scala:92)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:131)
  at com.normation.errors$IOResult$.effectM(ZioCommons.scala:104)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:132)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:131)
  at com.normation.errors$IOResult$.effectM(ZioCommons.scala:104)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:129)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:128)
  at com.normation.errors$IOResult$.effectM(ZioCommons.scala:104)
  at com.normation.rudder.services.policies.WriteNodeCertificatesPemImpl.checkParentDirOK(WriteNodeCertificatesPem.scala:125)

Fiber:566 was spawned by:

Fiber:565 was supposed to continue to:
  a future continuation at zio.ZIO.run(ZIO.scala:1123)
  a future continuation at zio.ZIO.bracket_(ZIO.scala:144)
  a future continuation at zio.ZIO.run(ZIO.scala:1123)
  a future continuation at zio.ZIO.bracket_(ZIO.scala:144)
  a future continuation at com.normation.zio$ZioRuntime$.runNow(ZioCommons.scala:330)

Fiber:565 execution trace:
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.internal.FiberContext.lock(FiberContext.scala:543)
  at zio.internal.FiberContext.lock(FiberContext.scala:543)
  at zio.blocking.Blocking$Service.blocking(Blocking.scala:69)
  at zio.blocking.package$.blockingExecutor(blocking.scala:23)
  at zio.ZIO.bracket_(ZIO.scala:144)
  at zio.internal.FiberContext.evaluateNow(FiberContext.scala:471)

Fiber:565 was spawned by: <empty trace>
[2019-12-31 10:47:11+0100] INFO  policy.generation - Policy generation failed after:           
[2019-12-31 10:47:11+0100] ERROR policy.generation - Error when updating policy, reason was: Cannot build target configuration node <- An error occured
[2019-12-31 10:47:11+0100] ERROR policy.generation - Root exception was: class com.normation.rudder.services.policies.JsEngine$SandboxSecurityManager (in unnamed module @0x1fe04292) cannot access class sun.security.provider.PolicyFile (in module java.base) because module java.base does not export sun.security.provider to unnamed module @0x1fe04292
[2019-12-31 10:47:11+0100] INFO  policy.generation - Flag file '/opt/rudder/etc/policy-update-running' successfully removed
[2019-12-31 10:47:11+0100] ERROR policy.generation - Policy update error for process '2' at 2019-12-31 10:47:11: Cannot build target configuration node
[2019-12-31 10:51:07+0100] WARN  explain_compliance.root - Can not get compliance for node with ID 'root' because it has no configuration id initialised nor sent reports (node just added ?)
[2019-12-31 10:51:07+0100] INFO  compliance - [metrics] global compliance (number of components): undefined
Actions
Copy link

Also available in: Atom PDF