"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileBackupDir|TestCopyFileCopyDest|TestDirMove|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$'" - Starting (try 2/5) 2025/05/04 06:08:09 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-pocereq4cudo" 2025/05/04 06:08:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/04 06:08:10 DEBUG : Starting OpenDrive session with ID: 6ad32bb0edffec134e3aa1cf9801806937bfaf5049aed5cb801e67e00917290d 2025/05/04 06:08:10 DEBUG : Creating backend with remote "/tmp/rclone342572515" === RUN TestCopyFileBackupDir run.go:180: Remote "OpenDrive root 'rclone-test-pocereq4cudo'", Local "Local file system at /tmp/rclone342572515", Modify Window "1s" 2025/05/04 06:08:11 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/05/04 06:08:13 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-pocereq4cudo/backup" 2025/05/04 06:08:13 DEBUG : Starting OpenDrive session with ID: 20dcdf0fecb35049cf59065e876f181690eb792197a839be0d20e7427487dd50 2025/05/04 06:08:14 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/05/04 06:08:15 INFO : dst/file1: Moved (server-side) 2025/05/04 06:08:16 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/05/04 06:08:17 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/05/04 06:08:17 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (9.73s) === RUN TestCopyFileCopyDest run.go:180: Remote "OpenDrive root 'rclone-test-pocereq4cudo'", Local "Local file system at /tmp/rclone342572515", Modify Window "1s" 2025/05/04 06:08:20 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-pocereq4cudo/dst" 2025/05/04 06:08:20 DEBUG : Starting OpenDrive session with ID: 0f79036e65b0f35782a93af5f938222b5c4c2f6226f96d8b53b5bae509f703bc 2025/05/04 06:08:21 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-pocereq4cudo/CopyDest" 2025/05/04 06:08:21 DEBUG : Starting OpenDrive session with ID: 0568e01ac128a5f7f283d3d78dd691a31cfbad3edaeab20b0e58fe5288a416fe 2025/05/04 06:08:22 DEBUG : one: Need to transfer - File not found at Destination 2025/05/04 06:08:23 DEBUG : one: Uploading chunk 0, size=3, remain=0 2025/05/04 06:08:24 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/05/04 06:08:24 INFO : one: Copied (new) 2025/05/04 06:08:25 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/04 06:08:25 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/05/04 06:08:26 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/05/04 06:08:26 INFO : one: Copied (replaced existing) 2025/05/04 06:08:27 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/05/04 06:08:29 DEBUG : CopyDest/one: Uploading chunk 0, size=5, remain=0 2025/05/04 06:08:31 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-pocereq4cudo/BackupDir" 2025/05/04 06:08:31 DEBUG : Starting OpenDrive session with ID: bdb582334e9984c6e8d7c0c3d3bbb823fa350ff483df3619dcdef429f2d92781 2025/05/04 06:08:32 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/04 06:08:32 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/05/04 06:08:32 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/04 06:08:33 INFO : one: Moved (server-side) 2025/05/04 06:08:33 DEBUG : one: Dst hash empty - aborting Src hash check 2025/05/04 06:08:33 INFO : one: Copied (server-side copy) 2025/05/04 06:08:33 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/05/04 06:08:35 DEBUG : CopyDest/two: Uploading chunk 0, size=3, remain=0 2025/05/04 06:08:36 DEBUG : two: Need to transfer - File not found at Destination 2025/05/04 06:08:36 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/05/04 06:08:37 DEBUG : two: Dst hash empty - aborting Src hash check 2025/05/04 06:08:37 INFO : two: Copied (server-side copy) 2025/05/04 06:08:37 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/05/04 06:08:37 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/05/04 06:08:37 DEBUG : two: Unchanged skipping 2025/05/04 06:08:38 DEBUG : CopyDest/three: Uploading chunk 0, size=5, remain=0 2025/05/04 06:08:40 DEBUG : three: Need to transfer - File not found at Destination 2025/05/04 06:08:40 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/05/04 06:08:40 DEBUG : three: Destination not found in --copy-dest 2025/05/04 06:08:41 DEBUG : three: Uploading chunk 0, size=7, remain=0 2025/05/04 06:08:42 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2025/05/04 06:08:42 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (25.28s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "OpenDrive root 'rclone-test-pocereq4cudo'", Local "Local file system at /tmp/rclone342572515", Modify Window "1s" 2025/05/04 06:08:45 INFO : A1: Making directory 2025/05/04 06:08:45 INFO : A1/B1: Making directory 2025/05/04 06:08:46 INFO : A1/B1/C1: Making directory 2025/05/04 06:08:47 DEBUG : removing 1 level 3 directories 2025/05/04 06:08:47 INFO : A1/B1/C1: Removing directory 2025/05/04 06:08:47 DEBUG : removing 1 level 2 directories 2025/05/04 06:08:47 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (4.08s) === RUN TestRmdirsWithFilter run.go:180: Remote "OpenDrive root 'rclone-test-pocereq4cudo'", Local "Local file system at /tmp/rclone342572515", Modify Window "1s" 2025/05/04 06:08:49 INFO : A1: Making directory 2025/05/04 06:08:49 INFO : A1/B1: Making directory 2025/05/04 06:08:50 INFO : A1/B1/C1: Making directory 2025/05/04 06:08:51 DEBUG : removing 1 level 3 directories 2025/05/04 06:08:51 INFO : A1/B1/C1: Removing directory 2025/05/04 06:08:52 DEBUG : removing 1 level 2 directories 2025/05/04 06:08:52 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (4.24s) === RUN TestDirMove run.go:180: Remote "OpenDrive root 'rclone-test-pocereq4cudo'", Local "Local file system at /tmp/rclone342572515", Modify Window "1s" 2025/05/04 06:08:54 DEBUG : A1/one: Uploading chunk 0, size=3, remain=0 2025/05/04 06:08:56 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/05/04 06:08:58 DEBUG : A1/B1/three: Uploading chunk 0, size=5, remain=0 2025/05/04 06:09:00 DEBUG : A1/B1/C1/four: Uploading chunk 0, size=4, remain=0 2025/05/04 06:09:02 DEBUG : A1/B1/C2/five: Uploading chunk 0, size=4, remain=0 2025/05/04 06:09:03 INFO : A1/B2: Making directory 2025/05/04 06:09:03 INFO : A1/B1/C3: Making directory 2025/05/04 06:09:05 DEBUG : A2: same parent dir (ODFfODU0MjYxNV9sd012Qw) - using folder/rename instead of move_copy 2025/05/04 06:09:09 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/05/04 06:09:09 INFO : A2/one: Moved (server-side) to: A3/one 2025/05/04 06:09:09 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/05/04 06:09:09 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/05/04 06:09:10 INFO : A2/two: Moved (server-side) to: A3/two 2025/05/04 06:09:13 INFO : OpenDrive root 'rclone-test-pocereq4cudo': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/05/04 06:09:16 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2025/05/04 06:09:16 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/05/04 06:09:16 INFO : A3/one: Moved (server-side) to: A4/one 2025/05/04 06:09:16 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/05/04 06:09:17 INFO : A3/two: Moved (server-side) to: A4/two --- PASS: TestDirMove (30.42s) PASS 2025/05/04 06:09:24 DEBUG : OpenDrive root 'rclone-test-pocereq4cudo': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileBackupDir|TestCopyFileCopyDest|TestDirMove|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$'" - Finished OK in 1m15.177542085s (try 2/5)