test_replica_ca_install_with_skip_schema_check is failing in [testing_ipa-4.9_latest_selinux] Nightly PR #785 with an error
test_replica_ca_install_with_skip_schema_check
E subprocess.CalledProcessError: Command '['ipa-ca-install', '-U', '-p', 'Secret.123', '-P', 'admin', '-w', 'Secret.123', '--skip-schema-check']' returned non-zero exit status 1. pytest_ipa/integration/host.py:202: CalledProcessError ------------------------------Captured stderr call------------------------------ ipa: WARNING: ipa: ERROR: DNS is not configured ipa: ERROR: stderr: ipaserver.install.dogtaginstance: CRITICAL Failed to configure CA instance ipaserver.install.dogtaginstance: CRITICAL See the installation logs and the following files/directories for more information: ipaserver.install.dogtaginstance: CRITICAL /var/log/pki/pki-tomcat CA configuration failed.
All logs.
@mpolovka the test is failing while installing a CA clone on replica0. ipareplica-ca-install.log shows that pkispawn timed out waiting for CA subsystem to start:
INFO: Waiting for CA subsystem to start (60s) ERROR: Exception: CA subsystem did not start after 60s File "/usr/lib/python3.9/site-packages/pki/server/pkispawn.py", line 575, in main scriptlet.spawn(deployer) File "/usr/lib/python3.9/site-packages/pki/server/deployment/scriptlets/configuration.py", line 962, in spawn deployer.instance.wait_for_startup( File "/usr/lib/python3.9/site-packages/pki/server/deployment/pkihelper.py", line 890, in wait_for_startup raise Exception('%s subsystem did not start after %ds' % 2021-03-19T16:36:26Z CRITICAL Failed to configure CA instance
This message is similar to the issue reported in #8748 [Tracker] Random nightly failure in replica install: timeout Waiting for CA subsystem to start
The journal shows exactly the same symptoms:
Mar 19 16:36:27 replica0.ipa.test server[20720]: WARNING: Match [Server/Service/Connector] failed to set property [address] to [localhost6] Mar 19 16:36:27 replica0.ipa.test java[20720]: usr/lib/api/apiutil.c Could not open /run/lock/opencryptoki/LCK..APIlock Mar 19 16:36:28 replica0.ipa.test server[20720]: WARNING: Some of the specified [protocols] are not supported by the SSL engine and have been skipped: [[TLSv1, TLSv1.1]] Mar 19 16:36:28 replica0.ipa.test server[20720]: SEVERE: Failed to initialize component [Connector[AJP/1.3-8009]] Mar 19 16:36:28 replica0.ipa.test server[20720]: org.apache.catalina.LifecycleException: Protocol handler initialization failed Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.connector.Connector.initInternal(Connector.java:1049) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:136) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.core.StandardService.initInternal(StandardService.java:558) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:136) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.core.StandardServer.initInternal(StandardServer.java:1045) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.util.LifecycleBase.init(LifecycleBase.java:136) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.startup.Catalina.load(Catalina.java:724) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.startup.Catalina.load(Catalina.java:746) Mar 19 16:36:28 replica0.ipa.test server[20720]: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Mar 19 16:36:28 replica0.ipa.test server[20720]: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) Mar 19 16:36:28 replica0.ipa.test server[20720]: at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) Mar 19 16:36:28 replica0.ipa.test server[20720]: at java.base/java.lang.reflect.Method.invoke(Method.java:566) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.startup.Bootstrap.load(Bootstrap.java:302) Mar 19 16:36:28 replica0.ipa.test server[20720]: at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:472) Mar 19 16:36:28 replica0.ipa.test server[20720]: Caused by: java.net.BindException: Address already in use
=> Closing this issue as a duplicate.
Metadata Update from @frenaud: - Issue close_status updated to: duplicate - Issue status updated to: Closed (was: Open)