"./operations.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -test.run '^TestCopyFileBackupDir$'" - Starting (try 2/5) 2021/03/23 06:06:33 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-tuxipuk4fozizok2homamiy4" 2021/03/23 06:06:33 DEBUG : TestS3MinioEdge: detected overridden config - adding "{Dqa1+}" suffix to name 2021/03/23 06:06:33 DEBUG : Creating backend with remote "/tmp/rclone664157740" === RUN TestCopyFileBackupDir run.go:176: Remote "S3 bucket rclone-test-tuxipuk4fozizok2homamiy4", Local "Local file system at /tmp/rclone664157740", Modify Window "1ns" 2021/03/23 06:06:33 DEBUG : pacer: low level retry 1/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A02442C4F6, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 2/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A024567F77, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 3/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A0264024A5, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 4/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A0264F32DE, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 5/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A02A847103, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 6/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A02ED6BAB4, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 7/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A037C821F8, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2021/03/23 06:06:33 DEBUG : pacer: low level retry 8/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A04ACC0A15, host id: ) 2021/03/23 06:06:33 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2021/03/23 06:06:34 DEBUG : pacer: low level retry 9/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE3A07081269D, host id: ) 2021/03/23 06:06:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2021/03/23 06:06:35 DEBUG : pacer: Reducing sleep to 1.5s 2021/03/23 06:06:35 INFO : S3 bucket rclone-test-tuxipuk4fozizok2homamiy4: Bucket "rclone-test-tuxipuk4fozizok2homamiy4" created with ACL "private" 2021/03/23 06:06:37 DEBUG : pacer: Reducing sleep to 1.125s 2021/03/23 06:06:39 DEBUG : pacer: Reducing sleep to 843.75ms 2021/03/23 06:06:40 DEBUG : pacer: Reducing sleep to 632.8125ms 2021/03/23 06:06:41 DEBUG : pacer: Reducing sleep to 474.609375ms 2021/03/23 06:06:41 DEBUG : pacer: Reducing sleep to 355.957031ms 2021/03/23 06:06:41 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-tuxipuk4fozizok2homamiy4/backup" 2021/03/23 06:06:41 DEBUG : TestS3MinioEdge: detected overridden config - adding "{Dqa1+}" suffix to name 2021/03/23 06:06:41 DEBUG : fs cache: renaming cache item "TestS3MinioEdge:rclone-test-tuxipuk4fozizok2homamiy4/backup" to be canonical "TestS3MinioEdge{Dqa1+}:rclone-test-tuxipuk4fozizok2homamiy4/backup" 2021/03/23 06:06:41 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/03/23 06:06:41 DEBUG : dst/file1: MD5 = 05164b153084ba910184c26e561a7c18 OK 2021/03/23 06:06:41 INFO : dst/file1: Copied (server-side copy) 2021/03/23 06:06:42 DEBUG : pacer: Reducing sleep to 266.967773ms 2021/03/23 06:06:42 INFO : dst/file1: Deleted 2021/03/23 06:06:42 DEBUG : pacer: Reducing sleep to 200.225829ms 2021/03/23 06:06:42 DEBUG : pacer: Reducing sleep to 150.169371ms 2021/03/23 06:06:42 DEBUG : dst/file1: MD5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/03/23 06:06:42 INFO : dst/file1: Copied (new) 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 112.627028ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 84.470271ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 63.352703ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 47.514527ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 35.635895ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 26.726921ms 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 20.04519ms --- PASS: TestCopyFileBackupDir (10.48s) PASS 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 15.033892ms 2021/03/23 06:06:43 DEBUG : S3 bucket rclone-test-tuxipuk4fozizok2homamiy4: Purge dir "" 2021/03/23 06:06:43 DEBUG : pacer: Reducing sleep to 11.275419ms 2021/03/23 06:06:43 INFO : S3 bucket rclone-test-tuxipuk4fozizok2homamiy4: Bucket "rclone-test-tuxipuk4fozizok2homamiy4" deleted "./operations.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -test.run '^TestCopyFileBackupDir$'" - Finished OK in 10.618352361s (try 2/5)