Attachment 668905 Details for Bug 890168 – cinder logs

cinder logs

cinder_logs.log (text/x-log), 20.50 KB, created by Nir Magnezi on 2012-12-25 12:57:50 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nir Magnezi

Created: 2012-12-25 12:57:50 UTC

Size: 20.50 KB

patch

obsolete

>==> /var/log/cinder/api.log <==
>2012-12-25 14:42:21 INFO cinder.api.openstack.wsgi [req-966f40ca-09ab-49a2-9c90-d0cab130b9ad 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail
>2012-12-25 14:42:21 AUDIT cinder.api.openstack.volume.volumes [req-966f40ca-09ab-49a2-9c90-d0cab130b9ad 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol=<cinder.db.sqlalchemy.models.Volume object at 0x4873f90>
>2012-12-25 14:42:21 INFO cinder.api.openstack.wsgi [req-966f40ca-09ab-49a2-9c90-d0cab130b9ad 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail returned with HTTP 200
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-d50a953d-f6f2-4173-bbb2-b6ae87eb7285 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail
>2012-12-25 14:42:26 AUDIT cinder.api.openstack.volume.volumes [req-d50a953d-f6f2-4173-bbb2-b6ae87eb7285 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol=<cinder.db.sqlalchemy.models.Volume object at 0x42c47d0>
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-d50a953d-f6f2-4173-bbb2-b6ae87eb7285 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail returned with HTTP 200
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] DELETE http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:26 AUDIT cinder.api.openstack.volume.volumes [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Delete volume with id: 26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648 returned with HTTP 202
>
>==> /var/log/cinder/volume.log <==
>2012-12-25 14:42:26 INFO cinder.volume.manager [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Clear capabilities
>2012-12-25 14:42:26 INFO cinder.volume.driver [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Skipping remove_export. No iscsi_target is presently exported for volume: 26ba112d-7424-4bc1-b4cd-ff97a09cf648
>
>==> /var/log/cinder/api.log <==
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-cb70ccf0-e125-4ee7-8f91-3e08c414e6fd 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail
>2012-12-25 14:42:26 AUDIT cinder.api.openstack.volume.volumes [req-cb70ccf0-e125-4ee7-8f91-3e08c414e6fd 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol=<cinder.db.sqlalchemy.models.Volume object at 0x41b2390>
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-cb70ccf0-e125-4ee7-8f91-3e08c414e6fd 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail returned with HTTP 200
>
>==> /var/log/cinder/volume.log <==
>2012-12-25 14:42:26 ERROR cinder.volume.driver [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Recovering from a failed execute.  Try number 1
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver Traceback (most recent call last):
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 98, in _try_execute
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver     self._execute(*command, **kwargs)
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/utils.py", line 187, in execute
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver     cmd=' '.join(cmd))
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver ProcessExecutionError: Unexpected error while running command.
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvdisplay cinder-volumes/volume-26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver Exit code: 5
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver Stdout: ''
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver Stderr: '  One or more specified logical volume(s) not found.\n'
>2012-12-25 14:42:26 26008 TRACE cinder.volume.driver 
>
>==> /var/log/cinder/api.log <==
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-324119ae-7eb5-4677-980c-e339ccd2d78e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:26 AUDIT cinder.api.openstack.volume.volumes [req-324119ae-7eb5-4677-980c-e339ccd2d78e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol={'volume_metadata': [], 'availability_zone': u'nova', 'terminated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'updated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'snapshot_id': None, 'ec2_id': None, 'mountpoint': None, 'deleted_at': None, 'id': u'26ba112d-7424-4bc1-b4cd-ff97a09cf648', 'size': 11L, 'user_id': u'46a7654d575440b98fb1c990ccdd34e1', 'attach_time': None, 'display_description': None, 'project_id': u'7d534bff2f4a40c39e6dd7dd404c0a62', 'launched_at': None, 'scheduled_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'status': u'deleting', 'volume_type_id': None, 'deleted': False, 'provider_location': None, 'host': u'nmagnezi_cinder', 'provider_auth': None, 'display_name': None, 'instance_uuid': None, 'created_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'attach_status': u'detached', 'volume_type': None}
>2012-12-25 14:42:26 INFO cinder.api.openstack.wsgi [req-324119ae-7eb5-4677-980c-e339ccd2d78e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648 returned with HTTP 200
>
>==> /var/log/cinder/volume.log <==
>2012-12-25 14:42:27 ERROR cinder.volume.driver [req-2e2bce2e-e3ff-4316-9151-9aeeae847eff 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Recovering from a failed execute.  Try number 2
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver Traceback (most recent call last):
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 98, in _try_execute
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver     self._execute(*command, **kwargs)
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/utils.py", line 187, in execute
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver     cmd=' '.join(cmd))
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver ProcessExecutionError: Unexpected error while running command.
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvdisplay cinder-volumes/volume-26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver Exit code: 5
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver Stdout: ''
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver Stderr: '  One or more specified logical volume(s) not found.\n'
>2012-12-25 14:42:27 26008 TRACE cinder.volume.driver 
>
>==> /var/log/cinder/api.log <==
>2012-12-25 14:42:29 INFO cinder.api.openstack.wsgi [req-0de6110c-5ec4-4866-9308-05bb08641364 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:29 AUDIT cinder.api.openstack.volume.volumes [req-0de6110c-5ec4-4866-9308-05bb08641364 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol={'volume_metadata': [], 'availability_zone': u'nova', 'terminated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'updated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'snapshot_id': None, 'ec2_id': None, 'mountpoint': None, 'deleted_at': None, 'id': u'26ba112d-7424-4bc1-b4cd-ff97a09cf648', 'size': 11L, 'user_id': u'46a7654d575440b98fb1c990ccdd34e1', 'attach_time': None, 'display_description': None, 'project_id': u'7d534bff2f4a40c39e6dd7dd404c0a62', 'launched_at': None, 'scheduled_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'status': u'deleting', 'volume_type_id': None, 'deleted': False, 'provider_location': None, 'host': u'nmagnezi_cinder', 'provider_auth': None, 'display_name': None, 'instance_uuid': None, 'created_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'attach_status': u'detached', 'volume_type': None}
>2012-12-25 14:42:29 INFO cinder.api.openstack.wsgi [req-0de6110c-5ec4-4866-9308-05bb08641364 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648 returned with HTTP 200
>2012-12-25 14:42:31 INFO cinder.api.openstack.wsgi [req-731df157-ca22-4d92-b442-055ea55d029e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:31 AUDIT cinder.api.openstack.volume.volumes [req-731df157-ca22-4d92-b442-055ea55d029e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol={'volume_metadata': [], 'availability_zone': u'nova', 'terminated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'updated_at': datetime.datetime(2012, 12, 25, 12, 42, 26), 'snapshot_id': None, 'ec2_id': None, 'mountpoint': None, 'deleted_at': None, 'id': u'26ba112d-7424-4bc1-b4cd-ff97a09cf648', 'size': 11L, 'user_id': u'46a7654d575440b98fb1c990ccdd34e1', 'attach_time': None, 'display_description': None, 'project_id': u'7d534bff2f4a40c39e6dd7dd404c0a62', 'launched_at': None, 'scheduled_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'status': u'deleting', 'volume_type_id': None, 'deleted': False, 'provider_location': None, 'host': u'nmagnezi_cinder', 'provider_auth': None, 'display_name': None, 'instance_uuid': None, 'created_at': datetime.datetime(2012, 12, 25, 12, 41, 33), 'attach_status': u'detached', 'volume_type': None}
>2012-12-25 14:42:31 INFO cinder.api.openstack.wsgi [req-731df157-ca22-4d92-b442-055ea55d029e 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648 returned with HTTP 200
>2012-12-25 14:42:36 INFO cinder.api.openstack.wsgi [req-44c0ca5f-7c33-4176-b3b4-fdb2e59df777 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648
>2012-12-25 14:42:36 INFO cinder.api.openstack.wsgi [req-44c0ca5f-7c33-4176-b3b4-fdb2e59df777 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] HTTP exception thrown: The resource could not be found.
>2012-12-25 14:42:36 INFO cinder.api.openstack.wsgi [req-44c0ca5f-7c33-4176-b3b4-fdb2e59df777 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/26ba112d-7424-4bc1-b4cd-ff97a09cf648 returned with HTTP 404
>2012-12-25 14:42:47 INFO cinder.api.openstack.wsgi [req-ade3140e-814a-4b5c-b9a0-a9b7d63b9ab9 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail
>2012-12-25 14:42:47 INFO cinder.api.openstack.wsgi [req-ade3140e-814a-4b5c-b9a0-a9b7d63b9ab9 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail returned with HTTP 200
>2012-12-25 14:43:25 INFO cinder.api.openstack.wsgi [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] POST http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes
>2012-12-25 14:43:25 AUDIT cinder.api.openstack.volume.volumes [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Create volume of 11 GB
>2012-12-25 14:43:26 AUDIT cinder.api.openstack.volume.volumes [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol={'availability_zone': 'nova', 'terminated_at': None, 'updated_at': None, 'provider_auth': None, 'snapshot_id': None, 'ec2_id': None, 'mountpoint': None, 'deleted_at': None, 'id': 'e37b1fbb-caed-4ef2-9664-44dabd0f86fa', 'size': 11, 'user_id': u'46a7654d575440b98fb1c990ccdd34e1', 'attach_time': None, 'display_description': None, 'project_id': u'7d534bff2f4a40c39e6dd7dd404c0a62', 'launched_at': None, 'scheduled_at': None, 'status': 'creating', 'volume_type_id': None, 'deleted': False, 'provider_location': None, 'host': None, 'display_name': None, 'instance_uuid': None, 'created_at': datetime.datetime(2012, 12, 25, 12, 43, 26, 24955), 'attach_status': 'detached'}
>2012-12-25 14:43:26 INFO cinder.api.openstack.wsgi [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes returned with HTTP 200
>
>==> /var/log/cinder/volume.log <==
>2012-12-25 14:43:26 INFO cinder.volume.manager [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] volume volume-e37b1fbb-caed-4ef2-9664-44dabd0f86fa: creating
>2012-12-25 14:43:26 ERROR cinder.volume.driver [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Recovering from a failed execute.  Try number 1
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver Traceback (most recent call last):
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 98, in _try_execute
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver     self._execute(*command, **kwargs)
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/utils.py", line 187, in execute
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver     cmd=' '.join(cmd))
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver ProcessExecutionError: Unexpected error while running command.
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvcreate -L 11G -n volume-e37b1fbb-caed-4ef2-9664-44dabd0f86fa cinder-volumes
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver Exit code: 5
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver Stdout: ''
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver Stderr: '  Volume group "cinder-volumes" has insufficient free space (511 extents): 2816 required.\n'
>2012-12-25 14:43:26 26008 TRACE cinder.volume.driver 
>2012-12-25 14:43:27 ERROR cinder.volume.driver [req-b82d770b-3b2c-4800-8890-af1bbd8fa475 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] Recovering from a failed execute.  Try number 2
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver Traceback (most recent call last):
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 98, in _try_execute
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver     self._execute(*command, **kwargs)
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver   File "/usr/lib/python2.6/site-packages/cinder/utils.py", line 187, in execute
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver     cmd=' '.join(cmd))
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver ProcessExecutionError: Unexpected error while running command.
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvcreate -L 11G -n volume-e37b1fbb-caed-4ef2-9664-44dabd0f86fa cinder-volumes
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver Exit code: 5
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver Stdout: ''
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver Stderr: '  Volume group "cinder-volumes" has insufficient free space (511 extents): 2816 required.\n'
>2012-12-25 14:43:27 26008 TRACE cinder.volume.driver 
>2012-12-25 14:43:31 26008 ERROR cinder.openstack.common.rpc.amqp [-] Exception during message handling
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp Traceback (most recent call last):
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/openstack/common/rpc/amqp.py", line 276, in _process_data
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     rval = self.proxy.dispatch(ctxt, version, method, **args)
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/openstack/common/rpc/dispatcher.py", line 145, in dispatch
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     return getattr(proxyobj, method)(ctxt, **kwargs)
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/volume/manager.py", line 163, in create_volume
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     volume_ref['id'], {'status': 'error'})
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib64/python2.6/contextlib.py", line 23, in __exit__
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     self.gen.next()
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/volume/manager.py", line 135, in create_volume
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     model_update = self.driver.create_volume(volume_ref)
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 176, in create_volume
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     self._create_volume(volume['name'], self._sizestr(volume['size']))
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 120, in _create_volume
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     volume_name, FLAGS.volume_group, run_as_root=True)
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/volume/driver.py", line 98, in _try_execute
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     self._execute(*command, **kwargs)
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/cinder/utils.py", line 187, in execute
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp     cmd=' '.join(cmd))
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp ProcessExecutionError: Unexpected error while running command.
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvcreate -L 11G -n volume-e37b1fbb-caed-4ef2-9664-44dabd0f86fa cinder-volumes
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp Exit code: 5
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp Stdout: ''
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp Stderr: '  Volume group "cinder-volumes" has insufficient free space (511 extents): 2816 required.\n'
>2012-12-25 14:43:31 26008 TRACE cinder.openstack.common.rpc.amqp 
>
>==> /var/log/cinder/api.log <==
>2012-12-25 14:46:49 INFO cinder.api.openstack.wsgi [req-f8dbe43c-5019-45a3-bfba-0778a7f86be2 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] GET http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail
>2012-12-25 14:46:49 AUDIT cinder.api.openstack.volume.volumes [req-f8dbe43c-5019-45a3-bfba-0778a7f86be2 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] vol=<cinder.db.sqlalchemy.models.Volume object at 0x3f39a90>
>2012-12-25 14:46:49 INFO cinder.api.openstack.wsgi [req-f8dbe43c-5019-45a3-bfba-0778a7f86be2 46a7654d575440b98fb1c990ccdd34e1 7d534bff2f4a40c39e6dd7dd404c0a62] http://10.35.171.174:8776/v1/7d534bff2f4a40c39e6dd7dd404c0a62/volumes/detail returned with HTTP 200
>

Actions: View

Attachments on bug 890168: 668905