Re: [Xen-devel] [Xen-API] (solved) xe vdi-create failure ot local SR type=file and type=ext

[Dimitar Kazakov <the.kazak@xxxxxxxxx>]

Thanks!
I found the problem in SMlog.

/usr/sbin/td-util create vhd 1024
/var/run/sr-mount/4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2/247b64e4-6b7f-4b2f-bd73-50e848c78d71.vhd
/usr/sbin/td-util: error while loading shared libraries:
libxenctrl.so.4.0: cannot open shared object file: No such file or directory

td-util from blktap-utils 2.0.90-3 (testing) is looking for
libxenctrl.so.4.0, but the package libxen-4.1 4.1.2-2.1 (testing) offers
only  libxenctrl-4.1.so in /usr/lib.
Makeing a link libxenctrl.so.4.0 to libxenctrl-4.1.so in /usr/lib solves
the problem.

SMlog snippet:
[22578] 2012-04-05 14:00:27.322636    ['uuidgen', '-r']
[22578] 2012-04-05 14:00:27.329600    SUCCESS
[22578] 2012-04-05 14:00:27.336360    lock: acquired
/var/lock/sm/4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2/sr
[22578] 2012-04-05 14:00:27.336677    vdi_create {'sr_uuid':
'4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2', 'subtask_of':
'DummyRef:|7d48c27e-b70e-59eb-6197-51518053c92e|VDI.create', 'vdi_type':
'user', 'args': ['1073741824', 'test', '', '', 'false',
'19700101T00:00:00Z', '', 'false'], 'host_ref':
'OpaqueRef:e5783245-3c2c-df70-80c3-244d77ebc59f', 'session_ref':
'OpaqueRef:0c7299c1-981a-c1b5-f5b7-17a1a467518f', 'device_config':
{'device': '/dev/sdb1', 'SRmaster': 'true'}, 'command': 'vdi_create',
'sr_ref': 'OpaqueRef:ed43ec0a-3570-7535-cac9-d4a086f69d18',
'vdi_sm_config': {}}
[22578] 2012-04-05 14:00:27.337019    ['/usr/sbin/td-util', 'create',
'vhd', '1024',
'/var/run/sr-mount/4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2/247b64e4-6b7f-4b2f-bd73-50e848c78d71.vhd']
[22578] 2012-04-05 14:00:27.342837    FAILED: (rc 127) stdout: '',
stderr: '/usr/sbin/td-util: error while loading shared libraries:
libxenctrl.so.4.0: cannot open shared object file: No such file or directory
'
[22578] 2012-04-05 14:00:27.361494    Raising exception [78, VDI
Creation failed [opterr=error 127]]
[22578] 2012-04-05 14:00:27.361842    lock: released
/var/lock/sm/4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2/sr
[22578] 2012-04-05 14:00:27.362757    ***** vdi_create: EXCEPTION <class
'SR.SROSError'>, VDI Creation failed [opterr=error 127]
  File "/usr/lib/xcp/sm/SRCommand.py", line 94, in run
    return self._run_locked(sr)
  File "/usr/lib/xcp/sm/SRCommand.py", line 131, in _run_locked
    return self._run(sr, target)
  File "/usr/lib/xcp/sm/SRCommand.py", line 159, in _run
    return target.create(self.params['sr_uuid'], self.vdi_uuid,
long(self.params['args'][0]))
  File "/usr/lib/xcp/sm/FileSR.py", line 464, in create
    opterr='error %d' % inst.code)
  File "/usr/lib/xcp/sm/xs_errors.py", line 49, in __init__
    raise SR.SROSError(errorcode, errormessage)

[22578] 2012-04-05 14:00:27.363242    lock: closed
/var/lock/sm/4137dc90-4ad7-ecc6-dd2f-6f05ac280fc2/sr






