"./sync.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -test.run '^TestSyncBackupDirWithSuffixKeepExtension$'" - Starting (try 3/5)
2021/03/23 05:10:07 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-finuyoj5mebibur1liwoqez7"
2021/03/23 05:10:07 DEBUG : TestS3MinioEdge: detected overridden config - adding "{4Z9wr}" suffix to name
2021/03/23 05:10:07 DEBUG : Creating backend with remote "/tmp/rclone157569090"
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:176: Remote "S3 bucket rclone-test-finuyoj5mebibur1liwoqez7", Local "Local file system at /tmp/rclone157569090", Modify Window "1ns"
2021/03/23 05:10:07 DEBUG : pacer: low level retry 1/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BE0CA0F66, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 10ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 2/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BE2CC3D1C, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 3/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BE2E69788, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 4/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BE46CEF5E, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 5/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BE83261E9, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 6/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BEB61AB07, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2021/03/23 05:10:07 DEBUG : pacer: low level retry 7/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08BF4D7EE40, host id: )
2021/03/23 05:10:07 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2021/03/23 05:10:08 DEBUG : pacer: low level retry 8/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08C07EF17AB, host id: )
2021/03/23 05:10:08 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2021/03/23 05:10:08 DEBUG : pacer: low level retry 9/10 (error XMinioServerNotInitialized: Server not initialized, please try again.
	status code: 503, request id: 166EE08C2E40DF11, host id: )
2021/03/23 05:10:08 DEBUG : pacer: Rate limited, increasing sleep to 2s
2021/03/23 05:10:10 DEBUG : pacer: Reducing sleep to 1.5s
2021/03/23 05:10:10 INFO  : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7: Bucket "rclone-test-finuyoj5mebibur1liwoqez7" created with ACL "private"
2021/03/23 05:10:12 DEBUG : pacer: Reducing sleep to 1.125s
2021/03/23 05:10:13 DEBUG : pacer: Reducing sleep to 843.75ms
2021/03/23 05:10:14 DEBUG : pacer: Reducing sleep to 632.8125ms
2021/03/23 05:10:15 DEBUG : pacer: Reducing sleep to 474.609375ms
2021/03/23 05:10:16 DEBUG : pacer: Reducing sleep to 355.957031ms
2021/03/23 05:10:16 DEBUG : pacer: Reducing sleep to 266.967773ms
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 200.225829ms
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 150.169371ms
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 112.627028ms
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 84.470271ms
2021/03/23 05:10:17 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-finuyoj5mebibur1liwoqez7/dst"
2021/03/23 05:10:17 DEBUG : TestS3MinioEdge: detected overridden config - adding "{4Z9wr}" suffix to name
2021/03/23 05:10:17 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-finuyoj5mebibur1liwoqez7/backup"
2021/03/23 05:10:17 DEBUG : TestS3MinioEdge: detected overridden config - adding "{4Z9wr}" suffix to name
2021/03/23 05:10:17 DEBUG : fs cache: renaming cache item "TestS3MinioEdge:rclone-test-finuyoj5mebibur1liwoqez7/backup" to be canonical "TestS3MinioEdge{4Z9wr}:rclone-test-finuyoj5mebibur1liwoqez7/backup"
2021/03/23 05:10:17 DEBUG : one: Sizes differ (src 4 vs dst 3)
2021/03/23 05:10:17 DEBUG : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7 path dst: Waiting for checks to finish
2021/03/23 05:10:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2021/03/23 05:10:17 DEBUG : two: Unchanged skipping
2021/03/23 05:10:17 DEBUG : one: MD5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2021/03/23 05:10:17 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2021/03/23 05:10:17 INFO  : one: Deleted
2021/03/23 05:10:17 DEBUG : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7 path dst: Waiting for transfers to finish
2021/03/23 05:10:17 DEBUG : one: MD5 = c7957179c41f69d44f217a108c7915d8 OK
2021/03/23 05:10:17 INFO  : one: Copied (new)
2021/03/23 05:10:17 DEBUG : Waiting for deletions to finish
2021/03/23 05:10:17 DEBUG : three.txt: MD5 = 35d6d33467aae9a2e3dccb4b6b027878 OK
2021/03/23 05:10:17 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2021/03/23 05:10:17 INFO  : three.txt: Deleted
2021/03/23 05:10:17 INFO  : three.txt: Moved into backup dir
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 63.352703ms
2021/03/23 05:10:17 DEBUG : pacer: Reducing sleep to 47.514527ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 35.635895ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 26.726921ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 20.04519ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 15.033892ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 11.275419ms
2021/03/23 05:10:18 DEBUG : pacer: Reducing sleep to 0s
2021/03/23 05:10:18 DEBUG : fs cache: switching user supplied name "TestS3MinioEdge:rclone-test-finuyoj5mebibur1liwoqez7/backup" for canonical name "TestS3MinioEdge{4Z9wr}:rclone-test-finuyoj5mebibur1liwoqez7/backup"
2021/03/23 05:10:18 DEBUG : one: Sizes differ (src 5 vs dst 4)
2021/03/23 05:10:18 DEBUG : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7 path dst: Waiting for checks to finish
2021/03/23 05:10:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2021/03/23 05:10:18 DEBUG : two: Unchanged skipping
2021/03/23 05:10:18 DEBUG : one: MD5 = c7957179c41f69d44f217a108c7915d8 OK
2021/03/23 05:10:18 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2021/03/23 05:10:18 INFO  : one: Deleted
2021/03/23 05:10:18 DEBUG : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7 path dst: Waiting for transfers to finish
2021/03/23 05:10:18 DEBUG : one: MD5 = 0f93e81041f0cab37c37a05ae998b219 OK
2021/03/23 05:10:18 INFO  : one: Copied (new)
2021/03/23 05:10:18 DEBUG : Waiting for deletions to finish
2021/03/23 05:10:18 DEBUG : three.txt: MD5 = 91341eed84691a83caea73aa785736d5 OK
2021/03/23 05:10:18 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2021/03/23 05:10:18 INFO  : three.txt: Deleted
2021/03/23 05:10:18 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (10.73s)
PASS
2021/03/23 05:10:18 DEBUG : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7: Purge dir ""
2021/03/23 05:10:18 INFO  : S3 bucket rclone-test-finuyoj5mebibur1liwoqez7: Bucket "rclone-test-finuyoj5mebibur1liwoqez7" deleted
"./sync.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -test.run '^TestSyncBackupDirWithSuffixKeepExtension$'" - Finished OK in 10.809237842s (try 3/5)