yahoo-eng-team team mailing list archive

[Mate Lakat <mate.lakat@xxxxxxxxxx>]

After removing the orphan vdi (bab415f3-62da-8bae-b80e-d3ce45a1ca5c)  no
more errors happened. I am assuming, it was the result of using a non-
clean environment. Marking as invalid, create a separate bug for the
logging error (that's still a problem)


** Changed in: nova
   Importance: Undecided => Low

** Changed in: nova
       Status: New => Invalid

** Tags added: xenserver

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to OpenStack Compute (nova).
https://bugs.launchpad.net/bugs/1194903

Title:
  xenapi: euca attach volume fails

Status in OpenStack Compute (Nova):
  Invalid

Bug description:
  Running exercise.sh, I experience the following:

  + timeout 1000 sh -c 'while ! euca-describe-volumes vol-00000001 |
  grep -q available; do sleep 1; done'

  + euca-attach-volume -i i-00000001 -d /dev/vdc vol-00000001
  VOLUME	vol-00000001
  + timeout 500 sh -c 'while ! euca-describe-volumes vol-00000001 | grep -A 1 in-use | grep -q attach; do sleep 1; done'

  + die 100 'Could not attach vol-00000001 to i-00000001'
  + local exitcode=0
  + set +o xtrace
  [ERROR] /opt/stack/devstack/exercises/euca.sh:100 Could not attach vol-00000001 to i-00000001

  In the compute logs, the following lines grabbed my attention:

  Failed to attach volume ca6e35e2-7056-42b8-a4d4-546cc1a8c998 at /dev/xvdc
  Traceback (most recent call last):
    File "/opt/stack/nova/nova/compute/manager.py", line 3091, in _attach_volume
      mountpoint)
    File "/opt/stack/nova/nova/virt/xenapi/driver.py", line 367, in attach_volume
      mountpoint)
    File "/opt/stack/nova/nova/virt/xenapi/volumeops.py", line 58, in attach_volume
      hotplug=hotplug)
    File "/opt/stack/nova/nova/virt/xenapi/volumeops.py", line 96, in _connect_volume
      self._session, sr_uuid, sr_label, sr_params)
    File "/opt/stack/nova/nova/virt/xenapi/volume_utils.py", line 74, in introduce_sr
      session.call_xenapi("SR.scan", sr_ref)
    File "/opt/stack/nova/nova/virt/xenapi/driver.py", line 725, in call_xenapi
      return session.xenapi_request(method, args)
    File "/usr/local/lib/python2.7/dist-packages/XenAPI.py", line 133, in xenapi_request
      result = _parse_result(getattr(self, methodname)(*full_params))
    File "/usr/local/lib/python2.7/dist-packages/XenAPI.py", line 203, in _parse_result
      raise Failure(result['ErrorDescription'])
  Failure: ['SR_BACKEND_FAILURE_40', '', 'The SR scan failed  [opterr=[\'INTERNAL_ERROR\', \'Db_exn.Uniqueness_constraint_violation("VDI", "uuid", "bab415f3-62da-8bae-b80e-d3ce45a1ca5c")\']]', '']

  ...

  [req-286ae122-06e4-4dfc-9e91-4416e37689b1 demo demo] Exception during message handling
  Traceback (most recent call last):
    File "/opt/stack/nova/nova/openstack/common/rpc/amqp.py", line 433, in _process_data
      **args)
    File "/opt/stack/nova/nova/openstack/common/rpc/dispatcher.py", line 172, in dispatch
      result = getattr(proxyobj, method)(ctxt, **kwargs)
    File "/opt/stack/nova/nova/exception.py", line 99, in wrapped
      temp_level, payload)
    File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
      self.gen.next()
    File "/opt/stack/nova/nova/exception.py", line 76, in wrapped
      return f(self, context, *args, **kw)
    File "/opt/stack/nova/nova/compute/manager.py", line 215, in decorated_function
      pass
    File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
      self.gen.next()
    File "/opt/stack/nova/nova/compute/manager.py", line 201, in decorated_function
      return function(self, context, *args, **kwargs)
    File "/opt/stack/nova/nova/compute/manager.py", line 243, in decorated_function
      e, sys.exc_info())
    File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
      self.gen.next()
    File "/opt/stack/nova/nova/compute/manager.py", line 230, in decorated_function
      return function(self, context, *args, **kwargs)
    File "/opt/stack/nova/nova/compute/manager.py", line 3064, in attach_volume
      context, instance, mountpoint)
    File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
      self.gen.next()
    File "/opt/stack/nova/nova/compute/manager.py", line 3059, in attach_volume
      mountpoint, instance)
    File "/opt/stack/nova/nova/compute/manager.py", line 3101, in _attach_volume
      connector)
    File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
      self.gen.next()
    File "/opt/stack/nova/nova/compute/manager.py", line 3091, in _attach_volume
      mountpoint)
    File "/opt/stack/nova/nova/virt/xenapi/driver.py", line 367, in attach_volume
      mountpoint)
    File "/opt/stack/nova/nova/virt/xenapi/volumeops.py", line 58, in attach_volume
      hotplug=hotplug)
    File "/opt/stack/nova/nova/virt/xenapi/volumeops.py", line 96, in _connect_volume
      self._session, sr_uuid, sr_label, sr_params)
    File "/opt/stack/nova/nova/virt/xenapi/volume_utils.py", line 74, in introduce_sr
      session.call_xenapi("SR.scan", sr_ref)
    File "/opt/stack/nova/nova/virt/xenapi/driver.py", line 725, in call_xenapi
      return session.xenapi_request(method, args)
    File "/usr/local/lib/python2.7/dist-packages/XenAPI.py", line 133, in xenapi_request
      result = _parse_result(getattr(self, methodname)(*full_params))
    File "/usr/local/lib/python2.7/dist-packages/XenAPI.py", line 203, in _parse_result
      raise Failure(result['ErrorDescription'])
  Failure: ['SR_BACKEND_FAILURE_40', '', 'The SR scan failed  [opterr=[\'INTERNAL_ERROR\', \'Db_exn.Uniqueness_constraint_violation("VDI", "uuid", "bab415f3-62da-8bae-b80e-d3ce45a1ca5c")\']]', '']

  Also interesting, but not sure if it's related:

  2013-06-26 14:02:34.851 DEBUG nova.virt.xenapi.volumeops [req-286ae122-06e4-4dfc-9e91-4416e37689b1 demo demo] Attach_volume: {u'driver_volume_type': u'iscsi', 'serial': u'ca6e35e2-7056-42b8-a4d4-546cc1a8c998',
   u'data': {u'target_discovered': False, u'target_iqn': u'iqn.2010-10.org.openstack:volume-ca6e35e2-7056-42b8-a4d4-546cc1a8c998', u'target_portal': u'10.219.3.143:3260', u'volume_id': u'ca6e35e2-7056-42b8-a4d4-
  546cc1a8c998', u'target_lun': 1, u'auth_password': u'KErojkWaXXJLGRrk9mBM', u'auth_username': u'boAtvqyJyX5i2DkdccDG', u'auth_method': u'CHAP'}}, instance-00000001," /dev/xvdc from (pid=23955) attach_volume /o
  pt/stack/nova/nova/virt/xenapi/volumeops.py:51
  Traceback (most recent call last):
    File "/usr/lib/python2.7/logging/__init__.py", line 846, in emit
      msg = self.format(record)
    File "/opt/stack/nova/nova/openstack/common/log.py", line 551, in format
      return logging.StreamHandler.format(self, record)
    File "/usr/lib/python2.7/logging/__init__.py", line 723, in format
      return fmt.format(record)
    File "/opt/stack/nova/nova/openstack/common/log.py", line 515, in format
      return logging.Formatter.format(self, record)
    File "/usr/lib/python2.7/logging/__init__.py", line 464, in format
      record.message = record.getMessage()
    File "/usr/lib/python2.7/logging/__init__.py", line 328, in getMessage
      msg = msg % self.args
  TypeError: not enough arguments for format string
  Logged from file volume_utils.py, line 237

To manage notifications about this bug go to:
https://bugs.launchpad.net/nova/+bug/1194903/+subscriptions