"./sync.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -fast-list -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Starting (try 5/5) === RUN TestServerSideMove 2020/03/09 06:25:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2020/03/09 06:25:21 DEBUG : empty space: Unchanged skipping 2020/03/09 06:25:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2020/03/09 06:25:21 DEBUG : B2 bucket rclone-test-bopigah8zakubom6yabodoh9: Waiting for checks to finish 2020/03/09 06:25:22 INFO : empty space: Deleted 2020/03/09 06:25:22 DEBUG : B2 bucket rclone-test-bopigah8zakubom6yabodoh9: Waiting for transfers to finish 2020/03/09 06:25:22 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2020/03/09 06:25:22 INFO : potato2: Copied (server side copy) 2020/03/09 06:25:25 INFO : potato2: Deleted 2020/03/09 06:25:45 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2020/03/09 06:25:45 INFO : potato3: Copied (server side copy) 2020/03/09 06:25:46 INFO : potato3: Deleted 2020/03/09 06:25:47 DEBUG : B2 bucket rclone-test-duvuvaw3curiliv1nepuley8: Waiting for checks to finish 2020/03/09 06:25:47 DEBUG : B2 bucket rclone-test-duvuvaw3curiliv1nepuley8: Waiting for transfers to finish 2020/03/09 06:25:47 ERROR : empty space: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:47 ERROR : empty space: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:48 ERROR : potato2: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:48 ERROR : potato2: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:48 ERROR : potato3: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:48 ERROR : potato3: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:25:48 INFO : There was nothing to transfer 2020/03/09 06:25:48 DEBUG : B2 bucket rclone-test-duvuvaw3curiliv1nepuley8: Purge remote 2020/03/09 06:25:49 purge failed: directory not found 2020/03/09 06:25:49 DEBUG : B2 bucket rclone-test-bopigah8zakubom6yabodoh9: Purge remote 2020/03/09 06:25:49 DEBUG : empty space: Deleting (id "4_z1f821dd3f08dbbdb7f080e1b_f11887b727f033b88_d20200309_m062520_c001_v0001120_t0017") 2020/03/09 06:25:49 DEBUG : potato2: Deleting (id "4_z1f821dd3f08dbbdb7f080e1b_f11391a9af10f6d8d_d20200309_m062521_c001_v0001131_t0057") 2020/03/09 06:25:49 DEBUG : potato3: Deleting (id "4_z1f821dd3f08dbbdb7f080e1b_f10675b0106c7e2ca_d20200309_m062522_c001_v0001113_t0052") 2020/03/09 06:25:49 DEBUG : potato3: Deleting (id "4_z1f821dd3f08dbbdb7f080e1b_f11887b727f033b8a_d20200309_m062520_c001_v0001120_t0017") --- FAIL: TestServerSideMove (51.01s) run.go:176: Remote "B2 bucket rclone-test-cewacud1vilucox4ceyacop4", Local "Local file system at /tmp/rclone341342179", Modify Window "1ms" sync_test.go:1156: Server side move (if possible) B2 bucket rclone-test-cewacud1vilucox4ceyacop4 -> B2 bucket rclone-test-bopigah8zakubom6yabodoh9 sync_test.go:1193: Error Trace: sync_test.go:1193 sync_test.go:1258 Error: Received unexpected error: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) Test: TestServerSideMove === RUN TestServerSideMoveWithFilter 2020/03/09 06:25:52 DEBUG : potato2: Clearing upload URL because of error: c001_v0001113_t0004 is too busy (503 service_unavailable) 2020/03/09 06:25:52 DEBUG : pacer: low level retry 1/1 (error c001_v0001113_t0004 is too busy (503 service_unavailable)) 2020/03/09 06:25:52 DEBUG : pacer: Rate limited, increasing sleep to 1s 2020/03/09 06:25:54 DEBUG : pacer: Reducing sleep to 500ms 2020/03/09 06:25:56 DEBUG : potato2: Clearing upload URL because of error: c001_v0001013_t0044 is too busy (503 service_unavailable) 2020/03/09 06:25:56 DEBUG : pacer: low level retry 1/1 (error c001_v0001013_t0044 is too busy (503 service_unavailable)) 2020/03/09 06:25:56 DEBUG : pacer: Rate limited, increasing sleep to 1s 2020/03/09 06:25:58 DEBUG : pacer: Reducing sleep to 500ms 2020/03/09 06:25:59 DEBUG : pacer: Reducing sleep to 250ms 2020/03/09 06:26:06 DEBUG : pacer: Reducing sleep to 125ms 2020/03/09 06:26:07 DEBUG : pacer: Reducing sleep to 62.5ms 2020/03/09 06:26:07 DEBUG : pacer: Reducing sleep to 31.25ms 2020/03/09 06:26:22 DEBUG : pacer: Reducing sleep to 15.625ms 2020/03/09 06:26:22 DEBUG : empty space: Excluded from sync (and deletion) 2020/03/09 06:26:22 DEBUG : empty space: Excluded from sync (and deletion) 2020/03/09 06:26:22 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2020/03/09 06:26:22 DEBUG : B2 bucket rclone-test-kafuget8xulazux8vitoran4: Waiting for checks to finish 2020/03/09 06:26:22 DEBUG : B2 bucket rclone-test-kafuget8xulazux8vitoran4: Waiting for transfers to finish 2020/03/09 06:26:22 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2020/03/09 06:26:22 INFO : potato3: Copied (server side copy) 2020/03/09 06:26:22 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2020/03/09 06:26:22 INFO : potato2: Copied (server side copy) 2020/03/09 06:26:23 DEBUG : pacer: Reducing sleep to 10ms 2020/03/09 06:26:23 INFO : potato3: Deleted 2020/03/09 06:26:26 INFO : potato2: Deleted 2020/03/09 06:26:27 DEBUG : empty space: Excluded from sync (and deletion) 2020/03/09 06:26:27 DEBUG : B2 bucket rclone-test-xutigin3dokefum5tamihev5: Waiting for checks to finish 2020/03/09 06:26:27 DEBUG : B2 bucket rclone-test-xutigin3dokefum5tamihev5: Waiting for transfers to finish 2020/03/09 06:26:27 ERROR : potato2: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:27 ERROR : potato2: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:28 ERROR : potato3: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:28 ERROR : potato3: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:28 INFO : There was nothing to transfer 2020/03/09 06:26:28 DEBUG : B2 bucket rclone-test-xutigin3dokefum5tamihev5: Purge remote 2020/03/09 06:26:28 purge failed: directory not found 2020/03/09 06:26:28 DEBUG : B2 bucket rclone-test-kafuget8xulazux8vitoran4: Purge remote 2020/03/09 06:26:28 DEBUG : empty space: Deleting (id "4_z5fd2dd93f08dbbdb7f080e1b_f1145384675b827e3_d20200309_m062608_c001_v0001040_t0010") 2020/03/09 06:26:28 DEBUG : potato2: Deleting (id "4_z5fd2dd93f08dbbdb7f080e1b_f118e9e275c3075d6_d20200309_m062622_c001_v0001039_t0058") 2020/03/09 06:26:28 DEBUG : potato3: Deleting (id "4_z5fd2dd93f08dbbdb7f080e1b_f10928fa92944e2d5_d20200309_m062622_c001_v0001043_t0027") 2020/03/09 06:26:28 DEBUG : potato3: Deleting (id "4_z5fd2dd93f08dbbdb7f080e1b_f1145384675b827f4_d20200309_m062614_c001_v0001040_t0010") --- FAIL: TestServerSideMoveWithFilter (38.91s) run.go:176: Remote "B2 bucket rclone-test-cewacud1vilucox4ceyacop4", Local "Local file system at /tmp/rclone341342179", Modify Window "1ms" run.go:278: Retry Put of "potato2" to B2 bucket rclone-test-cewacud1vilucox4ceyacop4: 1/10 (c001_v0001113_t0004 is too busy (503 service_unavailable)) run.go:278: Retry Put of "potato2" to B2 bucket rclone-test-cewacud1vilucox4ceyacop4: 2/10 (c001_v0001013_t0044 is too busy (503 service_unavailable)) sync_test.go:1156: Server side move (if possible) B2 bucket rclone-test-cewacud1vilucox4ceyacop4 -> B2 bucket rclone-test-kafuget8xulazux8vitoran4 sync_test.go:1193: Error Trace: sync_test.go:1193 sync_test.go:1271 Error: Received unexpected error: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) Test: TestServerSideMoveWithFilter === RUN TestServerSideMoveDeleteEmptySourceDirs 2020/03/09 06:26:36 DEBUG : tomatoDir: Making directory 2020/03/09 06:26:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2020/03/09 06:26:50 DEBUG : B2 bucket rclone-test-wekemar8gujazuk6zikomeg0: Waiting for checks to finish 2020/03/09 06:26:50 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2020/03/09 06:26:50 DEBUG : empty space: Unchanged skipping 2020/03/09 06:26:51 INFO : empty space: Deleted 2020/03/09 06:26:51 DEBUG : B2 bucket rclone-test-wekemar8gujazuk6zikomeg0: Waiting for transfers to finish 2020/03/09 06:26:51 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2020/03/09 06:26:51 INFO : potato3: Copied (server side copy) 2020/03/09 06:26:52 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2020/03/09 06:26:52 INFO : potato2: Copied (server side copy) 2020/03/09 06:26:52 INFO : potato2: Deleted 2020/03/09 06:26:53 INFO : potato3: Deleted 2020/03/09 06:26:54 DEBUG : tomatoDir: Making directory 2020/03/09 06:26:54 DEBUG : B2 bucket rclone-test-yiwepoy7fuxibef8tayoqul1: Waiting for checks to finish 2020/03/09 06:26:54 DEBUG : B2 bucket rclone-test-yiwepoy7fuxibef8tayoqul1: Waiting for transfers to finish 2020/03/09 06:26:54 ERROR : empty space: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:54 ERROR : empty space: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:54 ERROR : potato2: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:54 ERROR : potato2: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:55 ERROR : potato3: Failed to copy: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:55 ERROR : potato3: Not deleting source as copy failed: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) 2020/03/09 06:26:55 INFO : There was nothing to transfer 2020/03/09 06:26:55 DEBUG : B2 bucket rclone-test-yiwepoy7fuxibef8tayoqul1: Purge remote 2020/03/09 06:26:55 purge failed: directory not found 2020/03/09 06:26:55 DEBUG : B2 bucket rclone-test-wekemar8gujazuk6zikomeg0: Purge remote 2020/03/09 06:26:55 DEBUG : empty space: Deleting (id "4_z1ff24db3f09dbbdb7f080e1b_f11207c35d01cf2be_d20200309_m062637_c001_v0001032_t0034") 2020/03/09 06:26:55 DEBUG : potato2: Deleting (id "4_z1ff24db3f09dbbdb7f080e1b_f108b2a19a7dae8df_d20200309_m062651_c001_v0001031_t0025") 2020/03/09 06:26:55 DEBUG : potato3: Deleting (id "4_z1ff24db3f09dbbdb7f080e1b_f119da94719446834_d20200309_m062651_c001_v0001039_t0027") 2020/03/09 06:26:55 DEBUG : potato3: Deleting (id "4_z1ff24db3f09dbbdb7f080e1b_f11207c35d01cf2da_d20200309_m062649_c001_v0001032_t0034") --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (26.55s) run.go:176: Remote "B2 bucket rclone-test-cewacud1vilucox4ceyacop4", Local "Local file system at /tmp/rclone341342179", Modify Window "1ms" sync_test.go:1156: Server side move (if possible) B2 bucket rclone-test-cewacud1vilucox4ceyacop4 -> B2 bucket rclone-test-wekemar8gujazuk6zikomeg0 sync_test.go:1193: Error Trace: sync_test.go:1193 sync_test.go:1278 Error: Received unexpected error: failed to create bucket: The account is already at the maximum bucket count (400 too_many_buckets) Test: TestServerSideMoveDeleteEmptySourceDirs FAIL 2020/03/09 06:26:56 DEBUG : B2 bucket rclone-test-cewacud1vilucox4ceyacop4: Purge remote 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f103b532e2ae78e62_d20200309_m062651_c001_v0001031_t0034") 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b593_d20200309_m062635_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f1177e54cd4dd133b_d20200309_m062629_c001_v0001128_t0045") 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b56e_d20200309_m062600_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f10435259d28c82c4_d20200309_m062521_c001_v0001033_t0014") 2020/03/09 06:26:57 DEBUG : empty space: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f10675b0106c7e2aa_d20200309_m062515_c001_v0001113_t0004") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f119c75ff8affe8aa_d20200309_m062652_c001_v0001000_t0001") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b58c_d20200309_m062631_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f1004f2e8f61a4ae7_d20200309_m062622_c001_v0001031_t0024") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b56d_d20200309_m062559_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f116aebd2d0c7a978_d20200309_m062522_c001_v0001113_t0008") 2020/03/09 06:26:57 DEBUG : potato2: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f10675b0106c7e25e_d20200309_m062502_c001_v0001113_t0004") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f1193049d337303ec_d20200309_m062651_c001_v0001012_t0009") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b595_d20200309_m062635_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f106dc882c7d58781_d20200309_m062622_c001_v0001036_t0008") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f100ce5e595d2b573_d20200309_m062606_c001_v0001039_t0012") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f10675b0106c7e357_d20200309_m062545_c001_v0001113_t0043") 2020/03/09 06:26:57 DEBUG : potato3: Deleting (id "4_z3fe2dd73f07dbbdb7f080e1b_f10675b0106c7e2ae_d20200309_m062516_c001_v0001113_t0004") "./sync.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -fast-list -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Finished ERROR in 1m58.498418027s (try 5/5): exit status 1: Failed [TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs]