openstack team mailing list archive

[DeadSun <mwjpiero@xxxxxxxxx>]

I have create a volume sucessfully. When I use it to attach a server, the
nova-compute log show :"ERROR nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] instance 7: attach failed
/dev/vdc, removing"

how to fix it? Thank you;

$ nova --debug volume-attach 7 3 /dev/vdc

nova-compute.log
***********************************************
2011-10-25 09:08:08,371 DEBUG nova.rpc [-] received {u'_context_roles':
[u'Admin', u'Admin', u'KeystoneAdmin', u'KeystoneServiceAdmin'],
u'_context_request_id': u'df1f81f6-66b4-441e-8996-690e74265fef',
u'_context_read_deleted': False, u'args': {u'instance_id': u'7',
u'mountpoint': u'/dev/vdc', u'volume_id': 3}, u'_context_auth_token':
u'Mko09ijnbhu87ygv', u'_context_strategy': u'keystone',
u'_context_is_admin': True, u'_context_project_id': u'1',
u'_context_timestamp': u'2011-10-25T01:07:53.314598', u'_context_user_id':
u'admin', u'method': u'attach_volume', u'_context_remote_address':
u'10.200.200.4'} from (pid=13955) __call__
/data/nova/nova/rpc/impl_kombu.py:600
2011-10-25 09:08:08,371 DEBUG nova.rpc [-] unpacked context: {'user_id':
u'admin', 'roles': [u'Admin', u'Admin', u'KeystoneAdmin',
u'KeystoneServiceAdmin'], 'timestamp': u'2011-10-25T01:07:53.314598',
'auth_token': u'Mko09ijnbhu87ygv', 'msg_id': None, 'remote_address':
u'10.200.200.4', 'strategy': u'keystone', 'is_admin': True, 'request_id':
u'df1f81f6-66b4-441e-8996-690e74265fef', 'project_id': u'1', 'read_deleted':
False} from (pid=13955) _unpack_context
/data/nova/nova/rpc/impl_kombu.py:646
2011-10-25 09:08:08,376 INFO nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] check_instance_lock:
decorating: |<function attach_volume at 0x215a7d0>|
2011-10-25 09:08:08,377 INFO nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] check_instance_lock:
arguments: |<nova.compute.manager.ComputeManager object at 0x1a38f90>|
|<nova.rpc.impl_kombu.RpcContext object at 0x3dc6c50>| |7|
2011-10-25 09:08:08,377 DEBUG nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] instance 7: getting locked
state from (pid=13955) get_lock /data/nova/nova/compute/manager.py:1276
2011-10-25 09:08:08,464 INFO nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] check_instance_lock: locked:
|False|
2011-10-25 09:08:08,464 INFO nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] check_instance_lock: admin:
|True|
2011-10-25 09:08:08,465 INFO nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] check_instance_lock:
executing: |<function attach_volume at 0x215a7d0>|
2011-10-25 09:08:08,572 AUDIT nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] instance 7: attaching volume
3 to /dev/vdc
2011-10-25 09:08:08,631 DEBUG nova.rpc [-] Making asynchronous call on
volume.node2 ... from (pid=13955) multicall
/data/nova/nova/rpc/impl_kombu.py:721
2011-10-25 09:08:08,632 DEBUG nova.rpc [-] MSG_ID is
0380a1f3eeb049c182128c3b2ebb806f from (pid=13955) multicall
/data/nova/nova/rpc/impl_kombu.py:724
2011-10-25 09:08:09,481 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 from (pid=13955) execute /data/nova/nova/utils.py:168
2011-10-25 09:08:09,499 DEBUG nova.virt.libvirt.volume [-] iscsiadm ():
stdout=# BEGIN RECORD 2.0-871
node.name = iqn.2010-10.org.openstack:volume-00000003
node.tpgt = 1
node.startup = manual
iface.hwaddress = <empty>
iface.ipaddress = <empty>
iface.iscsi_ifacename = default
iface.net_ifacename = <empty>
iface.transport_name = tcp
iface.initiatorname = <empty>
node.discovery_address = node2
node.discovery_port = 3260
node.discovery_type = send_targets
node.session.initial_cmdsn = 0
node.session.initial_login_retry_max = 8
node.session.xmit_thread_priority = -20
node.session.cmds_max = 128
node.session.queue_depth = 32
node.session.auth.authmethod = None
node.session.auth.username = <empty>
node.session.auth.password = <empty>
node.session.auth.username_in = <empty>
node.session.auth.password_in = <empty>
node.session.timeo.replacement_timeout = 120
node.session.err_timeo.abort_timeout = 15
node.session.err_timeo.lu_reset_timeout = 20
node.session.err_timeo.host_reset_timeout = 60
node.session.iscsi.FastAbort = Yes
node.session.iscsi.InitialR2T = No
node.session.iscsi.ImmediateData = Yes
node.session.iscsi.FirstBurstLength = 262144
node.session.iscsi.MaxBurstLength = 16776192
node.session.iscsi.DefaultTime2Retain = 0
node.session.iscsi.DefaultTime2Wait = 2
node.session.iscsi.MaxConnections = 1
node.session.iscsi.MaxOutstandingR2T = 1
node.session.iscsi.ERL = 0
node.conn[0].address = 10.200.200.4
node.conn[0].port = 3260
node.conn[0].startup = manual
node.conn[0].tcp.window_size = 524288
node.conn[0].tcp.type_of_service = 0
node.conn[0].timeo.logout_timeout = 15
node.conn[0].timeo.login_timeout = 15
node.conn[0].timeo.auth_timeout = 45
node.conn[0].timeo.noop_out_interval = 5
node.conn[0].timeo.noop_out_timeout = 5
node.conn[0].iscsi.MaxRecvDataSegmentLength = 262144
node.conn[0].iscsi.HeaderDigest = None
node.conn[0].iscsi.DataDigest = None
node.conn[0].iscsi.IFMarker = No
node.conn[0].iscsi.OFMarker = No
# END RECORD
stderr= from (pid=13955) _run_iscsiadm
/data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:09,499 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 --login from (pid=13955) execute
/data/nova/nova/utils.py:168
2011-10-25 09:08:10,032 DEBUG nova.virt.libvirt.volume [-] iscsiadm
('--login',): stdout=Logging in to [iface: default, target:
iqn.2010-10.org.openstack:volume-00000003, portal: 10.200.200.4,3260]
Login to [iface: default, target: iqn.2010-10.org.openstack:volume-00000003,
portal: 10.200.200.4,3260]: successful
stderr= from (pid=13955) _run_iscsiadm
/data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:10,033 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 --op update -n node.startup -v automatic from (pid=13955)
execute /data/nova/nova/utils.py:168
2011-10-25 09:08:10,050 DEBUG nova.virt.libvirt.volume [-] iscsiadm ('--op',
'update', '-n', 'node.startup', '-v', 'automatic'): stdout= stderr= from
(pid=13955) _run_iscsiadm /data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:10,051 WARNING nova.virt.libvirt.volume [-] ISCSI volume
not yet found at: vdc. Will rescan & retry. Try number: 0
2011-10-25 09:08:10,051 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 --rescan from (pid=13955) execute
/data/nova/nova/utils.py:168
2011-10-25 09:08:10,073 DEBUG nova.virt.libvirt.volume [-] iscsiadm
('--rescan',): stdout=Rescanning session [sid: 4, target:
iqn.2010-10.org.openstack:volume-00000003, portal: 10.200.200.4,3260]
stderr= from (pid=13955) _run_iscsiadm
/data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:11,074 WARNING nova.virt.libvirt.volume [-] ISCSI volume
not yet found at: vdc. Will rescan & retry. Try number: 1
2011-10-25 09:08:11,074 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 --rescan from (pid=13955) execute
/data/nova/nova/utils.py:168
2011-10-25 09:08:11,099 DEBUG nova.virt.libvirt.volume [-] iscsiadm
('--rescan',): stdout=Rescanning session [sid: 4, target:
iqn.2010-10.org.openstack:volume-00000003, portal: 10.200.200.4,3260]
stderr= from (pid=13955) _run_iscsiadm
/data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:15,103 WARNING nova.virt.libvirt.volume [-] ISCSI volume
not yet found at: vdc. Will rescan & retry. Try number: 2
2011-10-25 09:08:15,103 DEBUG nova.utils [-] Running cmd (subprocess): sudo
iscsiadm -m node -T iqn.2010-10.org.openstack:volume-00000003 -p
10.200.200.4:3260 --rescan from (pid=13955) execute
/data/nova/nova/utils.py:168
2011-10-25 09:08:15,128 DEBUG nova.virt.libvirt.volume [-] iscsiadm
('--rescan',): stdout=Rescanning session [sid: 4, target:
iqn.2010-10.org.openstack:volume-00000003, portal: 10.200.200.4,3260]
stderr= from (pid=13955) _run_iscsiadm
/data/nova/nova/virt/libvirt/volume.py:76
2011-10-25 09:08:24,130 ERROR nova.compute.manager
[df1f81f6-66b4-441e-8996-690e74265fef admin 1] instance 7: attach failed
/dev/vdc, removing
(nova.compute.manager): TRACE: Traceback (most recent call last):
(nova.compute.manager): TRACE: File "/data/nova/nova/compute/manager.py",
line 1360, in attach_volume
(nova.compute.manager): TRACE: mountpoint)
(nova.compute.manager): TRACE: File "/data/nova/nova/exception.py", line
113, in wrapped
(nova.compute.manager): TRACE: return f(*args, **kw)
(nova.compute.manager): TRACE: File
"/data/nova/nova/virt/libvirt/connection.py", line 379, in attach_volume
(nova.compute.manager): TRACE: mount_device)
(nova.compute.manager): TRACE: File
"/data/nova/nova/virt/libvirt/connection.py", line 371, in
volume_driver_method
(nova.compute.manager): TRACE: return method(connection_info, *args,
**kwargs)
(nova.compute.manager): TRACE: File
"/data/nova/nova/virt/libvirt/volume.py", line 120, in connect_volume
(nova.compute.manager): TRACE: (host_device))
(nova.compute.manager): TRACE: Error: iSCSI device not found at
/dev/disk/by-path/ip-10.200.200.4:3260-iscsi-iqn.2010-10.org.openstack:volume-00000003-lun-0
(nova.compute.manager): TRACE:
2011-10-25 09:08:24,204 DEBUG nova.rpc [-] Making asynchronous call on
volume.node2 ... from (pid=13955) multicall
/data/nova/nova/rpc/impl_kombu.py:721
2011-10-25 09:08:24,205 DEBUG nova.rpc [-] MSG_ID is
3224ff5ac0c74a8e907b32c10a7ea0e4 from (pid=13955) multicall
/data/nova/nova/rpc/impl_kombu.py:724
2011-10-25 09:08:24,261 ERROR nova.rpc [-] Exception during message handling
(nova.rpc): TRACE: Traceback (most recent call last):
(nova.rpc): TRACE: File "/data/nova/nova/rpc/impl_kombu.py", line 620, in
_process_data
(nova.rpc): TRACE: rval = node_func(context=ctxt, **node_args)
(nova.rpc): TRACE: File "/data/nova/nova/compute/manager.py", line 119, in
decorated_function
(nova.rpc): TRACE: function(self, context, instance_id, *args, **kwargs)
(nova.rpc): TRACE: File "/data/nova/nova/compute/manager.py", line 1369, in
attach_volume
(nova.rpc): TRACE: raise exc
(nova.rpc): TRACE: Error: None
(nova.rpc): TRACE:

-- 
非淡薄无以明志，非宁静无以致远