"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFile|TestCheckSumDownload|TestCopyFileBackupDir)$'" - Starting (try 2/5)
2025/04/13 07:01:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-hadirel6wale"
2025/04/13 07:01:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/13 07:01:26 DEBUG : Starting OpenDrive session with ID: 21366485ececa2ce7ed48f7762383021ff2363751c1e0ffdb913d7b5788f7e10
2025/04/13 07:01:26 DEBUG : Creating backend with remote "/tmp/rclone595387573"
=== RUN   TestCheckSumDownload
    run.go:180: Remote "OpenDrive root 'rclone-test-hadirel6wale'", Local "Local file system at /tmp/rclone595387573", Modify Window "1s"
2025/04/13 07:01:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-hadirel6wale/data"
2025/04/13 07:01:27 DEBUG : Starting OpenDrive session with ID: a05da0bcfa66fd45b32744748616a876122fe033d49c2f105aabd29b07c02487
2025/04/13 07:01:29 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2025/04/13 07:01:30 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSumDownload/subtest1
2025/04/13 07:01:33 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2025/04/13 07:01:34 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSumDownload/subtest2
2025/04/13 07:01:37 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSumDownload/subtest3
2025/04/13 07:01:39 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSumDownload/subtest4
2025/04/13 07:01:42 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSumDownload/subtest5
2025/04/13 07:01:44 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSumDownload/subtest6
2025/04/13 07:01:46 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2025/04/13 07:01:47 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2025/04/13 07:01:49 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (25.45s)
    --- PASS: TestCheckSumDownload/subtest1 (1.04s)
    --- PASS: TestCheckSumDownload/subtest2 (0.66s)
    --- PASS: TestCheckSumDownload/subtest3 (1.05s)
    --- PASS: TestCheckSumDownload/subtest4 (0.68s)
    --- PASS: TestCheckSumDownload/subtest5 (0.66s)
    --- PASS: TestCheckSumDownload/subtest6 (0.88s)
    --- PASS: TestCheckSumDownload/subtest7 (0.68s)
=== RUN   TestCopyFileBackupDir
    run.go:180: Remote "OpenDrive root 'rclone-test-hadirel6wale'", Local "Local file system at /tmp/rclone595387573", Modify Window "1s"
2025/04/13 07:01:53 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0
2025/04/13 07:01:55 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-hadirel6wale/backup"
2025/04/13 07:01:55 DEBUG : Starting OpenDrive session with ID: fa4350cb6868c747cf629e02db238254d9835bad95d7ade7b8512ef17c5c8c1e
2025/04/13 07:01:56 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18)
2025/04/13 07:01:57 INFO  : dst/file1: Moved (server-side)
2025/04/13 07:01:58 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0
2025/04/13 07:01:59 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2025/04/13 07:01:59 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (9.47s)
=== RUN   TestCaseInsensitiveMoveFile
    run.go:180: Remote "OpenDrive root 'rclone-test-hadirel6wale'", Local "Local file system at /tmp/rclone595387573", Modify Window "1s"
2025/04/13 07:02:02 DEBUG : file1: Need to transfer - File not found at Destination
2025/04/13 07:02:03 DEBUG : sub/file2: Uploading chunk 0, size=14, remain=0
2025/04/13 07:02:04 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2025/04/13 07:02:04 INFO  : file1: Copied (new) to: sub/file2
2025/04/13 07:02:04 INFO  : file1: Deleted
2025/04/13 07:02:04 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/04/13 07:02:04 DEBUG : file1: Unchanged skipping
2025/04/13 07:02:04 INFO  : file1: Deleted
2025/04/13 07:02:05 DEBUG : sub/file2: moving to sub/File2-rclone-move-levejur6
2025/04/13 07:02:05 DEBUG : sub/file2: same parent dir (ODFfODIzMjYzN192TlEwTw) - using file/rename instead of move_copy for sub/File2-rclone-move-levejur6
2025/04/13 07:02:05 INFO  : sub/file2: Moved (server-side) to: sub/File2-rclone-move-levejur6
2025/04/13 07:02:05 DEBUG : sub/file2: moving to sub/File2
2025/04/13 07:02:06 DEBUG : sub/File2-rclone-move-levejur6: same parent dir (ODFfODIzMjYzN192TlEwTw) - using file/rename instead of move_copy for sub/File2
2025/04/13 07:02:06 INFO  : sub/File2-rclone-move-levejur6: Moved (server-side) to: sub/File2
--- PASS: TestCaseInsensitiveMoveFile (5.73s)
PASS
2025/04/13 07:02:07 DEBUG : OpenDrive root 'rclone-test-hadirel6wale': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFile|TestCheckSumDownload|TestCopyFileBackupDir)$'" - Finished OK in 41.935459071s (try 2/5)