Bug 1326809

Summary: undercloud fails to install on 1st try, re-running succeeds
Product: Red Hat OpenStack Reporter: Dan Yocum <dyocum>
Component: instack-undercloudAssignee: James Slagle <jslagle>
Status: CLOSED DUPLICATE QA Contact: Shai Revivo <srevivo>
Severity: medium Docs Contact:
Priority: unspecified    
Version: 8.0 (Liberty)CC: aschultz, astupnik, mburns, rhel-osp-director-maint
Target Milestone: ---Keywords: Triaged
Target Release: ---   
Hardware: x86_64   
OS: Linux   
Whiteboard:
Fixed In Version: instack-undercloud-2.2.7-4.el7ost.noarch Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2017-03-03 21:11:44 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:

Description Dan Yocum 2016-04-13 12:53:52 UTC
Description of problem:

Installing the undercloud fails

Version-Release number of selected component (if applicable):

[root@ops2 ~]# rpm -qa | grep 'instack\|tripleo' | sort 
instack-0.0.8-2.el7ost.noarch
instack-undercloud-2.2.7-2.el7ost.noarch
openstack-tripleo-0.0.7-1.el7ost.noarch
openstack-tripleo-common-0.3.1-1.el7ost.noarch
openstack-tripleo-heat-templates-0.8.14-5.el7ost.noarch
openstack-tripleo-heat-templates-kilo-0.8.14-5.el7ost.noarch
openstack-tripleo-image-elements-0.9.9-1.el7ost.noarch
openstack-tripleo-puppet-elements-0.0.5-1.el7ost.noarch
python-tripleoclient-0.3.4-2.el7ost.noarch

How reproducible:

I tried it once, it failed.  I ran it again, it succeeded.


Steps to Reproduce:
1.openstack undercloud install
2.
3.

Actual results:

+ echo dib-run-parts Tue Apr 12 13:01:56 EDT 2016 Running /tmp/tmp6nGKPG/pre-install.d/01-persistent-journal
dib-run-parts Tue Apr 12 13:01:56 EDT 2016 Running /tmp/tmp6nGKPG/pre-install.d/01-persistent-journal
+ target_tag=01-persistent-journal
+ date +%s.%N
+ /tmp/tmp6nGKPG/pre-install.d/01-persistent-journal
Job for systemd-journald.service failed because a fatal signal was delivered to the control process. See "systemctl status systemd-journald.service" and "journalctl -xe" for details.
INFO: 2016-04-12 13:02:29,914 -- ############### End stdout/stderr logging ###############
ERROR: 2016-04-12 13:02:29,914 -- Hook FAILED.
ERROR: 2016-04-12 13:02:29,915 -- Failed running command ['dib-run-parts', u'/tmp/tmp6nGKPG/pre-install.d']
File "/usr/lib/python2.7/site-packages/instack/main.py", line 163, in main
em.run()
File "/usr/lib/python2.7/site-packages/instack/runner.py", line 79, in run
self.run_hook(hook)
File "/usr/lib/python2.7/site-packages/instack/runner.py", line 172, in run_hook
raise Exception("Failed running command %s" % command)
ERROR: 2016-04-12 13:02:29,915 -- None
Traceback (most recent call last):
File "<string>", line 1, in <module>
File "/usr/lib/python2.7/site-packages/instack_undercloud/undercloud.py", line 808, in install
_run_instack(instack_env)
File "/usr/lib/python2.7/site-packages/instack_undercloud/undercloud.py", line 692, in _run_instack
_run_live_command(args, instack_env, 'instack')
File "/usr/lib/python2.7/site-packages/instack_undercloud/undercloud.py", line 370, in _run_live_command
raise RuntimeError('%s failed. See log for details.' % name)
RuntimeError: instack failed. See log for details.
Command 'instack-install-undercloud' returned non-zero exit status 1


Expected results:

success!

Additional info:

journalctl -xe output:

