Skip to content

Instantly share code, notes, and snippets.

@BFMeenink
Created September 30, 2019 14:07
Show Gist options
  • Save BFMeenink/1465f6e045a1c60168724a84e60435a3 to your computer and use it in GitHub Desktop.
Save BFMeenink/1465f6e045a1c60168724a84e60435a3 to your computer and use it in GitHub Desktop.
The logging of the RexRay docker plugin upon install
Sep 30 13:25:45 prod-1-worker-10.0.21.50 env[1290]: time="2019-09-30T13:25:45Z" level=info msg="shim containerd-shim started" address="/containerd-shim/plugins.moby/47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f/shim.sock" debug=true pid=4383
Sep 30 13:25:45 prod-1-worker-10.0.21.50 env[1290]: time="2019-09-30T13:25:45Z" level=debug msg="registering ttrpc server"
Sep 30 13:25:45 prod-1-worker-10.0.21.50 env[1290]: time="2019-09-30T13:25:45Z" level=debug msg="serving api on unix socket" socket="[inherited from parent]"
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=DockerLegacyMode enabled=true time=1569849946071 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"trapped signals\" time=1569849946072 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"loading config\" buildType=\"client+agent+controller\" configFileName=rexray globalConfigFileExists=true globalConfigFilePath=\"/etc/rexray/rexray.yml\" ignoreExists=false time=1569849946072 userConfigFileExists=false userConfigFilePath=\"/root/.rexray/rexray.yml\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"validating global config\" buildType=\"client+agent+controller\" configFileName=rexray globalConfigFileExists=true globalConfigFilePath=\"/etc/rexray/rexray.yml\" ignoreExists=false time=1569849946072 userConfigFileExists=false userConfigFilePath=\"/root/.rexray/rexray.yml\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"created new config\" buildType=\"client+agent+controller\" configFileName=rexray globalConfigFileExists=true globalConfigFilePath=\"/etc/rexray/rexray.yml\" ignoreExists=false time=1569849946072 userConfigFileExists=false userConfigFilePath=\"/root/.rexray/rexray.yml\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"initializing configuration\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"loading yaml for Global\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"loading yaml for CSI\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"loading global config file\" path=\"/etc/rexray/rexray.yml\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"usage template path\" path=\"/root/.rexray/usage.template\" time=1569849946076 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"loaded usage template\" source=UsageTemplate time=1569849946076 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"updating log level\" level=debug time=1569849946078 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"updated log level\" logLevel=debug " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=os.args time=1569849946079 val=[rexray start -f --nopid] " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"host is empty; initiliazing default services\" time=1569849946083 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"libStorage auto service mode disabled; services defined\" time=1569849946086 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"starting embedded libStorage server\" time=1569849946086 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=info msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"created scoped scope\" new=libstorage.server parentScopes=\"rexray,\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"configured logging\" libstorage.logging.httpRequests=false libstorage.logging.httpResponses=false libstorage.logging.level=debug server=malachite-sight-ad time=1569849946107 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.disabled=false server=malachite-sight-ad time=1569849946113 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.key= server=malachite-sight-ad time=1569849946118 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.alg=HS256 server=malachite-sight-ad time=1569849946121 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.allow=[] server=malachite-sight-ad time=1569849946137 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.deny=[] server=malachite-sight-ad time=1569849946141 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"configured global auth\" libstorage.server.auth.alg=HS256 libstorage.server.auth.allow=[] libstorage.server.auth.deny=[] libstorage.server.auth.disabled=false libstorage.server.auth.key= server=malachite-sight-ad time=1569849946141 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initializing server\" server=malachite-sight-ad time=1569849946142 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initializing server services\" server=malachite-sight-ad time=1569849946142 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"configured result schema validation\" enabled=false server=malachite-sight-ad time=1569849946144 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"got services map\" count=1 server=malachite-sight-ad time=1569849946148 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"processing service config\" server=malachite-sight-ad service=s3fs time=1569849946150 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"getting scoped config for service\" scope=libstorage.server.services.s3fs server=malachite-sight-ad service=s3fs time=1569849946150 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=info msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"created scoped scope\" new=libstorage.server.services.s3fs parentScopes=\"libstorage.server,rexray,\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"got driver name\" driverName=s3fs server=malachite-sight-ad service=s3fs time=1569849946153 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"getting s3 service connection\" region=eu-west-1 server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849946181 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"creating new s3 service connection\" region=eu-west-1 server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849946181 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"s3 connection created\" region=eu-west-1 server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849946183 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"DEBUG: Request s3/ListBuckets Details:\\n---[ REQUEST POST-SIGN ]-----------------------------\\nGET / HTTP/1.1\\r\\nHost: s3.eu-west-1.amazonaws.com\\r\\nUser-Agent: aws-sdk-go/1.12.46 (go1.9.1; linux; amd64)\\r\\nAuthorization: AWS4-HMAC-SHA256 Credential=<access key>/20190930/eu-west-1/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=0047884142a818270b2ee3b6bba6f066fcfb1be6279d553ef4b4eab8eaa1d20e\\r\\nX-Amz-Content-Sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855\\r\\nX-Amz-Date: 20190930T132546Z\\r\\nAccept-Encoding: gzip\\r\\n\\r\\n\\n-----------------------------------------------------\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"DEBUG: Response s3/ListBuckets Details:\\n---[ RESPONSE ]--------------------------------------\\nHTTP/1.1 200 OK\\r\\nTransfer-Encoding: chunked\\r\\nContent-Type: application/xml\\r\\nDate: Mon, 30 Sep 2019 13:25:47 GMT\\r\\nServer: AmazonS3\\r\\nX-Amz-Id-2: NRgvTNTYCA6iycBUe8MFD2Ww7Wu/Ennb0B6+yBNJVmc409DuZ4tc6L62aZtJxfJwiOHwblsnG2Q=\\r\\nX-Amz-Request-Id: F402D8D7734610DF\\r\\n\\r\\n\\n-----------------------------------------------------\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"<?xml version=\\\"1.0\\\" encoding=\\\"UTF-8\\\"?>\\n<ListAllMyBucketsResult xmlns=\\\"http://s3.amazonaws.com/doc/2006-03-01/\\\"><Owner><ID>98c8041cb8ad8a1d20c5a06c7980acf116e8308453101f4f0ca54be4011c599a</ID><DisplayName><team-name>+aws-<client></DisplayName></Owner><Buckets><Bucket><Name>remote-s3-bucket2</Name><CreationDate>2019-05-21T10:53:24.000Z</CreationDate></Bucket><Bucket><Name>remote-s3-bucket3</Name><CreationDate>2019-05-21T10:28:05.000Z</CreationDate></Bucket><Bucket><Name>remote-s3-bucket1</Name><CreationDate>2019-05-22T08:43:27.000Z</CreationDate></Bucket></Buckets></ListAllMyBucketsResult>\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"s3 connection successful\" region=eu-west-1 server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849946445 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"storage driver initialized\" accessKey=<access key> disablePathStyle=false endpoint= maxRetries=10 region=eu-west-1 secretKey=\"******\" server=malachite-sight-ad service=s3fs storageDriver=s3fs tag= time=1569849946446 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.disabled=false server=malachite-sight-ad service=s3fs time=1569849946463 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.key= server=malachite-sight-ad service=s3fs time=1569849946471 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.alg=HS256 server=malachite-sight-ad service=s3fs time=1569849946478 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.allow=[] server=malachite-sight-ad service=s3fs time=1569849946487 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"parsed server auth property\" libstorage.server.auth.deny=[] server=malachite-sight-ad service=s3fs time=1569849946493 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"configured service auth\" libstorage.server.auth.alg=HS256 libstorage.server.auth.allow=[] libstorage.server.auth.deny=[] libstorage.server.auth.disabled=false libstorage.server.auth.key= server=malachite-sight-ad service=s3fs time=1569849946493 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"created new service\" server=malachite-sight-ad service=s3fs time=1569849946494 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized services\" server=malachite-sight-ad time=1569849946494 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initializing default endpoint\" autoEndpointMode=unix server=malachite-sight-ad time=1569849946497 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initializing auto unix endpoint\" endpoint=libstorage.server.endpoints.localhost server=malachite-sight-ad time=1569849946500 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"endpoint info\" address=\"unix:///var/run/rexray/508982324.sock\" endpoint=libstorage.server.endpoints.localhost server=malachite-sight-ad time=1569849946500 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"disabling tls for unix sockets\" server=malachite-sight-ad time=1569849946500 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"configured endpoint\" address=\"unix:///var/run/rexray/508982324.sock\" endpoint=localhost server=malachite-sight-ad time=1569849946500 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"server created\" server=malachite-sight-ad time=1569849946501 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized endpoints\" server=malachite-sight-ad time=1569849946501 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=4 router=help-router server=malachite-sight-ad time=1569849946501 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=1 router=root-router server=malachite-sight-ad time=1569849946501 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=2 router=service-router server=malachite-sight-ad time=1569849946501 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=11 router=volume-router server=malachite-sight-ad time=1569849946502 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=6 router=snapshot-router server=malachite-sight-ad time=1569849946502 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"initialized router\" len(routes)=2 router=tasks-router server=malachite-sight-ad time=1569849946502 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/help\" queries=[] route=version server=malachite-sight-ad time=1569849946502 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/help/config\" queries=[] route=version server=malachite-sight-ad time=1569849946502 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/help/env\" queries=[] route=version server=malachite-sight-ad time=1569849946503 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/help/version\" queries=[] route=version server=malachite-sight-ad time=1569849946503 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/\" queries=[] route=root server=malachite-sight-ad time=1569849946503 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/services\" queries=[] route=services server=malachite-sight-ad time=1569849946503 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/services/{service}\" queries=[] route=serviceInspect server=malachite-sight-ad time=1569849946503 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/volumes\" queries=[] route=volumes server=malachite-sight-ad time=1569849946504 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/volumes/{service}\" queries=[] route=volumesForService server=malachite-sight-ad time=1569849946504 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/volumes/{service}/{volumeID}\" queries=[] route=volumeInspect server=malachite-sight-ad time=1569849946504 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes/{service}\" queries=[detach ] route=volumesDetachForService server=malachite-sight-ad time=1569849946504 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=POST path=\"/volumes/{service}\" queries=[] route=volumeCreate server=malachite-sight-ad time=1569849946505 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes/{service}/{volumeID}\" queries=[copy ] route=volumeCopy server=malachite-sight-ad time=1569849946505 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes/{service}/{volumeID}\" queries=[snapshot ] route=volumeSnapshot server=malachite-sight-ad time=1569849946505 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes/{service}/{volumeID}\" queries=[attach ] route=volumeAttach server=malachite-sight-ad time=1569849946505 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes\" queries=[detach ] route=volumesDetachAll server=malachite-sight-ad time=1569849946505 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/volumes/{service}/{volumeID}\" queries=[detach ] route=volumeDetach server=malachite-sight-ad time=1569849946506 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=DELETE path=\"/volumes/{service}/{volumeID}\" queries=[] route=volumeRemove server=malachite-sight-ad time=1569849946506 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/snapshots\" queries=[] route=snapshots server=malachite-sight-ad time=1569849946506 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/snapshots/{service}\" queries=[] route=snapshotsForService server=malachite-sight-ad time=1569849946506 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/snapshots/{service}/{snapshotID}\" queries=[] route=snapshotInspect server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/snapshots/{service}/{snapshotID}\" queries=[create ] route=snapshotCreate server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=2 method=POST path=\"/snapshots/{service}/{snapshotID}\" queries=[copy ] route=snapshotCopy server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=DELETE path=\"/snapshots/{service}/{snapshotID}\" queries=[] route=snapshotRemove server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/tasks\" queries=[] route=tasks server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=debug msg=\"registered route\" host=\"unix:///var/run/rexray/508982324.sock\" len(queries)=0 method=GET path=\"/tasks/{taskID}\" queries=[] route=taskInspect server=malachite-sight-ad time=1569849946507 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"waiting for err or close signal\" server=malachite-sight-ad time=1569849946508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:46 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:46Z" level=error msg="time=\"2019-09-30T13:25:46Z\" level=info msg=\"api listening\" host=\"unix:///var/run/rexray/508982324.sock\" server=malachite-sight-ad time=1569849946508 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"server started\" server=malachite-sight-ad time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got host from new server address server.Addrs()[0]\" specHost=\"unix:///var/run/rexray/508982324.sock\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"parseSafeHost - no change\" postParse=\"unix:///var/run/rexray/508982324.sock\" preParse=\"unix:///var/run/rexray/508982324.sock\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got host from new server address; updated\" specHost=\"unix:///var/run/rexray/508982324.sock\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"set host in context\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"set host in config\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"created scoped scope\" new=rexray.agent parentScopes=\"rexray,\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"created spec file\" host=\"unix:///var/run/rexray/508982324.sock\" path=\"/var/run/rexray/rexray.spec\" time=1569849947508 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"libStorage context cancellation - waiting\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947520 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"not starting embedded server; embedded mode disabled\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947522 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got modules map\" count=1 host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947524 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"rexray modules\" host=\"unix:///var/run/rexray/508982324.sock\" map=map[default-csi:map[type:csi desc:The default CSI module. host:/run/docker/plugins/rexray.sock disabled:false]] time=1569849947524 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"processing module config\" host=\"unix:///var/run/rexray/508982324.sock\" name=default-csi time=1569849947524 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"created scoped scope\" new=rexray.modules.default-csi parentScopes=\"rexray.agent,rexray,\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"created new mod config\" addr=\"/run/docker/plugins/rexray.sock\" desc=\"The default CSI module.\" host=\"unix:///var/run/rexray/508982324.sock\" name=default-csi time=1569849947534 type=csi " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got configured modules\" host=\"unix:///var/run/rexray/508982324.sock\" len(modConfigs)=1 time=1569849947534 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"creating libStorage client for module instance\" host=\"unix:///var/run/rexray/508982324.sock\" name=default-csi time=1569849947536 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"created scoped scope\" new=libstorage.client parentScopes=\"rexray.modules.default-csi,rexray.agent,rexray,\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"configured logging\" host=\"unix:///var/run/rexray/508982324.sock\" libstorage.logging.httpRequests=false libstorage.logging.httpResponses=false libstorage.logging.level=debug time=1569849947664 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"set client service name\" host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs serviceName=s3fs time=1569849947671 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got configured host address\" host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs storageDriver=libstorage time=1569849947681 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"disabling tls for unix sockets\" host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs storageDriver=libstorage time=1569849947685 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"getHost proto == \\\"unix\\\"\" getHost=libstorage-server host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs storageDriver=libstorage time=1569849947685 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"created libStorage client\" clientType=integration disableKeepAlive=false enableInstanceIDHeaders=true enableLocalDevicesHeaders=true host=\"unix:///var/run/rexray/508982324.sock\" lAddr=libstorage-server logRequests=false logResponses=false lsxPath= service=s3fs storageDriver=libstorage time=1569849947737 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"registered custom context key\" externalID=Libstorage-Tx internalID=2 keyBitmask=2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"registered custom context key\" externalID=Libstorage-Instanceid internalID=3 keyBitmask=2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"registered custom context key\" externalID=Libstorage-Localdevices internalID=4 keyBitmask=2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"registered custom context key\" externalID=Authorization internalID=5 keyBitmask=2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"successful connection\" host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs storageDriver=libstorage time=1569849947737 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"http request\" host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947738 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=schema-validator route=services server=malachite-sight-ad time=1569849947739 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=auth-svc-handler route=services server=malachite-sight-ad time=1569849947739 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=transaction-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=local-devices-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=instanceIDs-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=auth-global-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=error-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=transaction-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=query-params-handler route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Tx=\"txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5, txCR=1569849947\" host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947740 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"skipping global auth handler; empty allow & deny lists\" host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947741 tls=false txCR=1569849947 txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Instanceid=[] host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947741 tls=false txCR=1569849947 txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Localdevices=[] host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947742 tls=false txCR=1569849947 txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"skipping svc auth handler; empty allow & deny lists\" host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947742 tls=false txCR=1569849947 txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"validated all services access\" host=\"unix:///var/run/rexray/508982324.sock\" route=services server=malachite-sight-ad time=1569849947742 tls=false txCR=1569849947 txID=945ad3d5-87ac-4ebb-7f24-c6d295b906e5 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"initializing supported cache\" host=\"unix:///var/run/rexray/508982324.sock\" server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947742 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"storage executor initialized\" cmd=s3fs driver=s3fs host=\"unix:///var/run/rexray/508982324.sock\" opts=[allow_other,iam_role=auto,umask=000] server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947750 txCR=1569849947 txID=00d8d522-ef2a-4b03-7662-a0a969a7bdfe " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"cached supported flag\" host=\"unix:///var/run/rexray/508982324.sock\" server=malachite-sight-ad service=s3fs storageDriver=libstorage supported=95 time=1569849947751 txCR=1569849947 txID=00d8d522-ef2a-4b03-7662-a0a969a7bdfe " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"initializing instance ID cache\" host=\"unix:///var/run/rexray/508982324.sock\" server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947751 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"storage executor initialized\" cmd=s3fs driver=s3fs host=\"unix:///var/run/rexray/508982324.sock\" opts=[allow_other,iam_role=auto,umask=000] server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947766 txCR=1569849947 txID=010e8c87-6864-4a05-5c68-f295bd5535ca " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"cached instanceID\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947767 txCR=1569849947 txID=010e8c87-6864-4a05-5c68-f295bd5535ca " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"xli instanceID success\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947767 txCR=1569849947 txID=010e8c87-6864-4a05-5c68-f295bd5535ca " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"successefully dialed libStorage server\" host=\"unix:///var/run/rexray/508982324.sock\" server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947768 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"storage driver initialized\" host=\"unix:///var/run/rexray/508982324.sock\" service=s3fs storageDriver=libstorage time=1569849947768 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"os driver initialized\" host=\"unix:///var/run/rexray/508982324.sock\" osDriver=linux service=s3fs storageDriver=libstorage time=1569849947774 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"linux integration driver successfully initialized\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux libstorage.integration.volume.operations.create.default.IOPS=0 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=s3fs storageDriver=libstorage time=1569849947824 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"initializing the path cache\" async=true host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947863 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"listing volumes\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux opts=map[attachments:true] osDriver=linux service=s3fs storageDriver=libstorage time=1569849947863 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"storage executor initialized\" cmd=s3fs driver=s3fs host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" integrationDriver=linux opts=[allow_other,iam_role=auto,umask=000] osDriver=linux server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947881 txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"xli localdevices success\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" integrationDriver=linux osDriver=linux server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947883 txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"http request\" host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=schema-validator route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=storage-session-handler route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=auth-svc-handler route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added route middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=service-validator route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=transaction-handler route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=local-devices-handler route=volumesForService server=malachite-sight-ad time=1569849947885 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=instanceIDs-handler route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=auth-global-handler route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=error-handler route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=transaction-handler route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"added global middleware\" host=\"unix:///var/run/rexray/508982324.sock\" middleware=query-params-handler route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"query param\" host=\"unix:///var/run/rexray/508982324.sock\" key=attachments len(value)=1 route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false value=[15] " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Tx=\"txID=b7732978-4beb-4729-550d-ace74a29cb29, txCR=1569849947\" host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"skipping global auth handler; empty allow & deny lists\" host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad time=1569849947886 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Instanceid=[s3fs=prod-1-worker-10.0.21.50] host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"http header\" Libstorage-Localdevices=[s3fs=] host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"getting storage service\" host=\"unix:///var/run/rexray/508982324.sock\" route=volumesForService server=malachite-sight-ad service=s3fs time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"skipping svc auth handler; empty allow & deny lists\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"driver is not StorageDriverWithLogin\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"getting task service\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849947887 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"executing task\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947908 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"querying volumes\" attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947908 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"getting s3 service connection\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" region=eu-west-1 route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947909 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"got existing s3 service connection\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" region=eu-west-1 route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947909 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"DEBUG: Request s3/ListBuckets Details:\\n---[ REQUEST POST-SIGN ]-----------------------------\\nGET / HTTP/1.1\\r\\nHost: s3.eu-west-1.amazonaws.com\\r\\nUser-Agent: aws-sdk-go/1.12.46 (go1.9.1; linux; amd64)\\r\\nAuthorization: AWS4-HMAC-SHA256 Credential=<access key>/20190930/eu-west-1/s3/aws4_request, SignedHeaders=host;x-amz-content-sha256;x-amz-date, Signature=8bbe030df45f9e6508acada3ceea088c3666bae35d5abfae21022772a41db0c6\\r\\nX-Amz-Content-Sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855\\r\\nX-Amz-Date: 20190930T132547Z\\r\\nAccept-Encoding: gzip\\r\\n\\r\\n\\n-----------------------------------------------------\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"getting task service\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs time=1569849947912 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"DEBUG: Response s3/ListBuckets Details:\\n---[ RESPONSE ]--------------------------------------\\nHTTP/1.1 200 OK\\r\\nTransfer-Encoding: chunked\\r\\nContent-Type: application/xml\\r\\nDate: Mon, 30 Sep 2019 13:25:48 GMT\\r\\nServer: AmazonS3\\r\\nX-Amz-Id-2: 864simRFYsoYF/H5LvSaJpeY1jhzK7jHVmwdTRl2abFreo1V7tKyaUo7DgG9hmMm6fxxCz+3ulY=\\r\\nX-Amz-Request-Id: 5E714C887B86D78C\\r\\n\\r\\n\\n-----------------------------------------------------\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"<?xml version=\\\"1.0\\\" encoding=\\\"UTF-8\\\"?>\\n<ListAllMyBucketsResult xmlns=\\\"http://s3.amazonaws.com/doc/2006-03-01/\\\"><Owner><ID>98c8041cb8ad8a1d20c5a06c7980acf116e8308453101f4f0ca54be4011c599a</ID><DisplayName><team-name>+aws-<client></DisplayName></Owner><Buckets><Bucket><Name>remote-s3-bucket2</Name><CreationDate>2019-05-21T10:53:24.000Z</CreationDate></Bucket><Bucket><Name>remote-s3-bucket3</Name><CreationDate>2019-05-21T10:28:05.000Z</CreationDate></Bucket><Bucket><Name>remote-s3-bucket1</Name><CreationDate>2019-05-22T08:43:27.000Z</CreationDate></Bucket></Buckets></ListAllMyBucketsResult>\" " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"manually calculating attachment state\" attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket2 volumeName=remote-s3-bucket2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"including volume\" attachmentState=attached attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket2 volumeName=remote-s3-bucket2 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"manually calculating attachment state\" attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket3 volumeName=remote-s3-bucket3 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"including volume\" attachmentState=attached attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket3 volumeName=remote-s3-bucket3 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"manually calculating attachment state\" attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket1 volumeName=remote-s3-bucket1 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"including volume\" attachmentState=attached attachments=15 host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 volumeID=remote-s3-bucket1 volumeName=remote-s3-bucket1 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"skipping response schema validation; disabled\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"task completed\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 time=1569849947923 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"removing task\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" removedAfter=0s route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 tasksLen=1 time=1569849947930 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"removed task\" host=\"unix:///var/run/rexray/508982324.sock\" instanceID=\"s3fs=prod-1-worker-10.0.21.50\" route=volumesForService server=malachite-sight-ad service=s3fs storageDriver=s3fs task=0 tasksLen=0 time=1569849947930 tls=false txCR=1569849947 txID=b7732978-4beb-4729-550d-ace74a29cb29 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"initialized the path cache\" async=true host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947936 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"libStorage integration driver successfully initialized\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux 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=true libstorage.integration.volume.operations.remove.disable=false libstorage.integration.volume.operations.unmount.ignoreusedcount=false osDriver=linux service=s3fs storageDriver=libstorage time=1569849947953 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"integration driver initialized\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947960 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"created libStorage client\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947961 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"initializing module instance\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux name=default-csi osDriver=linux storageDriver=libstorage time=1569849947961 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"set mod service name\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs serviceName=s3fs storageDriver=libstorage time=1569849947963 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"configuring csi module's driver\" csi.driver=libstorage host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux mod.name=default-csi osDriver=linux service=s3fs storageDriver=libstorage time=1569849947965 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"initialized module instance\" address=\"/run/docker/plugins/rexray.sock\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux name=default-csi osDriver=linux service=s3fs storageDriver=libstorage time=1569849947965 typeName=csi " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"multiplexed csi+docker endpoint\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs sockFile=\"/run/docker/plugins/rexray.sock\" storageDriver=libstorage time=1569849947970 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"mod-csi: docker mode: legacy\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947971 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"docker-legacy: created Docker legacy endpoint\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947971 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"init csi libstorage bridge w ctx.config\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux service=s3fs storageDriver=libstorage time=1569849947971 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=debug msg=\"found cached instance ID\" host=\"unix:///var/run/rexray/508982324.sock\" integrationDriver=linux osDriver=linux server=malachite-sight-ad service=s3fs storageDriver=libstorage time=1569849947973 txCR=1569849947 txID=dfa44877-8bc0-4832-7140-74f176c660cd " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"started module\" address=\"/run/docker/plugins/rexray.sock\" host=\"unix:///var/run/rexray/508982324.sock\" name=default-csi time=1569849947975 typeName=csi " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"agent successfully initialized, waiting on stop signal\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947975 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ⌐▄Q▓▄Ç▓▄,▄_" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" Σ▄▓▓▓▓▓▓▓▓▓▓▄π" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ╒▓▓▌▓▓▓▓▓▓▓▓▓▓▀▓▄▄." plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ,_▄▀▓▓ ▓▓ ▓▓▓▓▓▓▓▓▓▓▓█" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" │▄▓▓ _▓▓▓▓▓▓▓▓▓┌▓▓▓▓▓█" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" _J┤▓▓▓▓▓▓▓▓▓▓▓▓▓├█▓█▓▀Γ" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ,▄▓▓▓▓▓▓^██▓▓▓▓▓▓▓▓▓▓▓▓▄▀▄▄▓▓Ω▄" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" F▌▓▌█ⁿⁿⁿ ⁿ└▀ⁿ██▓▀▀▀▀▀▀▀▀▀▀▌▓▓▓▌" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" 'ⁿ_ ,▄▄▄▄▄▄▄▄▄█_▄▄▄▄▄▄▄▄▄ⁿ▀~██" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" Γ ├▓▓▓▓▓█▀ⁿ█▌▓Ω]█▓▓▓▓▓▓ ├▓" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" │ ├▓▓▓▓▓▌≡,__▄▓▓▓█▓▓▓▓▓ ╞█~ Y,┐" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ╞ ├▓▓▓▓▓▄▄__^^▓▓▓▌▓▓▓▓▓ ▓ /▓▓▓" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ├▓▓▓▓▓▓▓▄▄═▄▓▓▓▓▓▓▓▓▓ π ⌐▄▓▓█║n" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" _ ├▓▓▓▓▓▓▓▓▓~▓▓▓▓▓▓▓▓▓▓ ▄4▄▓▓▓██" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" µ ├▓▓▓▓█▀█▓▓_▓▓███▓▓▓▓▓ ▓▓▓▓▓Ω4" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" µ ├▓▀▀L └ⁿ ▀ ▀ ▓▓█w ▓▓▓▀ìⁿ" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ⌐ ├_ τ▀▓ Σ⌐└" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ~ ├▓▓ ▄ _ ╒ ┌▄▓▓ Γ" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ├▓▓▓▌█═┴▓▄╒▀▄_▄▌═¢▓▓▓ ╚" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ⌠ ├▓▓▓▓▓ⁿ▄▓▓▓▓▓▓▓┐▄▓▓▓▓ └" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" Ω_.└██▓▀ⁿÇⁿ▀▀▀▀▀▀█≡▀▀▀▀▀ µ" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ⁿ .▄▄▓▓▓▓▄▄┌ ╖__▓_▄▄▄▄▄*Oⁿ" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" û▌├▓█▓▓▓██ⁿ ¡▓▓▓▓▓▓▓▓█▓╪" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ╙Ω▀█ ▓██ⁿ └█▀██▀▓█├█Å" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" ⁿⁿ ⁿ ⁿ^" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=":::::::.. .,:::::: .,:: .::::::::.. :::. .-:. ::-." plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=";;;;'';;;; ;;;;'''' ';;;, .,;; ;;;;'';;;; ;;';; ';;. ;;;;'" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" [[[,/[[[' [[cccc '[[,,[[' [[[,/[[[' ,[[ '[[, '[[,[[['" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" $$$$$$c $$\"\"\"\" Y$$$Pcccc $$$$$$c c$$$cc$$$c c$$\"" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" 888b \"88bo,888oo,__ oP\"''\"Yo, 888b \"88bo,888 888,,8P\"'" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=" MMMM \"W\" \"\"\"\"YUMMM,m\" \"Mm, MMMM \"W\" YMM \"\"'mM\"" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=error msg="time=\"2019-09-30T13:25:47Z\" level=info msg=\"agent context cancellation - waiting\" host=\"unix:///var/run/rexray/508982324.sock\" time=1569849947977 " plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=REX-Ray plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg=------- plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="Binary: /usr/bin/rexray" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="Flavor: client+agent+controller" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="SemVer: 0.11.4" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="OsArch: Linux-x86_64" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="Commit: e7414eaa971b27977d2283f2882825393493179d" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info msg="Formed: Tue, 15 Jan 2019 16:03:57 UTC" plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sep 30 13:25:47 prod-1-worker-10.0.21.50 env[1463]: time="2019-09-30T13:25:47Z" level=info plugin=47e7a1618608ff2423824400345618f2f04da6e279bc181c6af62b84233fa75f
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment