report.html

Report generated on 31-Oct-2019 at 17:19:43 by pytest-html v1.22.0

Environment

Packages {'pytest': '3.9.3', 'py': '1.7.0', 'pluggy': '0.8.1'}
Platform Linux-5.2.8-200.fc30.x86_64-x86_64-with-fedora-30-Thirty
Plugins {'metadata': '1.8.0', 'html': '1.22.0', 'sourceorder': '0.5', 'multihost': '3.0'}
Python 3.7.4

Summary

7 tests ran in 1024.32 seconds.

7 passed, 0 skipped, 0 failed, 0 errors, 0 expected failures, 0 unexpected passes

Results

Result Test Duration Links
Passed test_integration/test_external_ca.py::TestSelfExternalSelf::()::test_install_master 321.91
---------------------------- Captured stdout setup -----------------------------
<ipatests.pytest_ipa.integration.config.Config object at 0x7f33f1cc9150>
------------------------------ Captured log setup ------------------------------
__init__.py 267 INFO Preparing host master.ipa.test transport.py 1760 INFO Connected (version 2.0, client OpenSSH_8.0) transport.py 247 DEBUG Authenticating with private RSA key using user root transport.py 1760 INFO Authentication (publickey) successful! transport.py 318 INFO RUN ['true'] transport.py 513 DEBUG RUN ['true'] transport.py 558 DEBUG -bash: line 1: cd: /ipatests: No such file or directory transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/ipatests/env.sh to list of logs to collect transport.py 301 DEBUG STAT /ipatests sftp.py 158 INFO [chan 1] Opened sftp connection (server version 3) transport.py 301 DEBUG STAT / transport.py 312 INFO MKDIR /ipatests transport.py 293 INFO WRITE /ipatests/env.sh
------------------------------ Captured log call -------------------------------
__init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/errors to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/access to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/audit to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-conncheck.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-ca-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-kra-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipa-custodia.audit.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/iparestore.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipabackup.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/kadmind.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/krb5kdc.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/httpd/error_log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/pki/ to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/audit/audit.log to list of logs to collect transport.py 318 INFO RUN ['true'] transport.py 513 DEBUG RUN ['true'] transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/ipatests/env.sh to list of logs to collect transport.py 301 DEBUG STAT /ipatests transport.py 293 INFO WRITE /ipatests/env.sh transport.py 301 DEBUG STAT /etc/hostname transport.py 301 DEBUG STAT /ipatests/file_backup/etc transport.py 301 DEBUG STAT /ipatests/file_backup transport.py 301 DEBUG STAT /ipatests transport.py 312 INFO MKDIR /ipatests/file_backup transport.py 312 INFO MKDIR /ipatests/file_backup/etc transport.py 318 INFO RUN ['cp', '-af', '/etc/hostname', '/ipatests/file_backup/etc/hostname'] transport.py 513 DEBUG RUN ['cp', '-af', '/etc/hostname', '/ipatests/file_backup/etc/hostname'] transport.py 217 DEBUG Exit code: 0 transport.py 293 INFO WRITE /etc/hostname transport.py 318 INFO RUN ['hostname', 'master.ipa.test'] transport.py 513 DEBUG RUN ['hostname', 'master.ipa.test'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN hostname > '/ipatests/backup_hostname' transport.py 513 DEBUG RUN hostname > '/ipatests/backup_hostname' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes'] transport.py 513 DEBUG RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes'] transport.py 558 DEBUG Netid State Recv-Q Send-Q Local Address:Port Peer Address:Port transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:68 0.0.0.0:* users:(("dhclient",pid=1624,fd=7)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:111 0.0.0.0:* users:(("rpcbind",pid=2037,fd=5),("systemd",pid=1,fd=52)) transport.py 558 DEBUG udp UNCONN 0 0 127.0.0.1:323 0.0.0.0:* users:(("chronyd",pid=519,fd=5)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:43731 0.0.0.0:* transport.py 558 DEBUG udp UNCONN 0 0 127.0.0.1:942 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=5)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:52468 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=9)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:111 [::]:* users:(("rpcbind",pid=2037,fd=7),("systemd",pid=1,fd=54)) transport.py 558 DEBUG udp UNCONN 0 0 [::1]:323 [::]:* users:(("chronyd",pid=519,fd=6)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:42125 [::]:* users:(("rpc.statd",pid=2038,fd=11)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:60992 [::]:* transport.py 558 DEBUG tcp LISTEN 0 64 0.0.0.0:45345 0.0.0.0:* transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:44329 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=10)) transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:111 0.0.0.0:* users:(("rpcbind",pid=2037,fd=4),("systemd",pid=1,fd=50)) transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:22 0.0.0.0:* users:(("sshd",pid=567,fd=3)) transport.py 558 DEBUG tcp ESTAB 0 0 192.168.121.120:22 192.168.121.1:55304 users:(("sshd",pid=15840,fd=5),("sshd",pid=15831,fd=5)) transport.py 558 DEBUG tcp ESTAB 0 0 192.168.121.120:671 192.168.121.1:2049 transport.py 558 DEBUG tcp ESTAB 0 0 192.168.121.120:22 192.168.121.79:45308 users:(("sshd",pid=16416,fd=5),("sshd",pid=16414,fd=5)) transport.py 558 DEBUG tcp LISTEN 0 128 [::]:111 [::]:* users:(("rpcbind",pid=2037,fd=6),("systemd",pid=1,fd=53)) transport.py 558 DEBUG tcp LISTEN 0 128 [::]:22 [::]:* users:(("sshd",pid=567,fd=4)) transport.py 558 DEBUG tcp LISTEN 0 64 [::]:36791 [::]:* transport.py 558 DEBUG tcp LISTEN 0 128 [::]:44603 [::]:* users:(("rpc.statd",pid=2038,fd=12)) transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes', '-o', 'state', 'all', '( sport = :749 or dport = :749 or sport = :464 or dport = :464 )'] transport.py 513 DEBUG RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes', '-o', 'state', 'all', '( sport = :749 or dport = :749 or sport = :464 or dport = :464 )'] transport.py 558 DEBUG Netid State Recv-Q Send-Q Local Address:Port Peer Address:Port transport.py 217 DEBUG Exit code: 0 transport.py 301 DEBUG STAT /bin/systemctl transport.py 318 INFO RUN ['systemctl', 'stop', 'httpd'] transport.py 513 DEBUG RUN ['systemctl', 'stop', 'httpd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN for line in `ipcs -s | grep apache | cut -d " " -f 2`; do ipcrm -s $line; done transport.py 513 DEBUG RUN for line in `ipcs -s | grep apache | cut -d " " -f 2`; do ipcrm -s $line; done transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'unmask', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'unmask', 'firewalld'] transport.py 558 DEBUG Removed /etc/systemd/system/firewalld.service. transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'enable', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'enable', 'firewalld'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'start', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'start', 'firewalld'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', 'Secret.123', '-a', 'Secret.123', '--domain-level=1', '-U', '--setup-dns', '--forwarder', '192.168.121.1', '--auto-reverse'] transport.py 513 DEBUG RUN ['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', 'Secret.123', '-a', 'Secret.123', '--domain-level=1', '-U', '--setup-dns', '--forwarder', '192.168.121.1', '--auto-reverse'] transport.py 558 DEBUG Checking DNS domain ipa.test, please wait ... transport.py 558 DEBUG Checking DNS domain ipa.test., please wait ... transport.py 558 DEBUG Checking DNS domain 121.168.192.in-addr.arpa., please wait ... transport.py 558 DEBUG Reverse zone 121.168.192.in-addr.arpa. will be created transport.py 558 DEBUG Synchronizing time transport.py 558 DEBUG No SRV records of NTP servers found and no NTP server or pool address was provided. transport.py 558 DEBUG Attempting to sync time with chronyc. transport.py 558 DEBUG Process chronyc waitsync failed to sync time! transport.py 558 DEBUG 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. transport.py 558 DEBUG Checking DNS domain ipa.test, please wait ... transport.py 558 DEBUG transport.py 558 DEBUG The log file for this installation can be found in /var/log/ipaserver-install.log transport.py 558 DEBUG ============================================================================== transport.py 558 DEBUG This program will set up the FreeIPA Server. transport.py 558 DEBUG Version 4.9.0.dev transport.py 558 DEBUG transport.py 558 DEBUG This includes: transport.py 558 DEBUG * Configure a stand-alone CA (dogtag) for certificate management transport.py 558 DEBUG * Configure the NTP client (chronyd) transport.py 558 DEBUG * Create and configure an instance of Directory Server transport.py 558 DEBUG * Create and configure a Kerberos Key Distribution Center (KDC) transport.py 558 DEBUG * Configure Apache (httpd) transport.py 558 DEBUG * Configure DNS (bind) transport.py 558 DEBUG * Configure the KDC to enable PKINIT transport.py 558 DEBUG transport.py 558 DEBUG Warning: skipping DNS resolution of host master.ipa.test transport.py 558 DEBUG Checking DNS forwarders, please wait ... transport.py 558 DEBUG Using reverse zone(s) 121.168.192.in-addr.arpa. transport.py 558 DEBUG transport.py 558 DEBUG The IPA Master Server will be configured with: transport.py 558 DEBUG Hostname: master.ipa.test transport.py 558 DEBUG IP address(es): 192.168.121.120 transport.py 558 DEBUG Domain name: ipa.test transport.py 558 DEBUG Realm name: IPA.TEST transport.py 558 DEBUG transport.py 558 DEBUG The CA will be configured with: transport.py 558 DEBUG Subject DN: CN=Certificate Authority,O=IPA.TEST transport.py 558 DEBUG Subject base: O=IPA.TEST transport.py 558 DEBUG Chaining: self-signed transport.py 558 DEBUG transport.py 558 DEBUG BIND DNS server will be configured to serve IPA domain with: transport.py 558 DEBUG Forwarders: 192.168.121.1 transport.py 558 DEBUG Forward policy: only transport.py 558 DEBUG Reverse zone(s): 121.168.192.in-addr.arpa. transport.py 558 DEBUG transport.py 558 DEBUG Disabled p11-kit-proxy transport.py 558 DEBUG Using default chrony configuration. transport.py 558 DEBUG Warning: IPA was unable to sync time with chrony! transport.py 558 DEBUG Time synchronization is required for IPA to work correctly transport.py 558 DEBUG Configuring directory server (dirsrv). Estimated time: 30 seconds transport.py 558 DEBUG transport.py 558 DEBUG Starting installation... transport.py 558 DEBUG [1/44]: creating directory server instance transport.py 558 DEBUG Created symlink /etc/systemd/system/multi-user.target.wants/dirsrv@IPA-TEST.service → /usr/lib/systemd/system/dirsrv@.service. transport.py 558 DEBUG Opening SELinux policy "//etc/selinux/targeted/policy/policy.31" transport.py 558 DEBUG Successfully opened SELinux policy "//etc/selinux/targeted/policy/policy.31" transport.py 558 DEBUG Allocate local instance <class 'lib389.DirSrv'> with ldapi://%2fvar%2frun%2fslapd-IPA-TEST.socket transport.py 558 DEBUG [2/44]: configure autobind for root transport.py 558 DEBUG [3/44]: stopping directory server transport.py 558 DEBUG [4/44]: updating configuration in dse.ldif transport.py 558 DEBUG [5/44]: starting directory server transport.py 558 DEBUG [6/44]: adding default schema transport.py 558 DEBUG [7/44]: enabling memberof plugin transport.py 558 DEBUG [8/44]: enabling winsync plugin transport.py 558 DEBUG [9/44]: configure password logging transport.py 558 DEBUG [10/44]: configuring replication version plugin transport.py 558 DEBUG [11/44]: enabling IPA enrollment plugin transport.py 558 DEBUG [12/44]: configuring uniqueness plugin transport.py 558 DEBUG [13/44]: configuring uuid plugin transport.py 558 DEBUG [14/44]: configuring modrdn plugin transport.py 558 DEBUG [15/44]: configuring DNS plugin transport.py 558 DEBUG [16/44]: enabling entryUSN plugin transport.py 558 DEBUG [17/44]: configuring lockout plugin transport.py 558 DEBUG [18/44]: configuring topology plugin transport.py 558 DEBUG [19/44]: creating indices transport.py 558 DEBUG [20/44]: enabling referential integrity plugin transport.py 558 DEBUG [21/44]: configuring certmap.conf transport.py 558 DEBUG [22/44]: configure new location for managed entries transport.py 558 DEBUG [23/44]: configure dirsrv ccache and keytab transport.py 558 DEBUG [24/44]: enabling SASL mapping fallback transport.py 558 DEBUG [25/44]: restarting directory server transport.py 558 DEBUG [26/44]: adding sasl mappings to the directory transport.py 558 DEBUG [27/44]: adding default layout transport.py 558 DEBUG [28/44]: adding delegation layout transport.py 558 DEBUG [29/44]: creating container for managed entries transport.py 558 DEBUG [30/44]: configuring user private groups transport.py 558 DEBUG [31/44]: configuring netgroups from hostgroups transport.py 558 DEBUG [32/44]: creating default Sudo bind user transport.py 558 DEBUG [33/44]: creating default Auto Member layout transport.py 558 DEBUG [34/44]: adding range check plugin transport.py 558 DEBUG [35/44]: creating default HBAC rule allow_all transport.py 558 DEBUG [36/44]: adding entries for topology management transport.py 558 DEBUG [37/44]: initializing group membership transport.py 558 DEBUG [38/44]: adding master entry transport.py 558 DEBUG [39/44]: initializing domain level transport.py 558 DEBUG [40/44]: configuring Posix uid/gid generation transport.py 558 DEBUG [41/44]: adding replication acis transport.py 558 DEBUG [42/44]: activating sidgen plugin transport.py 558 DEBUG [43/44]: activating extdom plugin transport.py 558 DEBUG [44/44]: configuring directory to start on boot transport.py 558 DEBUG Done configuring directory server (dirsrv). transport.py 558 DEBUG Configuring Kerberos KDC (krb5kdc) transport.py 558 DEBUG [1/10]: adding kerberos container to the directory transport.py 558 DEBUG [2/10]: configuring KDC transport.py 558 DEBUG [3/10]: initialize kerberos container transport.py 558 DEBUG [4/10]: adding default ACIs transport.py 558 DEBUG [5/10]: creating a keytab for the directory transport.py 558 DEBUG [6/10]: creating a keytab for the machine transport.py 558 DEBUG [7/10]: adding the password extension to the directory transport.py 558 DEBUG [8/10]: creating anonymous principal transport.py 558 DEBUG [9/10]: starting the KDC transport.py 558 DEBUG [10/10]: configuring KDC to start on boot transport.py 558 DEBUG Done configuring Kerberos KDC (krb5kdc). transport.py 558 DEBUG Configuring kadmin transport.py 558 DEBUG [1/2]: starting kadmin transport.py 558 DEBUG [2/2]: configuring kadmin to start on boot transport.py 558 DEBUG Done configuring kadmin. transport.py 558 DEBUG Configuring ipa-custodia transport.py 558 DEBUG [1/5]: Making sure custodia container exists transport.py 558 DEBUG [2/5]: Generating ipa-custodia config file transport.py 558 DEBUG [3/5]: Generating ipa-custodia keys transport.py 558 DEBUG [4/5]: starting ipa-custodia transport.py 558 DEBUG [5/5]: configuring ipa-custodia to start on boot transport.py 558 DEBUG Done configuring ipa-custodia. transport.py 558 DEBUG Configuring certificate server (pki-tomcatd). Estimated time: 3 minutes transport.py 558 DEBUG [1/29]: configuring certificate server instance transport.py 558 DEBUG [2/29]: Add ipa-pki-wait-running transport.py 558 DEBUG [3/29]: reindex attributes transport.py 558 DEBUG [4/29]: exporting Dogtag certificate store pin transport.py 558 DEBUG [5/29]: stopping certificate server instance to update CS.cfg transport.py 558 DEBUG [6/29]: backing up CS.cfg transport.py 558 DEBUG [7/29]: disabling nonces transport.py 558 DEBUG [8/29]: set up CRL publishing transport.py 558 DEBUG [9/29]: enable PKIX certificate path discovery and validation transport.py 558 DEBUG [10/29]: starting certificate server instance transport.py 558 DEBUG [11/29]: configure certmonger for renewals transport.py 558 DEBUG [12/29]: requesting RA certificate from CA transport.py 558 DEBUG [13/29]: setting audit signing renewal to 2 years transport.py 558 DEBUG [14/29]: restarting certificate server transport.py 558 DEBUG [15/29]: publishing the CA certificate transport.py 558 DEBUG [16/29]: adding RA agent as a trusted user transport.py 558 DEBUG [17/29]: authorizing RA to modify profiles transport.py 558 DEBUG [18/29]: authorizing RA to manage lightweight CAs transport.py 558 DEBUG [19/29]: Ensure lightweight CAs container exists transport.py 558 DEBUG [20/29]: configure certificate renewals transport.py 558 DEBUG [21/29]: Configure HTTP to proxy connections transport.py 558 DEBUG [22/29]: restarting certificate server transport.py 558 DEBUG [23/29]: updating IPA configuration transport.py 558 DEBUG [24/29]: enabling CA instance transport.py 558 DEBUG [25/29]: migrating certificate profiles to LDAP transport.py 558 DEBUG [26/29]: importing IPA certificate profiles transport.py 558 DEBUG [27/29]: adding default CA ACL transport.py 558 DEBUG [28/29]: adding 'ipa' CA entry transport.py 558 DEBUG [29/29]: configuring certmonger renewal for lightweight CAs transport.py 558 DEBUG Done configuring certificate server (pki-tomcatd). transport.py 558 DEBUG Configuring directory server (dirsrv) transport.py 558 DEBUG [1/3]: configuring TLS for DS instance transport.py 558 DEBUG [2/3]: adding CA certificate entry transport.py 558 DEBUG [3/3]: restarting directory server transport.py 558 DEBUG Done configuring directory server (dirsrv). transport.py 558 DEBUG Configuring ipa-otpd transport.py 558 DEBUG [1/2]: starting ipa-otpd transport.py 558 DEBUG [2/2]: configuring ipa-otpd to start on boot transport.py 558 DEBUG Done configuring ipa-otpd. transport.py 558 DEBUG Configuring the web interface (httpd) transport.py 558 DEBUG [1/21]: stopping httpd transport.py 558 DEBUG [2/21]: backing up ssl.conf transport.py 558 DEBUG [3/21]: disabling nss.conf transport.py 558 DEBUG [4/21]: configuring mod_ssl certificate paths transport.py 558 DEBUG [5/21]: setting mod_ssl protocol list transport.py 558 DEBUG [6/21]: configuring mod_ssl log directory transport.py 558 DEBUG [7/21]: disabling mod_ssl OCSP transport.py 558 DEBUG [8/21]: adding URL rewriting rules transport.py 558 DEBUG [9/21]: configuring httpd transport.py 558 DEBUG [10/21]: setting up httpd keytab transport.py 558 DEBUG [11/21]: configuring Gssproxy transport.py 558 DEBUG [12/21]: setting up ssl transport.py 558 DEBUG [13/21]: configure certmonger for renewals transport.py 558 DEBUG [14/21]: publish CA cert transport.py 558 DEBUG [15/21]: clean up any existing httpd ccaches transport.py 558 DEBUG [16/21]: configuring SELinux for httpd transport.py 558 DEBUG [17/21]: create KDC proxy config transport.py 558 DEBUG [18/21]: enable KDC proxy transport.py 558 DEBUG [19/21]: starting httpd transport.py 558 DEBUG [20/21]: configuring httpd to start on boot transport.py 558 DEBUG [21/21]: enabling oddjobd transport.py 558 DEBUG Done configuring the web interface (httpd). transport.py 558 DEBUG Configuring Kerberos KDC (krb5kdc) transport.py 558 DEBUG [1/1]: installing X509 Certificate for PKINIT transport.py 558 DEBUG Done configuring Kerberos KDC (krb5kdc). transport.py 558 DEBUG Applying LDAP updates transport.py 558 DEBUG Upgrading IPA:. Estimated time: 1 minute 30 seconds transport.py 558 DEBUG [1/11]: stopping directory server transport.py 558 DEBUG [2/11]: saving configuration transport.py 558 DEBUG [3/11]: disabling listeners transport.py 558 DEBUG [4/11]: enabling DS global lock transport.py 558 DEBUG [5/11]: disabling Schema Compat transport.py 558 DEBUG [6/11]: starting directory server transport.py 558 DEBUG [7/11]: updating schema transport.py 558 DEBUG [8/11]: upgrading server transport.py 558 DEBUG [9/11]: stopping directory server transport.py 558 DEBUG [10/11]: restoring configuration transport.py 558 DEBUG [11/11]: starting directory server transport.py 558 DEBUG Done. transport.py 558 DEBUG Restarting the KDC transport.py 558 DEBUG Configuring DNS (named) transport.py 558 DEBUG [1/12]: generating rndc key file transport.py 558 DEBUG [2/12]: adding DNS container transport.py 558 DEBUG [3/12]: setting up our zone transport.py 558 DEBUG [4/12]: setting up reverse zone transport.py 558 DEBUG [5/12]: setting up our own record transport.py 558 DEBUG [6/12]: setting up records for other masters transport.py 558 DEBUG [7/12]: adding NS record to the zones transport.py 558 DEBUG [8/12]: setting up kerberos principal transport.py 558 DEBUG [9/12]: setting up named.conf transport.py 558 DEBUG [10/12]: setting up server configuration transport.py 558 DEBUG [11/12]: configuring named to start on boot transport.py 558 DEBUG [12/12]: changing resolv.conf to point to ourselves transport.py 558 DEBUG Done configuring DNS (named). transport.py 558 DEBUG Restarting the web server to pick up resolv.conf changes transport.py 558 DEBUG Configuring DNS key synchronization service (ipa-dnskeysyncd) transport.py 558 DEBUG [1/7]: checking status transport.py 558 DEBUG [2/7]: setting up bind-dyndb-ldap working directory transport.py 558 DEBUG [3/7]: setting up kerberos principal transport.py 558 DEBUG [4/7]: setting up SoftHSM transport.py 558 DEBUG [5/7]: adding DNSSEC containers transport.py 558 DEBUG [6/7]: creating replica keys transport.py 558 DEBUG [7/7]: configuring ipa-dnskeysyncd to start on boot transport.py 558 DEBUG Done configuring DNS key synchronization service (ipa-dnskeysyncd). transport.py 558 DEBUG Restarting ipa-dnskeysyncd transport.py 558 DEBUG Restarting named transport.py 558 DEBUG Updating DNS system records transport.py 558 DEBUG Configuring client side components transport.py 558 DEBUG Using existing certificate '/etc/ipa/ca.crt'. transport.py 558 DEBUG Client hostname: master.ipa.test transport.py 558 DEBUG Realm: IPA.TEST transport.py 558 DEBUG DNS Domain: ipa.test transport.py 558 DEBUG IPA Server: master.ipa.test transport.py 558 DEBUG BaseDN: dc=ipa,dc=test transport.py 558 DEBUG Configured sudoers in /etc/authselect/user-nsswitch.conf transport.py 558 DEBUG Configured /etc/sssd/sssd.conf transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_rsa_key.pub transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_ecdsa_key.pub transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_ed25519_key.pub transport.py 558 DEBUG SSSD enabled transport.py 558 DEBUG Configured /etc/openldap/ldap.conf transport.py 558 DEBUG Configured /etc/ssh/ssh_config transport.py 558 DEBUG Configured /etc/ssh/sshd_config transport.py 558 DEBUG Configuring ipa.test as NIS domain. transport.py 558 DEBUG Client configuration complete. transport.py 558 DEBUG The ipa-client-install command was successful transport.py 558 DEBUG This program will set up FreeIPA client. transport.py 558 DEBUG Version 4.9.0.dev transport.py 558 DEBUG transport.py 558 DEBUG transport.py 558 DEBUG The ipa-server-install command was successful transport.py 558 DEBUG transport.py 558 DEBUG ============================================================================== transport.py 558 DEBUG Setup complete transport.py 558 DEBUG transport.py 558 DEBUG Next steps: transport.py 558 DEBUG 1. You must make sure these network ports are open: transport.py 558 DEBUG TCP Ports: transport.py 558 DEBUG * 80, 443: HTTP/HTTPS transport.py 558 DEBUG * 389, 636: LDAP/LDAPS transport.py 558 DEBUG * 88, 464: kerberos transport.py 558 DEBUG * 53: bind transport.py 558 DEBUG UDP Ports: transport.py 558 DEBUG * 88, 464: kerberos transport.py 558 DEBUG * 53: bind transport.py 558 DEBUG * 123: ntp transport.py 558 DEBUG transport.py 558 DEBUG 2. You can now obtain a kerberos ticket using the command: 'kinit admin' transport.py 558 DEBUG This ticket will allow you to use the IPA tools (e.g., ipa user-add) transport.py 558 DEBUG and the web user interface. transport.py 558 DEBUG transport.py 558 DEBUG Be sure to back up the CA certificates stored in /root/cacert.p12 transport.py 558 DEBUG These files are required to create replicas. The password for these transport.py 558 DEBUG files is the Directory Manager password transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns'] transport.py 513 DEBUG RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns'] transport.py 558 DEBUG success transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns', '--permanent'] transport.py 513 DEBUG RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns', '--permanent'] transport.py 558 DEBUG success transport.py 217 DEBUG Exit code: 0 tasks.py 304 INFO Set LDAP debug level transport.py 318 INFO RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 513 DEBUG RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 558 DEBUG modifying entry "cn=config" transport.py 558 DEBUG transport.py 217 DEBUG Exit code: 0 tasks.py 320 INFO Set LDAP audit log transport.py 318 INFO RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 513 DEBUG RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 558 DEBUG modifying entry "cn=config" transport.py 558 DEBUG transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['sed', '-i', '/debug_level = 7/d', '/etc/sssd/sssd.conf'] transport.py 513 DEBUG RUN ['sed', '-i', '/debug_level = 7/d', '/etc/sssd/sssd.conf'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['sed', '-i', '/\\[*\\]/ a\\debug_level = 7', '/etc/sssd/sssd.conf'] transport.py 513 DEBUG RUN ['sed', '-i', '/\\[*\\]/ a\\debug_level = 7', '/etc/sssd/sssd.conf'] transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/var/log/sssd to list of logs to collect transport.py 301 DEBUG STAT /bin/systemctl transport.py 318 INFO RUN ['systemctl', 'stop', 'sssd'] transport.py 513 DEBUG RUN ['systemctl', 'stop', 'sssd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN find /var/lib/sss/db -name '*.ldb' | xargs rm -fv transport.py 513 DEBUG RUN find /var/lib/sss/db -name '*.ldb' | xargs rm -fv transport.py 558 DEBUG removed '/var/lib/sss/db/config.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/timestamps_ipa.test.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/cache_implicit_files.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/timestamps_implicit_files.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/cache_ipa.test.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/sssd.ldb' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['rm', '-fv', '/var/lib/sss/mc/group'] transport.py 513 DEBUG RUN ['rm', '-fv', '/var/lib/sss/mc/group'] transport.py 558 DEBUG removed '/var/lib/sss/mc/group' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['rm', '-fv', '/var/lib/sss/mc/passwd'] transport.py 513 DEBUG RUN ['rm', '-fv', '/var/lib/sss/mc/passwd'] transport.py 558 DEBUG removed '/var/lib/sss/mc/passwd' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'start', 'sssd'] transport.py 513 DEBUG RUN ['systemctl', 'start', 'sssd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['kinit', 'admin'] transport.py 513 DEBUG RUN ['kinit', 'admin'] transport.py 558 DEBUG Password for admin@IPA.TEST: transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ipa', 'dnszone-mod', 'ipa.test', '--default-ttl', '1', '--ttl', '1'] transport.py 513 DEBUG RUN ['ipa', 'dnszone-mod', 'ipa.test', '--default-ttl', '1', '--ttl', '1'] transport.py 558 DEBUG ipa: WARNING: Service named-pkcs11.service requires restart on IPA server <all IPA DNS servers> to apply configuration changes. transport.py 558 DEBUG Zone name: ipa.test. transport.py 558 DEBUG Active zone: TRUE transport.py 558 DEBUG Authoritative nameserver: master.ipa.test. transport.py 558 DEBUG Administrator e-mail address: hostmaster.ipa.test. transport.py 558 DEBUG SOA serial: 1572541672 transport.py 558 DEBUG SOA refresh: 3600 transport.py 558 DEBUG SOA retry: 900 transport.py 558 DEBUG SOA expire: 1209600 transport.py 558 DEBUG SOA minimum: 3600 transport.py 558 DEBUG Time to live: 1 transport.py 558 DEBUG Default time to live: 1 transport.py 558 DEBUG Allow query: any; transport.py 558 DEBUG Allow transfer: none; transport.py 217 DEBUG Exit code: 0 transport.py 284 DEBUG READ /etc/ipa/ca.crt host.py 77 INFO Connecting to LDAP at master.ipa.test transport.py 284 DEBUG READ /etc/ipa/ca.crt host.py 90 INFO LDAP bind as cn=Directory Manager
Passed test_integration/test_external_ca.py::TestSelfExternalSelf::()::test_switch_to_external_ca 123.83
------------------------------ Captured log call -------------------------------
transport.py 318 INFO RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--external-ca'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--external-ca'] transport.py 558 DEBUG The ipa-cacert-manage command was successful transport.py 558 DEBUG Exporting CA certificate signing request, please wait transport.py 558 DEBUG The next step is to get /var/lib/ipa/ca.csr signed by your CA and re-run ipa-cacert-manage as: transport.py 558 DEBUG ipa-cacert-manage renew --external-cert-file=/path/to/signed_certificate --external-cert-file=/path/to/external_ca_certificate transport.py 217 DEBUG Exit code: 0 transport.py 284 DEBUG READ /var/lib/ipa/ca.csr transport.py 293 INFO WRITE /ipatests/root_ca.crt transport.py 293 INFO WRITE /ipatests/ipa_ca.crt transport.py 318 INFO RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--external-cert-file=/ipatests/ipa_ca.crt', '--external-cert-file=/ipatests/root_ca.crt'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--external-cert-file=/ipatests/ipa_ca.crt', '--external-cert-file=/ipatests/root_ca.crt'] transport.py 558 DEBUG Importing the renewed CA certificate, please wait transport.py 558 DEBUG CA certificate successfully renewed transport.py 558 DEBUG The ipa-cacert-manage command was successful transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['/usr/sbin/ipa-certupdate'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-certupdate'] transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG The ipa-certupdate command was successful transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['certutil', '-L', '-d', '/etc/pki/pki-tomcat/alias'] transport.py 513 DEBUG RUN ['certutil', '-L', '-d', '/etc/pki/pki-tomcat/alias'] transport.py 558 DEBUG transport.py 558 DEBUG Certificate Nickname Trust Attributes transport.py 558 DEBUG SSL,S/MIME,JAR/XPI transport.py 558 DEBUG transport.py 558 DEBUG ocspSigningCert cert-pki-ca u,u,u transport.py 558 DEBUG subsystemCert cert-pki-ca u,u,u transport.py 558 DEBUG auditSigningCert cert-pki-ca u,u,Pu transport.py 558 DEBUG Server-Cert cert-pki-ca u,u,u transport.py 558 DEBUG caSigningCert cert-pki-ca CTu,Cu,Cu transport.py 558 DEBUG IPA.TEST IPA CA CTu,Cu,Cu transport.py 558 DEBUG CN=example.test C,, transport.py 217 DEBUG Exit code: 0 transport.py 284 DEBUG READ /ipatests/ipa_ca.crt host.py 77 INFO Connecting to LDAP at master.ipa.test transport.py 284 DEBUG READ /etc/ipa/ca.crt host.py 90 INFO LDAP bind as cn=Directory Manager
Passed test_integration/test_external_ca.py::TestSelfExternalSelf::()::test_issuerDN_after_renew_to_external 2.82
------------------------------ Captured log call -------------------------------
transport.py 318 INFO RUN ['ipa', 'ca-show', 'ipa'] transport.py 513 DEBUG RUN ['ipa', 'ca-show', 'ipa'] transport.py 558 DEBUG Name: ipa transport.py 558 DEBUG Description: IPA CA transport.py 558 DEBUG Authority ID: e1097839-8702-4dac-8f1e-29b8f2f4e4e3 transport.py 558 DEBUG Subject DN: CN=Certificate Authority,O=IPA.TEST transport.py 558 DEBUG Issuer DN: CN=example.test transport.py 558 DEBUG Certificate: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQELBQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIwMTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1UdEwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7TmBw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjfDC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BNF3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHlsNWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EBD4w= transport.py 217 DEBUG Exit code: 0
Passed test_integration/test_external_ca.py::TestSelfExternalSelf::()::test_switch_back_to_self_signed 98.57
------------------------------ Captured log call -------------------------------
transport.py 318 INFO RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--self-signed'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-cacert-manage', 'renew', '--self-signed'] transport.py 558 DEBUG The ipa-cacert-manage command was successful transport.py 558 DEBUG Renewing CA certificate, please wait transport.py 558 DEBUG CA certificate successfully renewed transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['journalctl', '--since=17:10:15', '-u', 'certmonger'] transport.py 513 DEBUG RUN ['journalctl', '--since=17:10:15', '-u', 'certmonger'] transport.py 558 DEBUG -- Logs begin at Thu 2019-10-31 16:58:41 UTC, end at Thu 2019-10-31 17:10:48 UTC. -- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22824] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22826] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_OPERATION" to "SUBMIT" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22828]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22828]: dogtag-ipa-renew-agent returned 5 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Child status = 5. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: "0 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: {"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null} transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate not (yet?) issued. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Saved cookie "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}". transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_OPERATION" to "POLL" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CA_COOKIE" to "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:23 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22834]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22834]: dogtag-ipa-renew-agent returned 5 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Child status = 5. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: "0 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: {"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null} transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate not (yet?) issued. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Saved cookie "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}". transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_OPERATION" to "POLL" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CA_COOKIE" to "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22841]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22841]: dogtag-ipa-renew-agent returned 0 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child status = 0. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [22846] Postprocessing output "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission postprocessing complete. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child status = 0. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: "{"certificate":"-----BEGIN CERTIFICATE-----\nMIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu\nVEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3\nMTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV\nBAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP\nADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8\nZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq\niFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE\nl6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f\nHKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+\n6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ\nxrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2\nOX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc\nlatd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge\n/kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E\nBTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH\nMAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF\nAAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27\nNZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp\nUrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ\nhpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q\nVErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/\n2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI\n/gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY\nGsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb\nTjGb6sX2\n-----END CERTIFICATE-----\n","key_checked":true} transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Issued certificate is "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate issued (0 chain certificates, 0 roots). transport.py 558 DEBUG Oct 31 17:10:30 master.ipa.test /stop_pkicad[22847]: Stopping pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:30 master.ipa.test /stop_pkicad[22847]: Stopped pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Imported certificate with nickname "caSigningCert cert-pki-ca". transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Error shutting down NSS. transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22879] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Updating entry cn=e1097839-8702-4dac-8f1e-29b8f2f4e4e3,ou=authorities,ou=ca,o=ipaca transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Updating CS.cfg transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Starting pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:44 master.ipa.test /renew_ca_cert[22880]: Started pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:48 master.ipa.test certmonger[18272]: 2019-10-31 17:10:48 [23161] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['journalctl', '--since=17:10:15', '-u', 'certmonger'] transport.py 513 DEBUG RUN ['journalctl', '--since=17:10:15', '-u', 'certmonger'] transport.py 558 DEBUG -- Logs begin at Thu 2019-10-31 16:58:41 UTC, end at Thu 2019-10-31 17:10:48 UTC. -- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22824] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22826] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_OPERATION" to "SUBMIT" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:17 master.ipa.test certmonger[18272]: 2019-10-31 17:10:17 [22828] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22828]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22828]: dogtag-ipa-renew-agent returned 5 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Child status = 5. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: "0 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: {"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null} transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Certificate not (yet?) issued. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [18272] Saved cookie "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}". transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_OPERATION" to "POLL" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CA_COOKIE" to "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=approve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:20 master.ipa.test certmonger[18272]: 2019-10-31 17:10:20 [22834] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:23 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22834]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22834]: dogtag-ipa-renew-agent returned 5 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Child status = 5. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: "0 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: {"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null} transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Certificate not (yet?) issued. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [18272] Saved cookie "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}". transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_REQ_SUBJECT" to "CN=Certificate Authority,O=IPA.TEST" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_OPERATION" to "POLL" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CSR" to "-----BEGIN NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MIIENDCCApwCAQAwMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwIDAQABoIG7MEEGCSqGSIb3DQEJFDE0HjIAYwBhAFMAaQBnAG4AaQBuAGcAQwBl transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AHIAdAAgAGMAZQByAHQALQBwAGsAaQAtAGMAYTB2BgkqhkiG9w0BCQ4xaTBnMA4G transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: A1UdDwEBAAQEAwIBxjAPBgNVHRMBAf8EBTADAQH/MCIGA1UdIwEBAAQYMBaAFAwx transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Knve8mPjhVR6HHge/kUbUQU8MCAGA1UdDgEBAAQWBBQMMSp73vJj44VUehx4Hv5F transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: G1EFPDANBgkqhkiG9w0BAQsFAAOCAYEAWwfab/3L774OBNQvWQHeSlZhz5vQcmBl transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 80yHLL9Z82ljnZiEuIxSXMQbZ0U1kmF4SbNErdZx6vOBDlGd4o/WUR8Ct329KtpM transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwR3Ju+Gi3nxQ8e//4reMuw+kZ+BgIUqhSJJde9dzfIjEo0RW06IM3+NZ5Ny4hU4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: yuQv5m9HFWMAgHn9KEubhzyJXH8CjMcmFpaWqX7QyboeaS9ajx8Q4shI4x3EUYS9 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: G08nQMzfhY/kELUSZmMkzgxAfpDKZUdiNEfq5OvGZ3I8UM10n3vtynGAr8PJO7dj transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: N0he/NZwT9mP+tiw/XYUOBrI0WDaEzQpyRzGhf19PknYX7GKBwWxkyp4L+6ZyAXs transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 4a+VHtAOs9shD4vAbVUTHBky2+u/KJhMzDSXeQXpYKnGsFs0A8CjN4QgFWcSIXwM transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: RYgaHSufwEH2Pa8l07gMifZ9Ll4MyayV6SY0vwsU6ceMhQ18ohxY4A/MQFFMkmya transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: CTQ4twtgS7PfoPAHvOo3VmIVmF0RqSvS transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: -----END NEW CERTIFICATE REQUEST----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_SPKAC" to "MIIDQDCCAagwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCX3VNn7Yia/kXzACUKltFkTM++hc3zAaJBZosCwBWXQ8mLuuUafGcm6BItTk/+c0zKYXgtjZYrSHWMrIGF71lBRdozX89HrctfDIKcM38Ti0wG/IuJaohQMrXCB8Gq3dsCWVXitBA60S62GjSd96oNkXKb9vLUccHo3BaCprTRMCxCSy3pRJes/NkuEMbhqPmYB3J5PYPdMhdBpq+O1KA6fgGiGX4dpIZrnpLiLVThk/77sMAOHxymonbIstNPmNL6Mgf8z+4q7o5FBMLEgwXappepdLYZSaWvHIm3sA2AVMsOCdj9vuvhi7Za7TcUCw2MA9KDLE0DOD46pVtPP8coOUYVtigOlhzMNnGOlAhO/cF7ewb1mcawD00/QXnZeGNCzspoazBsyi1xbTXTjJMqLh/Tu3FG7rRiDOHJaE6qpYUN8cJTNjl+MS/z09Uuf5blrrxzBdb9YQNueiVtrLSgU0FpagPGRrKuzKOSwH8ESRKhHjJbHJWrXfxJ2uFffg8CAwEAARYAMA0GCSqGSIb3DQEBCwUAA4IBgQByUZpzmf+9/28BpsJxNhb4VrSull8nBSD5eRkQl6sD4i9zXcxNIx1HYIql/x1iY9xfIVBNXV8slN/8Os/EGiK7rglY7p4nvqB5rz8v4JyyAqQsRFmgu92GLCjC5Np2lawYnBdiUX/lGn3p8JYvZ/Uzfy4H+lru8ZzSOHlsigOQrhn2D1e7MEF8jW1ZAQAd2cGyv895bYCZPRsLlcogLxssSnHi/4Yh9z+ZMXmHfDbVWVP/js7Mvi2AhPOpFWp7bqkStjKM7bPgTn0cfPSbU/CsmZQtVHWXy9JxOECNktVk09owml6Ay6Pxudp3+inrWX3jg/q6TNjbhuplMTpPJJ11NgMZ5OnXq82RzN3c9pNjSdYyALJdlu7e4OnlOAi03JIgQIn4nqDQJNVVktxn4XP/3bZt6nXZepzPO2jZ012y78itIfw3wmcoms1apbeAXqo5Y84x0p2FxapbqvCFac8fI3Km+Gfkyp5fOyZi7rBmrUUwtBWvGcmbN91HUM/eybI=" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_SPKI" to "MIIBojANBgkqhkiG9w0BAQEFAAOCAY8AMIIBigKCAYEAl91TZ+2Imv5F8wAlCpbRZEzPvoXN8wGiQWaLAsAVl0PJi7rlGnxnJugSLU5P/nNMymF4LY2WK0h1jKyBhe9ZQUXaM1/PR63LXwyCnDN/E4tMBvyLiWqIUDK1wgfBqt3bAllV4rQQOtEutho0nfeqDZFym/by1HHB6NwWgqa00TAsQkst6USXrPzZLhDG4aj5mAdyeT2D3TIXQaavjtSgOn4Bohl+HaSGa56S4i1U4ZP++7DADh8cpqJ2yLLTT5jS+jIH/M/uKu6ORQTCxIMF2qaXqXS2GUmlrxyJt7ANgFTLDgnY/b7r4Yu2Wu03FAsNjAPSgyxNAzg+OqVbTz/HKDlGFbYoDpYczDZxjpQITv3Be3sG9ZnGsA9NP0F52XhjQs7KaGswbMotcW0104yTKi4f07txRu60YgzhyWhOqqWFDfHCUzY5fjEv89PVLn+W5a68cwXW/WEDbnolbay0oFNBaWoDxkayrsyjksB/BEkSoR4yWxyVq138SdrhX34PAgMBAAE=" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_LOCAL_CA_DIR" to "/var/lib/certmonger/local" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_KEY_TYPE" to "RSA" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CA_COOKIE" to "{"cookie": "request:{\"cookie\": \"request:{\\\"cookie\\\": \\\"state=retrieve&requestId=11\\\", \\\"profile\\\": \\\"caCACert\\\"}\", \"profile\": \"caCACert\"}", "profile": null}" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CA_NICKNAME" to "dogtag-ipa-ca-renew-agent" for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Setting "CERTMONGER_CERTIFICATE" to "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MIIDvjCCAqagAwIBAgIUbQUy8grg3aTtXIGrv6g6dzYXBEUwDQYJKoZIhvcNAQEL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: BQAwFzEVMBMGA1UEAwwMZXhhbXBsZS50ZXN0MB4XDTE5MTAzMTE3MDgzMVoXDTIw transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: MTAzMDE3MDgzMVowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRp transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: ZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: AJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5z transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: TMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: +ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQL transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+ transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DwIDAQABo2YwZDAOBgNVHQ8BAf8EBAMCAQYwHQYDVR0OBBYEFAwxKnve8mPjhVR6 transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: HHge/kUbUQU8MB8GA1UdIwQYMBaAFEVjENDc910W3/BMwumWqWb1KeW4MBIGA1Ud transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: EwEB/wQIMAYBAf8CAQEwDQYJKoZIhvcNAQELBQADggEBAMR1gqYwBzpfEM0cGB5P transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 7NtFKygO3PMt5IVxw/rS4nHmmPkwMvupY5QL3SFGyu7U179L0dpZpPMUH0zOX7Tm transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: Bw96SYZGD4hRThReTk0KR/1AuXHDkxMoijkC1Cn5mj/WBLK7ZtXJkvXOiUnnAgjf transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: DC6FgzXS4t83F+KsqKuPv4Z4/c5MSJIoP8IcQmmx0s/VLblDk2Qd2JvZJ+qkh5BN transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: F3tJb/KWQgrRebENpxkM+skubncyjnB6+unMj8XqyLg+AnbX+PJLMSo602d3ZHls transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: NWBsOuJHAY5G6hLhoykN9tX3MJHCFpuUIk6rBS4c2dWoFX+Ya5EKTugiz300X5EB transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: D4w= transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: " for child. transport.py 558 DEBUG Oct 31 17:10:24 master.ipa.test certmonger[18272]: 2019-10-31 17:10:24 [22841] Redirecting stdin and stderr to /dev/null, leaving stdout open for child "/usr/libexec/certmonger/dogtag-ipa-ca-renew-agent-submit". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22841]: Forwarding request to dogtag-ipa-renew-agent transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test /dogtag-ipa-ca-renew-agent-submit[22841]: dogtag-ipa-renew-agent returned 0 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission attempt complete. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child status = 0. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [22846] Postprocessing output "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission still ongoing. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate submission postprocessing complete. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child status = 0. transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Child output: transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: "{"certificate":"-----BEGIN CERTIFICATE-----\nMIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu\nVEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3\nMTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV\nBAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP\nADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8\nZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq\niFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE\nl6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f\nHKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+\n6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ\nxrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2\nOX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc\nlatd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge\n/kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E\nBTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH\nMAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF\nAAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27\nNZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp\nUrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ\nhpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q\nVErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/\n2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI\n/gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY\nGsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb\nTjGb6sX2\n-----END CERTIFICATE-----\n","key_checked":true} transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: " transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Issued certificate is "-----BEGIN CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEu transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNV transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGP transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lq transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: iFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelE transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: l6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4f transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: HKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: xrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsc transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: latd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8E transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: BTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUH transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: MAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsF transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: AAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeyp transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: UrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: hpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7Q transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: VErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/ transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: /gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUY transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: GsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKb transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: TjGb6sX2 transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: -----END CERTIFICATE----- transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: ". transport.py 558 DEBUG Oct 31 17:10:27 master.ipa.test certmonger[18272]: 2019-10-31 17:10:27 [18272] Certificate issued (0 chain certificates, 0 roots). transport.py 558 DEBUG Oct 31 17:10:30 master.ipa.test /stop_pkicad[22847]: Stopping pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:30 master.ipa.test /stop_pkicad[22847]: Stopped pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Imported certificate with nickname "caSigningCert cert-pki-ca". transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22877] Error shutting down NSS. transport.py 558 DEBUG Oct 31 17:10:31 master.ipa.test certmonger[18272]: 2019-10-31 17:10:31 [22879] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Updating entry cn=e1097839-8702-4dac-8f1e-29b8f2f4e4e3,ou=authorities,ou=ca,o=ipaca transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Updating CS.cfg transport.py 558 DEBUG Oct 31 17:10:34 master.ipa.test /renew_ca_cert[22880]: Starting pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:44 master.ipa.test /renew_ca_cert[22880]: Started pki_tomcatd transport.py 558 DEBUG Oct 31 17:10:48 master.ipa.test certmonger[18272]: 2019-10-31 17:10:48 [23161] Token is named "NSS Generic Crypto Services", not "NSS Certificate DB", skipping. transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['/usr/sbin/ipa-certupdate'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-certupdate'] transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG The ipa-certupdate command was successful transport.py 217 DEBUG Exit code: 0
Passed test_integration/test_external_ca.py::TestSelfExternalSelf::()::test_issuerDN_after_renew_to_self_signed 2.30
------------------------------ Captured log call -------------------------------
transport.py 318 INFO RUN ['ipa', 'ca-show', 'ipa'] transport.py 513 DEBUG RUN ['ipa', 'ca-show', 'ipa'] transport.py 558 DEBUG Name: ipa transport.py 558 DEBUG Description: IPA CA transport.py 558 DEBUG Authority ID: e1097839-8702-4dac-8f1e-29b8f2f4e4e3 transport.py 558 DEBUG Subject DN: CN=Certificate Authority,O=IPA.TEST transport.py 558 DEBUG Issuer DN: CN=Certificate Authority,O=IPA.TEST transport.py 558 DEBUG Certificate: MIIEgjCCAuqgAwIBAgIBCzANBgkqhkiG9w0BAQsFADAzMREwDwYDVQQKDAhJUEEuVEVTVDEeMBwGA1UEAwwVQ2VydGlmaWNhdGUgQXV0aG9yaXR5MB4XDTE5MTAzMTE3MTAyMFoXDTM5MTAzMTE3MTAyMFowMzERMA8GA1UECgwISVBBLlRFU1QxHjAcBgNVBAMMFUNlcnRpZmljYXRlIEF1dGhvcml0eTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAJfdU2ftiJr+RfMAJQqW0WRMz76FzfMBokFmiwLAFZdDyYu65Rp8ZyboEi1OT/5zTMpheC2NlitIdYysgYXvWUFF2jNfz0ety18MgpwzfxOLTAb8i4lqiFAytcIHward2wJZVeK0EDrRLrYaNJ33qg2Rcpv28tRxwejcFoKmtNEwLEJLLelEl6z82S4QxuGo+ZgHcnk9g90yF0Gmr47UoDp+AaIZfh2khmuekuItVOGT/vuwwA4fHKaidsiy00+Y0voyB/zP7irujkUEwsSDBdqml6l0thlJpa8cibewDYBUyw4J2P2+6+GLtlrtNxQLDYwD0oMsTQM4PjqlW08/xyg5RhW2KA6WHMw2cY6UCE79wXt7BvWZxrAPTT9Bedl4Y0LOymhrMGzKLXFtNdOMkyouH9O7cUbutGIM4cloTqqlhQ3xwlM2OX4xL/PT1S5/luWuvHMF1v1hA256JW2stKBTQWlqA8ZGsq7Mo5LAfwRJEqEeMlsclatd/Ena4V9+DwIDAQABo4GgMIGdMB8GA1UdIwQYMBaAFAwxKnve8mPjhVR6HHge/kUbUQU8MB0GA1UdDgQWBBQMMSp73vJj44VUehx4Hv5FG1EFPDAPBgNVHRMBAf8EBTADAQH/MA4GA1UdDwEB/wQEAwIBxjA6BggrBgEFBQcBAQQuMCwwKgYIKwYBBQUHMAGGHmh0dHA6Ly9pcGEtY2EuaXBhLnRlc3QvY2Evb2NzcDANBgkqhkiG9w0BAQsFAAOCAYEAQFrC19mmG2oC5GEEdzzHCl6VaRAGDMJkS3rX6kP9gG5uBY5AK8P3xn27NZJVMLBTPn3ZmR/P1wqHCvR1CWg8oQNG4a34bES5WNAUUM3+3NBGDmjWz7UoSeypUrEavv/oP+5/AlSGou9dKQ6vaFikF6XrwLpcjV2bCTemFqiHlp2iNr9AfE2D8BnQhpB9FywRec/ZFZRcmTniaFQMCasROK2pApvl6rFAVDUVRaJUDvGMkU6NXsB39s7QVErHqXtbFOVOh1gIRafsCoEMYLeJ/e47D8K9brJbWyjzilNGb+IK/RQYW6wHrYt/2qbUeM6ywy2CnlGW02k0KPTaKE+esQpadHag991++MmbpjsLtTOKnKpSd5hfgnoI/gU1oRS/dbx82tksa6scJZVvGyoXxOZKiYAY1F8b/RfyXsmRHyRhiycbOlBOIFUYGsHotIuITGNWk7DskKDwPbl7AkA5SvYMmRSg5AOnUslkFIRM8dSHYWquEiHArgKbTjGb6sX2 transport.py 217 DEBUG Exit code: 0
Passed test_integration/test_external_ca.py::TestExternalCAInstall::()::test_install_master 320.26
---------------------------- Captured stdout setup -----------------------------
<ipatests.pytest_ipa.integration.config.Config object at 0x7f33f0337410>
------------------------------ Captured log setup ------------------------------
__init__.py 267 INFO Preparing host master.ipa.test transport.py 1760 INFO Connected (version 2.0, client OpenSSH_8.0) transport.py 247 DEBUG Authenticating with private RSA key using user root transport.py 1760 INFO Authentication (publickey) successful! transport.py 318 INFO RUN ['true'] transport.py 513 DEBUG RUN ['true'] transport.py 558 DEBUG -bash: line 1: cd: /ipatests: No such file or directory transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/ipatests/env.sh to list of logs to collect transport.py 301 DEBUG STAT /ipatests sftp.py 158 INFO [chan 1] Opened sftp connection (server version 3) transport.py 301 DEBUG STAT / transport.py 312 INFO MKDIR /ipatests transport.py 293 INFO WRITE /ipatests/env.sh
------------------------------ Captured log call -------------------------------
__init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/errors to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/access to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/dirsrv/slapd-IPA-TEST/audit to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-conncheck.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipareplica-ca-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaserver-kra-install.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipa-custodia.audit.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipaclient-uninstall.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/iparestore.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/ipabackup.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/kadmind.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/krb5kdc.log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/httpd/error_log to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/pki/ to list of logs to collect __init__.py 261 INFO Adding master.ipa.test:/var/log/audit/audit.log to list of logs to collect transport.py 318 INFO RUN ['true'] transport.py 513 DEBUG RUN ['true'] transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/ipatests/env.sh to list of logs to collect transport.py 301 DEBUG STAT /ipatests transport.py 293 INFO WRITE /ipatests/env.sh transport.py 301 DEBUG STAT /etc/hostname transport.py 301 DEBUG STAT /ipatests/file_backup/etc transport.py 301 DEBUG STAT /ipatests/file_backup transport.py 301 DEBUG STAT /ipatests transport.py 312 INFO MKDIR /ipatests/file_backup transport.py 312 INFO MKDIR /ipatests/file_backup/etc transport.py 318 INFO RUN ['cp', '-af', '/etc/hostname', '/ipatests/file_backup/etc/hostname'] transport.py 513 DEBUG RUN ['cp', '-af', '/etc/hostname', '/ipatests/file_backup/etc/hostname'] transport.py 217 DEBUG Exit code: 0 transport.py 293 INFO WRITE /etc/hostname transport.py 318 INFO RUN ['hostname', 'master.ipa.test'] transport.py 513 DEBUG RUN ['hostname', 'master.ipa.test'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN hostname > '/ipatests/backup_hostname' transport.py 513 DEBUG RUN hostname > '/ipatests/backup_hostname' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes'] transport.py 513 DEBUG RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes'] transport.py 558 DEBUG Netid State Recv-Q Send-Q Local Address:Port Peer Address:Port transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:68 0.0.0.0:* users:(("dhclient",pid=1624,fd=7)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:111 0.0.0.0:* users:(("rpcbind",pid=2037,fd=5),("systemd",pid=1,fd=43)) transport.py 558 DEBUG udp UNCONN 0 0 127.0.0.1:323 0.0.0.0:* users:(("chronyd",pid=16811,fd=7)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:43731 0.0.0.0:* transport.py 558 DEBUG udp UNCONN 0 0 127.0.0.1:942 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=5)) transport.py 558 DEBUG udp UNCONN 0 0 0.0.0.0:52468 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=9)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:111 [::]:* users:(("rpcbind",pid=2037,fd=7),("systemd",pid=1,fd=45)) transport.py 558 DEBUG udp UNCONN 0 0 [::1]:323 [::]:* users:(("chronyd",pid=16811,fd=8)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:42125 [::]:* users:(("rpc.statd",pid=2038,fd=11)) transport.py 558 DEBUG udp UNCONN 0 0 [::]:60992 [::]:* transport.py 558 DEBUG tcp LISTEN 0 64 0.0.0.0:45345 0.0.0.0:* transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:44329 0.0.0.0:* users:(("rpc.statd",pid=2038,fd=10)) transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:111 0.0.0.0:* users:(("rpcbind",pid=2037,fd=4),("systemd",pid=1,fd=41)) transport.py 558 DEBUG tcp LISTEN 0 128 0.0.0.0:22 0.0.0.0:* users:(("sshd",pid=25043,fd=3)) transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:88 192.168.121.120:41878 transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:41882 192.168.121.120:88 transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:41886 192.168.121.120:88 transport.py 558 DEBUG tcp ESTAB 0 0 192.168.121.120:22 192.168.121.79:45326 users:(("sshd",pid=25376,fd=4),("sshd",pid=25374,fd=4)) transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:54978 192.168.121.120:389 transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:88 192.168.121.120:41880 transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:88 192.168.121.120:41882 transport.py 558 DEBUG tcp TIME-WAIT 0 0 127.0.0.1:60728 127.0.0.1:8009 transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:88 192.168.121.120:41874 transport.py 558 DEBUG tcp ESTAB 0 0 192.168.121.120:22 192.168.121.79:45308 users:(("sshd",pid=16416,fd=5),("sshd",pid=16414,fd=5)) transport.py 558 DEBUG tcp TIME-WAIT 0 0 192.168.121.120:88 192.168.121.120:41872 transport.py 558 DEBUG tcp TIME-WAIT 0 0 127.0.0.1:48399 127.0.0.1:953 transport.py 558 DEBUG tcp LISTEN 0 128 [::]:111 [::]:* users:(("rpcbind",pid=2037,fd=6),("systemd",pid=1,fd=44)) transport.py 558 DEBUG tcp LISTEN 0 128 [::]:22 [::]:* users:(("sshd",pid=25043,fd=4)) transport.py 558 DEBUG tcp LISTEN 0 64 [::]:36791 [::]:* transport.py 558 DEBUG tcp LISTEN 0 128 [::]:44603 [::]:* users:(("rpc.statd",pid=2038,fd=12)) transport.py 558 DEBUG tcp TIME-WAIT 0 0 [::ffff:192.168.121.120]:636 [::ffff:192.168.121.120]:37182 transport.py 558 DEBUG tcp TIME-WAIT 0 0 [::1]:8080 [::1]:52234 transport.py 558 DEBUG tcp TIME-WAIT 0 0 [::ffff:127.0.0.1]:60762 [::ffff:127.0.0.1]:8009 transport.py 558 DEBUG tcp TIME-WAIT 0 0 [::1]:8443 [::1]:51664 transport.py 558 DEBUG tcp TIME-WAIT 0 0 [::ffff:127.0.0.1]:53676 [::ffff:127.0.0.1]:8005 transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes', '-o', 'state', 'all', '( sport = :749 or dport = :749 or sport = :464 or dport = :464 )'] transport.py 513 DEBUG RUN ['ss', '--all', '--tcp', '--udp', '--numeric', '--processes', '-o', 'state', 'all', '( sport = :749 or dport = :749 or sport = :464 or dport = :464 )'] transport.py 558 DEBUG Netid State Recv-Q Send-Q Local Address:Port Peer Address:Port transport.py 217 DEBUG Exit code: 0 transport.py 301 DEBUG STAT /bin/systemctl transport.py 318 INFO RUN ['systemctl', 'stop', 'httpd'] transport.py 513 DEBUG RUN ['systemctl', 'stop', 'httpd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN for line in `ipcs -s | grep apache | cut -d " " -f 2`; do ipcrm -s $line; done transport.py 513 DEBUG RUN for line in `ipcs -s | grep apache | cut -d " " -f 2`; do ipcrm -s $line; done transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'unmask', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'unmask', 'firewalld'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'enable', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'enable', 'firewalld'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'start', 'firewalld'] transport.py 513 DEBUG RUN ['systemctl', 'start', 'firewalld'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', 'Secret.123', '-a', 'Secret.123', '--domain-level=1', '-U', '--setup-dns', '--forwarder', '192.168.121.1', '--auto-reverse'] transport.py 513 DEBUG RUN ['ipa-server-install', '-n', 'ipa.test', '-r', 'IPA.TEST', '-p', 'Secret.123', '-a', 'Secret.123', '--domain-level=1', '-U', '--setup-dns', '--forwarder', '192.168.121.1', '--auto-reverse'] transport.py 558 DEBUG Checking DNS domain ipa.test, please wait ... transport.py 558 DEBUG Checking DNS domain ipa.test., please wait ... transport.py 558 DEBUG Checking DNS domain 121.168.192.in-addr.arpa., please wait ... transport.py 558 DEBUG Reverse zone 121.168.192.in-addr.arpa. will be created transport.py 558 DEBUG Synchronizing time transport.py 558 DEBUG No SRV records of NTP servers found and no NTP server or pool address was provided. transport.py 558 DEBUG Attempting to sync time with chronyc. transport.py 558 DEBUG Process chronyc waitsync failed to sync time! transport.py 558 DEBUG 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. transport.py 558 DEBUG Checking DNS domain ipa.test, please wait ... transport.py 558 DEBUG transport.py 558 DEBUG The log file for this installation can be found in /var/log/ipaserver-install.log transport.py 558 DEBUG ============================================================================== transport.py 558 DEBUG This program will set up the FreeIPA Server. transport.py 558 DEBUG Version 4.9.0.dev transport.py 558 DEBUG transport.py 558 DEBUG This includes: transport.py 558 DEBUG * Configure a stand-alone CA (dogtag) for certificate management transport.py 558 DEBUG * Configure the NTP client (chronyd) transport.py 558 DEBUG * Create and configure an instance of Directory Server transport.py 558 DEBUG * Create and configure a Kerberos Key Distribution Center (KDC) transport.py 558 DEBUG * Configure Apache (httpd) transport.py 558 DEBUG * Configure DNS (bind) transport.py 558 DEBUG * Configure the KDC to enable PKINIT transport.py 558 DEBUG transport.py 558 DEBUG Warning: skipping DNS resolution of host master.ipa.test transport.py 558 DEBUG Checking DNS forwarders, please wait ... transport.py 558 DEBUG Using reverse zone(s) 121.168.192.in-addr.arpa. transport.py 558 DEBUG transport.py 558 DEBUG The IPA Master Server will be configured with: transport.py 558 DEBUG Hostname: master.ipa.test transport.py 558 DEBUG IP address(es): 192.168.121.120 transport.py 558 DEBUG Domain name: ipa.test transport.py 558 DEBUG Realm name: IPA.TEST transport.py 558 DEBUG transport.py 558 DEBUG The CA will be configured with: transport.py 558 DEBUG Subject DN: CN=Certificate Authority,O=IPA.TEST transport.py 558 DEBUG Subject base: O=IPA.TEST transport.py 558 DEBUG Chaining: self-signed transport.py 558 DEBUG transport.py 558 DEBUG BIND DNS server will be configured to serve IPA domain with: transport.py 558 DEBUG Forwarders: 192.168.121.1 transport.py 558 DEBUG Forward policy: only transport.py 558 DEBUG Reverse zone(s): 121.168.192.in-addr.arpa. transport.py 558 DEBUG transport.py 558 DEBUG Disabled p11-kit-proxy transport.py 558 DEBUG Using default chrony configuration. transport.py 558 DEBUG Warning: IPA was unable to sync time with chrony! transport.py 558 DEBUG Time synchronization is required for IPA to work correctly transport.py 558 DEBUG Configuring directory server (dirsrv). Estimated time: 30 seconds transport.py 558 DEBUG [1/44]: creating directory server instance transport.py 558 DEBUG transport.py 558 DEBUG Starting installation... transport.py 558 DEBUG Created symlink /etc/systemd/system/multi-user.target.wants/dirsrv@IPA-TEST.service → /usr/lib/systemd/system/dirsrv@.service. transport.py 558 DEBUG Opening SELinux policy "//etc/selinux/targeted/policy/policy.31" transport.py 558 DEBUG Successfully opened SELinux policy "//etc/selinux/targeted/policy/policy.31" transport.py 558 DEBUG Allocate local instance <class 'lib389.DirSrv'> with ldapi://%2fvar%2frun%2fslapd-IPA-TEST.socket transport.py 558 DEBUG [2/44]: configure autobind for root transport.py 558 DEBUG [3/44]: stopping directory server transport.py 558 DEBUG [4/44]: updating configuration in dse.ldif transport.py 558 DEBUG [5/44]: starting directory server transport.py 558 DEBUG [6/44]: adding default schema transport.py 558 DEBUG [7/44]: enabling memberof plugin transport.py 558 DEBUG [8/44]: enabling winsync plugin transport.py 558 DEBUG [9/44]: configure password logging transport.py 558 DEBUG [10/44]: configuring replication version plugin transport.py 558 DEBUG [11/44]: enabling IPA enrollment plugin transport.py 558 DEBUG [12/44]: configuring uniqueness plugin transport.py 558 DEBUG [13/44]: configuring uuid plugin transport.py 558 DEBUG [14/44]: configuring modrdn plugin transport.py 558 DEBUG [15/44]: configuring DNS plugin transport.py 558 DEBUG [16/44]: enabling entryUSN plugin transport.py 558 DEBUG [17/44]: configuring lockout plugin transport.py 558 DEBUG [18/44]: configuring topology plugin transport.py 558 DEBUG [19/44]: creating indices transport.py 558 DEBUG [20/44]: enabling referential integrity plugin transport.py 558 DEBUG [21/44]: configuring certmap.conf transport.py 558 DEBUG [22/44]: configure new location for managed entries transport.py 558 DEBUG [23/44]: configure dirsrv ccache and keytab transport.py 558 DEBUG [24/44]: enabling SASL mapping fallback transport.py 558 DEBUG [25/44]: restarting directory server transport.py 558 DEBUG [26/44]: adding sasl mappings to the directory transport.py 558 DEBUG [27/44]: adding default layout transport.py 558 DEBUG [28/44]: adding delegation layout transport.py 558 DEBUG [29/44]: creating container for managed entries transport.py 558 DEBUG [30/44]: configuring user private groups transport.py 558 DEBUG [31/44]: configuring netgroups from hostgroups transport.py 558 DEBUG [32/44]: creating default Sudo bind user transport.py 558 DEBUG [33/44]: creating default Auto Member layout transport.py 558 DEBUG [34/44]: adding range check plugin transport.py 558 DEBUG [35/44]: creating default HBAC rule allow_all transport.py 558 DEBUG [36/44]: adding entries for topology management transport.py 558 DEBUG [37/44]: initializing group membership transport.py 558 DEBUG [38/44]: adding master entry transport.py 558 DEBUG [39/44]: initializing domain level transport.py 558 DEBUG [40/44]: configuring Posix uid/gid generation transport.py 558 DEBUG [41/44]: adding replication acis transport.py 558 DEBUG [42/44]: activating sidgen plugin transport.py 558 DEBUG [43/44]: activating extdom plugin transport.py 558 DEBUG [44/44]: configuring directory to start on boot transport.py 558 DEBUG Done configuring directory server (dirsrv). transport.py 558 DEBUG Configuring Kerberos KDC (krb5kdc) transport.py 558 DEBUG [1/10]: adding kerberos container to the directory transport.py 558 DEBUG [2/10]: configuring KDC transport.py 558 DEBUG [3/10]: initialize kerberos container transport.py 558 DEBUG [4/10]: adding default ACIs transport.py 558 DEBUG [5/10]: creating a keytab for the directory transport.py 558 DEBUG [6/10]: creating a keytab for the machine transport.py 558 DEBUG [7/10]: adding the password extension to the directory transport.py 558 DEBUG [8/10]: creating anonymous principal transport.py 558 DEBUG [9/10]: starting the KDC transport.py 558 DEBUG [10/10]: configuring KDC to start on boot transport.py 558 DEBUG Done configuring Kerberos KDC (krb5kdc). transport.py 558 DEBUG Configuring kadmin transport.py 558 DEBUG [1/2]: starting kadmin transport.py 558 DEBUG [2/2]: configuring kadmin to start on boot transport.py 558 DEBUG Done configuring kadmin. transport.py 558 DEBUG Configuring ipa-custodia transport.py 558 DEBUG [1/5]: Making sure custodia container exists transport.py 558 DEBUG [2/5]: Generating ipa-custodia config file transport.py 558 DEBUG [3/5]: Generating ipa-custodia keys transport.py 558 DEBUG [4/5]: starting ipa-custodia transport.py 558 DEBUG [5/5]: configuring ipa-custodia to start on boot transport.py 558 DEBUG Done configuring ipa-custodia. transport.py 558 DEBUG Configuring certificate server (pki-tomcatd). Estimated time: 3 minutes transport.py 558 DEBUG [1/29]: configuring certificate server instance transport.py 558 DEBUG [2/29]: Add ipa-pki-wait-running transport.py 558 DEBUG [3/29]: reindex attributes transport.py 558 DEBUG [4/29]: exporting Dogtag certificate store pin transport.py 558 DEBUG [5/29]: stopping certificate server instance to update CS.cfg transport.py 558 DEBUG [6/29]: backing up CS.cfg transport.py 558 DEBUG [7/29]: disabling nonces transport.py 558 DEBUG [8/29]: set up CRL publishing transport.py 558 DEBUG [9/29]: enable PKIX certificate path discovery and validation transport.py 558 DEBUG [10/29]: starting certificate server instance transport.py 558 DEBUG [11/29]: configure certmonger for renewals transport.py 558 DEBUG [12/29]: requesting RA certificate from CA transport.py 558 DEBUG [13/29]: setting audit signing renewal to 2 years transport.py 558 DEBUG [14/29]: restarting certificate server transport.py 558 DEBUG [15/29]: publishing the CA certificate transport.py 558 DEBUG [16/29]: adding RA agent as a trusted user transport.py 558 DEBUG [17/29]: authorizing RA to modify profiles transport.py 558 DEBUG [18/29]: authorizing RA to manage lightweight CAs transport.py 558 DEBUG [19/29]: Ensure lightweight CAs container exists transport.py 558 DEBUG [20/29]: configure certificate renewals transport.py 558 DEBUG [21/29]: Configure HTTP to proxy connections transport.py 558 DEBUG [22/29]: restarting certificate server transport.py 558 DEBUG [23/29]: updating IPA configuration transport.py 558 DEBUG [24/29]: enabling CA instance transport.py 558 DEBUG [25/29]: migrating certificate profiles to LDAP transport.py 558 DEBUG [26/29]: importing IPA certificate profiles transport.py 558 DEBUG [27/29]: adding default CA ACL transport.py 558 DEBUG [28/29]: adding 'ipa' CA entry transport.py 558 DEBUG [29/29]: configuring certmonger renewal for lightweight CAs transport.py 558 DEBUG Done configuring certificate server (pki-tomcatd). transport.py 558 DEBUG Configuring directory server (dirsrv) transport.py 558 DEBUG [1/3]: configuring TLS for DS instance transport.py 558 DEBUG [2/3]: adding CA certificate entry transport.py 558 DEBUG [3/3]: restarting directory server transport.py 558 DEBUG Done configuring directory server (dirsrv). transport.py 558 DEBUG Configuring ipa-otpd transport.py 558 DEBUG [1/2]: starting ipa-otpd transport.py 558 DEBUG [2/2]: configuring ipa-otpd to start on boot transport.py 558 DEBUG Done configuring ipa-otpd. transport.py 558 DEBUG Configuring the web interface (httpd) transport.py 558 DEBUG [1/21]: stopping httpd transport.py 558 DEBUG [2/21]: backing up ssl.conf transport.py 558 DEBUG [3/21]: disabling nss.conf transport.py 558 DEBUG [4/21]: configuring mod_ssl certificate paths transport.py 558 DEBUG [5/21]: setting mod_ssl protocol list transport.py 558 DEBUG [6/21]: configuring mod_ssl log directory transport.py 558 DEBUG [7/21]: disabling mod_ssl OCSP transport.py 558 DEBUG [8/21]: adding URL rewriting rules transport.py 558 DEBUG [9/21]: configuring httpd transport.py 558 DEBUG [10/21]: setting up httpd keytab transport.py 558 DEBUG [11/21]: configuring Gssproxy transport.py 558 DEBUG [12/21]: setting up ssl transport.py 558 DEBUG [13/21]: configure certmonger for renewals transport.py 558 DEBUG [14/21]: publish CA cert transport.py 558 DEBUG [15/21]: clean up any existing httpd ccaches transport.py 558 DEBUG [16/21]: configuring SELinux for httpd transport.py 558 DEBUG [17/21]: create KDC proxy config transport.py 558 DEBUG [18/21]: enable KDC proxy transport.py 558 DEBUG [19/21]: starting httpd transport.py 558 DEBUG [20/21]: configuring httpd to start on boot transport.py 558 DEBUG [21/21]: enabling oddjobd transport.py 558 DEBUG Done configuring the web interface (httpd). transport.py 558 DEBUG Configuring Kerberos KDC (krb5kdc) transport.py 558 DEBUG [1/1]: installing X509 Certificate for PKINIT transport.py 558 DEBUG Done configuring Kerberos KDC (krb5kdc). transport.py 558 DEBUG Applying LDAP updates transport.py 558 DEBUG Upgrading IPA:. Estimated time: 1 minute 30 seconds transport.py 558 DEBUG [1/11]: stopping directory server transport.py 558 DEBUG [2/11]: saving configuration transport.py 558 DEBUG [3/11]: disabling listeners transport.py 558 DEBUG [4/11]: enabling DS global lock transport.py 558 DEBUG [5/11]: disabling Schema Compat transport.py 558 DEBUG [6/11]: starting directory server transport.py 558 DEBUG [7/11]: updating schema transport.py 558 DEBUG [8/11]: upgrading server transport.py 558 DEBUG [9/11]: stopping directory server transport.py 558 DEBUG [10/11]: restoring configuration transport.py 558 DEBUG [11/11]: starting directory server transport.py 558 DEBUG Done. transport.py 558 DEBUG Restarting the KDC transport.py 558 DEBUG Configuring DNS (named) transport.py 558 DEBUG [1/12]: generating rndc key file transport.py 558 DEBUG [2/12]: adding DNS container transport.py 558 DEBUG [3/12]: setting up our zone transport.py 558 DEBUG [4/12]: setting up reverse zone transport.py 558 DEBUG [5/12]: setting up our own record transport.py 558 DEBUG [6/12]: setting up records for other masters transport.py 558 DEBUG [7/12]: adding NS record to the zones transport.py 558 DEBUG [8/12]: setting up kerberos principal transport.py 558 DEBUG [9/12]: setting up named.conf transport.py 558 DEBUG [10/12]: setting up server configuration transport.py 558 DEBUG [11/12]: configuring named to start on boot transport.py 558 DEBUG [12/12]: changing resolv.conf to point to ourselves transport.py 558 DEBUG Done configuring DNS (named). transport.py 558 DEBUG Restarting the web server to pick up resolv.conf changes transport.py 558 DEBUG Configuring DNS key synchronization service (ipa-dnskeysyncd) transport.py 558 DEBUG [1/7]: checking status transport.py 558 DEBUG [2/7]: setting up bind-dyndb-ldap working directory transport.py 558 DEBUG [3/7]: setting up kerberos principal transport.py 558 DEBUG [4/7]: setting up SoftHSM transport.py 558 DEBUG [5/7]: adding DNSSEC containers transport.py 558 DEBUG [6/7]: creating replica keys transport.py 558 DEBUG [7/7]: configuring ipa-dnskeysyncd to start on boot transport.py 558 DEBUG Done configuring DNS key synchronization service (ipa-dnskeysyncd). transport.py 558 DEBUG Restarting ipa-dnskeysyncd transport.py 558 DEBUG Restarting named transport.py 558 DEBUG Updating DNS system records transport.py 558 DEBUG Configuring client side components transport.py 558 DEBUG Using existing certificate '/etc/ipa/ca.crt'. transport.py 558 DEBUG Client hostname: master.ipa.test transport.py 558 DEBUG Realm: IPA.TEST transport.py 558 DEBUG DNS Domain: ipa.test transport.py 558 DEBUG IPA Server: master.ipa.test transport.py 558 DEBUG BaseDN: dc=ipa,dc=test transport.py 558 DEBUG Configured sudoers in /etc/authselect/user-nsswitch.conf transport.py 558 DEBUG Configured /etc/sssd/sssd.conf transport.py 558 DEBUG Systemwide CA database updated. transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_rsa_key.pub transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_ecdsa_key.pub transport.py 558 DEBUG Adding SSH public key from /etc/ssh/ssh_host_ed25519_key.pub transport.py 558 DEBUG SSSD enabled transport.py 558 DEBUG Configured /etc/openldap/ldap.conf transport.py 558 DEBUG Configured /etc/ssh/ssh_config transport.py 558 DEBUG Configured /etc/ssh/sshd_config transport.py 558 DEBUG Configuring ipa.test as NIS domain. transport.py 558 DEBUG Client configuration complete. transport.py 558 DEBUG The ipa-client-install command was successful transport.py 558 DEBUG This program will set up FreeIPA client. transport.py 558 DEBUG Version 4.9.0.dev transport.py 558 DEBUG transport.py 558 DEBUG transport.py 558 DEBUG The ipa-server-install command was successful transport.py 558 DEBUG transport.py 558 DEBUG ============================================================================== transport.py 558 DEBUG Setup complete transport.py 558 DEBUG transport.py 558 DEBUG Next steps: transport.py 558 DEBUG 1. You must make sure these network ports are open: transport.py 558 DEBUG TCP Ports: transport.py 558 DEBUG * 80, 443: HTTP/HTTPS transport.py 558 DEBUG * 389, 636: LDAP/LDAPS transport.py 558 DEBUG * 88, 464: kerberos transport.py 558 DEBUG * 53: bind transport.py 558 DEBUG UDP Ports: transport.py 558 DEBUG * 88, 464: kerberos transport.py 558 DEBUG * 53: bind transport.py 558 DEBUG * 123: ntp transport.py 558 DEBUG transport.py 558 DEBUG 2. You can now obtain a kerberos ticket using the command: 'kinit admin' transport.py 558 DEBUG This ticket will allow you to use the IPA tools (e.g., ipa user-add) transport.py 558 DEBUG and the web user interface. transport.py 558 DEBUG transport.py 558 DEBUG Be sure to back up the CA certificates stored in /root/cacert.p12 transport.py 558 DEBUG These files are required to create replicas. The password for these transport.py 558 DEBUG files is the Directory Manager password transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns'] transport.py 513 DEBUG RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns'] transport.py 558 DEBUG success transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns', '--permanent'] transport.py 513 DEBUG RUN ['firewall-cmd', '--add-service', 'freeipa-ldap', '--add-service', 'freeipa-ldaps', '--add-service', 'dns', '--permanent'] transport.py 558 DEBUG success transport.py 217 DEBUG Exit code: 0 tasks.py 304 INFO Set LDAP debug level transport.py 318 INFO RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 513 DEBUG RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 558 DEBUG modifying entry "cn=config" transport.py 558 DEBUG transport.py 217 DEBUG Exit code: 0 tasks.py 320 INFO Set LDAP audit log transport.py 318 INFO RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 513 DEBUG RUN ['ldapmodify', '-x', '-D', 'cn=Directory Manager', '-w', 'Secret.123'] transport.py 558 DEBUG modifying entry "cn=config" transport.py 558 DEBUG transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['sed', '-i', '/debug_level = 7/d', '/etc/sssd/sssd.conf'] transport.py 513 DEBUG RUN ['sed', '-i', '/debug_level = 7/d', '/etc/sssd/sssd.conf'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['sed', '-i', '/\\[*\\]/ a\\debug_level = 7', '/etc/sssd/sssd.conf'] transport.py 513 DEBUG RUN ['sed', '-i', '/\\[*\\]/ a\\debug_level = 7', '/etc/sssd/sssd.conf'] transport.py 217 DEBUG Exit code: 0 __init__.py 261 INFO Adding master.ipa.test:/var/log/sssd to list of logs to collect transport.py 301 DEBUG STAT /bin/systemctl transport.py 318 INFO RUN ['systemctl', 'stop', 'sssd'] transport.py 513 DEBUG RUN ['systemctl', 'stop', 'sssd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN find /var/lib/sss/db -name '*.ldb' | xargs rm -fv transport.py 513 DEBUG RUN find /var/lib/sss/db -name '*.ldb' | xargs rm -fv transport.py 558 DEBUG removed '/var/lib/sss/db/config.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/timestamps_ipa.test.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/cache_implicit_files.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/timestamps_implicit_files.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/cache_ipa.test.ldb' transport.py 558 DEBUG removed '/var/lib/sss/db/sssd.ldb' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['rm', '-fv', '/var/lib/sss/mc/group'] transport.py 513 DEBUG RUN ['rm', '-fv', '/var/lib/sss/mc/group'] transport.py 558 DEBUG removed '/var/lib/sss/mc/group' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['rm', '-fv', '/var/lib/sss/mc/passwd'] transport.py 513 DEBUG RUN ['rm', '-fv', '/var/lib/sss/mc/passwd'] transport.py 558 DEBUG removed '/var/lib/sss/mc/passwd' transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['systemctl', 'start', 'sssd'] transport.py 513 DEBUG RUN ['systemctl', 'start', 'sssd'] transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['kinit', 'admin'] transport.py 513 DEBUG RUN ['kinit', 'admin'] transport.py 558 DEBUG Password for admin@IPA.TEST: transport.py 217 DEBUG Exit code: 0 transport.py 318 INFO RUN ['ipa', 'dnszone-mod', 'ipa.test', '--default-ttl', '1', '--ttl', '1'] transport.py 513 DEBUG RUN ['ipa', 'dnszone-mod', 'ipa.test', '--default-ttl', '1', '--ttl', '1'] transport.py 558 DEBUG ipa: WARNING: Service named-pkcs11.service requires restart on IPA server <all IPA DNS servers> to apply configuration changes. transport.py 558 DEBUG Zone name: ipa.test. transport.py 558 DEBUG Active zone: TRUE transport.py 558 DEBUG Authoritative nameserver: master.ipa.test. transport.py 558 DEBUG Administrator e-mail address: hostmaster.ipa.test. transport.py 558 DEBUG SOA serial: 1572542298 transport.py 558 DEBUG SOA refresh: 3600 transport.py 558 DEBUG SOA retry: 900 transport.py 558 DEBUG SOA expire: 1209600 transport.py 558 DEBUG SOA minimum: 3600 transport.py 558 DEBUG Time to live: 1 transport.py 558 DEBUG Default time to live: 1 transport.py 558 DEBUG Allow query: any; transport.py 558 DEBUG Allow transfer: none; transport.py 217 DEBUG Exit code: 0
Passed test_integration/test_external_ca.py::TestExternalCAInstall::()::test_install_external_ca 3.67
------------------------------ Captured log call -------------------------------
transport.py 293 INFO WRITE /ipatests/root_ca.crt transport.py 318 INFO RUN ['/usr/sbin/ipa-cacert-manage', 'install', '/ipatests/root_ca.crt'] transport.py 513 DEBUG RUN ['/usr/sbin/ipa-cacert-manage', 'install', '/ipatests/root_ca.crt'] transport.py 558 DEBUG The ipa-cacert-manage command was successful transport.py 558 DEBUG Installing CA certificate, please wait transport.py 558 DEBUG Verified CN=example.test transport.py 558 DEBUG CA certificate successfully installed transport.py 217 DEBUG Exit code: 0