"./operations.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -fast-list -test.run '^TestCopyFileBackupDir$'" - Starting (try 2/5) 2021/03/23 05:02:19 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-niwofuv2zubequk9cocoyux3" 2021/03/23 05:02:19 DEBUG : TestS3MinioEdge: detected overridden config - adding "{Dqa1+}" suffix to name 2021/03/23 05:02:19 DEBUG : Creating backend with remote "/tmp/rclone017965919" === RUN TestCopyFileBackupDir run.go:176: Remote "S3 bucket rclone-test-niwofuv2zubequk9cocoyux3", Local "Local file system at /tmp/rclone017965919", Modify Window "1ns" 2021/03/23 05:02:19 DEBUG : pacer: low level retry 1/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EE7B754ED, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2021/03/23 05:02:19 DEBUG : pacer: low level retry 2/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EEC5B776D, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/03/23 05:02:19 DEBUG : pacer: low level retry 3/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EF0F2957E, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2021/03/23 05:02:19 DEBUG : pacer: low level retry 4/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EF3ECDC27, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2021/03/23 05:02:19 DEBUG : pacer: low level retry 5/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EF464145A, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2021/03/23 05:02:19 DEBUG : pacer: low level retry 6/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01EFA1A1A03, host id: ) 2021/03/23 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2021/03/23 05:02:20 DEBUG : pacer: low level retry 7/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01F05EEA2DB, host id: ) 2021/03/23 05:02:20 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2021/03/23 05:02:20 DEBUG : pacer: low level retry 8/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01F170D2EC5, host id: ) 2021/03/23 05:02:20 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2021/03/23 05:02:21 DEBUG : pacer: low level retry 9/10 (error XMinioServerNotInitialized: Server not initialized, please try again. status code: 503, request id: 166EE01F3CAD2C5B, host id: ) 2021/03/23 05:02:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2021/03/23 05:02:22 DEBUG : pacer: Reducing sleep to 1.5s 2021/03/23 05:02:22 INFO : S3 bucket rclone-test-niwofuv2zubequk9cocoyux3: Bucket "rclone-test-niwofuv2zubequk9cocoyux3" created with ACL "private" 2021/03/23 05:02:24 DEBUG : pacer: Reducing sleep to 1.125s 2021/03/23 05:02:25 DEBUG : pacer: Reducing sleep to 843.75ms 2021/03/23 05:02:26 DEBUG : pacer: Reducing sleep to 632.8125ms 2021/03/23 05:02:27 DEBUG : pacer: Reducing sleep to 474.609375ms 2021/03/23 05:02:28 DEBUG : pacer: Reducing sleep to 355.957031ms 2021/03/23 05:02:28 DEBUG : Creating backend with remote "TestS3MinioEdge:rclone-test-niwofuv2zubequk9cocoyux3/backup" 2021/03/23 05:02:28 DEBUG : TestS3MinioEdge: detected overridden config - adding "{Dqa1+}" suffix to name 2021/03/23 05:02:28 DEBUG : fs cache: renaming cache item "TestS3MinioEdge:rclone-test-niwofuv2zubequk9cocoyux3/backup" to be canonical "TestS3MinioEdge{Dqa1+}:rclone-test-niwofuv2zubequk9cocoyux3/backup" 2021/03/23 05:02:28 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/03/23 05:02:28 DEBUG : dst/file1: MD5 = 05164b153084ba910184c26e561a7c18 OK 2021/03/23 05:02:28 INFO : dst/file1: Copied (server-side copy) 2021/03/23 05:02:28 DEBUG : pacer: Reducing sleep to 266.967773ms 2021/03/23 05:02:28 INFO : dst/file1: Deleted 2021/03/23 05:02:29 DEBUG : pacer: Reducing sleep to 200.225829ms 2021/03/23 05:02:29 DEBUG : pacer: Reducing sleep to 150.169371ms 2021/03/23 05:02:29 DEBUG : dst/file1: MD5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/03/23 05:02:29 INFO : dst/file1: Copied (new) 2021/03/23 05:02:29 DEBUG : pacer: Reducing sleep to 112.627028ms 2021/03/23 05:02:29 DEBUG : pacer: Reducing sleep to 84.470271ms 2021/03/23 05:02:29 DEBUG : pacer: Reducing sleep to 63.352703ms 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 47.514527ms 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 35.635895ms 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 26.726921ms 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 20.04519ms --- PASS: TestCopyFileBackupDir (10.66s) PASS 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 15.033892ms 2021/03/23 05:02:30 DEBUG : S3 bucket rclone-test-niwofuv2zubequk9cocoyux3: Purge dir "" 2021/03/23 05:02:30 DEBUG : pacer: Reducing sleep to 11.275419ms 2021/03/23 05:02:30 INFO : S3 bucket rclone-test-niwofuv2zubequk9cocoyux3: Bucket "rclone-test-niwofuv2zubequk9cocoyux3" deleted "./operations.test -test.v -test.timeout 1h0m0s -remote TestS3MinioEdge: -verbose -fast-list -test.run '^TestCopyFileBackupDir$'" - Finished OK in 10.979410602s (try 2/5)