[Master] tripleo-ci-centos-7-containers-multinode failed at undercloud deploy with timed out waiting for runtime to create pidfile for exec sessio

Bug #1803497 reported by chandan kumar
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
tripleo
Fix Released
Critical
Emilien Macchi

Bug Description

On master noop check job, tripleo-ci-centos-7-containers-multinode job got failed at undercloud deploy step http://logs.openstack.org/45/560445/193/check/tripleo-ci-centos-7-containers-multinode/1f1369f/logs/undercloud/home/zuul/undercloud_install.log.txt.gz#_2018-11-15_01_41_29

2018-11-15 01:41:29 | "Completed $ podman create --name ironic_inspector_dnsmasq --label config_id=tripleo_step4 --label container_name=ironic_inspector_dnsmasq --label managed_by=paunch --label config_data={\"start_order\": 93, \"healthcheck\": {\"test\": \"/openstack/healthcheck\"}, \"image\": \"192.168.24.1:8787/tripleomaster/centos-binary-ironic-inspector:current-tripleo-updated-20181115001011\", \"environment\": [\"KOLLA_CONFIG_STRATEGY=COPY_ALWAYS\", \"TRIPLEO_CONFIG_HASH=be9e84433a3f21e95685b27b0480716c\"], \"user\": \"root\", \"volumes\": [\"/etc/hosts:/etc/hosts:ro\", \"/etc/localtime:/etc/localtime:ro\", \"/etc/pki/ca-trust/extracted:/etc/pki/ca-trust/extracted:ro\", \"/etc/pki/ca-trust/source/anchors:/etc/pki/ca-trust/source/anchors:ro\", \"/etc/pki/tls/certs/ca-bundle.crt:/etc/pki/tls/certs/ca-bundle.crt:ro\", \"/etc/pki/tls/certs/ca-bundle.trust.crt:/etc/pki/tls/certs/ca-bundle.trust.crt:ro\", \"/etc/pki/tls/cert.pem:/etc/pki/tls/cert.pem:ro\", \"/dev/log:/dev/log\", \"/etc/ssh/ssh_known_hosts:/etc/ssh/ssh_known_hosts:ro\", \"/etc/puppet:/etc/puppet:ro\", \"/var/lib/kolla/config_files/ironic_inspector_dnsmasq.json:/var/lib/kolla/config_files/config.json:ro\", \"/var/lib/config-data/puppet-generated/ironic_inspector/:/var/lib/kolla/config_files/src:ro\", \"/var/log/containers/ironic-inspector:/var/log/ironic-inspector\", \"/var/lib/ironic-inspector/dhcp-hostsdir:/var/lib/ironic-inspector/dhcp-hostsdir:shared\"], \"net\": \"host\", \"privileged\": true, \"restart\": \"always\"} --detach=true --env=KOLLA_CONFIG_STRATEGY=COPY_ALWAYS --env=TRIPLEO_CONFIG_HASH=be9e84433a3f21e95685b27b0480716c --net=host --privileged=true --user=root --volume=/etc/hosts:/etc/hosts:ro --volume=/etc/localtime:/etc/localtime:ro --volume=/etc/pki/ca-trust/extracted:/etc/pki/ca-trust/extracted:ro --volume=/etc/pki/ca-trust/source/anchors:/etc/pki/ca-trust/source/anchors:ro --volume=/etc/pki/tls/certs/ca-bundle.crt:/etc/pki/tls/certs/ca-bundle.crt:ro --volume=/etc/pki/tls/certs/ca-bundle.trust.crt:/etc/pki/tls/certs/ca-bundle.trust.crt:ro --volume=/etc/pki/tls/cert.pem:/etc/pki/tls/cert.pem:ro --volume=/dev/log:/dev/log --volume=/etc/ssh/ssh_known_hosts:/etc/ssh/ssh_known_hosts:ro --volume=/etc/puppet:/etc/puppet:ro --volume=/var/lib/kolla/config_files/ironic_inspector_dnsmasq.json:/var/lib/kolla/config_files/config.json:ro --volume=/var/lib/config-data/puppet-generated/ironic_inspector/:/var/lib/kolla/config_files/src:ro --volume=/var/log/containers/ironic-inspector:/var/log/ironic-inspector --volume=/var/lib/ironic-inspector/dhcp-hostsdir:/var/lib/ironic-inspector/dhcp-hostsdir:shared 192.168.24.1:8787/tripleomaster/centos-binary-ironic-inspector:current-tripleo-updated-20181115001011",
2018-11-15 01:41:29 | "stdout: 21f6bf585613661b105572b54972e6dbb13ee4f539b0c7f130bedba1755f0fa3",
2018-11-15 01:41:29 | "Creating systemd unit file: /etc/systemd/system/ironic_inspector_dnsmasq.service",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_container_updater.service to /etc/systemd/system/swift_container_updater.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/mistral_executor.service to /etc/systemd/system/mistral_executor.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/nova_scheduler.service to /etc/systemd/system/nova_scheduler.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_object_server.service to /etc/systemd/system/swift_object_server.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/heat_api.service to /etc/systemd/system/heat_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/zaqar_websocket.service to /etc/systemd/system/zaqar_websocket.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/nova_api_cron.service to /etc/systemd/system/nova_api_cron.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/mistral_event_engine.service to /etc/systemd/system/mistral_event_engine.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_account_reaper.service to /etc/systemd/system/swift_account_reaper.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_object_expirer.service to /etc/systemd/system/swift_object_expirer.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_rsync.service to /etc/systemd/system/swift_rsync.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/heat_engine.service to /etc/systemd/system/heat_engine.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/heat_api_cron.service to /etc/systemd/system/heat_api_cron.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/nova_conductor.service to /etc/systemd/system/nova_conductor.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_account_server.service to /etc/systemd/system/swift_account_server.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/neutron_api.service to /etc/systemd/system/neutron_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_object_updater.service to /etc/systemd/system/swift_object_updater.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_container_server.service to /etc/systemd/system/swift_container_server.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/zaqar.service to /etc/systemd/system/zaqar.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/mistral_engine.service to /etc/systemd/system/mistral_engine.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/heat_api_cfn.service to /etc/systemd/system/heat_api_cfn.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/tripleo_ui.service to /etc/systemd/system/tripleo_ui.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/logrotate_crond.service to /etc/systemd/system/logrotate_crond.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/swift_proxy.service to /etc/systemd/system/swift_proxy.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/glance_api.service to /etc/systemd/system/glance_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/nova_api.service to /etc/systemd/system/nova_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/nova_metadata.service to /etc/systemd/system/nova_metadata.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_api.service to /etc/systemd/system/ironic_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/neutron_dhcp.service to /etc/systemd/system/neutron_dhcp.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/neutron_l3_agent.service to /etc/systemd/system/neutron_l3_agent.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/neutron_ovs_agent.service to /etc/systemd/system/neutron_ovs_agent.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/mistral_api.service to /etc/systemd/system/mistral_api.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_neutron_agent.service to /etc/systemd/system/ironic_neutron_agent.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_conductor.service to /etc/systemd/system/ironic_conductor.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_pxe_tftp.service to /etc/systemd/system/ironic_pxe_tftp.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_pxe_http.service to /etc/systemd/system/ironic_pxe_http.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_inspector.service to /etc/systemd/system/ironic_inspector.service.",
2018-11-15 01:41:29 | "Created symlink from /etc/systemd/system/multi-user.target.wants/ironic_inspector_dnsmasq.service to /etc/systemd/system/ironic_inspector_dnsmasq.service."
2018-11-15 01:41:29 | ]
2018-11-15 01:41:29 | }
2018-11-15 01:41:29 | ]
2018-11-15 01:41:29 | ]

From other logs: http://logs.openstack.org/45/560445/193/check/tripleo-ci-centos-7-containers-multinode/1f1369f/logs/undercloud/var/log/extra/errors.txt.gz#_2018-11-15_01_40_38_974

we found this 2018-11-15 01:40:38.973 ERROR /var/log/paunch.log: 38112 ERROR paunch [ ] Error running ['podman', 'exec', '--user=root', 'keystone', 'pkill', '--signal', 'USR1', 'httpd']. [125]
2018-11-15 01:40:38.973 ERROR /var/log/paunch.log: 38112 ERROR paunch [ ] stdout:
2018-11-15 01:40:38.974 ERROR /var/log/paunch.log: 38112 ERROR paunch [ ] stderr: timed out waiting for runtime to create pidfile for exec session in container 9d042e4b0fdd47efef90d902ae515c84a5377e82516416024338916b42379d4a: timed out waiting for file /var/run/containers/storage/overlay-containers/9d042e4b0fdd47efef90d902ae515c84a5377e82516416024338916b42379d4a/userdata/exec_pid_f7c0fa93a27fa552d4ab58929929fdef14c113796d6d488995f7baf59c9617b2: internal libpod error

The podman got timed out while executing keystone container.
For more info check these two issues:
https://github.com/containers/libpod/issues/1816
https://github.com/containers/libpod/issues/1495

It pops up randomly but good to investigated
Podman version used: http://logs.openstack.org/45/560445/193/check/tripleo-ci-centos-7-containers-multinode/1f1369f/logs/undercloud/var/log/extra/podman/podman_allinfo.log.txt.gz

Revision history for this message
Emilien Macchi (emilienm) wrote :

It sounds related to https://github.com/containers/libpod/issues/1495 which we fixed long time ago.
Maybe the code changed in the meantime and we hit it again.

Changed in tripleo:
milestone: none → stein-2
assignee: nobody → Emilien Macchi (emilienm)
Revision history for this message
Emilien Macchi (emilienm) wrote :
Changed in tripleo:
milestone: stein-2 → stein-3
wes hayutin (weshayutin)
tags: removed: promotion-blocker
Changed in tripleo:
status: Triaged → Incomplete
Changed in tripleo:
milestone: stein-3 → stein-rc1
Revision history for this message
wes hayutin (weshayutin) wrote :
Revision history for this message
wes hayutin (weshayutin) wrote :

no longer seeing this, fixed released

Changed in tripleo:
status: Incomplete → Fix Released
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.