[stack@ops2 ~]$ sudo journalctl -xe
-- 
-- The start-up result is done.
Apr 12 13:01:56 ops2.os1.phx2.redhat.com polkitd[916]: Unregistered Authentication Agent for unix-process:9113:9601676 (system bus name :1.132, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale
Apr 12 13:01:57 ops2.os1.phx2.redhat.com polkitd[916]: Registered Authentication Agent for unix-process:9137:9601680 (system bus name :1.133 [/usr/bin/pkttyagent --notify-fd 7 --fallback], object path /org/freed
Apr 12 13:01:57 ops2.os1.phx2.redhat.com systemd[1]: Stopping Flush Journal to Persistent Storage...
-- Subject: Unit systemd-journal-flush.service has begun shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-journal-flush.service has begun shutting down.
Apr 12 13:01:57 ops2.os1.phx2.redhat.com systemd-journal[528]: Journal stopped
-- Subject: The journal has been stopped
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- The system journal process has shut down and closed all currently
-- active journal files.
Apr 12 13:01:57 ops2.os1.phx2.redhat.com systemd-journal[9143]: Permanent journal is using 8.0M (max allowed 4.0G, trying to leave 4.0G free of 338.3G available → current limit 4.0G).
Apr 12 13:01:57 ops2.os1.phx2.redhat.com systemd-journal[9143]: Permanent journal is using 8.0M (max allowed 4.0G, trying to leave 4.0G free of 338.3G available → current limit 4.0G).
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journal[9285]: Permanent journal is using 640.0M (max allowed 4.0G, trying to leave 4.0G free of 337.7G available → current limit 4.0G).
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[528]: Received SIGTERM from PID 1 (systemd).
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to create new runtime journal: No such file or directory
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Assertion 'f' failed at src/journal/journal-file.c:132, function journal_file_close(). Aborting.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journal[9285]: Journal started
-- Subject: The journal has been started
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- The system journal process has started up, opened the journal
-- files for writing and is now ready to process requests.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com polkitd[916]: Unregistered Authentication Agent for unix-process:9137:9601680 (system bus name :1.133, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd[1]: Starting Flush Journal to Persistent Storage...
-- Subject: Unit systemd-journal-flush.service has begun start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-journal-flush.service has begun starting up.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd[1]: Started Flush Journal to Persistent Storage.
-- Subject: Unit systemd-journal-flush.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-journal-flush.service has finished starting up.
-- 
-- The start-up result is done.
Apr 12 13:05:28 ops2.os1.phx2.redhat.com sudo[10020]: stack : TTY=pts/0 ; PWD=/var/lib/stack ; USER=root ; COMMAND=/bin/bash
Apr 12 13:06:29 ops2.os1.phx2.redhat.com sudo[10302]: stack : TTY=pts/0 ; PWD=/var/lib/stack ; USER=root ; COMMAND=/bin/journalctl -xe
...skipping...
-- 
-- The start-up result is done.
-- Unit iptables.service has finished starting up.
-- Unit iptables.service has finished starting up.
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit iptables.service has finished starting up.
Apr 12 13:01:56 ops2.os1.phx2.redhat.com polkitd[916]: Unregistered Authentication Agent for unix-process:9113:9601676 (system bus name :1.132, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale
Apr 12 13:01:57 ops2.os1.phx2.redhat.com polkitd[916]: Registered Authentication Agent for unix-process:9137:9601680 (system bus name :1.133 [/usr/bin/pkttyagent --notify-fd 7 --fallback], object path /org/freed
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to create new runtime journal: No such file or directory
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Failed to set file attributes: Operation not supported
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journald[9143]: Assertion 'f' failed at src/journal/journal-file.c:132, function journal_file_close(). Aborting.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd-journal[9285]: Journal started
-- Subject: The journal has been started
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- The system journal process has started up, opened the journal
-- files for writing and is now ready to process requests.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com polkitd[916]: Unregistered Authentication Agent for unix-process:9137:9601680 (system bus name :1.133, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd[1]: Starting Flush Journal to Persistent Storage...
-- Subject: Unit systemd-journal-flush.service has begun start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-journal-flush.service has begun starting up.
Apr 12 13:02:29 ops2.os1.phx2.redhat.com systemd[1]: Started Flush Journal to Persistent Storage.
-- Subject: Unit systemd-journal-flush.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-journal-flush.service has finished starting up.
-- 
-- The start-up result is done.
Apr 12 13:05:28 ops2.os1.phx2.redhat.com sudo[10020]: stack : TTY=pts/0 ; PWD=/var/lib/stack ; USER=root ; COMMAND=/bin/bash
Apr 12 13:06:29 ops2.os1.phx2.redhat.com sudo[10302]: stack : TTY=pts/0 ; PWD=/var/lib/stack ; USER=root ; COMMAND=/bin/journalctl -xe

Comment 3 Alex Schultz 2017-03-03 21:11:44 UTC

*** This bug has been marked as a duplicate of bug 1315442 ***