Hi Marco,
Would you mind also providing detailed repro steps for this? How many hosts do
you have in your pool? Which host did you do it on?
Thanks,
Andrei
-----Original Message-----
From: Marco Sinhoreli [mailto:msinhore@xxxxxxxxx]
Sent: Thursday, March 24, 2011 5:04 PM
To: Jonathan Davies
Cc: Andrei Lifchits; xen-api
Subject: Re: [Xen-API] Resizing VDI with Local Caching enabled
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
|
Home