"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileCompareDest|TestCopyFileMaxTransfer|TestRmdirsNoLeaveRoot)$|^TestCheck$/^4$'" - Starting (try 2/5)
2025/09/19 02:08:16 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-lesorod1jehu"
2025/09/19 02:08:16 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/19 02:08:16 DEBUG : Starting OpenDrive session with ID: da525b2c5701b4c8087ff4fe3ceeb11a1fe3b5471c2bce17e73cb77f979486cb
2025/09/19 02:08:17 DEBUG : Creating backend with remote "/tmp/rclone3718072846"
=== RUN   TestCheck
    run.go:180: Remote "OpenDrive root 'rclone-test-lesorod1jehu'", Local "Local file system at /tmp/rclone3718072846", Modify Window "1s"
2025/09/19 02:08:18 DEBUG : rutabaga: Uploading chunk 0, size=8, remain=0
2025/09/19 02:08:20 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
2025/09/19 02:08:22 DEBUG : potato2: Uploading chunk 0, size=60, remain=0
=== RUN   TestCheck/4
2025/09/19 02:08:24 DEBUG : remotepotato: Uploading chunk 0, size=60, remain=0
--- PASS: TestCheck (9.24s)
    --- PASS: TestCheck/4 (0.17s)
=== RUN   TestCopyFileCompareDest
    run.go:180: Remote "OpenDrive root 'rclone-test-lesorod1jehu'", Local "Local file system at /tmp/rclone3718072846", Modify Window "1s"
2025/09/19 02:08:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-lesorod1jehu/dst"
2025/09/19 02:08:27 DEBUG : Starting OpenDrive session with ID: 08cea28265f6812d5b3ab70367a171f1b93a218490e2b04920ec88fa82e7139e
2025/09/19 02:08:27 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-lesorod1jehu/CompareDest"
2025/09/19 02:08:28 DEBUG : Starting OpenDrive session with ID: 75b173f59b987466979c3e1713a98899964c7551ff09e13f9a9dc6d7aea746eb
2025/09/19 02:08:29 DEBUG : one: Need to transfer - File not found at Destination
2025/09/19 02:08:30 DEBUG : one: Uploading chunk 0, size=3, remain=0
2025/09/19 02:08:31 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/09/19 02:08:31 INFO  : one: Copied (new)
2025/09/19 02:08:32 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/09/19 02:08:32 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/09/19 02:08:33 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/09/19 02:08:33 INFO  : one: Copied (replaced existing)
2025/09/19 02:08:34 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/09/19 02:08:36 DEBUG : CompareDest/one: Uploading chunk 0, size=5, remain=0
2025/09/19 02:08:38 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/09/19 02:08:38 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/19 02:08:38 DEBUG : one: Destination found in --compare-dest, skipping
2025/09/19 02:08:40 DEBUG : CompareDest/two: Uploading chunk 0, size=3, remain=0
2025/09/19 02:08:41 DEBUG : two: Need to transfer - File not found at Destination
2025/09/19 02:08:42 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/19 02:08:42 DEBUG : two: Destination found in --compare-dest, skipping
2025/09/19 02:08:42 DEBUG : two: Need to transfer - File not found at Destination
2025/09/19 02:08:42 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/19 02:08:42 DEBUG : two: Destination found in --compare-dest, skipping
2025/09/19 02:08:44 DEBUG : two: Need to transfer - File not found at Destination
2025/09/19 02:08:44 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/09/19 02:08:44 DEBUG : two: Uploading chunk 0, size=5, remain=0
2025/09/19 02:08:45 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2025/09/19 02:08:45 INFO  : two: Copied (new)
--- PASS: TestCopyFileCompareDest (21.76s)
=== RUN   TestCopyFileMaxTransfer
    run.go:180: Remote "OpenDrive root 'rclone-test-lesorod1jehu'", Local "Local file system at /tmp/rclone3718072846", Modify Window "1s"
2025/09/19 02:08:48 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2025/09/19 02:08:49 DEBUG : TestCopyFileMaxTransfer/file1: Uploading chunk 0, size=14, remain=0
2025/09/19 02:08:50 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2025/09/19 02:08:50 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2025/09/19 02:08:51 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2025/09/19 02:08:51 DEBUG : TestCopyFileMaxTransfer/file2: Uploading chunk 0, size=2062, remain=0
2025/09/19 02:08:51 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: failed to create file: Post "https://dev.opendrive.com/api/v1/upload/upload_file_chunk.json": failed to copy data: max transfer limit reached as set by --max-transfer
2025/09/19 02:08:52 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2025/09/19 02:08:53 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2025/09/19 02:08:54 DEBUG : TestCopyFileMaxTransfer/file4: Uploading chunk 0, size=2062, remain=0
2025/09/19 02:08:55 DEBUG : TestCopyFileMaxTransfer/file4: md5 = 1daed43bba980c41a7f0d7ad9566e0de OK
2025/09/19 02:08:55 INFO  : TestCopyFileMaxTransfer/file4: Copied (new)
    run.go:125: removing dir "TestCopyFileMaxTransfer" failed - try 1/3: folder not empty
--- PASS: TestCopyFileMaxTransfer (10.58s)
=== RUN   TestRmdirsNoLeaveRoot
    run.go:180: Remote "OpenDrive root 'rclone-test-lesorod1jehu'", Local "Local file system at /tmp/rclone3718072846", Modify Window "1s"
2025/09/19 02:09:01 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0
2025/09/19 02:09:02 INFO  : A2: Making directory
2025/09/19 02:09:02 INFO  : A1/B2: Making directory
2025/09/19 02:09:03 INFO  : A1/B2/C2: Making directory
2025/09/19 02:09:03 INFO  : A1/B1/C3: Making directory
2025/09/19 02:09:04 INFO  : A3: Making directory
2025/09/19 02:09:04 INFO  : A3/B3: Making directory
2025/09/19 02:09:05 INFO  : A3/B3/C4: Making directory
2025/09/19 02:09:06 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0
2025/09/19 02:09:09 DEBUG : removing 1 level 3 directories
2025/09/19 02:09:09 INFO  : A3/B3/C4: Removing directory
2025/09/19 02:09:12 DEBUG : removing 2 level 3 directories
2025/09/19 02:09:12 INFO  : A1/B2/C2: Removing directory
2025/09/19 02:09:12 INFO  : A1/B1/C3: Removing directory
2025/09/19 02:09:13 DEBUG : removing 2 level 2 directories
2025/09/19 02:09:13 INFO  : A3/B3: Removing directory
2025/09/19 02:09:13 INFO  : A1/B2: Removing directory
2025/09/19 02:09:14 DEBUG : removing 2 level 1 directories
2025/09/19 02:09:14 INFO  : A3: Removing directory
2025/09/19 02:09:14 INFO  : A2: Removing directory
2025/09/19 02:09:18 DEBUG : removing 1 level 3 directories
2025/09/19 02:09:18 INFO  : A1/B1/C1: Removing directory
2025/09/19 02:09:19 DEBUG : removing 1 level 2 directories
2025/09/19 02:09:19 INFO  : A1/B1: Removing directory
2025/09/19 02:09:19 DEBUG : removing 1 level 1 directories
2025/09/19 02:09:19 INFO  : A1: Removing directory
2025/09/19 02:09:20 DEBUG : removing 1 level 0 directories
2025/09/19 02:09:20 INFO  : OpenDrive root 'rclone-test-lesorod1jehu': Removing directory
2025/09/19 02:09:21 ERROR : error listing: directory not found
2025/09/19 02:09:21 ERROR : error listing: directory not found
--- PASS: TestRmdirsNoLeaveRoot (23.04s)
PASS
2025/09/19 02:09:21 DEBUG : OpenDrive root 'rclone-test-lesorod1jehu': Purge remote
2025/09/19 02:09:22 NOTICE: purge failed: directory not found
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileCompareDest|TestCopyFileMaxTransfer|TestRmdirsNoLeaveRoot)$|^TestCheck$/^4$'" - Finished OK in 1m5.862281893s (try 2/5)