On 04/05/2012 01:08 PM, Jonathan Ludlam wrote:
> The log snippet doesn't have the detail in it - have a look in /var/log/SMlog 
> - you might find something more useful in there.
>
> Jon
>
> On 5 Apr 2012, at 10:23, Dimitar Kazakov wrote:
>
>> Hi,
>> have permanent failure when try to create VDI on local SR type=file or
>> type=ext. On both types it failed with the same error:
>> SR_BACKEND_FAILURE_78
>> VDI Creation failed [opterr=error 127]
>>
>> I am on Debian box with kernel 3.3.0-rc7, Xen version 4.1.2 (Debian
>> 4.1.2-2.1), Xen-API Version: 1.3.2-4 (Kronos)
>>
>> Is it a bug, or am I missing something? Anybody managed to workaround
>> this problem?
>>
>>
>> Here is a short extract from xcp-xapi.log
>>
>> id=ba4e9e1a-bc42-0dc9-af0e-5db2905666ab type=user name-label=test
>> virtual-size=1GiB username=root password=null
>> [20120403T07:57:53.973Z| info|hyperion|546 UNIX
>> /var/lib/xcp/xapi|session.login_with_password D:93575fa7333c|xapi]
>> Session.create trackid=1ef3448b63e70822073569022044e96b pool=false
>> uname=root is_local_superuser=true auth_user_sid=
>> parent=trackid=9834f5af41c964e225f24279aefe4e49
>> [20120403T07:57:53.974Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|session.login_with_password D:93575fa7333c|xapi]
>> Attempting to open /var/lib/xcp/xapi
>> [20120403T07:57:53.975Z|debug|hyperion|547 UNIX
>> /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid
>> D:4cab7e7aa9ae created by task D:93575fa7333c
>> [20120403T07:57:53.982Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|audit] VDI.create: SR =
>> 'ba4e9e1a-bc42-0dc9-af0e-5db2905666ab (Local storage)'; name label = 'test'
>> [20120403T07:57:53.983Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Marking SR for
>> VDI.create (task=OpaqueRef:efdfb350-d7ac-c3e3-3a69-9c8e4d560f2a)
>> [20120403T07:57:53.984Z| info|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|storage_impl] VDI.create
>> task:OpaqueRef:efdfb350-d7ac-c3e3-3a69-9c8e4d560f2a
>> sr:ba4e9e1a-bc42-0dc9-af0e-5db2905666ab vdi_info:{"vdi": "",
>> "name_label": "test", "name_description": "", "ty": "user",
>> "metadata_of_pool": "", "is_a_snapshot": false, "snapshot_time":
>> "19700101T00:00:00Z", "snapshot_of": "", "read_only": false,
>> "virtual_size": 1073741824, "physical_utilisation": 0} params:
>> [20120403T07:57:53.984Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|dummytaskhelper] task
>> VDI.create D:db9f2e113fee created by task R:efdfb350d7ac
>> [20120403T07:57:53.986Z| info|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Session.create
>> trackid=654ed4437d52fe9cdd8e5d98a5955526 pool=false uname=
>> is_local_superuser=true auth_user_sid=
>> parent=trackid=9834f5af41c964e225f24279aefe4e49
>> [20120403T07:57:53.987Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Attempting to open
>> /var/lib/xcp/xapi
>> [20120403T07:57:53.987Z|debug|hyperion|548 UNIX
>> /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid
>> D:3829e36dbb97 created by task D:6ec167aaa83d
>> [20120403T07:57:54.066Z|debug|hyperion|549 UNIX
>> /var/lib/xcp/xapi||dummytaskhelper] task dispatch:host.get_other_config
>> D:c813aaba73c4 created by task D:db9f2e113fee
>> [20120403T07:57:54.071Z|debug|hyperion|549 UNIX
>> /var/lib/xcp/xapi||http_critical] Premature termination of connection!
>> [20120403T07:57:54.109Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Raised at
>> sm_exec.ml:220.7-69 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.109Z| info|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Session.destroy
>> trackid=654ed4437d52fe9cdd8e5d98a5955526
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|backtrace] Raised at
>> pervasiveext.ml:26.22-25 -> server_helpers.ml:76.11-23
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|dispatcher] Server_helpers.exec
>> exception_handler: Got exception SR_BACKEND_FAILURE_78: [ ; VDI Creation
>> failed [opterr=error 127];  ]
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|dispatcher] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|backtrace] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Raised at
>> server_helpers.ml:94.14-15 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|sm_exec D:6ec167aaa83d|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|backtrace] Raised at
>> pervasiveext.ml:26.22-25 -> sm.ml:132.25-98 ->
>> storage_access.ml:259.36-331 -> storage_access.ml:257.28-492 ->
>> server_helpers.ml:76.11-23
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|dispatcher]
>> Server_helpers.exec exception_handler: Got exception
>> SR_BACKEND_FAILURE_78: [ ; VDI Creation failed [opterr=error 127];  ]
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|dispatcher] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|backtrace] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|xapi] Raised at
>> server_helpers.ml:94.14-15 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create D:db9f2e113fee|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Raised at
>> storage_access.ml:449.8-47 -> message_forwarding.ml:233.25-44 ->
>> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.110Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Unmarking SR after
>> VDI.create (task=OpaqueRef:efdfb350-d7ac-c3e3-3a69-9c8e4d560f2a)
>> [20120403T07:57:54.111Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|backtrace] Raised at
>> pervasiveext.ml:26.22-25 -> server.ml:24034.78-280 -> rbac.ml:229.16-23
>> [20120403T07:57:54.112Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|backtrace] Raised at
>> rbac.ml:238.10-15 -> server_helpers.ml:79.11-41
>> [20120403T07:57:54.112Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|dispatcher]
>> Server_helpers.exec exception_handler: Got exception
>> SR_BACKEND_FAILURE_78: [ ; VDI Creation failed [opterr=error 127];  ]
>> [20120403T07:57:54.112Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|dispatcher] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.112Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|backtrace] Raised at
>> string.ml:150.25-34 -> stringext.ml:108.13-29
>> [20120403T07:57:54.114Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Raised at
>> server_helpers.ml:94.14-15 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.115Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|VDI.create R:efdfb350d7ac|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.115Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|dispatch:VDI.create D:f979b7f99455|xapi] Raised at
>> pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.115Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi|dispatch:VDI.create D:f979b7f99455|backtrace] Raised
>> at pervasiveext.ml:26.22-25 -> server_helpers.ml:153.10-106 ->
>> server.ml:24035.19-190 -> server_helpers.ml:119.4-7
>> [20120403T07:57:54.115Z|debug|hyperion|546 UNIX /var/lib/xcp/xapi||xapi]
>> Raised at client.ml:6.37-75 -> client.ml:9043.48-106 ->
>> cli_operations.ml:1082.11-187 -> xapi_cli.ml:112.18-56 ->
>> pervasiveext.ml:22.2-9
>> [20120403T07:57:54.117Z| info|hyperion|546 UNIX
>> /var/lib/xcp/xapi|session.logout D:2d486a4a5b26|xapi] Session.destroy
>> trackid=1ef3448b63e70822073569022044e96b
>> [20120403T07:57:54.118Z|debug|hyperion|546 UNIX
>> /var/lib/xcp/xapi||backtrace] Raised at pervasiveext.ml:26.22-25 ->
>> xapi_cli.ml:111.2-138 -> xapi_cli.ml:205.7-44 -> xapi_cli.ml:257.4-23
>> [20120403T07:57:54.118Z|debug|hyperion|546 UNIX /var/lib/xcp/xapi||cli]
>> Xapi_cli.exception_handler: Got exception SR_BACKEND_FAILURE_78: [ ; VDI
>> Creation failed [opterr=error 127];  ]
>> [20120403T07:57:54.118Z|debug|hyperion|546 UNIX /var/lib/xcp/xapi||cli]
>> Raised at string.ml:150.25-34 -> stringext.ml:108.13-29
>>
>> Thanks,
>> Dimitar Kazkov
>> <the_kazak.vcf>_______________________________________________
>> xen-api mailing list
>> xen-api@xxxxxxxxxxxxx
>> http://lists.xen.org/cgi-bin/mailman/listinfo/xen-api

Attachment: the_kazak.vcf
Description: Vcard

_______________________________________________
Xen-devel mailing list
Xen-devel@xxxxxxxxxxxxx
http://lists.xen.org/xen-devel