Skip to content

Instantly share code, notes, and snippets.

@akutz

akutz/efs-attach-invalid-security-group.log

Created October 29, 2016 18:54
Show Gist options
  • Save akutz/2877a8e21b6d1b7c64a00f35dbcd2f44 to your computer and use it in GitHub Desktop.
Save akutz/2877a8e21b6d1b7c64a00f35dbcd2f44 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
efs-attach-invalid-security-group.log
[root@ip-172-31-25-144 rexray]# LIBSTORAGE_LOGGING_HTTPREQUESTS=true LIBSTORAGE_LOGGING_HTTPRESPONSES=true rexray -l debug volume attach builds --service efs
INFO[0000] updated log level logLevel=debug
DEBU[0000] os.args time=1477767257331 val=[rexray -l debug volume attach builds --service efs]
DEBU[0000] activating libStorage cmd=attach time=1477767257331
DEBU[0000] is local tcp server active port=7979 time=1477767257332
DEBU[0000] not starting embeddded server; already running host=tcp://127.0.0.1:7979 time=1477767257333
DEBU[0000] created scoped scope new=libstorage.client parentScopes=rexray,
INFO[0000] configured logging host=tcp://127.0.0.1:7979 libstorage.logging.httpRequests=true libstorage.logging.httpResponses=true libstorage.logging.level=debug time=1477767257337
DEBU[0000] got configured host address host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257338
INFO[0000] created libStorage client clientType=integration disableKeepAlive=false enableInstanceIDHeaders=true enableLocalDevicesHeaders=true host=tcp://127.0.0.1:7979 logRequests=true logResponses=true lsxPath=/var/lib/libstorage/lsx-linux service=efs storageDriver=libstorage time=1477767257339
INFO[0000] lsx lock file path host=tcp://127.0.0.1:7979 path=/var/run/libstorage/lsx.lock service=efs storageDriver=libstorage time=1477767257339
INFO[0000]
INFO[0000] -------------------------- HTTP REQUEST (CLIENT) -------------------------
INFO[0000] GET /services HTTP/1.1
INFO[0000] Host: 127.0.0.1:7979
INFO[0000] Libstorage-Tx: txID=a98fac65-a848-4f25-738c-7d4a7e5f8780, txCR=1477767257
INFO[0000]
INFO[0000]
INFO[0000] -------------------------- HTTP RESPONSE (CLIENT) -------------------------
INFO[0000] HTTP/1.1 200 OK
INFO[0000] Content-Length: 308
INFO[0000] Content-Type: application/json
INFO[0000] Date: Sat, 29 Oct 2016 18:54:17 GMT
INFO[0000] Libstorage-Servername: island-pixie-nr
INFO[0000]
INFO[0000] {
INFO[0000] "ebs": {
INFO[0000] "name": "ebs",
INFO[0000] "driver": {
INFO[0000] "name": "ebs",
INFO[0000] "type": "block",
INFO[0000] "nextDevice": {
INFO[0000] "ignore": false,
INFO[0000] "prefix": "xvd",
INFO[0000] "pattern": "[f-p]"
INFO[0000] }
INFO[0000] }
INFO[0000] },
INFO[0000] "efs": {
INFO[0000] "name": "efs",
INFO[0000] "driver": {
INFO[0000] "name": "efs",
INFO[0000] "type": "nas"
INFO[0000] }
INFO[0000] }
INFO[0000] }
INFO[0000] initializing executors cache host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257346
INFO[0000]
INFO[0000] -------------------------- HTTP REQUEST (CLIENT) -------------------------
INFO[0000] GET /executors HTTP/1.1
INFO[0000] Host: 127.0.0.1:7979
INFO[0000] Libstorage-Tx: txID=8bf446a5-33d7-4dc2-6b0b-ae959a381a74, txCR=1477767257
INFO[0000]
INFO[0000]
INFO[0000] -------------------------- HTTP RESPONSE (CLIENT) -------------------------
INFO[0000] HTTP/1.1 200 OK
INFO[0000] Content-Length: 313
INFO[0000] Content-Type: application/json
INFO[0000] Date: Sat, 29 Oct 2016 18:54:17 GMT
INFO[0000] Libstorage-Servername: island-pixie-nr
INFO[0000]
INFO[0000] {
INFO[0000] "lsx-darwin": {
INFO[0000] "name": "lsx-darwin",
INFO[0000] "md5checksum": "08391c612204fa8b5e3e3688bad52964",
INFO[0000] "size": 9885664,
INFO[0000] "lastModified": 1477766074
INFO[0000] },
INFO[0000] "lsx-linux": {
INFO[0000] "name": "lsx-linux",
INFO[0000] "md5checksum": "6413153d8947c4a98b3ebd07708c0c07",
INFO[0000] "size": 10040729,
INFO[0000] "lastModified": 1477766000
INFO[0000] }
INFO[0000] }
DEBU[0000] updating executor host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257347
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257348
DEBU[0000] executor exists, getting local checksum host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257348
DEBU[0000] getting executor checksum host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257348
DEBU[0000] got local executor checksum host=tcp://127.0.0.1:7979 localChecksum=6413153d8947c4a98b3ebd07708c0c07 service=efs storageDriver=libstorage time=1477767257372
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257372
INFO[0000] initializing supported cache host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257372
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257372 txCR=1477767257 txID=35889202-eb05-4d82-7d3f-f91d733a145e
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257382 txCR=1477767257 txID=35889202-eb05-4d82-7d3f-f91d733a145e
DEBU[0000] cached supported flag host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage supported=true time=1477767257382 txCR=1477767257 txID=35889202-eb05-4d82-7d3f-f91d733a145e
INFO[0000] initializing instance ID cache host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257382
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257382 txCR=1477767257 txID=8ef5d946-4aeb-499d-681f-6e0829c69806
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257392 txCR=1477767257 txID=8ef5d946-4aeb-499d-681f-6e0829c69806
DEBU[0000] cached instanceID host=tcp://127.0.0.1:7979 instanceID=ebs=i-cddeaad5,availabilityZone=us-west-2a&region=us-west-2 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257393 txCR=1477767257 txID=8ef5d946-4aeb-499d-681f-6e0829c69806
DEBU[0000] xli instanceID success host=tcp://127.0.0.1:7979 instanceID=ebs=i-cddeaad5,availabilityZone=us-west-2a&region=us-west-2 server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257393 txCR=1477767257 txID=8ef5d946-4aeb-499d-681f-6e0829c69806
INFO[0000] initializing supported cache host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257393
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257393 txCR=1477767257 txID=6a4486e0-fa1d-4b68-57e4-f60e846a18c7
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257402 txCR=1477767257 txID=6a4486e0-fa1d-4b68-57e4-f60e846a18c7
DEBU[0000] cached supported flag host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage supported=true time=1477767257402 txCR=1477767257 txID=6a4486e0-fa1d-4b68-57e4-f60e846a18c7
INFO[0000] initializing instance ID cache host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257402
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257402 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257412 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
DEBU[0000] sending instanceID in API.InstanceInspect call host=tcp://127.0.0.1:7979 instanceID=efs=,,InN1Ym5ldC02YTY2MTgwZiI= server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257412 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
INFO[0000]
INFO[0000] -------------------------- HTTP REQUEST (CLIENT) -------------------------
INFO[0000] GET /services/efs?instance HTTP/1.1
INFO[0000] Host: 127.0.0.1:7979
INFO[0000] Libstorage-Instanceid: efs=,,InN1Ym5ldC02YTY2MTgwZiI=
INFO[0000] Libstorage-Tx: txID=ba6b23de-4837-40b3-75d3-fefc974b62c0, txCR=1477767257
INFO[0000]
INFO[0000]
INFO[0000] -------------------------- HTTP RESPONSE (CLIENT) -------------------------
INFO[0000] HTTP/1.1 200 OK
INFO[0000] Content-Length: 199
INFO[0000] Content-Type: application/json
INFO[0000] Date: Sat, 29 Oct 2016 18:54:17 GMT
INFO[0000] Libstorage-Servername: island-pixie-nr
INFO[0000]
INFO[0000] {
INFO[0000] "name": "efs",
INFO[0000] "instance": {
INFO[0000] "instanceID": {
INFO[0000] "id": "subnet-6a66180f",
INFO[0000] "driver": "efs"
INFO[0000] },
INFO[0000] "providerName": ""
INFO[0000] },
INFO[0000] "driver": {
INFO[0000] "name": "efs",
INFO[0000] "type": "nas"
INFO[0000] }
INFO[0000] }
DEBU[0000] received instanceID from API.InstanceInspect call host=tcp://127.0.0.1:7979 instanceID=efs=,,InN1Ym5ldC02YTY2MTgwZiI= server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257415 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
DEBU[0000] cached instanceID host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257415 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
DEBU[0000] xli instanceID success host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257415 txCR=1477767257 txID=ba6b23de-4837-40b3-75d3-fefc974b62c0
INFO[0000] successefully dialed libStorage server host=tcp://127.0.0.1:7979 server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257415
INFO[0000] storage driver initialized host=tcp://127.0.0.1:7979 service=efs storageDriver=libstorage time=1477767257415
INFO[0000] os driver initialized host=tcp://127.0.0.1:7979 osDriver=linux service=efs storageDriver=libstorage time=1477767257416
INFO[0000] docker integration driver successfully initialized host=tcp://127.0.0.1:7979 integrationDriver=docker libstorage.integration.volume.operations.create.default.IOPS= libstorage.integration.volume.operations.create.default.availabilityZone= libstorage.integration.volume.operations.create.default.fsType=ext4 libstorage.integration.volume.operations.create.default.size=16 libstorage.integration.volume.operations.create.default.type= libstorage.integration.volume.operations.create.implicit=true libstorage.integration.volume.operations.mount.path=/var/lib/rexray/volumes libstorage.integration.volume.operations.mount.rootPath=/data osDriver=linux service=efs storageDriver=libstorage time=1477767257417
INFO[0000] path cache initializion disabled host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux service=efs storageDriver=libstorage time=1477767257418
INFO[0000] libStorage integration driver successfully initialized host=tcp://127.0.0.1:7979 integrationDriver=docker libstorage.integration.volume.operations.create.disable=false libstorage.integration.volume.operations.mount.preempt=false libstorage.integration.volume.operations.path.cache.async=true libstorage.integration.volume.operations.path.cache.enabled=false libstorage.integration.volume.operations.remove.disable=false libstorage.integration.volume.operations.unmount.ignoreusedcount=false osDriver=linux service=efs storageDriver=libstorage time=1477767257418
INFO[0000] integration driver initialized host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux service=efs storageDriver=libstorage time=1477767257418
INFO[0000] created libStorage client host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux service=efs storageDriver=libstorage time=1477767257418
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257419 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257427 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
DEBU[0000] xli localdevices success host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257428 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257428 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257438 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
DEBU[0000] xli localdevices success host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257438 txCR=1477767257 txID=a427e5b9-f283-4ea7-4895-9883525245fb
INFO[0000]
INFO[0000] -------------------------- HTTP REQUEST (CLIENT) -------------------------
INFO[0000] GET /volumes/efs?attachments=false HTTP/1.1
INFO[0000] Host: 127.0.0.1:7979
INFO[0000] Libstorage-Instanceid: efs=subnet-6a66180f
INFO[0000] Libstorage-Localdevices: efs=/dev/xvda1::/var/lib/docker/devicemapper,cgroup::/sys/fs/cgroup/blkio,configfs::/sys/kernel/config,debugfs::/sys/kernel/debug,devpts::/dev/pts,devtmpfs::/dev,hugetlbfs::/dev/hugepages,mqueue::/dev/mqueue,nfsd::/proc/fs/nfsd,proc::/proc,pstore::/sys/fs/pstore,rpc_pipefs::/var/lib/nfs/rpc_pipefs,securityfs::/sys/kernel/security,selinuxfs::/sys/fs/selinux,sysfs::/sys,systemd-1::/proc/sys/fs/binfmt_misc,tmpfs::/run/user/1000
INFO[0000] Libstorage-Localdevices: ebs=/dev/xvda::/dev/xvda
INFO[0000] Libstorage-Tx: txID=a427e5b9-f283-4ea7-4895-9883525245fb, txCR=1477767257
INFO[0000]
INFO[0000]
INFO[0000] -------------------------- HTTP RESPONSE (CLIENT) -------------------------
INFO[0000] HTTP/1.1 200 OK
INFO[0000] Content-Length: 106
INFO[0000] Content-Type: application/json
INFO[0000] Date: Sat, 29 Oct 2016 18:54:17 GMT
INFO[0000] Libstorage-Servername: island-pixie-nr
INFO[0000]
INFO[0000] {
INFO[0000] "fs-03ec16aa": {
INFO[0000] "name": "builds",
INFO[0000] "size": 6144,
INFO[0000] "id": "fs-03ec16aa",
INFO[0000] "type": ""
INFO[0000] }
INFO[0000] }
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257645 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257655 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] xli nextdevice success host=tcp://127.0.0.1:7979 integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257655 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257655 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257664 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] xli localdevices success host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=efs storageDriver=libstorage time=1477767257665 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] waiting on executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257665 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] signalling executor lock host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257674 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
DEBU[0000] xli localdevices success host=tcp://127.0.0.1:7979 instanceID=efs=subnet-6a66180f integrationDriver=docker osDriver=linux server=island-pixie-nr service=ebs storageDriver=libstorage time=1477767257674 txCR=1477767257 txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2
INFO[0000]
INFO[0000] -------------------------- HTTP REQUEST (CLIENT) -------------------------
INFO[0000] POST /volumes/efs/fs-03ec16aa?attach HTTP/1.1
INFO[0000] Host: 127.0.0.1:7979
INFO[0000] Libstorage-Instanceid: efs=subnet-6a66180f
INFO[0000] Libstorage-Localdevices: ebs=/dev/xvda::/dev/xvda
INFO[0000] Libstorage-Localdevices: efs=/dev/xvda1::/var/lib/docker/devicemapper,cgroup::/sys/fs/cgroup/blkio,configfs::/sys/kernel/config,debugfs::/sys/kernel/debug,devpts::/dev/pts,devtmpfs::/dev,hugetlbfs::/dev/hugepages,mqueue::/dev/mqueue,nfsd::/proc/fs/nfsd,proc::/proc,pstore::/sys/fs/pstore,rpc_pipefs::/var/lib/nfs/rpc_pipefs,securityfs::/sys/kernel/security,selinuxfs::/sys/fs/selinux,sysfs::/sys,systemd-1::/proc/sys/fs/binfmt_misc,tmpfs::/run/user/1000
INFO[0000] Libstorage-Tx: txID=8be956ed-d0c7-4bcd-5d9a-628a073694f2, txCR=1477767257
INFO[0000]
INFO[0000] {}
INFO[0000]
INFO[0000] -------------------------- HTTP RESPONSE (CLIENT) -------------------------
INFO[0000] HTTP/1.1 500 Internal Server Error
INFO[0000] Content-Length: 269
INFO[0000] Content-Type: application/json
INFO[0000] Date: Sat, 29 Oct 2016 18:54:17 GMT
INFO[0000] Libstorage-Servername: island-pixie-nr
INFO[0000]
INFO[0000] {
INFO[0000] "message": "BadRequest: invalid security group ID: \n\tstatus code: 400, request id: 1815b999-9e09-11e6-b01a-d723e26903fe",
INFO[0000] "status": 500,
INFO[0000] "error": "BadRequest: invalid security group ID: \n\tstatus code: 400, request id: 1815b999-9e09-11e6-b01a-d723e26903fe"
INFO[0000] }
DEBU[0000] built output template host=tcp://127.0.0.1:7979 template={{define "printObject"}}{{printf "%v" .}}{{end}}{{define "printJSON"}}{{. | json}}{{end}}{{define "printPrettyJSON"}}{{. | jsonp}}{{end}}{{define "printVolumeID"}}{{.ID}}{{end}}{{define "printVolumeFields"}}{{.ID}} {{.Name}} {{. | volumeStatus}} {{.Size}}{{end}}{{define "printVolumeWithPathFields"}}{{.ID}} {{.Name}} {{.Volume | volumeStatus}} {{.Size}} {{.Path}}{{end}}{{define "printServiceFields"}}{{.Name}} {{.Driver.Name}}{{end}}{{define "printStringSlice"}}{{.}}{{end}}{{define "printSnapshotFields"}}{{.ID}} {{.Name}} {{.Status}} {{.VolumeID}}{{end}}{{define "printInstanceFields"}}{{.InstanceID.ID}} {{.Name}} {{.ProviderName}} {{.Region}}{{end}}{{define "printMountFields"}}{{.ID}} {{.Source}} {{.MountPoint}}{{end}}ID Name Status Size
{{range sort .D "Name" }}{{template "printVolumeFields" .}}
{{end}} time=1477767257760
ID Name Status Size
FATA[0000] error attaching volume error.status=500 volume=builds
[root@ip-172-31-25-144 rexray]#
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment