"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileBackupDir|TestDirMove|TestMoveFileBackupDir|TestPurge|TestRmdirsNoLeaveRoot)$'" - Starting (try 2/5) 2025/01/06 01:27:25 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-niwezaz3feza" 2025/01/06 01:27:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/06 01:27:26 DEBUG : Starting OpenDrive session with ID: f01401d734345832c374e3dc3506591746c1a44143353313b84f9240a6e7f012 2025/01/06 01:27:26 DEBUG : Creating backend with remote "/tmp/rclone522007634" === RUN TestCheckSumDownload run.go:180: Remote "OpenDrive root 'rclone-test-niwezaz3feza'", Local "Local file system at /tmp/rclone522007634", Modify Window "1s" 2025/01/06 01:27:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-niwezaz3feza/data" 2025/01/06 01:27:26 DEBUG : Starting OpenDrive session with ID: 3acb224209083f85f462f27aae897d8fb92cc646696462d5bc07987a54856a77 2025/01/06 01:27:28 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0 2025/01/06 01:27:30 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0 === RUN TestCheckSumDownload/subtest1 2025/01/06 01:27:34 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0 2025/01/06 01:27:36 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0 === RUN TestCheckSumDownload/subtest2 2025/01/06 01:27:38 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSumDownload/subtest3 2025/01/06 01:27:41 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSumDownload/subtest4 2025/01/06 01:27:43 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0 === RUN TestCheckSumDownload/subtest5 2025/01/06 01:27:46 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0 === RUN TestCheckSumDownload/subtest6 2025/01/06 01:27:48 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0 2025/01/06 01:27:49 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0 2025/01/06 01:27:51 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (28.18s) --- PASS: TestCheckSumDownload/subtest1 (1.13s) --- PASS: TestCheckSumDownload/subtest2 (0.70s) --- PASS: TestCheckSumDownload/subtest3 (1.08s) --- PASS: TestCheckSumDownload/subtest4 (0.72s) --- PASS: TestCheckSumDownload/subtest5 (0.72s) --- PASS: TestCheckSumDownload/subtest6 (0.78s) --- PASS: TestCheckSumDownload/subtest7 (0.74s) === RUN TestCopyFileBackupDir run.go:180: Remote "OpenDrive root 'rclone-test-niwezaz3feza'", Local "Local file system at /tmp/rclone522007634", Modify Window "1s" 2025/01/06 01:27:55 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/01/06 01:27:57 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-niwezaz3feza/backup" 2025/01/06 01:27:58 DEBUG : Starting OpenDrive session with ID: 79cb60aebfd3563ee04aa78fe339b8fcadec5c481c62098bd0244c5011e1d125 2025/01/06 01:27:59 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/01/06 01:28:00 INFO : dst/file1: Moved (server-side) 2025/01/06 01:28:01 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/01/06 01:28:02 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/06 01:28:02 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (10.67s) === RUN TestPurge 2025/01/06 01:28:05 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kabeguk1tare" 2025/01/06 01:28:05 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/06 01:28:05 DEBUG : Starting OpenDrive session with ID: e6cb9840115ddee4033d28339e79a3474cd5a2f8f9e88511264ceab4cd75ee00 2025/01/06 01:28:06 DEBUG : Creating backend with remote "/tmp/rclone2952962938" run.go:180: Remote "OpenDrive root 'rclone-test-kabeguk1tare'", Local "Local file system at /tmp/rclone2952962938", Modify Window "1s" 2025/01/06 01:28:08 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:09 DEBUG : A2: Making directory 2025/01/06 01:28:09 DEBUG : A1/B2: Making directory 2025/01/06 01:28:10 DEBUG : A1/B2/C2: Making directory 2025/01/06 01:28:10 DEBUG : A1/B1/C3: Making directory 2025/01/06 01:28:10 DEBUG : A3: Making directory 2025/01/06 01:28:11 DEBUG : A3/B3: Making directory 2025/01/06 01:28:11 DEBUG : A3/B3/C4: Making directory 2025/01/06 01:28:12 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:16 ERROR : : error listing: directory not found 2025/01/06 01:28:16 DEBUG : OpenDrive root 'rclone-test-kabeguk1tare': Purge remote 2025/01/06 01:28:16 NOTICE: purge failed: directory not found --- PASS: TestPurge (11.58s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "OpenDrive root 'rclone-test-niwezaz3feza'", Local "Local file system at /tmp/rclone522007634", Modify Window "1s" 2025/01/06 01:28:18 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:19 DEBUG : A2: Making directory 2025/01/06 01:28:20 DEBUG : A1/B2: Making directory 2025/01/06 01:28:20 DEBUG : A1/B2/C2: Making directory 2025/01/06 01:28:20 DEBUG : A1/B1/C3: Making directory 2025/01/06 01:28:21 DEBUG : A3: Making directory 2025/01/06 01:28:21 DEBUG : A3/B3: Making directory 2025/01/06 01:28:22 DEBUG : A3/B3/C4: Making directory 2025/01/06 01:28:23 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:25 DEBUG : removing 1 level 3 directories 2025/01/06 01:28:25 INFO : A3/B3/C4: Removing directory 2025/01/06 01:28:27 DEBUG : removing 2 level 3 directories 2025/01/06 01:28:27 INFO : A1/B2/C2: Removing directory 2025/01/06 01:28:27 INFO : A1/B1/C3: Removing directory 2025/01/06 01:28:27 DEBUG : removing 2 level 2 directories 2025/01/06 01:28:27 INFO : A3/B3: Removing directory 2025/01/06 01:28:27 INFO : A1/B2: Removing directory 2025/01/06 01:28:28 DEBUG : removing 2 level 1 directories 2025/01/06 01:28:28 INFO : A3: Removing directory 2025/01/06 01:28:28 INFO : A2: Removing directory 2025/01/06 01:28:31 DEBUG : removing 1 level 3 directories 2025/01/06 01:28:31 INFO : A1/B1/C1: Removing directory 2025/01/06 01:28:32 DEBUG : removing 1 level 2 directories 2025/01/06 01:28:32 INFO : A1/B1: Removing directory 2025/01/06 01:28:32 DEBUG : removing 1 level 1 directories 2025/01/06 01:28:32 INFO : A1: Removing directory 2025/01/06 01:28:33 DEBUG : removing 1 level 0 directories 2025/01/06 01:28:33 INFO : OpenDrive root 'rclone-test-niwezaz3feza': Removing directory 2025/01/06 01:28:33 ERROR : : error listing: directory not found 2025/01/06 01:28:33 ERROR : : error listing: directory not found --- PASS: TestRmdirsNoLeaveRoot (17.09s) === RUN TestMoveFileBackupDir run.go:180: Remote "OpenDrive root 'rclone-test-niwezaz3feza'", Local "Local file system at /tmp/rclone522007634", Modify Window "1s" 2025/01/06 01:28:35 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/01/06 01:28:37 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-niwezaz3feza/backup" 2025/01/06 01:28:37 DEBUG : Starting OpenDrive session with ID: 621412ac5e37260059d2a1d12d0dc9b466409b919fa31a04e03205965b8245fb 2025/01/06 01:28:38 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/01/06 01:28:39 INFO : dst/file1: Moved (server-side) 2025/01/06 01:28:40 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/01/06 01:28:41 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/06 01:28:41 INFO : dst/file1: Copied (new) 2025/01/06 01:28:41 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (10.17s) === RUN TestDirMove run.go:180: Remote "OpenDrive root 'rclone-test-niwezaz3feza'", Local "Local file system at /tmp/rclone522007634", Modify Window "1s" 2025/01/06 01:28:45 DEBUG : A1/one: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:46 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/01/06 01:28:48 DEBUG : A1/B1/three: Uploading chunk 0, size=5, remain=0 2025/01/06 01:28:51 DEBUG : A1/B1/C1/four: Uploading chunk 0, size=4, remain=0 2025/01/06 01:28:53 DEBUG : A1/B1/C2/five: Uploading chunk 0, size=4, remain=0 2025/01/06 01:28:54 DEBUG : A1/B2: Making directory 2025/01/06 01:28:54 DEBUG : A1/B1/C3: Making directory 2025/01/06 01:28:56 DEBUG : A2: same parent dir (ODFfNzg5ODYxMV9XMnNLcw) - using folder/rename instead of move_copy 2025/01/06 01:29:00 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/01/06 01:29:01 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/01/06 01:29:01 INFO : A2/one: Moved (server-side) to: A3/one 2025/01/06 01:29:01 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/01/06 01:29:01 INFO : A2/two: Moved (server-side) to: A3/two 2025/01/06 01:29:04 INFO : OpenDrive root 'rclone-test-niwezaz3feza': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/01/06 01:29:07 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2025/01/06 01:29:07 INFO : A3/two: Moved (server-side) to: A4/two 2025/01/06 01:29:07 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/01/06 01:29:07 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/01/06 01:29:07 INFO : A3/one: Moved (server-side) to: A4/one --- PASS: TestDirMove (30.64s) PASS 2025/01/06 01:29:14 DEBUG : OpenDrive root 'rclone-test-niwezaz3feza': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSumDownload|TestCopyFileBackupDir|TestDirMove|TestMoveFileBackupDir|TestPurge|TestRmdirsNoLeaveRoot)$'" - Finished OK in 1m49.781652682s (try 2/5)