[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

Re: [Xen-API] Resizing VDI with Local Caching enabled


  • To: Jonathan Davies <Jonathan.Davies@xxxxxxxxxxxxx>
  • From: Marco Sinhoreli <msinhore@xxxxxxxxx>
  • Date: Thu, 24 Mar 2011 14:04:00 -0300
  • Cc: xen-api <xen-api@xxxxxxxxxxxxxxxxxxx>, Andrei Lifchits <Andrei.Lifchits@xxxxxxxxxx>
  • Delivery-date: Thu, 24 Mar 2011 10:04:28 -0700
  • Domainkey-signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=mime-version:in-reply-to:references:date:message-id:subject:from:to :cc:content-type:content-transfer-encoding; b=o2atRR8YDDzDiRO5BS/3m8VHxNzq2JaC8l4wDF4ucGBLa9SAojy7xO36be4sQJuCQQ WmvcmJH9IZYmV7ufLbHzwX+gIdl9dh9AfLekwZ9tIGzUQJnBEOQdbwqlcb6ysMB4qH+5 Whru71jioMz2trjGxsNKlHkLGdYfbtWmD8q4U=
  • List-id: Discussion of API issues surrounding Xen <xen-api.lists.xensource.com>

Hi Jonathan:

Bellow the /var/log/SMlog file content:

<log>

[6667] 2011-03-24 13:54:15.913428       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[6667] 2011-03-24 13:54:15.917045        = 0
[6904] 2011-03-24 13:55:11.249673       ['/usr/sbin/tap-ctl', 'list']
[6904] 2011-03-24 13:55:11.253768        = 0
[6904] 2011-03-24 13:55:11.259516       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[6904] 2011-03-24 13:55:11.263313        = 0
[6904] 2011-03-24 13:55:11.263955       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[6904] 2011-03-24 13:55:11.267715        = 0
[7257] 2011-03-24 13:56:06.571060       ['/usr/sbin/tap-ctl', 'list']
[7257] 2011-03-24 13:56:06.574950        = 0
[7257] 2011-03-24 13:56:06.580724       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[7257] 2011-03-24 13:56:06.584472        = 0
[7257] 2011-03-24 13:56:06.585132       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[7257] 2011-03-24 13:56:06.588925        = 0
[7538] 2011-03-24 13:57:01.902472       ['/usr/sbin/tap-ctl', 'list']
[7538] 2011-03-24 13:57:01.906591        = 0
[7538] 2011-03-24 13:57:01.912364       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[7538] 2011-03-24 13:57:01.916432        = 0
[7538] 2011-03-24 13:57:01.917099       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[7538] 2011-03-24 13:57:01.921214        = 0
[7931] 2011-03-24 13:57:57.242696       ['/usr/sbin/tap-ctl', 'list']
[7931] 2011-03-24 13:57:57.246488        = 0
[7931] 2011-03-24 13:57:57.252225       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[7931] 2011-03-24 13:57:57.256070        = 0
[7931] 2011-03-24 13:57:57.256718       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[7931] 2011-03-24 13:57:57.260511        = 0
[8329] 2011-03-24 13:58:52.568972       ['/usr/sbin/tap-ctl', 'list']
[8329] 2011-03-24 13:58:52.573106        = 0
[8329] 2011-03-24 13:58:52.578847       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[8329] 2011-03-24 13:58:52.582838        = 0
[8329] 2011-03-24 13:58:52.583487       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[8329] 2011-03-24 13:58:52.587380        = 0
[8523] 2011-03-24 13:59:47.905467       ['/usr/sbin/tap-ctl', 'list']
[8523] 2011-03-24 13:59:47.909332        = 0
[8523] 2011-03-24 13:59:47.915058       ['/usr/sbin/tap-ctl', 'stats',
'-p', '26360', '-m', '2']
[8523] 2011-03-24 13:59:47.918973        = 0
[8523] 2011-03-24 13:59:47.919625       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[8523] 2011-03-24 13:59:47.923533        = 0
[8766] 2011-03-24 14:00:16.874228       lock: acquired
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8766] 2011-03-24 14:00:16.876175       ['/usr/sbin/td-util', 'query',
'vhd', '-vpf', 
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[8766] 2011-03-24 14:00:16.903674       SUCCESS
[8766] 2011-03-24 14:00:16.904485       lock: released
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8766] 2011-03-24 14:00:16.904600       vdi_deactivate {'sr_uuid':
'b5631d2b-7931-c93c-39da-5a20978e823b', 'subtask_of':
'OpaqueRef:c7c8309d-f5fb-a97c-6443-a8b1f4b3dabe', 'vdi_ref':
'OpaqueRef:c602d033-57a7-bf8f-7d5d-ca76e2520402', 'vdi_on_boot':
'persist', 'args': [], 'vdi_location':
'5d095db5-4135-47f7-8118-3d9449965799', 'host_ref':
'OpaqueRef:0ed3e74b-aee7-e262-61cd-fe18a9a6d360', 'session_ref':
'OpaqueRef:fcea3677-4e21-e61b-a171-4369039ffe22', 'device_config':
{'options': '', 'SRmaster': 'true', 'serverpath':
'/vol/vol6/orquestra', 'server': 'riofd06.globoi.com'}, 'command':
'vdi_deactivate', 'vdi_allow_caching': 'true', 'sr_ref':
'OpaqueRef:e5bbc8cc-f3d5-3cc5-3e11-2c68797c8c45', 'local_cache_sr':
'5dea02ae-a488-829b-92d2-3eb5c288b90f', 'vdi_uuid':
'5d095db5-4135-47f7-8118-3d9449965799'}
[8766] 2011-03-24 14:00:16.904773       blktap2.deactivate
[8766] 2011-03-24 14:00:16.904855       lock: acquired
/var/lock/sm/5d095db5-4135-47f7-8118-3d9449965799/vdi
[8766] 2011-03-24 14:00:16.913169       ['/usr/sbin/tap-ctl', 'list', '-m', '2']
[8766] 2011-03-24 14:00:16.916386        = 0
[8766] 2011-03-24 14:00:16.916680       ['/usr/sbin/tap-ctl', 'close',
'-p', '26360', '-m', '2']
[8766] 2011-03-24 14:00:16.992138        = 0
[8766] 2011-03-24 14:00:16.992272       ['/usr/sbin/tap-ctl',
'detach', '-p', '26360', '-m', '2']
[8766] 2011-03-24 14:00:16.996854        = 0
[8766] 2011-03-24 14:00:16.997078       ['/usr/sbin/tap-ctl', 'free', '-m', '2']
[8766] 2011-03-24 14:00:16.999694        = 0
[8766] 2011-03-24 14:00:16.999870       tap.deactivate: Shut down
Tapdisk(vhd:/var/run/sr-mount/5dea02ae-a488-829b-92d2-3eb5c288b90f/5d095db5-4135-47f7-8118-3d9449965799.vhdcache,
pid=26360, minor=2, state=R)
[8766] 2011-03-24 14:00:17.039695       ['/usr/sbin/vhd-util',
'query', '--debug', '-p', '-n',
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[8766] 2011-03-24 14:00:17.052353       SUCCESS
[8766] 2011-03-24 14:00:17.058312       Tearing down the cache
[8766] 2011-03-24 14:00:17.059648       ['/usr/sbin/td-util', 'query',
'vhd', '-vpf', 
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/7dde9a41-45bf-4a4a-a17c-10b9ca93c41f.vhd']
[8766] 2011-03-24 14:00:17.102206       SUCCESS
[8766] 2011-03-24 14:00:17.449727       lock: acquired
/var/lock/sm/7dde9a41-45bf-4a4a-a17c-10b9ca93c41f/cachesetup
[8766] 2011-03-24 14:00:17.449808       lock: released
/var/lock/sm/7dde9a41-45bf-4a4a-a17c-10b9ca93c41f/cachesetup
[8766] 2011-03-24 14:00:17.449863       lock: closed
/var/lock/sm/7dde9a41-45bf-4a4a-a17c-10b9ca93c41f/cachesetup
[8766] 2011-03-24 14:00:17.449926       lock: closed
/var/lock/sm/5dea02ae-a488-829b-92d2-3eb5c288b90f/sr
[8766] 2011-03-24 14:00:17.734256       ['/usr/sbin/td-util', 'query',
'vhd', '-vpf', 
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[8766] 2011-03-24 14:00:17.746639       SUCCESS
[8766] 2011-03-24 14:00:17.762216       Removed host key
host_OpaqueRef:0ed3e74b-aee7-e262-61cd-fe18a9a6d360 for
5d095db5-4135-47f7-8118-3d9449965799
[8766] 2011-03-24 14:00:17.762311       lock: released
/var/lock/sm/5d095db5-4135-47f7-8118-3d9449965799/vdi
[8766] 2011-03-24 14:00:17.762378       lock: closed
/var/lock/sm/5d095db5-4135-47f7-8118-3d9449965799/vdi
[8766] 2011-03-24 14:00:17.762456       lock: closed
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8766] 2011-03-24 14:00:17.762628       lock: closed
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8822] 2011-03-24 14:00:17.884668       lock: acquired
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8822] 2011-03-24 14:00:17.886117       ['/usr/sbin/td-util', 'query',
'vhd', '-vpf', 
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[8822] 2011-03-24 14:00:17.902571       SUCCESS
[8822] 2011-03-24 14:00:17.903878       vdi_detach {'sr_uuid':
'b5631d2b-7931-c93c-39da-5a20978e823b', 'subtask_of':
'OpaqueRef:c7c8309d-f5fb-a97c-6443-a8b1f4b3dabe', 'vdi_ref':
'OpaqueRef:c602d033-57a7-bf8f-7d5d-ca76e2520402', 'vdi_on_boot':
'persist', 'args': [], 'vdi_location':
'5d095db5-4135-47f7-8118-3d9449965799', 'host_ref':
'OpaqueRef:0ed3e74b-aee7-e262-61cd-fe18a9a6d360', 'session_ref':
'OpaqueRef:28d24a42-044e-091a-6b31-a49a5b80b565', 'device_config':
{'options': '', 'SRmaster': 'true', 'serverpath':
'/vol/vol6/orquestra', 'server': 'riofd06.globoi.com'}, 'command':
'vdi_detach', 'vdi_allow_caching': 'true', 'sr_ref':
'OpaqueRef:e5bbc8cc-f3d5-3cc5-3e11-2c68797c8c45', 'local_cache_sr':
'5dea02ae-a488-829b-92d2-3eb5c288b90f', 'vdi_uuid':
'5d095db5-4135-47f7-8118-3d9449965799'}
[8822] 2011-03-24 14:00:17.904166       lock: closed
/var/lock/sm/5d095db5-4135-47f7-8118-3d9449965799/vdi
[8822] 2011-03-24 14:00:17.904285       lock: released
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8822] 2011-03-24 14:00:17.904565       lock: closed
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[8994] 2011-03-24 14:00:43.246717       ['/usr/sbin/tap-ctl', 'list']
[8994] 2011-03-24 14:00:43.250366        = 0
[8994] 2011-03-24 14:00:43.256244       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[8994] 2011-03-24 14:00:43.260298        = 0
[9095] 2011-03-24 14:01:12.462263       lock: acquired
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[9095] 2011-03-24 14:01:12.464090       ['/usr/sbin/td-util', 'query',
'vhd', '-vpf', 
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[9095] 2011-03-24 14:01:12.481012       SUCCESS
[9095] 2011-03-24 14:01:12.482403       lock: released
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[9095] 2011-03-24 14:01:12.482584       vdi_resize {'sr_uuid':
'b5631d2b-7931-c93c-39da-5a20978e823b', 'subtask_of':
'OpaqueRef:4e9f7429-4c78-35ca-3c35-aa2ba7e87b03', 'vdi_ref':
'OpaqueRef:c602d033-57a7-bf8f-7d5d-ca76e2520402', 'vdi_on_boot':
'persist', 'args': ['42949672960'], 'vdi_location':
'5d095db5-4135-47f7-8118-3d9449965799', 'host_ref':
'OpaqueRef:0ed3e74b-aee7-e262-61cd-fe18a9a6d360', 'session_ref':
'OpaqueRef:f7ef4d98-e63d-d4cc-ea06-c1eefd721779', 'device_config':
{'options': '', 'SRmaster': 'true', 'serverpath':
'/vol/vol6/orquestra', 'server': 'riofd06.globoi.com'}, 'command':
'vdi_resize', 'vdi_allow_caching': 'true', 'sr_ref':
'OpaqueRef:e5bbc8cc-f3d5-3cc5-3e11-2c68797c8c45', 'local_cache_sr':
'5dea02ae-a488-829b-92d2-3eb5c288b90f', 'vdi_uuid':
'5d095db5-4135-47f7-8118-3d9449965799'}
[9095] 2011-03-24 14:01:12.482785       ['/usr/sbin/vhd-util',
'resize', '--debug', '-s', '40960', '-n',
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd',
'-j', '.journal-5d095db5-4135-47f7-8118-3d9449965799']
[9095] 2011-03-24 14:01:12.702535       SUCCESS
[9095] 2011-03-24 14:01:12.702738       ['/usr/sbin/vhd-util',
'query', '--debug', '-v', '-n',
'/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/5d095db5-4135-47f7-8118-3d9449965799.vhd']
[9095] 2011-03-24 14:01:12.716394       SUCCESS
[9095] 2011-03-24 14:01:12.749430       _db_update_sm_config:
5d095db5-4135-47f7-8118-3d9449965799 del sm-config:vhd-parent
[9095] 2011-03-24 14:01:12.788894       lock: closed
/var/lock/sm/b5631d2b-7931-c93c-39da-5a20978e823b/sr
[9233] 2011-03-24 14:01:38.575962       ['/usr/sbin/tap-ctl', 'list']
[9233] 2011-03-24 14:01:38.579594        = 0
[9233] 2011-03-24 14:01:38.585400       ['/usr/sbin/tap-ctl', 'stats',
'-p', '28818', '-m', '0']
[9233] 2011-03-24 14:01:38.589243        = 0

</log>

On Thu, Mar 24, 2011 at 12:01 PM, Jonathan Davies
<Jonathan.Davies@xxxxxxxxxxxxx> wrote:
> Hi Marco,
>
> No, that's not the expected behaviour...
>
> Andrei (cc'd) has not been able to reproduce this. Are you able to provide 
> /var/log/SMlog and some more detailed reproduction steps?
>
> Thanks,
>
> Jonathan
>
>> -----Original Message-----
>> From: xen-api-bounces@xxxxxxxxxxxxxxxxxxx [mailto:xen-api-
>> bounces@xxxxxxxxxxxxxxxxxxx] On Behalf Of Marco Sinhoreli
>> Sent: 23 March 2011 15:03
>> To: xen-api
>> Subject: [Xen-API] Resizing VDI with Local Caching enabled
>>
>> Hello all:
>>
>> I'm trying resize a VDI cloned from a gold-image. I'm using storage
>> local caching in my tests. After resize, the virtual machine isn't
>> booting. Bellow the exception:
>>
>>
>> <output>
>> [root@server ~]# vdi=$(xe vbd-list
>> vm-uuid=fa537d17-1b07-b472-74c7-67b2a2f5561f device=xvda
>> params=vdi-uuid --minimal)
>> [root@server ~]# xe vdi-resize uuid=$vdi disk-size=40GiB
>> [root@server ~]# echo $?
>> 0
>> [root@server ~]# xe vm-start Âuuid=fa537d17-1b07-b472-74c7-67b2a2f5561f
>> There was an SR backend failure.
>> status: non-zero exit
>> stdout:
>> stderr: Traceback (most recent call last):
>> Â File "/opt/xensource/sm/NFSSR", line 253, in ?
>> Â Â SRCommand.run(NFSSR, DRIVER_INFO)
>> Â File "/opt/xensource/sm/SRCommand.py", line 246, in run
>> Â Â ret = cmd.run(sr)
>> Â File "/opt/xensource/sm/SRCommand.py", line 94, in run
>> Â Â return self._run_locked(sr)
>> Â File "/opt/xensource/sm/SRCommand.py", line 131, in _run_locked
>> Â Â return self._run(sr, target)
>> Â File "/opt/xensource/sm/SRCommand.py", line 183, in _run
>> Â Â caching_params)
>> Â File "/opt/xensource/sm/blktap2.py", line 1280, in activate
>> Â Â if self._activate_locked(sr_uuid, vdi_uuid, caching_params):
>> Â File "/opt/xensource/sm/blktap2.py", line 29, in wrapper
>> Â Â ret = op(self, *args)
>> Â File "/opt/xensource/sm/blktap2.py", line 1312, in _activate_locked
>> Â Â dev_path = self._activate(sr_uuid, vdi_uuid, caching_params)
>> Â File "/opt/xensource/sm/blktap2.py", line 1326, in _activate
>> Â Â dev_path = self.setup_cache(sr_uuid, vdi_uuid, caching_params)
>> Â File "/opt/xensource/sm/blktap2.py", line 1468, in setup_cache
>> Â Â local_sr_uuid, scratch_mode)
>> Â File "/opt/xensource/sm/blktap2.py", line 1550, in _setup_cache
>> Â Â standby=scratch_mode)
>> Â File "/opt/xensource/sm/blktap2.py", line 711, in launch_on_tap
>> Â Â raise TapdiskFailed(cls.Arg(_type, path), ctl)
>> blktap2.TapdiskFailed:
>> Tapdisk(vhd:/var/run/sr-mount/01cbd019-bd89-1296-a4bf-
>> fd9d412f64f4/05732396-9466-4828-9926-2217a10a18c9.vhdcache):
>> ['/usr/sbin/tap-ctl', 'open', '-p', '21483', '-m', '3', '-a',
>> 'vhd:/var/run/sr-mount/01cbd019-bd89-1296-a4bf-fd9d412f64f4/05732396-
>> 9466-4828-9926-2217a10a18c9.vhdcache',
>> '-e', '0', '-2',
>> 'vhd:/var/run/sr-mount/b5631d2b-7931-c93c-39da-5a20978e823b/05732396-
>> 9466-4828-9926-2217a10a18c9.vhd']
>> failed: status=22, pid=21485, errmsg=
>> </output>
>>
>> Is it a bug or could I have done something not permitted?
>>
>> Thoughts?
>>
>>
>> Cheers!
>>
>> --
>> Marco Sinhoreli
>>
>> _______________________________________________
>> xen-api mailing list
>> xen-api@xxxxxxxxxxxxxxxxxxx
>> http://lists.xensource.com/mailman/listinfo/xen-api
>



-- 
Marco Sinhoreli

_______________________________________________
xen-api mailing list
xen-api@xxxxxxxxxxxxxxxxxxx
http://lists.xensource.com/mailman/listinfo/xen-api


 


Rackspace

Lists.xenproject.org is hosted with RackSpace, monitoring our
servers 24x7x365 and backed by RackSpace's Fanatical Support®.