yahoo-eng-team team mailing list archive

Thread
Date
[Bug 1217167] Re: value too long for type character varying(255)

To: yahoo-eng-team@xxxxxxxxxxxxxxxxxxx
From: Thierry Carrez <thierry.carrez+lp@xxxxxxxxx>
Date: Thu, 03 Oct 2013 07:43:09 -0000
Reply-to: Bug 1217167 <1217167@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
** Changed in: nova
       Status: Fix Committed => Fix Released

-- 
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/1217167

Title:
  value too long for type character varying(255)

Status in OpenStack Compute (Nova):
  Fix Released

Bug description:
  Looks like there is a schema problem, noticed this on the postgres
  devstack gate run:

  2013-08-26 23:59:45.136 20443 TRACE nova.openstack.common.rpc.amqp
  'INSERT INTO instance_faults (created_at, updated_at, deleted_at,
  deleted, instance_uuid, code, message, details, host) VALUES
  (%(created_at)s, %(updated_at)s, %(deleted_at)s, %(deleted)s,
  %(instance_uuid)s, %(code)s, %(message)s, %(details)s, %(host)s)
  RETURNING instance_faults.id' {'instance_uuid':
  u'0c6641f4-6330-44eb-9280-41a016242c90', 'code': 500, 'deleted': 0,
  'created_at': datetime.datetime(2013, 8, 26, 23, 59, 45, 33573),
  'updated_at': None, 'host': u'devstack-precise-hpcloud-az1-173434',
  'details': u'  File "/opt/stack/new/nova/nova/compute/manager.py",
  line 256, in decorated_function\n    return function(self, context,
  *args, **kwargs)\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1494, in
  run_instance\n    do_run_instance()\n  File
  "/opt/stack/new/nova/nova/openstack/common/lockutils.py", line 246, in
  inner\n    return f(*args, **kwargs)\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1493, in
  do_run_instance\n    legacy_bdm_in_spec)\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 931, in
  _run_instance\n    notify("error", msg=unicode(e))  # notify that
  build failed\n  File "/opt/stack/new/nova/nova/compute/manager.py",
  line 915, in _run_instance\n    instance, image_meta,
  legacy_bdm_in_spec)\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1040, in
  _build_instance\n    filter_properties, bdms, legacy_bdm_in_spec)\n
  File "/opt/stack/new/nova/nova/compute/manager.py", line 1071, in
  _reschedule_or_error\n    instance, exc_info[1], exc_info=exc_info)\n
  File "/opt/stack/new/nova/nova/compute/utils.py", line 78, in
  add_instance_fault_from_exc\n
  conductor.instance_fault_create(context, values)\n  File
  "/opt/stack/new/nova/nova/conductor/api.py", line 111, in
  instance_fault_create\n    return
  self._manager.instance_fault_create(context, values)\n  File
  "/opt/stack/new/nova/nova/conductor/rpcapi.py", line 358, in
  instance_fault_create\n    return self.call(context, msg,
  version=\'1.36\')\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/proxy.py", line 126, in
  call\n    result = rpc.call(context, real_topic, msg, timeout)\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/__init__.py", line 140,
  in call\n    return _get_impl().call(CONF, context, topic, msg,
  timeout)\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/impl_kombu.py", line
  828, in call\n    rpc_amqp.get_connection_pool(conf, Connection))\n
  File "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line
  534, in call\n    rv = list(rv)\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 499, in
  __iter__\n    raise result\n', 'message': u'Remote error: DBError
  (DataError) value too long for type character varying(255)\n \'INSERT
  INTO instance_faults (created_at, updated_at, deleted_at, deleted,
  instance_uuid, code, message, details, host) VALUES (%(created_at)s,
  %(updated_at)s, %(deleted_at)s, %(deleted)s, %(instance_uuid)s,
  %(code)s, %(message)s, %(details)s, %(host)s) RETURNING
  instance_faults.id\' {\'instance_uuid\':
  u\'0c6641f4-6330-44eb-9280-41a016242c90\', \'code\': 500, \'deleted\':
  0, \'created_at\': datetime.datetime(2013, 8, 26, 23, 59, 44, 944253),
  \'updated_at\': None, \'host\': u\'devstack-precise-hpcloud-
  az1-173434\', \'details\': u\'  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1002, in
  _build_instance\\n    set_access_ip=set_access_ip)\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1292, in _spawn\\n
  LOG.exception(_(\\\'Instance failed to spawn\\\'),
  instance=instance)\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1288, in _spawn\\n
  block_device_info)\\n  File
  "/opt/stack/new/nova/nova/virt/libvirt/driver.py", line 1676, in
  spawn\\n    admin_pass=admin_password)\\n  File
  "/opt/stack/new/nova/nova/virt/libvirt/driver.py", line 2052, in
  _create_image\\n    net =
  netutils.get_injected_network_template(network_info)\\n  File
  "/opt/stack/new/nova/nova/virt/netutils.py", line 158, in
  get_injected_network_template\\n    if not (network_info and
  template):\\n  File "/opt/stack/new/nova/nova/network/model.py", line
  487, in __len__\\n    return self._sync_wrapper(fn, *args,
  **kwargs)\\n  File "/opt/stack/new/nova/nova/network/model.py", line
  474, in _sync_wrapper\\n    self.wait()\\n  File
  "/opt/stack/new/nova/nova/network/model.py", line 506, in wait\\n
  self[:] = self._gt.wait()\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/greenthread.py", line 168, in wait\\n    return
  self._exit_event.wait()\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/event.py", line 120, in wait\\n
  current.throw(*self._exc)\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/greenthread.py", line 194, in main\\n    result =
  function(*args, **kwargs)\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1195, in
  _allocate_network_async\\n    dhcp_options=dhcp_options)\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 93, in wrapped\\n
  return func(self, context, *args, **kwargs)\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 49, in wrapper\\n
  res = f(self, context, *args, **kwargs)\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 288, in
  allocate_for_instance\\n    nw_info =
  self.network_rpcapi.allocate_for_instance(context, **args)\\n  File
  "/opt/stack/new/nova/nova/network/rpcapi.py", line 183, in
  allocate_for_instance\\n    topic=topic, version=\\\'1.9\\\')\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/proxy.py", line 126, in
  call\\n    result = rpc.call(context, real_topic, msg, timeout)\\n
  File "/opt/stack/new/nova/nova/openstack/common/rpc/__init__.py", line
  140, in call\\n    return _get_impl().call(CONF, context, topic, msg,
  timeout)\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/impl_kombu.py", line
  828, in call\\n    rpc_amqp.get_connection_pool(conf, Connection))\\n
  File "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line
  534, in call\\n    rv = list(rv)\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 499, in
  __iter__\\n    raise result\\n\', \'message\': u\'Remote error:
  ProcessExecutionError Unexpected error while running
  command.\\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf ip
  route del default dev br100\\nExit code: 2\\nStdout:
  \\\'\\\'\\nStderr: \\\'RTNETLINK answers: No such
  process\\\\n\\\'\\n[u\\\'Traceback (most recent call last):\\\\n\\\',
  u\\\'  File "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py",
  line 421, in _process_data\\\\n    **args)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/dispatcher.py", line
  172, in dispatch\\\\n    result = getattr(proxyobj, method)(ctxt,
  **kwargs)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/floating_ips.py", line 118, in
  allocate_for_instance\\\\n    **kwargs)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 493, in
  allocate_for_instance\\\\n
  requested_networks=requested_networks)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 210, in
  _allocate_fixed_ips\\\\n    vpn=vpn, address=address)\\\\n\\\', u\\\'
  File "/opt/stack/new/nova/nova/network/manager.py", line 860, in
  allocate_fixed_ip\\\\n    QUOTAS.rollback(context,
  reservations)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 853, in
  allocate_fixed_ip\\\\n    self._setup_network_on_host(context,
  network)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 1610, in
  _setup_network_on_host\\\\n
  self.l3driver.initialize_gateway(network)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/l3.py", line 107, in
  initialize_gateway\\\\n    linux_net.initialize_gateway_device(dev,
  network_ref)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/linux_net.py", line 839, in
  initialize_gateway_device\\\\n    \\\\\\\'dev\\\\\\\', dev,
  run_as_root=True)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/network/linux_net.py", line 1189, in
  _execute\\\\n    return utils.execute(*cmd, **kwargs)\\\\n\\\', u\\\'
  File "/opt/stack/new/nova/nova/utils.py", line 167, in execute\\\\n
  return processutils.execute(*cmd, **kwargs)\\\\n\\\', u\\\'  File
  "/opt/stack/new/nova/nova/openstack/common/processutils.py", line 178,
  in execute\\\\n    cmd=\\\\\\\' \\\\\\\'.join(cmd))\\\\n\\\',
  u"ProcessExecutionError: Unexpected error while running
  command.\\\\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf ip
  route del default dev br100\\\\nExit code: 2\\\\nStdout:
  \\\'\\\'\\\\nStderr: \\\'RTNETLINK answers: No such
  process\\\\\\\\n\\\'\\\\n"].\', \'deleted_at\': None}\n[u\'Traceback
  (most recent call last):\\n\', u\'  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 421, in
  _process_data\\n    **args)\\n\', u\'  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/dispatcher.py", line
  172, in dispatch\\n    result = getattr(proxyobj, method)(ctxt,
  **kwargs)\\n\', u\'  File
  "/opt/stack/new/nova/nova/conductor/manager.py", line 376, in
  instance_fault_create\\n    result =
  self.db.instance_fault_create(context, values)\\n\', u\'  File
  "/opt/stack/new/nova/nova/db/api.py", line 1728, in
  instance_fault_create\\n    rv = IMPL.instance_fault_create(context,
  values)\\n\', u\'  File
  "/opt/stack/new/nova/nova/db/sqlalchemy/api.py", line 5066, in
  instance_fault_create\\n    fault_ref.save()\\n\', u\'  File
  "/opt/stack/new/nova/nova/openstack/common/db/sqlalchemy/models.py",
  line 53, in save\\n    session.flush()\\n\', u\'  File
  "/opt/stack/new/nova/nova/openstack/common/db/sqlalchemy/session.py",
  line 543, in _wrap\\n    raise exception.DBError(e)\\n\', u\'DBError:
  (DataError) value too long for type character varying(255)\\n
  \\\'INSERT INTO instance_faults (created_at, updated_at, deleted_at,
  deleted, instance_uuid, code, message, details, host) VALUES
  (%(created_at)s, %(updated_at)s, %(deleted_at)s, %(deleted)s,
  %(instance_uuid)s, %(code)s, %(message)s, %(details)s, %(host)s)
  RETURNING instance_faults.id\\\' {\\\'instance_uuid\\\':
  u\\\'0c6641f4-6330-44eb-9280-41a016242c90\\\', \\\'code\\\': 500,
  \\\'deleted\\\': 0, \\\'created_at\\\': datetime.datetime(2013, 8, 26,
  23, 59, 44, 944253), \\\'updated_at\\\': None, \\\'host\\\': u
  \\\'devstack-precise-hpcloud-az1-173434\\\', \\\'details\\\': u\\\'
  File "/opt/stack/new/nova/nova/compute/manager.py", line 1002, in
  _build_instance\\\\n    set_access_ip=set_access_ip)\\\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1292, in
  _spawn\\\\n    LOG.exception(_(\\\\\\\'Instance failed to
  spawn\\\\\\\'), instance=instance)\\\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1288, in
  _spawn\\\\n    block_device_info)\\\\n  File
  "/opt/stack/new/nova/nova/virt/libvirt/driver.py", line 1676, in
  spawn\\\\n    admin_pass=admin_password)\\\\n  File
  "/opt/stack/new/nova/nova/virt/libvirt/driver.py", line 2052, in
  _create_image\\\\n    net =
  netutils.get_injected_network_template(network_info)\\\\n  File
  "/opt/stack/new/nova/nova/virt/netutils.py", line 158, in
  get_injected_network_template\\\\n    if not (network_info and
  template):\\\\n  File "/opt/stack/new/nova/nova/network/model.py",
  line 487, in __len__\\\\n    return self._sync_wrapper(fn, *args,
  **kwargs)\\\\n  File "/opt/stack/new/nova/nova/network/model.py", line
  474, in _sync_wrapper\\\\n    self.wait()\\\\n  File
  "/opt/stack/new/nova/nova/network/model.py", line 506, in wait\\\\n
  self[:] = self._gt.wait()\\\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/greenthread.py", line 168, in wait\\\\n    return
  self._exit_event.wait()\\\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/event.py", line 120, in wait\\\\n
  current.throw(*self._exc)\\\\n  File "/usr/local/lib/python2.7/dist-
  packages/eventlet/greenthread.py", line 194, in main\\\\n    result =
  function(*args, **kwargs)\\\\n  File
  "/opt/stack/new/nova/nova/compute/manager.py", line 1195, in
  _allocate_network_async\\\\n    dhcp_options=dhcp_options)\\\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 93, in wrapped\\\\n
  return func(self, context, *args, **kwargs)\\\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 49, in wrapper\\\\n
  res = f(self, context, *args, **kwargs)\\\\n  File
  "/opt/stack/new/nova/nova/network/api.py", line 288, in
  allocate_for_instance\\\\n    nw_info =
  self.network_rpcapi.allocate_for_instance(context, **args)\\\\n  File
  "/opt/stack/new/nova/nova/network/rpcapi.py", line 183, in
  allocate_for_instance\\\\n    topic=topic,
  version=\\\\\\\'1.9\\\\\\\')\\\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/proxy.py", line 126, in
  call\\\\n    result = rpc.call(context, real_topic, msg, timeout)\\\\n
  File "/opt/stack/new/nova/nova/openstack/common/rpc/__init__.py", line
  140, in call\\\\n    return _get_impl().call(CONF, context, topic,
  msg, timeout)\\\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/impl_kombu.py", line
  828, in call\\\\n    rpc_amqp.get_connection_pool(conf,
  Connection))\\\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 534, in
  call\\\\n    rv = list(rv)\\\\n  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 499, in
  __iter__\\\\n    raise result\\\\n\\\', \\\'message\\\': u\\\'Remote
  error: ProcessExecutionError Unexpected error while running
  command.\\\\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf ip
  route del default dev br100\\\\nExit code: 2\\\\nStdout:
  \\\\\\\'\\\\\\\'\\\\nStderr: \\\\\\\'RTNETLINK answers: No such
  process\\\\\\\\n\\\\\\\'\\\\n[u\\\\\\\'Traceback (most recent call
  last):\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/amqp.py", line 421, in
  _process_data\\\\\\\\n    **args)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/openstack/common/rpc/dispatcher.py", line
  172, in dispatch\\\\\\\\n    result = getattr(proxyobj, method)(ctxt,
  **kwargs)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/floating_ips.py", line 118, in
  allocate_for_instance\\\\\\\\n    **kwargs)\\\\\\\\n\\\\\\\',
  u\\\\\\\'  File "/opt/stack/new/nova/nova/network/manager.py", line
  493, in allocate_for_instance\\\\\\\\n
  requested_networks=requested_networks)\\\\\\\\n\\\\\\\', u\\\\\\\'
  File "/opt/stack/new/nova/nova/network/manager.py", line 210, in
  _allocate_fixed_ips\\\\\\\\n    vpn=vpn,
  address=address)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 860, in
  allocate_fixed_ip\\\\\\\\n    QUOTAS.rollback(context,
  reservations)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 853, in
  allocate_fixed_ip\\\\\\\\n    self._setup_network_on_host(context,
  network)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/manager.py", line 1610, in
  _setup_network_on_host\\\\\\\\n
  self.l3driver.initialize_gateway(network)\\\\\\\\n\\\\\\\', u\\\\\\\'
  File "/opt/stack/new/nova/nova/network/l3.py", line 107, in
  initialize_gateway\\\\\\\\n
  linux_net.initialize_gateway_device(dev,
  network_ref)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/linux_net.py", line 839, in
  initialize_gateway_device\\\\\\\\n
  \\\\\\\\\\\\\\\'dev\\\\\\\\\\\\\\\', dev,
  run_as_root=True)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/network/linux_net.py", line 1189, in
  _execute\\\\\\\\n    return utils.execute(*cmd,
  **kwargs)\\\\\\\\n\\\\\\\', u\\\\\\\'  File
  "/opt/stack/new/nova/nova/utils.py", line 167, in execute\\\\\\\\n
  return processutils.execute(*cmd, **kwargs)\\\\\\\\n\\\\\\\',
  u\\\\\\\'  File
  "/opt/stack/new/nova/nova/openstack/common/processutils.py", line 178,
  in execute\\\\\\\\n    cmd=\\\\\\\\\\\\\\\'
  \\\\\\\\\\\\\\\'.join(cmd))\\\\\\\\n\\\\\\\', u"ProcessExecutionError:
  Unexpected error while running command.\\\\\\\\nCommand: sudo nova-
  rootwrap /etc/nova/rootwrap.conf ip route del default dev
  br100\\\\\\\\nExit code: 2\\\\\\\\nStdout:
  \\\\\\\'\\\\\\\'\\\\\\\\nStderr: \\\\\\\'RTNETLINK answers: No such
  process\\\\\\\\\\\\\\\\n\\\\\\\'\\\\\\\\n"].\\\', \\\'deleted_at\\\':
  None}\\n\'].', 'deleted_at': None}

  http://logs.openstack.org/60/43460/3/check/gate-tempest-devstack-vm-
  postgres-full/4384cb3/logs/screen-n-cpu.txt.gz

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