Created
July 19, 2017 07:09
-
-
Save zhiweiyin318/7fb22220de9ad7ed495622a835ba9cac to your computer and use it in GitHub Desktop.
failed to attach cinder volume
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
DEBU[0030] /VolumeDriver.Get host=unix:///var/run/libstorage/451292995.sock pluginResponse={Name:voltest Opts:map[]} time=1500447977914 | |
DEBU[0030] inspecting volume host=unix:///var/run/libstorage/451292995.sock opts=map[] time=1500447977914 volumeName=voltest | |
INFO[0030] inspecting volume host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux opts=map[] osDriver=linux service=cinder storageDriver=libstorage time=1500447977914 volumeName=voltest | |
DEBU[0030] waiting on executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447977914 txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] invoking executor cli args=[cinder localDevices quick] cmd=/var/lib/libstorage/lsx-linux host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447977914 txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] signalling executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447977993 txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] xli localdevices success host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447977993 txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
INFO[0030] | |
INFO[0030] -------------------------- HTTP REQUEST (CLIENT) ------------------------- | |
INFO[0030] GET /volumes/cinder/voltest?attachments=0&byName HTTP/1.1 | |
INFO[0030] Host: libstorage-server | |
INFO[0030] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0030] Libstorage-Localdevices: cinder= | |
INFO[0030] Libstorage-Tx: txID=b707d597-3365-46c6-6879-141d9fcc1030, txCR=1500447977 | |
INFO[0030] | |
INFO[0030] http request host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=schema-validator route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=storage-session-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-svc-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=service-validator route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=local-devices-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=instanceIDs-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-global-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=error-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=logging-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=query-params-handler route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] query param host=unix:///var/run/libstorage/451292995.sock key=attachments len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false value=[0] | |
DEBU[0030] query param host=unix:///var/run/libstorage/451292995.sock key=byName len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false value=[] | |
DEBU[0030] http header Libstorage-Tx=txID=b707d597-3365-46c6-6879-141d9fcc1030, txCR=1500447977 host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false | |
DEBU[0030] skipping global auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447977994 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] http header Libstorage-Instanceid=[cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] http header Libstorage-Localdevices=[cinder=] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] getting storage service host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg service=cinder time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] skipping svc auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] driver is not StorageDriverWithLogin host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
INFO[0030] executing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447977995 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] driver is not StorageDriverVolInspectByName host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447977996 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447977996 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] skipping response schema validation; disabled host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447978199 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] task completed host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447978199 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
INFO[0030] @ - - [19/Jul/2017:15:06:18 +0800] "GET /volumes/cinder/voltest?attachments=0&byName HTTP/1.1" 200 153 | |
INFO[0030] | |
INFO[0030] -------------------------- HTTP REQUEST (SERVER) -------------------------- | |
INFO[0030] GET /volumes/cinder/voltest?attachments=0&byName HTTP/1.1 | |
INFO[0030] Host: libstorage-server | |
INFO[0030] Accept-Encoding: gzip | |
INFO[0030] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0030] Libstorage-Localdevices: cinder= | |
INFO[0030] Libstorage-Tx: txID=b707d597-3365-46c6-6879-141d9fcc1030, txCR=1500447977 | |
INFO[0030] User-Agent: Go-http-client/1.1 | |
INFO[0030] | |
INFO[0030] -------------------------- HTTP RESPONSE (SERVER) ------------------------- | |
INFO[0030] Content-Type=application/json | |
INFO[0030] | |
INFO[0030] { | |
INFO[0030] "availabilityZone": "nova", | |
INFO[0030] "name": "voltest", | |
INFO[0030] "size": 1, | |
INFO[0030] "status": "available", | |
INFO[0030] "id": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2", | |
INFO[0030] "type": "" | |
INFO[0030] } | |
INFO[0030] | |
INFO[0030] -------------------------- HTTP RESPONSE (CLIENT) ------------------------- | |
INFO[0030] HTTP/1.1 200 OK | |
INFO[0030] Content-Length: 153 | |
INFO[0030] Content-Type: application/json | |
INFO[0030] Date: Wed, 19 Jul 2017 07:06:18 GMT | |
INFO[0030] Libstorage-Servername: helix-bear-vg | |
INFO[0030] | |
INFO[0030] { | |
INFO[0030] "availabilityZone": "nova", | |
INFO[0030] "name": "voltest", | |
INFO[0030] "size": 1, | |
INFO[0030] "status": "available", | |
INFO[0030] "id": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2", | |
INFO[0030] "type": "" | |
INFO[0030] } | |
INFO[0030] volume inspected host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux service=cinder storageDriver=libstorage time=1500447978199 volume=&{Name:voltest VolumeMountPoint: VolumeStatus:map[iops:0 type: availabilityZone:nova fields:map[] service:cinder server:cinder name:voltest size:1]} volumeName=voltest | |
DEBU[0030] /VolumeDriver.Path host=unix:///var/run/libstorage/451292995.sock pluginResponse={Name:voltest Opts:map[]} time=1500447978200 | |
DEBU[0030] getting path to volume host=unix:///var/run/libstorage/451292995.sock opts=map[] time=1500447978200 volumeID= volumeName=voltest | |
DEBU[0030] removing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 removedAfter=0s route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=1 time=1500447978202 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] removed task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=0 time=1500447978202 tls=false txCR=1500447977 txID=b707d597-3365-46c6-6879-141d9fcc1030 | |
DEBU[0030] skipping path lookup host=unix:///var/run/libstorage/451292995.sock opts=map[] time=1500447978203 volumeID= volumeName=voltest | |
DEBU[0031] /VolumeDriver.Mount host=unix:///var/run/libstorage/451292995.sock pluginResponse={Name:voltest Opts:map[]} time=1500447979128 | |
DEBU[0031] mounting volume host=unix:///var/run/libstorage/451292995.sock opts=&{OverwriteFS:false NewFSType: Preempt:false Opts:<nil>} time=1500447979131 volumeID= volumeName=voltest | |
INFO[0031] mounting volume host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux opts=&{OverwriteFS:false NewFSType: Preempt:false Opts:<nil>} osDriver=linux service=cinder storageDriver=libstorage time=1500447979131 volumeID= volumeName=voltest | |
DEBU[0031] waiting on executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979131 txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] invoking executor cli args=[cinder localDevices quick] cmd=/var/lib/libstorage/lsx-linux host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979132 txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] signalling executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979214 txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] xli localdevices success host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979214 txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
INFO[0031] | |
INFO[0031] -------------------------- HTTP REQUEST (CLIENT) ------------------------- | |
INFO[0031] GET /volumes/cinder/voltest?attachments=31&byName HTTP/1.1 | |
INFO[0031] Host: libstorage-server | |
INFO[0031] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0031] Libstorage-Localdevices: cinder= | |
INFO[0031] Libstorage-Tx: txID=559f8327-55b8-40e1-4d92-8a2584a487a0, txCR=1500447979 | |
INFO[0031] | |
INFO[0031] http request host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447979214 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=schema-validator route=volumeInspect server=helix-bear-vg time=1500447979214 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=storage-session-handler route=volumeInspect server=helix-bear-vg time=1500447979214 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-svc-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=service-validator route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=local-devices-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=instanceIDs-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-global-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=error-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=logging-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=query-params-handler route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] query param host=unix:///var/run/libstorage/451292995.sock key=byName len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false value=[] | |
DEBU[0031] query param host=unix:///var/run/libstorage/451292995.sock key=attachments len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false value=[31] | |
DEBU[0031] http header Libstorage-Tx=txID=559f8327-55b8-40e1-4d92-8a2584a487a0, txCR=1500447979 host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false | |
DEBU[0031] skipping global auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] http header Libstorage-Instanceid=[cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] http header Libstorage-Localdevices=[cinder=] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] getting storage service host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg service=cinder time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] skipping svc auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] driver is not StorageDriverWithLogin host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
INFO[0031] executing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] driver is not StorageDriverVolInspectByName host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979215 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979218 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] manually calculating attachment state host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979422 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] including volume attachmentState=available host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979422 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] skipping response schema validation; disabled host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979422 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] task completed host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979422 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
INFO[0031] @ - - [19/Jul/2017:15:06:19 +0800] "GET /volumes/cinder/voltest?attachments=31&byName HTTP/1.1" 200 177 | |
INFO[0031] | |
INFO[0031] -------------------------- HTTP REQUEST (SERVER) -------------------------- | |
INFO[0031] GET /volumes/cinder/voltest?attachments=31&byName HTTP/1.1 | |
INFO[0031] Host: libstorage-server | |
INFO[0031] Accept-Encoding: gzip | |
INFO[0031] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0031] Libstorage-Localdevices: cinder= | |
INFO[0031] Libstorage-Tx: txID=559f8327-55b8-40e1-4d92-8a2584a487a0, txCR=1500447979 | |
INFO[0031] User-Agent: Go-http-client/1.1 | |
INFO[0031] | |
INFO[0031] -------------------------- HTTP RESPONSE (SERVER) ------------------------- | |
INFO[0031] Content-Type=application/json | |
INFO[0031] | |
INFO[0031] { | |
INFO[0031] "attachmentState": 3, | |
INFO[0031] "availabilityZone": "nova", | |
INFO[0031] "name": "voltest", | |
INFO[0031] "size": 1, | |
INFO[0031] "status": "available", | |
INFO[0031] "id": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2", | |
INFO[0031] "type": "" | |
INFO[0031] } | |
INFO[0031] | |
INFO[0031] -------------------------- HTTP RESPONSE (CLIENT) ------------------------- | |
INFO[0031] HTTP/1.1 200 OK | |
INFO[0031] Content-Length: 177 | |
INFO[0031] Content-Type: application/json | |
INFO[0031] Date: Wed, 19 Jul 2017 07:06:19 GMT | |
INFO[0031] Libstorage-Servername: helix-bear-vg | |
INFO[0031] | |
INFO[0031] { | |
INFO[0031] "attachmentState": 3, | |
INFO[0031] "availabilityZone": "nova", | |
INFO[0031] "name": "voltest", | |
INFO[0031] "size": 1, | |
INFO[0031] "status": "available", | |
INFO[0031] "id": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2", | |
INFO[0031] "type": "" | |
INFO[0031] } | |
DEBU[0031] removing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 removedAfter=0s route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=1 time=1500447979425 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] removed task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=0 time=1500447979425 tls=false txCR=1500447979 txID=559f8327-55b8-40e1-4d92-8a2584a487a0 | |
DEBU[0031] performing precautionary unmount host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux service=cinder storageDriver=libstorage time=1500447979425 | |
DEBU[0031] waiting on executor lock host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979426 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] invoking executor cli args=[cinder nextDevice] cmd=/var/lib/libstorage/lsx-linux host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979426 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] signalling executor lock host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979513 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] xli nextdevice success host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979513 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] waiting on executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979514 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] invoking executor cli args=[cinder localDevices quick] cmd=/var/lib/libstorage/lsx-linux host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979514 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] signalling executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979590 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] xli localdevices success host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447979592 txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
INFO[0031] | |
INFO[0031] -------------------------- HTTP REQUEST (CLIENT) ------------------------- | |
INFO[0031] POST /volumes/cinder/54704d6a-c853-4bb1-b98c-8c08e33ee2c2?attach HTTP/1.1 | |
INFO[0031] Host: libstorage-server | |
INFO[0031] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0031] Libstorage-Localdevices: cinder= | |
INFO[0031] Libstorage-Tx: txID=84fef27b-ba59-4b07-6b65-66a81d3d7043, txCR=1500447979 | |
INFO[0031] | |
INFO[0031] {} | |
INFO[0031] http request host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=post-args-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=schema-validator route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=storage-session-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-svc-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=service-validator route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=local-devices-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=instanceIDs-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-global-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=error-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=logging-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=query-params-handler route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] query param host=unix:///var/run/libstorage/451292995.sock key=attach len(value)=1 route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false value=[] | |
DEBU[0031] http header Libstorage-Tx=txID=84fef27b-ba59-4b07-6b65-66a81d3d7043, txCR=1500447979 host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false | |
DEBU[0031] skipping global auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] http header Libstorage-Instanceid=[cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1] host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] http header Libstorage-Localdevices=[cinder=] host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] getting storage service host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg service=cinder time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] skipping svc auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] driver is not StorageDriverWithLogin host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979593 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] validating schema body={} host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach schema={ | |
"$schema": "http://json-schema.org/draft-04/schema#", | |
"$ref": "https://github.com/codedellemc/libstorage#/definitions/volumeAttachRequest" | |
} server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979594 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979597 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
INFO[0031] executing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979597 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0031] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder time=1500447979598 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
ERRO[0032] error attaching volume host=unix:///var/run/libstorage/451292995.sock inner=Resource not found instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 instanceId=c62d1c7a-65f4-4658-99de-d65dc99733c1 provider=cinder route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979812 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 volumeId=54704d6a-c853-4bb1-b98c-8c08e33ee2c2 | |
DEBU[0032] task completed host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979812 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
ERRO[0032] error: api call failed error.volumeId=54704d6a-c853-4bb1-b98c-8c08e33ee2c2 error.instanceId=c62d1c7a-65f4-4658-99de-d65dc99733c1 error.provider=cinder host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979813 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0032] api call error json apiErr={"message":"error attaching volume","status":500,"error":{"inner":"Resource not found","instanceId":"c62d1c7a-65f4-4658-99de-d65dc99733c1","provider":"cinder","volumeId":"54704d6a-c853-4bb1-b98c-8c08e33ee2c2"}} host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979813 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
INFO[0032] @ - - [19/Jul/2017:15:06:19 +0800] "POST /volumes/cinder/54704d6a-c853-4bb1-b98c-8c08e33ee2c2?attach HTTP/1.1" 500 250 | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP REQUEST (SERVER) -------------------------- | |
INFO[0032] POST /volumes/cinder/54704d6a-c853-4bb1-b98c-8c08e33ee2c2?attach HTTP/1.1 | |
INFO[0032] Host: libstorage-server | |
INFO[0032] Accept-Encoding: gzip | |
INFO[0032] Content-Length: 2 | |
INFO[0032] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0032] Libstorage-Localdevices: cinder= | |
INFO[0032] Libstorage-Tx: txID=84fef27b-ba59-4b07-6b65-66a81d3d7043, txCR=1500447979 | |
INFO[0032] User-Agent: Go-http-client/1.1 | |
INFO[0032] | |
INFO[0032] {} | |
INFO[0032] -------------------------- HTTP RESPONSE (SERVER) ------------------------- | |
INFO[0032] Content-Type=application/json | |
INFO[0032] | |
INFO[0032] { | |
INFO[0032] "message": "error attaching volume", | |
INFO[0032] "status": 500, | |
INFO[0032] "error": { | |
INFO[0032] "inner": "Resource not found", | |
INFO[0032] "instanceId": "c62d1c7a-65f4-4658-99de-d65dc99733c1", | |
INFO[0032] "provider": "cinder", | |
INFO[0032] "volumeId": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2" | |
INFO[0032] } | |
INFO[0032] } | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP RESPONSE (CLIENT) ------------------------- | |
INFO[0032] HTTP/1.1 500 Internal Server Error | |
INFO[0032] Content-Length: 250 | |
INFO[0032] Content-Type: application/json | |
INFO[0032] Date: Wed, 19 Jul 2017 07:06:19 GMT | |
INFO[0032] Libstorage-Servername: helix-bear-vg | |
INFO[0032] | |
INFO[0032] { | |
INFO[0032] "message": "error attaching volume", | |
INFO[0032] "status": 500, | |
INFO[0032] "error": { | |
INFO[0032] "inner": "Resource not found", | |
INFO[0032] "instanceId": "c62d1c7a-65f4-4658-99de-d65dc99733c1", | |
INFO[0032] "provider": "cinder", | |
INFO[0032] "volumeId": "54704d6a-c853-4bb1-b98c-8c08e33ee2c2" | |
INFO[0032] } | |
INFO[0032] } | |
ERRO[0032] /VolumeDriver.Mount: error mounting volume error.inner.instanceId=c62d1c7a-65f4-4658-99de-d65dc99733c1 error.inner.provider=cinder error.inner.volumeId=54704d6a-c853-4bb1-b98c-8c08e33ee2c2 error.status=500 host=unix:///var/run/libstorage/451292995.sock time=1500447979814 | |
DEBU[0032] removing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 removedAfter=0s route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=1 time=1500447979815 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0032] removed task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=0 time=1500447979815 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 | |
DEBU[0032] /VolumeDriver.Unmount host=unix:///var/run/libstorage/451292995.sock pluginResponse={Name:voltest Opts:map[]} time=1500447980297 | |
DEBU[0032] unmounting volume host=unix:///var/run/libstorage/451292995.sock opts=map[] time=1500447980297 volumeID= volumeName=voltest | |
DEBU[0032] init count count=0 host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux osDriver=linux service=cinder storageDriver=libstorage time=1500447980300 volumeName=voltest | |
INFO[0032] unmounting volume host=unix:///var/run/libstorage/451292995.sock integrationDriver=linux opts=map[] osDriver=linux service=cinder storageDriver=libstorage time=1500447980300 volumeID= volumeName=voltest | |
DEBU[0032] waiting on executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447980301 txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] invoking executor cli args=[cinder localDevices quick] cmd=/var/lib/libstorage/lsx-linux host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447980301 txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] signalling executor lock host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447980379 txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] xli localdevices success host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 integrationDriver=linux osDriver=linux server=helix-bear-vg service=cinder storageDriver=libstorage time=1500447980379 txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP REQUEST (CLIENT) ------------------------- | |
INFO[0032] GET /volumes/cinder/voltest?attachments=15&byName HTTP/1.1 | |
INFO[0032] Host: libstorage-server | |
INFO[0032] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0032] Libstorage-Localdevices: cinder= | |
INFO[0032] Libstorage-Tx: txID=f955789a-312f-4b9d-60e3-4de80a45d06a, txCR=1500447980 | |
INFO[0032] | |
INFO[0032] http request host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980379 tls=false | |
DEBU[0032] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=schema-validator route=volumeInspect server=helix-bear-vg time=1500447980380 tls=false | |
DEBU[0032] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=storage-session-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-svc-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added route middleware host=unix:///var/run/libstorage/451292995.sock middleware=service-validator route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=local-devices-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=instanceIDs-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=auth-global-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=error-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=transaction-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=logging-handler route=volumeInspect server=helix-bear-vg time=1500447980381 tls=false | |
DEBU[0032] added global middleware host=unix:///var/run/libstorage/451292995.sock middleware=query-params-handler route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false | |
DEBU[0032] query param host=unix:///var/run/libstorage/451292995.sock key=attachments len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false value=[15] | |
DEBU[0032] query param host=unix:///var/run/libstorage/451292995.sock key=byName len(value)=1 route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false value=[] | |
DEBU[0032] http header Libstorage-Tx=txID=f955789a-312f-4b9d-60e3-4de80a45d06a, txCR=1500447980 host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false | |
DEBU[0032] skipping global auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] http header Libstorage-Instanceid=[cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] http header Libstorage-Localdevices=[cinder=] host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] getting storage service host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg service=cinder time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] skipping svc auth handler; empty allow & deny lists host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] driver is not StorageDriverWithLogin host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447980382 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] getting task service host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder time=1500447980384 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
INFO[0032] executing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980384 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] driver is not StorageDriverVolInspectByName host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980384 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] manually calculating attachment state host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] omitting unattached volume attachmentState=available host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
ERRO[0032] resource not found host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 resourceID=voltest route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] task completed host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
ERRO[0032] error: api call failed error.resourceID=voltest host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] api call error json apiErr={"message":"resource not found","status":404,"error":{"resourceID":"voltest"}} host=unix:///var/run/libstorage/451292995.sock route=volumeInspect server=helix-bear-vg time=1500447980584 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
INFO[0032] @ - - [19/Jul/2017:15:06:20 +0800] "GET /volumes/cinder/voltest?attachments=15&byName HTTP/1.1" 404 100 | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP REQUEST (SERVER) -------------------------- | |
INFO[0032] GET /volumes/cinder/voltest?attachments=15&byName HTTP/1.1 | |
INFO[0032] Host: libstorage-server | |
INFO[0032] Accept-Encoding: gzip | |
INFO[0032] Libstorage-Instanceid: cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 | |
INFO[0032] Libstorage-Localdevices: cinder= | |
INFO[0032] Libstorage-Tx: txID=f955789a-312f-4b9d-60e3-4de80a45d06a, txCR=1500447980 | |
INFO[0032] User-Agent: Go-http-client/1.1 | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP RESPONSE (SERVER) ------------------------- | |
INFO[0032] Content-Type=application/json | |
INFO[0032] | |
INFO[0032] { | |
INFO[0032] "message": "resource not found", | |
INFO[0032] "status": 404, | |
INFO[0032] "error": { | |
INFO[0032] "resourceID": "voltest" | |
INFO[0032] } | |
INFO[0032] } | |
INFO[0032] | |
INFO[0032] -------------------------- HTTP RESPONSE (CLIENT) ------------------------- | |
INFO[0032] HTTP/1.1 404 Not Found | |
INFO[0032] Content-Length: 100 | |
INFO[0032] Content-Type: application/json | |
INFO[0032] Date: Wed, 19 Jul 2017 07:06:20 GMT | |
INFO[0032] Libstorage-Servername: helix-bear-vg | |
INFO[0032] | |
INFO[0032] { | |
INFO[0032] "message": "resource not found", | |
INFO[0032] "status": 404, | |
INFO[0032] "error": { | |
INFO[0032] "resourceID": "voltest" | |
INFO[0032] } | |
INFO[0032] } | |
ERRO[0032] /VolumeDriver.Unmount: error unmounting volume error.inner.resourceID=voltest error.status=404 host=unix:///var/run/libstorage/451292995.sock time=1500447980585 | |
DEBU[0032] removing task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 removedAfter=0s route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=1 time=1500447980586 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a | |
DEBU[0032] removed task host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeInspect server=helix-bear-vg service=cinder storageDriver=cinder task=0 tasksLen=0 time=1500447980586 tls=false txCR=1500447980 txID=f955789a-312f-4b9d-60e3-4de80a45d06a |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment
the log shows :
ERRO[0032] error attaching volume host=unix:///var/run/libstorage/451292995.sock inner=Resource not found instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 instanceId=c62d1c7a-65f4-4658-99de-d65dc99733c1 provider=cinder route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979812 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043 volumeId=54704d6a-c853-4bb1-b98c-8c08e33ee2c2
DEBU[0032] task completed host=unix:///var/run/libstorage/451292995.sock instanceID=cinder=c62d1c7a-65f4-4658-99de-d65dc99733c1 route=volumeAttach server=helix-bear-vg service=cinder storageDriver=cinder task=0 time=1500447979812 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043
ERRO[0032] error: api call failed error.volumeId=54704d6a-c853-4bb1-b98c-8c08e33ee2c2 error.instanceId=c62d1c7a-65f4-4658-99de-d65dc99733c1 error.provider=cinder host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979813 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043
DEBU[0032] api call error json apiErr={"message":"error attaching volume","status":500,"error":{"inner":"Resource not found","instanceId":"c62d1c7a-65f4-4658-99de-d65dc99733c1","provider":"cinder","volumeId":"54704d6a-c853-4bb1-b98c-8c08e33ee2c2"}} host=unix:///var/run/libstorage/451292995.sock route=volumeAttach server=helix-bear-vg time=1500447979813 tls=false txCR=1500447979 txID=84fef27b-ba59-4b07-6b65-66a81d3d7043