Actions
Bug #20034
closedBroken webapp after debian10 install
Pull Request:
Severity:
Critical - prevents main use of Rudder | no workaround | data loss | security
UX impact:
User visibility:
First impressions of Rudder
Effort required:
Priority:
124
Name check:
To do
Fix check:
To do
Regression:
Description
I tried to install a rudder-server-root on a debian10 and I ended up with an unusable webapp, here are the logs:
install logs:
robot_server: The following additional packages will be installed: robot_server: augeas-lenses augeas-tools libaugeas0 libltdl7 libxml-treepp-perl robot_server: python3-bs4 python3-distutils python3-html5lib python3-lib2to3 python3-lxml robot_server: python3-soupsieve python3-webencodings rudder-agent rudder-reports robot_server: rudder-server-relay rudder-webapp robot_server: Suggested packages: robot_server: augeas-doc python3-genshi python3-lxml-dbg python-lxml-doc robot_server: The following NEW packages will be installed: robot_server: augeas-lenses augeas-tools libaugeas0 libltdl7 libxml-treepp-perl robot_server: python3-bs4 python3-distutils python3-html5lib python3-lib2to3 python3-lxml robot_server: python3-soupsieve python3-webencodings rudder-agent rudder-reports robot_server: rudder-server-relay rudder-server-root rudder-webapp robot_server: 0 upgraded, 17 newly installed, 0 to remove and 110 not upgraded. robot_server: Need to get 145 MB of archives. robot_server: After this operation, 223 MB of additional robot_server: disk space will be used. robot_server: Get:1 http://ftp.fr.debian.org/debian buster/main amd64 python3-lib2to3 all 3.7.3-1 [76.7 kB] robot_server: Get:2 http://ftp.fr.debian.org/debian buster/main amd64 python3-distutils all 3.7.3-1 [142 kB] robot_server: Get:3 http://ftp.fr.debian.org/debian buster/main amd64 python3-lxml amd64 4.3.2-1+deb10u3 [1,162 kB] robot_server: Get:4 http://ftp.fr.debian.org/debian buster/main amd64 libxml-treepp-perl all 0.43-1 [21.7 kB] robot_server: Get:5 http://ftp.fr.debian.org/debian buster/main amd64 augeas-lenses all 1.11.0-3 [442 kB] robot_server: Get:6 http://ftp.fr.debian.org/debian buster/main amd64 libaugeas0 amd64 1.11.0-3 [301 kB] robot_server: Get:7 http://ftp.fr.debian.org/debian buster/main amd64 augeas-tools amd64 1.11.0-3 [173 kB] robot_server: Get:8 http://ftp.fr.debian.org/debian buster/main amd64 libltdl7 amd64 2.4.6-9 [390 kB] robot_server: Get:9 http://ftp.fr.debian.org/debian buster/main amd64 python3-soupsieve all 1.8+dfsg-1 [27.6 kB] robot_server: Get:10 http://ftp.fr.debian.org/debian buster/main amd64 python3-bs4 all 4.7.1-1 [94.1 kB] robot_server: Get:11 http://ftp.fr.debian.org/debian buster/main amd64 python3-webencodings all 0.5.1-1 [10.9 kB] robot_server: Get:12 http://ftp.fr.debian.org/debian buster/main amd64 python3-html5lib all 1.0.1-1 [89.5 kB] robot_server: Get:13 https://repository.rudder.io/rtf/apt/6.2-nightly buster/main amd64 rudder-agent amd64 6.2.11~rc1~git202110010122-debian10 [3,205 kB] robot_server: Get:14 https://repository.rudder.io/rtf/apt/6.2-nightly buster/main amd64 rudder-server-relay amd64 6.2.11~rc1~git202110010122-debian10 [3,432 kB] robot_server: Get:15 https://repository.rudder.io/rtf/apt/6.2-nightly buster/main amd64 rudder-reports all 6.2.11~rc1~git202110010122-debian10 [8,580 B] robot_server: Get:16 https://repository.rudder.io/rtf/apt/6.2-nightly buster/main amd64 rudder-webapp amd64 6.2.11~rc1~git202110010122-debian10 [136 MB] robot_server: Get:17 https://repository.rudder.io/rtf/apt/6.2-nightly buster/main amd64 rudder-server-root all 6.2.11~rc1~git202110010122-debian10 [3,376 B] robot_server: Preconfiguring packages ... robot_server: Fetched 145 MB in 4s (40.0 MB/s) robot_server: Selecting previously unselected package python3-lib2to3. (Reading database ... 59920 files and directories currently installed.) robot_server: Preparing to unpack .../00-python3-lib2to3_3.7.3-1_all.deb ... robot_server: Unpacking python3-lib2to3 (3.7.3-1) ... robot_server: Selecting previously unselected package python3-distutils. robot_server: Preparing to unpack .../01-python3-distutils_3.7.3-1_all.deb ... robot_server: Unpacking python3-distutils (3.7.3-1) ... robot_server: Selecting previously unselected package python3-lxml:amd64. robot_server: Preparing to unpack .../02-python3-lxml_4.3.2-1+deb10u3_amd64.deb ... robot_server: Unpacking python3-lxml:amd64 (4.3.2-1+deb10u3) ... robot_server: Selecting previously unselected package libxml-treepp-perl. robot_server: Preparing to unpack .../03-libxml-treepp-perl_0.43-1_all.deb ... robot_server: Unpacking libxml-treepp-perl (0.43-1) ... robot_server: Selecting previously unselected package augeas-lenses. robot_server: Preparing to unpack .../04-augeas-lenses_1.11.0-3_all.deb ... robot_server: Unpacking augeas-lenses (1.11.0-3) ... robot_server: Selecting previously unselected package libaugeas0:amd64. robot_server: Preparing to unpack .../05-libaugeas0_1.11.0-3_amd64.deb ... robot_server: Unpacking libaugeas0:amd64 (1.11.0-3) ... robot_server: Selecting previously unselected package augeas-tools. robot_server: Preparing to unpack .../06-augeas-tools_1.11.0-3_amd64.deb ... robot_server: Unpacking augeas-tools (1.11.0-3) ... robot_server: Selecting previously unselected package rudder-agent. robot_server: Preparing to unpack .../07-rudder-agent_6.2.11~rc1~git202110010122-debian10_amd64.deb ... robot_server: Unpacking rudder-agent (6.2.11~rc1~git202110010122-debian10) ... robot_server: Selecting previously unselected package rudder-server-relay. robot_server: Preparing to unpack .../08-rudder-server-relay_6.2.11~rc1~git202110010122-debian10_amd64.deb ... robot_server: Unpacking robot_server: rudder-server-relay (6.2.11~rc1~git202110010122-debian10) ... robot_server: Selecting previously unselected package libltdl7:amd64. robot_server: Preparing to unpack .../09-libltdl7_2.4.6-9_amd64.deb ... robot_server: Unpacking libltdl7:amd64 (2.4.6-9) ... robot_server: Selecting previously unselected package rudder-reports. robot_server: Preparing to unpack .../10-rudder-reports_6.2.11~rc1~git202110010122-debian10_all.deb ... robot_server: Unpacking rudder-reports (6.2.11~rc1~git202110010122-debian10) ... robot_server: Setting up python3-lib2to3 (3.7.3-1) ... robot_server: Setting up python3-distutils (3.7.3-1) ... robot_server: Setting up python3-lxml:amd64 (4.3.2-1+deb10u3) ... robot_server: Setting up libxml-treepp-perl (0.43-1) ... robot_server: Setting up augeas-lenses (1.11.0-3) ... robot_server: Setting up libaugeas0:amd64 (1.11.0-3) ... robot_server: Setting up augeas-tools (1.11.0-3) ... robot_server: Setting up rudder-agent (6.2.11~rc1~git202110010122-debian10) ... robot_server: Created symlink /etc/systemd/system/multi-user.target.wants/rudder-agent.service → /lib/systemd/system/rudder-agent.service. robot_server: Created symlink /etc/systemd/system/multi-user.target.wants/rudder-cf-execd.service → /lib/systemd/system/rudder-cf-execd.service. robot_server: Created symlink /etc/systemd/system/rudder-agent.service.requires/rudder-cf-execd.service → /lib/systemd/system/rudder-cf-execd.service. robot_server: Created symlink /etc/systemd/system/multi-user.target.wants/rudder-cf-serverd.service → /lib/systemd/system/rudder-cf-serverd.service. robot_server: Created symlink /etc/systemd/system/rudder-agent.service.wants/rudder-cf-serverd.service → /lib/systemd/system/rudder-cf-serverd.service. robot_server: INFO: Scheduling an inventory during next run... robot_server: rudder agent check is already running robot_server: Setting up rudder-server-relay (6.2.11~rc1~git202110010122-debian10) ... robot_server: INFO: Creating users ... Done robot_server: INFO: Configuring systemd services...Created symlink /etc/systemd/system/multi-user.target.wants/rudder-relayd.service → /lib/systemd/system/rudder-relayd.service. robot_server: Created symlink /etc/systemd/system/rudder-server.service.requires/rudder-relayd.service → /lib/systemd/system/rudder-relayd.service. robot_server: Done robot_server: INFO: No usable SSL certificate detected for Rudder relay HTTPS support, generating one automatically...Generating a RSA private key robot_server: ......................................+++++ robot_server: .............................+++++ robot_server: writing new private key to '/opt/rudder/etc/ssl/rudder.key' robot_server: ----- robot_server: Done robot_server: INFO: Starting services... Done robot_server: INFO: rudder-server-relay setup complete. robot_server: robot_server: ***************************************************************************************** robot_server: INFO: * If you are installing a root server, configuration is automatically done robot_server: INFO: * If you are installing a simple relay, run: robot_server: INFO: 'rudder server node-to-relay <your uuid>' robot_server: INFO: on your root server to complete this node transition to a relay server. robot_server: INFO: Please look at the documentation for details (Section 'Relay servers') robot_server: ***************************************************************************************** robot_server: Selecting previously unselected package rudder-webapp. (Reading database ... 63445 files and directories currently installed.) robot_server: Preparing to unpack .../0-rudder-webapp_6.2.11~rc1~git202110010122-debian10_amd64.deb ... robot_server: Unpacking rudder-webapp (6.2.11~rc1~git202110010122-debian10) ... robot_server: Selecting previously unselected package python3-soupsieve. robot_server: Preparing to unpack .../1-python3-soupsieve_1.8+dfsg-1_all.deb ... robot_server: Unpacking python3-soupsieve (1.8+dfsg-1) ... robot_server: Selecting previously unselected package python3-bs4. robot_server: Preparing to unpack .../2-python3-bs4_4.7.1-1_all.deb ... robot_server: Unpacki robot_server: Job for rudder-jetty.service failed because the control process exited with error code. robot_server: See "systemctl status rudder-jetty.service" and "journalctl -xe" for details. robot_server: ng python3-bs4 (4.7.1-1) ... robot_server: Selecting previously unselected package python3-webencodings. robot_server: Preparing to unpack .../3-python3-webencodings_0.5.1-1_all.deb ... robot_server: Unpacking python3-webencodings (0.5.1-1) ... robot_server: Selecting previously unselected package python3-html5lib. robot_server: Preparing to unpack .../4-python3-html5lib_1.0.1-1_all.deb ... robot_server: Unpacking python3-html5lib (1.0.1-1) ... robot_server: Selecting previously unselected package rudder-server-root. robot_server: Preparing to unpack .../5-rudder-server-root_6.2.11~rc1~git202110010122-debian10_all.deb ... robot_server: Unpacking rudder-server-root (6.2.11~rc1~git202110010122-debian10) ... robot_server: Setting up rudder-reports (6.2.11~rc1~git202110010122-debian10) ... robot_server: INFO: Setting PostgreSQL as a boot service...Synchronizing state of postgresql.service with SysV service script with /lib/systemd/systemd-sysv-install. robot_server: Executing: /lib/systemd/systemd-sysv-install enable postgresql robot_server: Done robot_server: INFO: Waiting for PostgreSQL to be up... Done robot_server: INFO: Creating Rudder PostgreSQL user...Done robot_server: INFO: Creating Rudder PostgreSQL database... Done robot_server: Setting up python3-webencodings (0.5.1-1) ... robot_server: Setting up python3-html5lib (1.0.1-1) ... robot_server: Setting up libltdl7:amd64 (2.4.6-9) ... robot_server: Setting up python3-soupsieve (1.8+dfsg-1) ... robot_server: Setting up rudder-webapp (6.2.11~rc1~git202110010122-debian10) ... robot_server: INFO: Creating groups ... Done robot_server: INFO: Creating users ... Done robot_server: INFO: Removing ncf-api-venv user and group ... Done robot_server: INFO: Setting up systemd ...Created symlink /etc/systemd/system/multi-user.target.wants/rudder-jetty.service → /lib/systemd/system/rudder-jetty.service. robot_server: Created symlink /etc/systemd/system/rudder-server.service.requires/rudder-jetty.service → /lib/systemd/system/rudder-jetty.service. robot_server: Created symlink /etc/systemd/system/multi-user.target.wants/rudder-slapd.service → /lib/systemd/system/rudder-slapd.service. robot_server: Created symlink /etc/systemd/system/rudder-server.service.requires/rudder-slapd.service → /lib/systemd/system/rudder-slapd.service. robot_server: INFO: Restarting rudder-slapd... Done robot_server: robot_server: SUMMARY OF OPTIONS: robot_server: robot_server: Allowed networks: 192.168.4.0/24 10.0.2.15/32 192.168.4.2/32 robot_server: Force LDAP reset: no robot_server: robot_server: Initializing LDAP database...Can't open /opt/rudder/etc/ssl/agent.cert: No such file or directory. robot_server: done. robot_server: robot_server: Updating Rudder password file with random passwords... done. robot_server: Cleaning up temporary directories... done. robot_server: robot_server: Reinitialization complete, Rudder is currently reloading. robot_server: robot_server: You can access it via https://server.rudder.local/rudder robot_server: robot_server: INFO: Launching script to check if a migration is needed ... robot_server: Done robot_server: INFO: Re-generate rudder-lang libraries ... robot_server: Done robot_server: INFO: Make sure Rudder webapp is started...Job for rudder-jetty.service failed because the control process exited with error code. robot_server: See "systemctl status rudder-jetty.service" and "journalctl -xe" for details. robot_server: Done robot_server: INFO: Make sure Apache HTTPd is started... Done robot_server: INFO: No disable file detected and no agent executor process either. Restarting agent service... Done robot_server: FINISH: Rudder agent check ran properly, please look at messages above to see if there has been any error. robot_server: Setting up python3-bs4 (4.7.1-1) ... robot_server: Setting up rudder-server-root (6.2.11~rc1~git202110010122-debian10) ... robot_server: Created symlink /etc/systemd/system/multi-user.target.wants/rudder-server.service → /lib/systemd/system/rudder-server.service. robot_server: Processing triggers for rsyslog (8.1901.0-1) ... robot_server: Processing triggers for man-db (2.8.5-2) ... robot_server: Processing triggers for libc-bin (2.28-10) ...
Webapp logs:
2021-10-01 15:32:03.858:INFO:oejs.SetUIDListener:main: Setting umask=07 2021-10-01 15:32:03.870:INFO:oejs.Server:main: jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: de97d26f7bd222a0e16831e353d702a7a422f711; jvm 11.0.6+10-post-Debian-1deb10u1 2021-10-01 15:32:03.896:INFO:oejdp.ScanningAppProvider:main: Deployment monitor [file:///opt/rudder/share/webapps/] at interval 0 2021-10-01 15:32:05.799: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 2021-10-01 15:32:06.252:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0 2021-10-01 15:32:06.252:INFO:oejs.session:main: No SessionScavenger set, using defaults 2021-10-01 15:32:06.252:INFO:oejs.session:main: node0 Scavenging every 660000ms [2021-10-01 15:32:06+0200] INFO application - Rudder starts with PID 27351 on 1 cores [2021-10-01 15:32:07+0200] INFO application - Use configuration file defined by JVM property -Drudder.configFile : /opt/rudder/etc/rudder-web.properties [2021-10-01 15:32:07+0200] INFO application - Global exception handler configured to stop Rudder on: java.lang.Error [2021-10-01 15:32:08+0200] INFO application - Property 'rudder.batch.delete.software.interval' is missing or empty in rudder.configFile. Default to 24 hours. [2021-10-01 15:32:08+0200] INFO application - Property 'metrics.healthcheck.scheduler.period' is missing or empty in rudder.configFile. Default to 6 hours. [2021-10-01 15:32:08+0200] INFO application - Using 'move' behavior when a node is deleted [2021-10-01 15:32:08+0200] INFO application - Starting Rudder 6.2.11-SNAPSHOT web application [build timestamp: 2021-09-30T16:26:03Z] [2021-10-01 15:32:18+0200] INFO report - Disable automatic database archive sinces property rudder.batch.reportsCleaner.archive.TTL is 0 or negative [2021-10-01 15:32:18+0200] WARN scheduled.job - Automatic report logger has never run, logging latest 100 non compliant reports [2021-10-01 15:32:19+0200] WARN healthcheck - CPU cores: Only one core, recommended value is at least 2 [2021-10-01 15:32:19+0200] INFO scheduled.job - Starting [Store Agent Run Times] scheduler with a period of 5 s [2021-10-01 15:32:19+0200] INFO application - List of registered properties: [2021-10-01 15:32:19+0200] INFO application - registered property: awt.toolkit="sun.awt.X11.XToolkit" [2021-10-01 15:32:19+0200] INFO application - registered property: file.encoding="UTF-8" [2021-10-01 15:32:19+0200] INFO application - registered property: file.separator="/" [2021-10-01 15:32:19+0200] INFO application - registered property: history.inventories.rootdir="/var/rudder/inventories/historical" [2021-10-01 15:32:19+0200] INFO application - registered property: inventories.root.directory="/var/rudder/inventories" [2021-10-01 15:32:19+0200] INFO application - registered property: inventories.watcher.enable="true" [2021-10-01 15:32:19+0200] INFO application - registered property: inventories.watcher.period.garbage.old="5 minutes" [2021-10-01 15:32:19+0200] INFO application - registered property: inventories.watcher.waitForSignatureDuration="10" [2021-10-01 15:32:19+0200] INFO application - registered property: inventory.parse.parallelization="0.5x" [2021-10-01 15:32:19+0200] INFO application - registered property: java.awt.graphicsenv="sun.awt.X11GraphicsEnvironment" [2021-10-01 15:32:19+0200] INFO application - registered property: java.awt.printerjob="sun.print.PSPrinterJob" [2021-10-01 15:32:20+0200] INFO application - registered property: java.class.path="/opt/rudder/jetty/start.jar" [2021-10-01 15:32:20+0200] INFO application - registered property: java.class.version="55.0" [2021-10-01 15:32:20+0200] INFO application - registered property: java.home="/usr/lib/jvm/java-11-openjdk-amd64" [2021-10-01 15:32:20+0200] INFO application - registered property: java.io.tmpdir="/var/rudder/tmp/jetty" [2021-10-01 15:32:20+0200] INFO application - registered property: java.library.path="/usr/java/packages/lib:/usr/lib/x86_64-linux-gnu/jni:/lib/x86_64-linux-gnu:/usr/lib/x86_64-linux-gnu:/usr/lib/jni:/lib:/usr/lib" [2021-10-01 15:32:20+0200] INFO application - registered property: java.runtime.name="OpenJDK Runtime Environment" [2021-10-01 15:32:20+0200] INFO application - registered property: java.runtime.version="11.0.6+10-post-Debian-1deb10u1" [2021-10-01 15:32:20+0200] INFO application - registered property: java.specification.name="Java Platform API Specification" [2021-10-01 15:32:20+0200] INFO application - registered property: java.specification.vendor="Oracle Corporation" [2021-10-01 15:32:20+0200] INFO application - registered property: java.specification.version="11" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vendor.url.bug="https://bugs.debian.org/openjdk-11" [2021-10-01 15:32:20+0200] INFO application - registered property: java.version="11.0.6" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.compressedOopsMode="32-bit" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.info="mixed mode, sharing" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.name="OpenJDK 64-Bit Server VM" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.specification.name="Java Virtual Machine Specification" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.specification.vendor="Oracle Corporation" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.specification.version="11" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.vendor="Debian" [2021-10-01 15:32:20+0200] INFO application - registered property: java.vm.version="11.0.6+10-post-Debian-1deb10u1" [2021-10-01 15:32:20+0200] INFO application - registered property: jdk.debug="release" [2021-10-01 15:32:20+0200] INFO application - registered property: jetty.base="/opt/rudder/etc/rudder-jetty-base" [2021-10-01 15:32:20+0200] INFO application - registered property: jetty.git.hash="de97d26f7bd222a0e16831e353d702a7a422f711" [2021-10-01 15:32:20+0200] INFO application - registered property: jetty.home="/opt/rudder/jetty" [2021-10-01 15:32:20+0200] INFO application - registered property: jetty.tag.version="master" [2021-10-01 15:32:20+0200] INFO application - registered property: jetty.version="9.4.32.v20200930" [2021-10-01 15:32:20+0200] INFO application - registered property: ldap.authdn="cn=manager,cn=rudder-configuration" [2021-10-01 15:32:20+0200] INFO application - registered property: ldap.authpw=********** [2021-10-01 15:32:20+0200] INFO application - registered property: ldap.host="localhost" [2021-10-01 15:32:20+0200] INFO application - registered property: ldap.maxPoolSize="2" [2021-10-01 15:32:20+0200] INFO application - registered property: ldap.port="389" [2021-10-01 15:32:20+0200] INFO application - registered property: ldif.tracelog.rootdir="/var/rudder/inventories/debug" [2021-10-01 15:32:20+0200] INFO application - registered property: line.separator="\n" [2021-10-01 15:32:20+0200] INFO application - registered property: logback.configurationFile="/opt/rudder/etc/logback.xml" [2021-10-01 15:32:20+0200] INFO application - registered property: os.arch="amd64" [2021-10-01 15:32:20+0200] INFO application - registered property: os.name="Linux" [2021-10-01 15:32:20+0200] INFO application - registered property: os.version="4.19.0-9-amd64" [2021-10-01 15:32:20+0200] INFO application - registered property: path.separator=":" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.auth.provider="file" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.authFile="/opt/rudder/etc/rudder-users.xml" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.autoArchiveItems="true" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.check.node.cache.interval="15 s" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.databasecleaner.runtime.day="sunday" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.databasecleaner.runtime.hour="0" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.databasecleaner.runtime.minute="0" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.dyngroup.updateInterval="5" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.purge.inventories.delete.TTL="7" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.purge.inventories.delete.interval="24" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reports.logInterval="1" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reportsCleaner.deleteLogReport.TTL="2x" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reportscleaner.archive.TTL="0" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reportscleaner.compliancelevels.delete.TTL="8" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reportscleaner.delete.TTL="4" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.reportscleaner.frequency="daily" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.storeAgentRunTimes.maxBatchSize="5" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.storeAgentRunTimes.maxDays="0" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.storeAgentRunTimes.maxMinutes="30" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.storeAgentRunTimes.updateInterval="5" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.batch.techniqueLibrary.updateInterval="5" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.community.port="5309" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.config.repo.new.file.group.owner="rudder" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.configFile="/opt/rudder/etc/rudder-web.properties" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.debug.nodeconfiguration.path="/var/log/rudder/nodeConfigurations" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.dir.backup="/var/rudder/share/backup/" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.dir.dependencies="/var/rudder/tools" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.dir.gitRoot="/var/rudder/configuration-repository" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.dir.lock="/var/rudder/lock/" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.dir.shared.files.folder="/var/rudder/configuration-repository/shared-files" [2021-10-01 15:32:20+0200] 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" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.batch.max.size="500" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.driver="org.postgresql.Driver" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.maxPoolSize="25" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.password=********** [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.url="jdbc:postgresql://localhost:5432/rudder" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jdbc.username="rudder" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.jvm.fatal.exceptions="" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.lang.test-loop.exec="true" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.nodes.delete.defaultMode="move" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.relayd.reload="/opt/rudder/bin/rudder relay reload -p" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.rest.allowNonAuthenticatedUser="true" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.cfengine-mission-portal="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.db="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.inventory-endpoint="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.ldap="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.relay-promises-only="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.relay-top="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server-roles.web="autodetect" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.server.relay.api="https://localhost/rudder/relay-api" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.syslog.port="514" [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.webdav.password=********** [2021-10-01 15:32:20+0200] INFO application - registered property: rudder.webdav.user="rudder" [2021-10-01 15:32:20+0200] INFO application - registered property: run.mode="production" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.arch.data.model="64" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.boot.library.path="/usr/lib/jvm/java-11-openjdk-amd64/lib" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.cpu.endian="little" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.cpu.isalist="" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.io.unicode.encoding="UnicodeLittle" [2021-10-01 15:32:20+0200] 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" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.java.launcher="SUN_STANDARD" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.jnu.encoding="ANSI_X3.4-1968" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.management.compiler="HotSpot 64-Bit Tiered Compilers" [2021-10-01 15:32:20+0200] INFO application - registered property: sun.os.patch.level="unknown" [2021-10-01 15:32:20+0200] INFO application - registered property: user.country="US" [2021-10-01 15:32:20+0200] INFO application - registered property: user.dir="/opt/rudder/etc/rudder-jetty-base" [2021-10-01 15:32:20+0200] INFO application - registered property: user.home="/root" [2021-10-01 15:32:20+0200] INFO application - registered property: user.language="en" [2021-10-01 15:32:20+0200] INFO application - registered property: user.name="root" [2021-10-01 15:32:20+0200] INFO application - registered property: user.timezone="Europe/Paris" [2021-10-01 15:32:20+0200] INFO application - registered property: waiting.inventory.queue.size="5" [2021-10-01 15:32:20+0200] INFO application - Plugin's license directory: '/opt/rudder/etc/plugins/licenses/' [2021-10-01 15:32:20+0200] INFO bootchecks - Check LDAP and PostgreSQL connection [2021-10-01 15:32:20+0200] INFO bootchecks - LDAP and PostgreSQL connection are OK [2021-10-01 15:32:20+0200] INFO bootchecks - Check mandatory DIT entries Fiber failed. An unchecked error was produced. java.lang.AssertionError: assertion failed at scala.Predef$.assert(Predef.scala:267) at com.normation.inventory.domain.Certificate.<init>(DataTypes.scala:155) at com.normation.inventory.domain.AgentInfoSerialisation$.parseSecurityToken(AgentTypes.scala:207) at com.normation.inventory.domain.AgentInfoSerialisation$.$anonfun$parseJson$5(AgentTypes.scala:246) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:916) at zio.internal.FiberContext.$anonfun$evaluateLater$1(FiberContext.scala:778) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) Fiber:Id(1633095138982,44) was supposed to continue to: a future continuation at com.normation.inventory.domain.AgentInfoSerialisation$.parseCompatNonJson(AgentTypes.scala:269) a future continuation at zio.ZIO$.foreach(ZIO.scala:2808) a future continuation at zio.ZIO$.foreach(ZIO.scala:2809) a future continuation at com.normation.rudder.repository.ldap.LDAPEntityMapper.parseAgentInfo(LDAPEntityMapper.scala:280) a future continuation at com.normation.rudder.repository.ldap.LDAPEntityMapper.inventoryEntriesToNodeInfos(LDAPEntityMapper.scala:314) a future continuation at com.normation.rudder.repository.ldap.LDAPEntityMapper.convertEntriesToNodeInfos(LDAPEntityMapper.scala:240) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:673) a future continuation at zio.ZIO$.foreach(ZIO.scala:2808) a future continuation at zio.ZIO$.foreach(ZIO.scala:2809) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:676) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:687) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:687) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:710) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:717) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:752) a future continuation at zio.ZIO.run(ZIO.scala:1640) a future continuation at zio.Semaphore.withPermits(Semaphore.scala:61) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:700) a future continuation at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:700) a future continuation at zio.ZIO$.zio$ZIO$$_succeedRight(ZIO.scala:4121) a future continuation at zio.ZIO.run(ZIO.scala:1640) a future continuation at zio.ZIO.bracket_(ZIO.scala:256) a future continuation at zio.ZIO.run(ZIO.scala:1640) a future continuation at zio.ZIO.bracket_(ZIO.scala:256) a future continuation at com.normation.zio$ZioRuntime$.runNow(ZioCommons.scala:382) Fiber:Id(1633095138982,44) execution trace: at com.normation.inventory.domain.AgentInfoSerialisation$.parseJson(AgentTypes.scala:236) at com.normation.inventory.domain.AgentInfoSerialisation$.parseJson(AgentTypes.scala:236) at zio.ZIO$.fromEither(ZIO.scala:3098) at <unknown>.<unknown>(ZioCommons.scala:0) at com.normation.inventory.domain.AgentInfoSerialisation$.parseJson(AgentTypes.scala:236) at com.normation.inventory.domain.AgentInfoSerialisation$.parseJson(AgentTypes.scala:235) at com.normation.inventory.domain.AgentInfoSerialisation$.parseJson(AgentTypes.scala:235) at zio.ZIO.zipWith(ZIO.scala:2137) at zio.ZIO$.foreach(ZIO.scala:2807) at com.normation.rudder.repository.ldap.LDAPEntityMapper.inventoryEntriesToNodeInfos(LDAPEntityMapper.scala:312) at zio.ZIO$.foreach(ZIO.scala:2819) at zio.ZIO$.foreach(ZIO.scala:2809) at zio.ZIO$.foreach(ZIO.scala:2807) at com.normation.rudder.repository.ldap.LDAPEntityMapper.inventoryEntriesToNodeInfos(LDAPEntityMapper.scala:296) at com.normation.rudder.repository.ldap.LDAPEntityMapper.inventoryEntriesToNodeInfos(LDAPEntityMapper.scala:296) at zio.ZIO$.fromEither(ZIO.scala:3098) at <unknown>.<unknown>(ZioCommons.scala:0) at com.normation.rudder.repository.ldap.LDAPEntityMapper.inventoryEntriesToNodeInfos(LDAPEntityMapper.scala:296) at zio.syntax$ToZio.succeed(syntax.scala:9) at com.normation.rudder.repository.ldap.LDAPEntityMapper.convertEntriesToNodeInfos(LDAPEntityMapper.scala:238) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at com.normation.rudder.repository.ldap.LDAPEntityMapper.convertEntriesToNodeInfos(LDAPEntityMapper.scala:235) at zio.ZIO$.fromEither(ZIO.scala:3098) at <unknown>.<unknown>(ZioCommons.scala:0) at zio.ZIO.zipWith(ZIO.scala:2137) at zio.ZIO$.foreach(ZIO.scala:2807) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:661) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:661) at zio.syntax$ToZio.succeed(syntax.scala:9) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:652) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:652) at zio.syntax$ToZio.succeed(syntax.scala:9) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:644) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:644) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:465) at zio.ZRef$Atomic.get(ZRef.scala:201) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:457) at zio.ZIO$WhenM$.apply(ZIO.scala:4059) at zio.ZRef$Atomic.get(ZRef.scala:201) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:436) at zio.ZIO$.foreach(ZIO.scala:2809) at zio.ZIO$.foreach(ZIO.scala:2808) at zio.ZIO.unit(ZIO.scala:1994) at zio.ZRef$Atomic.set(ZRef.scala:219) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:452) at zio.ZRef$Atomic.update(ZRef.scala:337) at zio.ZIO.zipWith(ZIO.scala:2137) at zio.ZIO$.foreach(ZIO.scala:2807) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:436) at zio.ZRef$.make(ZRef.scala:749) at com.normation.rudder.services.nodes.NodeInfoServiceCached$.constructNodesFromAllEntries(NodeInfoService.scala:434) at zio.ZRef$.make(ZRef.scala:749) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:687) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:161) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at zio.ZIO$.bracketExit(ZIO.scala:2273) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:559) at zio.ZIO.bracket_(ZIO.scala:256) at zio.ZIO.run(ZIO.scala:1640) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:161) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at zio.ZIO$.bracketExit(ZIO.scala:2273) at com.normation.ldap.sdk.PooledConnectionProvider.releaseInternalConnection(LDAPConnectionProvider.scala:254) at com.normation.ldap.sdk.LDAPConnectionProvider.withCon(LDAPConnectionProvider.scala:117) at zio.ZIO.run(ZIO.scala:1640) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:161) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at zio.ZIO$.bracketExit(ZIO.scala:2273) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:559) at zio.ZIO.bracket_(ZIO.scala:256) at zio.ZIO.run(ZIO.scala:1640) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:623) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:161) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) at zio.ZIO$.bracketExit(ZIO.scala:2273) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:559) at zio.ZIO.bracket_(ZIO.scala:256) at zio.ZIO.run(ZIO.scala:1640) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.clock.package$Clock$Service$$anon$1.currentTime(package.scala:41) at zio.clock.package$Clock$Service$$anon$1.currentTime(package.scala:41) at com.normation.zio$.currentTimeMillis(ZioCommons.scala:351) at zio.ZIO.bracket_(ZIO.scala:256) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:555) at com.normation.rudder.services.nodes.NodeInfoServiceCached.withUpToDateCache(NodeInfoService.scala:623) at com.normation.ldap.sdk.RoLDAPConnection.search(LDAPConnection.scala:322) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:161) at zio.internal.FiberContext$InterruptExit$.apply(FiberContext.scala:154) at zio.ZIO$.effectSuspendTotal(ZIO.scala:2640) Fiber:Id(1633095138982,44) was spawned by: <empty trace> [2021-10-01 15:32:20+0200] INFO bootchecks - All the required DIT entries are present in the LDAP directory [2021-10-01 15:32:20+0200] INFO bootchecks - Check initialization of User Technique Library [2021-10-01 15:32:20+0200] ERROR net.liftweb.actor.ActorLogger - Actor threw an exception java.lang.AssertionError: assertion failed at scala.Predef$.assert(Predef.scala:267) at com.normation.inventory.domain.Certificate.<init>(DataTypes.scala:155) at com.normation.inventory.domain.AgentInfoSerialisation$.parseSecurityToken(AgentTypes.scala:207) at com.normation.inventory.domain.AgentInfoSerialisation$.$anonfun$parseJson$5(AgentTypes.scala:246) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:916) at zio.internal.FiberContext.$anonfun$evaluateLater$1(FiberContext.scala:778) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834) [2021-10-01 15:32:20+0200] INFO bootchecks - The Active Technique library is not marked as being initialized: adding all policies from reference library... [2021-10-01T15:32:20.908+02:00] ERROR FATAL Rudder JVM caught an unhandled fatal exception. Rudder will now stop to prevent further inconsistant behavior. This is likely a bug, please contact Rudder developers. You can configure the list of fatal exception in /opt/rudder/etc/rudder-web.properties -> rudder.jvm.fatal.exceptions [2021-10-01T15:32:20.908+02:00] ERROR FATAL exception in thread 'pool-2-thread-5' (in threadgroup 'main'): 'java.lang.AssertionError': 'assertion failed' java.lang.AssertionError: assertion failed at scala.Predef$.assert(Predef.scala:267) at com.normation.inventory.domain.Certificate.<init>(DataTypes.scala:155) at com.normation.inventory.domain.AgentInfoSerialisation$.parseSecurityToken(AgentTypes.scala:207) at com.normation.inventory.domain.AgentInfoSerialisation$.$anonfun$parseJson$5(AgentTypes.scala:246) at zio.internal.FiberContext.evaluateNow(FiberContext.scala:916) at zio.internal.FiberContext.$anonfun$evaluateLater$1(FiberContext.scala:778) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) at java.base/java.lang.Thread.run(Thread.java:834)
rudder agent info:
root@server:~# rudder agent info Hostname: server.rudder.local UUID: root Key hash: MD5=06f1c689e46fe9f13d02b9772fffae9d Certificate creation: Oct 1 11:56:39 2021 GMT Certificate expiration: Sep 29 11:56:39 2031 GMT Certificate fingerprint: D5:38:E3:0B:6B:BF:42:D6:0A:82:1C:7D:F2:60:4A:20:8A:28:57:E6 Policy server: 127.0.0.1 Roles: rudder-db, rudder-reports, rudder-server-root, rudder-webapp, rudder-agent Report mode: full-compliance Run interval: 5 min Agent is enabled Agent is not forced in audit mode Configuration id: 0 Policy updated: 2021-10-01 15:36:44 Inventory sent: 2021-10-01 15:36:46 Version: Rudder agent 6.2.11~rc1~git202110010122-debian10
Running rudder-init to re-init the ldap does not fix this.
The /opt/rudder/etc/ssl/agent.cert does exists
Actions