The nightly tests for freeipa are randomly failing in ipa-server-install in rawhide. Please see PR #259 with for instance the following test_report:
cls = <class 'ipatests.test_integration.test_installation.TestInstallWithCA1'> mh = <pytest_multihost.plugin.MultihostFixture object at 0x7f9d2360d220> @classmethod def install(cls, mh): > tasks.install_master(cls.master, setup_dns=False) test_integration/test_installation.py:170: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ pytest_ipa/integration/tasks.py:325: in install_master result = host.run_command(args, raiseonerr=raiseonerr, _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ self = <ipatests.pytest_ipa.integration.host.Host master.ipa.test (master)> argv = ['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', ...] set_env = True, stdin_text = None, log_stdout = True, raiseonerr = True cwd = None, bg = False, encoding = 'utf-8', ok_returncode = 0 def run_command(self, argv, set_env=True, stdin_text=None, log_stdout=True, raiseonerr=True, cwd=None, bg=False, encoding='utf-8', ok_returncode=0): """Wrapper around run_command to log stderr on raiseonerr=True :param ok_returncode: return code considered to be correct, you can pass an integer or sequence of integers """ result = super().run_command( argv, set_env=set_env, stdin_text=stdin_text, log_stdout=log_stdout, raiseonerr=False, cwd=cwd, bg=bg, encoding=encoding ) # in FIPS mode SSH may print noise to stderr, remove the string # "FIPS mode initialized" + optional newline. result.stderr_bytes = FIPS_NOISE_RE.sub(b'', result.stderr_bytes) try: result_ok = result.returncode in ok_returncode except TypeError: result_ok = result.returncode == ok_returncode if not result_ok and raiseonerr: result.log.error('stderr: %s', result.stderr_text) > raise subprocess.CalledProcessError( result.returncode, argv, result.stdout_text, result.stderr_text ) E subprocess.CalledProcessError: Command '['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', 'Secret.123', '-a', 'Secret.123', '--domain-level=1', '-U']' returned non-zero exit status 1. pytest_ipa/integration/host.py:200: CalledProcessError -----------------------------Captured stderr setup------------------------------ ipa: ERROR: stderr: Synchronizing time No SRV records of NTP servers found and no NTP server or pool address was provided. Attempting to sync time with chronyc. Process chronyc waitsync failed to sync time! Unable to sync time with chrony server, assuming the time is in sync. Please check that 123 UDP port is opened, and any time server is on network. Failed to configure CA instance: CalledProcessError(Command ['/usr/sbin/pkispawn', '-s', 'CA', '-f', '/tmp/tmp8agl5nai'] returned non-zero exit status 1: 'Notice: Trust flag u is set automatically if the private key is present.\njava: ../nptl/pthread_mutex_lock.c:81: __pthread_mutex_lock: Assertion `mutex->__data.__owner == 0\' failed.\nERROR: CalledProcessError: Command \'[\'sudo\', \'-u\', \'pkiuser\', \'/usr/lib/jvm/jre-1.8.0-openjdk/bin/java\', \'-classpath\', \'/usr/share/tomcat/bin/tomcat-juli.jar:/usr/share/java/tomcat-servlet-api.jar:/usr/share/pki/ca/webapps/ca/WEB-INF/lib/*:/var/lib/pki/pki-tomcat/common/lib/*:/usr/share/pki/lib/*\', \'-Djavax.sql.DataSource.Factory=org.apache.commons.dbcp.BasicDataSourceFactory\', \'-Dcatalina.base=/var/lib/pki/pki-tomcat\', \'-Dcatalina.home=/usr/share/tomcat\', \'-Djava.endorsed.dirs=\', \'-Djava.io.tmpdir=/var/lib/pki/pki-tomcat/temp\', \'-Djava.util.logging.config.file=/etc/pki/pki-tomcat/logging.properties\', \'-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager\', \'org.dogtagpki.server.cli.PKIServerCLI\', \'ca-db-remove\', \'--force\']\' died with <Signals.SIGABRT: 6>.\n File "/usr/lib/python3.9/site-packages/pki/server/pkispawn.py", line 569, in main\n scriptlet.spawn(deployer)\n File "/usr/lib/python3.9/site-packages/pki/server/deployment/scriptlets/configuration.py", line 790, in spawn\n subsystem.remove_database(force=True)\n File "/usr/lib/python3.9/site-packages/pki/server/subsystem.py", line 942, in remove_database\n self.run(cmd, as_current_user=as_current_user)\n File "/usr/lib/python3.9/site-packages/pki/server/subsystem.py", line 1121, in run\n subprocess.run(cmd, check=True)\n File "/usr/lib64/python3.9/subprocess.py", line 524, in run\n raise CalledProcessError(retcode, process.args,\n\n') See the installation logs and the following files/directories for more information: /var/log/pki/pki-tomcat CA configuration failed. The ipa-server-install command failed. See /var/log/ipaserver-install.log for more information
pkispawn logs:
2020-06-27 16:05:35 ERROR: CalledProcessError: Command '['sudo', '-u', 'pkiuser', '/usr/lib/jvm/jre-1.8.0-openjdk/bin/java', '-classpath', '/usr/share/tomcat/bin/tomcat-juli.jar:/usr/share/java/tomcat-servlet-api.jar:/usr/share/pki/ca/webapps/ca/WEB-INF/lib/*:/var/lib/pki/pki-tomcat/common/lib/*:/usr/share/pki/lib/*', '-Djavax.sql.DataSource.Factory=org.apache.commons.dbcp.BasicDataSourceFactory', '-Dcatalina.base=/var/lib/pki/pki-tomcat', '-Dcatalina.home=/usr/share/tomcat', '-Djava.endorsed.dirs=', '-Djava.io.tmpdir=/var/lib/pki/pki-tomcat/temp', '-Djava.util.logging.config.file=/etc/pki/pki-tomcat/logging.properties', '-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager', 'org.dogtagpki.server.cli.PKIServerCLI', 'ca-db-remove', '--force']' died with <Signals.SIGABRT: 6>. File "/usr/lib/python3.9/site-packages/pki/server/pkispawn.py", line 569, in main scriptlet.spawn(deployer) File "/usr/lib/python3.9/site-packages/pki/server/deployment/scriptlets/configuration.py", line 790, in spawn subsystem.remove_database(force=True) File "/usr/lib/python3.9/site-packages/pki/server/subsystem.py", line 942, in remove_database self.run(cmd, as_current_user=as_current_user) File "/usr/lib/python3.9/site-packages/pki/server/subsystem.py", line 1121, in run subprocess.run(cmd, check=True) File "/usr/lib64/python3.9/subprocess.py", line 524, in run raise CalledProcessError(retcode, process.args,
Package version available here: - jss-4.7.0-0.2.fc33.x86_64 - pki-base-10.9.0-0.2.fc33.noarch - tomcat-9.0.36-1.fc33.noarch - tomcatjss-7.5.0-0.1.fc33.noarch
A stack trace can also be seen in the journal:
Jun 27 16:05:35 master.ipa.test audit[27698]: CRED_DISP pid=27698 uid=0 auid=0 ses=9 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_env,pam_unix acct="pkiuser" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Jun 27 16:05:35 master.ipa.test audit[27698]: ANOM_ABEND auid=0 uid=0 gid=17 ses=9 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 pid=27698 comm="sudo" exe="/usr/bin/sudo" sig=6 res=1 Jun 27 16:05:36 master.ipa.test systemd-coredump[27712]: Process 27700 (java) of user 17 dumped core. Stack trace of thread 27701: #0 0x00007f7c222adb05 raise (libc.so.6 + 0x3cb05) #1 0x00007f7c222968a4 abort (libc.so.6 + 0x258a4) #2 0x00007f7c22296789 __assert_fail_base.cold (libc.so.6 + 0x25789) #3 0x00007f7c222a5fa6 __assert_fail (libc.so.6 + 0x34fa6) #4 0x00007f7c222397f4 __pthread_mutex_lock (libpthread.so.0 + 0xb7f4) #5 0x00007f7bfefbd527 bt_destroy (libopencryptoki.so + 0x11527) #6 0x00007f7bfefbb0d6 C_Initialize (libopencryptoki.so + 0xf0d6) #7 0x00007f7bff423234 initialize_module_inlock_reentrant (p11-kit-proxy.so + 0x2d234) #8 0x00007f7bff423383 managed_C_Initialize (p11-kit-proxy.so + 0x2d383) #9 0x00007f7bff425be0 p11_kit_modules_initialize (p11-kit-proxy.so + 0x2fbe0) #10 0x00007f7bff429a97 proxy_C_Initialize (p11-kit-proxy.so + 0x33a97) #11 0x00007f7bff8056f2 secmod_ModuleInit (libnss3.so + 0x486f2) #12 0x00007f7bff805e4a secmod_LoadPKCS11Module (libnss3.so + 0x48e4a) #13 0x00007f7bff81300d SECMOD_LoadModule (libnss3.so + 0x5600d) #14 0x00007f7bff813148 SECMOD_LoadModule (libnss3.so + 0x56148) #15 0x00007f7bff7dbdc1 nss_Init (libnss3.so + 0x1edc1) #16 0x00007f7bff7dc24d NSS_InitReadWrite (libnss3.so + 0x1f24d) #17 0x00007f7bff9a2a29 Java_org_mozilla_jss_CryptoManager_initializeAllNative2 (libjss4.so + 0x15a29) #18 0x00007f7c0d0183c7 n/a (n/a + 0x0) #19 0x00007f7c0d007ffd n/a (n/a + 0x0) #20 0x00007f7c0d007ffd n/a (n/a + 0x0) #21 0x00007f7c0d007ffd n/a (n/a + 0x0) #22 0x00007f7c0d007ffd n/a (n/a + 0x0) #23 0x00007f7c0d007ffd n/a (n/a + 0x0) #24 0x00007f7c0d007ffd n/a (n/a + 0x0) #25 0x00007f7c0d007ffd n/a (n/a + 0x0) #26 0x00007f7c0d007ffd n/a (n/a + 0x0) #27 0x00007f7c0d007ffd n/a (n/a + 0x0) #28 0x00007f7c0d0004e7 n/a (n/a + 0x0) #29 0x00007f7c21abbe45 _ZN9JavaCalls11call_helperEP9JavaValueP12methodHandleP17JavaCallArgumentsP6Thread (libjvm.so + 0x694e45) #30 0x00007f7c21adf88d _ZL17jni_invoke_staticP7JNIEnv_P9JavaValueP8_jobject11JNICallTypeP10_jmethodIDP18JNI_ArgumentPusherP6Thread.constprop.1 (libjvm.so + 0x6b888d) #31 0x00007f7c21ae2996 jni_CallStaticVoidMethod (libjvm.so + 0x6bb996) #32 0x00007f7c22449877 JavaMain (libjli.so + 0x4877) #33 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #34 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27700: #0 0x00007f7c222389a7 __pthread_clockjoin_ex (libpthread.so.0 + 0xa9a7) #1 0x00007f7c2244ed2d ContinueInNewThread0 (libjli.so + 0x9d2d) #2 0x00007f7c2244b00e ContinueInNewThread (libjli.so + 0x600e) #3 0x00007f7c2244c412 JLI_Launch (libjli.so + 0x7412) #4 0x0000564a3c3320b5 main (java + 0x10b5) #5 0x00007f7c22298172 __libc_start_main (libc.so.6 + 0x27172) #6 0x0000564a3c3320ee _start (java + 0x10ee) Stack trace of thread 27702: #0 0x00007f7c2223d9b8 pthread_cond_timedwait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf9b8) #1 0x00007f7c21d3f734 _ZN2os13PlatformEvent4parkEl (libjvm.so + 0x918734) #2 0x00007f7c21cf6074 _ZN7Monitor5IWaitEP6Threadl (libjvm.so + 0x8cf074) #3 0x00007f7c21cf6b6a _ZN7Monitor4waitEblb (libjvm.so + 0x8cfb6a) #4 0x00007f7c21f572aa _ZN8VMThread4loopEv (libjvm.so + 0xb302aa) #5 0x00007f7c21f5797d _ZN8VMThread3runEv (libjvm.so + 0xb3097d) #6 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #7 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #8 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27703: #0 0x00007f7c2223d692 pthread_cond_wait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf692) #1 0x00007f7c21d3f55b _ZN2os13PlatformEvent4parkEv (libjvm.so + 0x91855b) #2 0x00007f7c21d26e95 _ZN13ObjectMonitor4waitElbP6Thread (libjvm.so + 0x8ffe95) #3 0x00007f7c21ebd5f3 _ZN18ObjectSynchronizer4waitE6HandlelP6Thread (libjvm.so + 0xa965f3) #4 0x00007f7c21b0f6af JVM_MonitorWait (libjvm.so + 0x6e86af) #5 0x00007f7c0d0183c7 n/a (n/a + 0x0) #6 0x00007f7c0d007ffd n/a (n/a + 0x0) #7 0x00007f7c0d007ffd n/a (n/a + 0x0) #8 0x00007f7c0d0077d0 n/a (n/a + 0x0) #9 0x00007f7c0d0004e7 n/a (n/a + 0x0) #10 0x00007f7c21abbe45 _ZN9JavaCalls11call_helperEP9JavaValueP12methodHandleP17JavaCallArgumentsP6Thread (libjvm.so + 0x694e45) #11 0x00007f7c21ab969f _ZN9JavaCalls12call_virtualEP9JavaValue11KlassHandleP6SymbolS4_P17JavaCallArgumentsP6Thread (libjvm.so + 0x69269f) #12 0x00007f7c21ab9c41 _ZN9JavaCalls12call_virtualEP9JavaValue6Handle11KlassHandleP6SymbolS5_P6Thread (libjvm.so + 0x692c41) #13 0x00007f7c21b0d7f0 _ZL12thread_entryP10JavaThreadP6Thread (libjvm.so + 0x6e67f0) #14 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #15 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #16 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #17 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27704: #0 0x00007f7c2223d692 pthread_cond_wait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf692) #1 0x00007f7c21d3f55b _ZN2os13PlatformEvent4parkEv (libjvm.so + 0x91855b) #2 0x00007f7c21d26e95 _ZN13ObjectMonitor4waitElbP6Thread (libjvm.so + 0x8ffe95) #3 0x00007f7c21ebd5f3 _ZN18ObjectSynchronizer4waitE6HandlelP6Thread (libjvm.so + 0xa965f3) #4 0x00007f7c21b0f6af JVM_MonitorWait (libjvm.so + 0x6e86af) #5 0x00007f7c0d0183c7 n/a (n/a + 0x0) #6 0x00007f7c0d007ffd n/a (n/a + 0x0) #7 0x00007f7c0d007d80 n/a (n/a + 0x0) #8 0x00007f7c0d007d80 n/a (n/a + 0x0) #9 0x00007f7c0d0004e7 n/a (n/a + 0x0) #10 0x00007f7c21abbe45 _ZN9JavaCalls11call_helperEP9JavaValueP12methodHandleP17JavaCallArgumentsP6Thread (libjvm.so + 0x694e45) #11 0x00007f7c21ab969f _ZN9JavaCalls12call_virtualEP9JavaValue11KlassHandleP6SymbolS4_P17JavaCallArgumentsP6Thread (libjvm.so + 0x69269f) #12 0x00007f7c21ab9c41 _ZN9JavaCalls12call_virtualEP9JavaValue6Handle11KlassHandleP6SymbolS5_P6Thread (libjvm.so + 0x692c41) #13 0x00007f7c21b0d7f0 _ZL12thread_entryP10JavaThreadP6Thread (libjvm.so + 0x6e67f0) #14 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #15 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #16 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #17 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27705: #0 0x00007f7c222400d4 do_futex_wait.constprop.0 (libpthread.so.0 + 0x120d4) #1 0x00007f7c222401d8 __new_sem_wait_slow.constprop.0 (libpthread.so.0 + 0x121d8) #2 0x00007f7c21d36236 _ZL21check_pending_signalsb (libjvm.so + 0x90f236) #3 0x00007f7c21d2df95 _ZL19signal_thread_entryP10JavaThreadP6Thread (libjvm.so + 0x906f95) #4 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #5 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #6 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #7 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27706: #0 0x00007f7c2223d9b8 pthread_cond_timedwait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf9b8) #1 0x00007f7c21d3f734 _ZN2os13PlatformEvent4parkEl (libjvm.so + 0x918734) #2 0x00007f7c21cf6074 _ZN7Monitor5IWaitEP6Threadl (libjvm.so + 0x8cf074) #3 0x00007f7c21cf6bde _ZN7Monitor4waitEblb (libjvm.so + 0x8cfbde) #4 0x00007f7c218c810e _ZN12CompileQueue3getEv (libjvm.so + 0x4a110e) #5 0x00007f7c218cc79f _ZN13CompileBroker20compiler_thread_loopEv (libjvm.so + 0x4a579f) #6 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #7 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #8 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #9 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27707: #0 0x00007f7c2223d9b8 pthread_cond_timedwait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf9b8) #1 0x00007f7c21d3f734 _ZN2os13PlatformEvent4parkEl (libjvm.so + 0x918734) #2 0x00007f7c21cf6074 _ZN7Monitor5IWaitEP6Threadl (libjvm.so + 0x8cf074) #3 0x00007f7c21cf6bde _ZN7Monitor4waitEblb (libjvm.so + 0x8cfbde) #4 0x00007f7c218c810e _ZN12CompileQueue3getEv (libjvm.so + 0x4a110e) #5 0x00007f7c218cc79f _ZN13CompileBroker20compiler_thread_loopEv (libjvm.so + 0x4a579f) #6 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #7 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #8 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #9 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27708: #0 0x00007f7c2223d692 pthread_cond_wait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf692) #1 0x00007f7c21d3f55b _ZN2os13PlatformEvent4parkEv (libjvm.so + 0x91855b) #2 0x00007f7c21cf5ec7 _ZN7Monitor5IWaitEP6Threadl (libjvm.so + 0x8ceec7) #3 0x00007f7c21cf6b6a _ZN7Monitor4waitEblb (libjvm.so + 0x8cfb6a) #4 0x00007f7c21dd9b22 _ZN13ServiceThread20service_thread_entryEP10JavaThreadP6Thread (libjvm.so + 0x9b2b22) #5 0x00007f7c21ef6f78 _ZN10JavaThread17thread_main_innerEv (libjvm.so + 0xacff78) #6 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #7 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #8 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Stack trace of thread 27709: #0 0x00007f7c2223d9b8 pthread_cond_timedwait@@GLIBC_2.3.2 (libpthread.so.0 + 0xf9b8) #1 0x00007f7c21d3f734 _ZN2os13PlatformEvent4parkEl (libjvm.so + 0x918734) #2 0x00007f7c21cf6074 _ZN7Monitor5IWaitEP6Threadl (libjvm.so + 0x8cf074) #3 0x00007f7c21cf6b6a _ZN7Monitor4waitEblb (libjvm.so + 0x8cfb6a) #4 0x00007f7c21eeda30 _ZNK13WatcherThread5sleepEv (libjvm.so + 0xac6a30) #5 0x00007f7c21eedc3f _ZN13WatcherThread3runEv (libjvm.so + 0xac6c3f) #6 0x00007f7c21d37930 _ZL10java_startP6Thread (libjvm.so + 0x910930) #7 0x00007f7c222373f9 start_thread (libpthread.so.0 + 0x93f9) #8 0x00007f7c223733b3 __clone (libc.so.6 + 0x1023b3) Jun 27 16:05:36 master.ipa.test systemd[1]: systemd-coredump@0-27711-0.service: Succeeded.
Per discussion with Daiki, I've filed https://github.com/opencryptoki/opencryptoki/issues/304.
Metadata Update from @cipherboy: - Custom field component adjusted to None - Custom field feature adjusted to None - Custom field origin adjusted to None - Custom field proposedmilestone adjusted to None - Custom field proposedpriority adjusted to None - Custom field reviewer adjusted to None - Custom field type adjusted to None - Custom field version adjusted to None
I'm closing this in favor of the uptstream issue and this bugzilla: https://bugzilla.redhat.com/show_bug.cgi?id=1844875
This isn't a Dogtag issue, so our issue tracker isn't the proper place for this.
Metadata Update from @cipherboy: - Issue close_status updated to: invalid - Issue status updated to: Closed (was: Open)
Dogtag PKI is moving from Pagure issues to GitHub issues. This means that existing or new issues will be reported and tracked through Dogtag PKI's GitHub Issue tracker.
This issue has been cloned to GitHub and is available here: https://github.com/dogtagpki/pki/issues/3298
If you want to receive further updates on the issue, please navigate to the GitHub issue and click on Subscribe button.
Subscribe
Thank you for understanding, and we apologize for any inconvenience.
Login to comment on this ticket.