"./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestCat|TestCopyFileCopyDest|TestRemoveExisting)$'" - Starting (try 2/5) 2025/09/15 05:11:28 DEBUG : Creating backend with remote "TestPcloud:rclone-test-nudatow3rifa" 2025/09/15 05:11:28 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/15 05:11:29 DEBUG : Creating backend with remote "/tmp/rclone2906100615" === RUN TestCopyFileCopyDest run.go:180: Remote "pcloud root 'rclone-test-nudatow3rifa'", Local "Local file system at /tmp/rclone2906100615", Modify Window "1s" 2025/09/15 05:11:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-nudatow3rifa/dst" 2025/09/15 05:11:30 DEBUG : Creating backend with remote "TestPcloud:rclone-test-nudatow3rifa/CopyDest" 2025/09/15 05:11:30 DEBUG : one: Need to transfer - File not found at Destination 2025/09/15 05:11:31 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/09/15 05:11:31 DEBUG : one.b2cc3c6c.partial: renamed to: one 2025/09/15 05:11:31 INFO : one: Copied (new) 2025/09/15 05:11:32 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/09/15 05:11:33 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/09/15 05:11:33 DEBUG : one.4a8516eb.partial: renamed to: one 2025/09/15 05:11:33 INFO : one: Copied (replaced existing) 2025/09/15 05:11:34 DEBUG : Creating backend with remote "TestPcloud:rclone-test-nudatow3rifa/BackupDir" 2025/09/15 05:11:34 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/09/15 05:11:35 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/09/15 05:11:35 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/09/15 05:11:35 INFO : one: Moved (server-side) 2025/09/15 05:11:35 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/09/15 05:11:35 DEBUG : one.a000e91c.partial: renamed to: one 2025/09/15 05:11:35 INFO : one: Copied (server-side copy) 2025/09/15 05:11:35 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/09/15 05:11:36 DEBUG : two: Need to transfer - File not found at Destination 2025/09/15 05:11:36 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/09/15 05:11:37 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/09/15 05:11:37 DEBUG : two.0c2263ec.partial: renamed to: two 2025/09/15 05:11:37 INFO : two: Copied (server-side copy) 2025/09/15 05:11:37 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/09/15 05:11:37 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/09/15 05:11:37 DEBUG : two: Unchanged skipping 2025/09/15 05:11:39 DEBUG : three: Need to transfer - File not found at Destination 2025/09/15 05:11:39 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/09/15 05:11:39 DEBUG : three: Destination not found in --copy-dest 2025/09/15 05:11:39 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2025/09/15 05:11:39 DEBUG : three.63cf7c49.partial: renamed to: three 2025/09/15 05:11:39 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (11.56s) === RUN TestCat run.go:180: Remote "pcloud root 'rclone-test-nudatow3rifa'", Local "Local file system at /tmp/rclone2906100615", Modify Window "1s" 2025/09/15 05:11:41 DEBUG : Couldn't parse Date: from server edef3.pcloud.com: "Mon, 15 Sep 2025 05:11:41 +0000": parsing time "Mon, 15 Sep 2025 05:11:41 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:41 +0000" as " " 2025/09/15 05:11:41 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Mon, 15 Sep 2025 05:11:41 +0000": parsing time "Mon, 15 Sep 2025 05:11:41 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:41 +0000" as " " 2025/09/15 05:11:42 DEBUG : Couldn't parse Date: from server edef3.pcloud.com: "Mon, 15 Sep 2025 05:11:42 +0000": parsing time "Mon, 15 Sep 2025 05:11:42 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:42 +0000" as " " 2025/09/15 05:11:42 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Mon, 15 Sep 2025 05:11:42 +0000": parsing time "Mon, 15 Sep 2025 05:11:42 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:42 +0000" as " " 2025/09/15 05:11:42 DEBUG : Couldn't parse Date: from server edef3.pcloud.com: "Mon, 15 Sep 2025 05:11:42 +0000": parsing time "Mon, 15 Sep 2025 05:11:42 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:42 +0000" as " " 2025/09/15 05:11:42 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Mon, 15 Sep 2025 05:11:42 +0000": parsing time "Mon, 15 Sep 2025 05:11:42 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:42 +0000" as " " 2025/09/15 05:11:43 DEBUG : Couldn't parse Date: from server edef3.pcloud.com: "Mon, 15 Sep 2025 05:11:43 +0000": parsing time "Mon, 15 Sep 2025 05:11:43 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:43 +0000" as " " 2025/09/15 05:11:43 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Mon, 15 Sep 2025 05:11:43 +0000": parsing time "Mon, 15 Sep 2025 05:11:43 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:43 +0000" as " " 2025/09/15 05:11:43 DEBUG : Couldn't parse Date: from server edef3.pcloud.com: "Mon, 15 Sep 2025 05:11:43 +0000": parsing time "Mon, 15 Sep 2025 05:11:43 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:43 +0000" as " " 2025/09/15 05:11:43 DEBUG : Couldn't parse Date: from server edef5.pcloud.com: "Mon, 15 Sep 2025 05:11:43 +0000": parsing time "Mon, 15 Sep 2025 05:11:43 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 15 Sep 2025 05:11:43 +0000" as " " --- PASS: TestCat (3.00s) === RUN TestRemoveExisting run.go:180: Remote "pcloud root 'rclone-test-nudatow3rifa'", Local "Local file system at /tmp/rclone2906100615", Modify Window "1s" 2025/09/15 05:11:45 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.conogin8" before starting 2025/09/15 05:11:45 DEBUG : sub dir/test remove existing.conogin8: TEST: removing renamed existing file after operation 2025/09/15 05:11:45 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zawanut8" before starting 2025/09/15 05:11:46 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zawanut8: TEST: renaming existing back after failed operation 2025/09/15 05:11:46 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.xawopib0" before starting 2025/09/15 05:11:46 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.xawopib0: TEST: removing renamed existing file after operation --- PASS: TestRemoveExisting (3.02s) PASS 2025/09/15 05:11:47 DEBUG : pcloud root 'rclone-test-nudatow3rifa': Purge remote 2025/09/15 05:11:47 DEBUG : pacer: low level retry 1/10 (error pcloud error: Internal error. Try again later. (5000)) 2025/09/15 05:11:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/09/15 05:11:47 DEBUG : pacer: Reducing sleep to 15ms "./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestCat|TestCopyFileCopyDest|TestRemoveExisting)$'" - Finished OK in 18.498793495s (try 2/5)