"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFileDryRun|TestCheckSum|TestCheckSumDownload|TestCopyFileBackupDir)$'" - Starting (try 2/5)
2024/10/29 04:38:22 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qoloqex0weja"
2024/10/29 04:38:22 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/10/29 04:38:23 DEBUG : Starting OpenDrive session with ID: 5c163ad16a961e42870469a69e42ead44ac47e87c3df66b42efa940ecfe7caf2
2024/10/29 04:38:23 DEBUG : Creating backend with remote "/tmp/rclone2499888853"
=== RUN   TestCheckSum
    run.go:180: Remote "OpenDrive root 'rclone-test-qoloqex0weja'", Local "Local file system at /tmp/rclone2499888853", Modify Window "1s"
2024/10/29 04:38:23 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qoloqex0weja/data"
2024/10/29 04:38:24 DEBUG : Starting OpenDrive session with ID: d4118ef3443b63a2bcbfd6c5081bdac6affa156d95ae93e2c43a4b508bb31cd9
2024/10/29 04:38:26 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2024/10/29 04:38:27 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest1
2024/10/29 04:38:31 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2024/10/29 04:38:32 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest2
2024/10/29 04:38:35 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest3
2024/10/29 04:38:37 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest4
2024/10/29 04:38:40 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest5
2024/10/29 04:38:42 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest6
2024/10/29 04:38:45 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2024/10/29 04:38:46 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2024/10/29 04:38:48 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest7
--- PASS: TestCheckSum (28.19s)
    --- PASS: TestCheckSum/subtest1 (1.29s)
    --- PASS: TestCheckSum/subtest2 (0.86s)
    --- PASS: TestCheckSum/subtest3 (0.86s)
    --- PASS: TestCheckSum/subtest4 (0.85s)
    --- PASS: TestCheckSum/subtest5 (0.89s)
    --- PASS: TestCheckSum/subtest6 (0.87s)
    --- PASS: TestCheckSum/subtest7 (0.87s)
=== RUN   TestCheckSumDownload
    run.go:180: Remote "OpenDrive root 'rclone-test-qoloqex0weja'", Local "Local file system at /tmp/rclone2499888853", Modify Window "1s"
2024/10/29 04:38:51 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qoloqex0weja/data"
2024/10/29 04:38:52 DEBUG : Starting OpenDrive session with ID: 8fb785c3b757e39a16a68b5ff9fe8fa5012c396a27700362401414cf53faf60c
2024/10/29 04:38:54 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2024/10/29 04:38:55 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSumDownload/subtest1
2024/10/29 04:38:59 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2024/10/29 04:39:00 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSumDownload/subtest2
2024/10/29 04:39:03 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== NAME  TestCheckSumDownload
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:286: Sleeping for 6s just to make sure
=== RUN   TestCheckSumDownload/subtest3
2024/10/29 04:39:14 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSumDownload/subtest4
2024/10/29 04:39:18 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSumDownload/subtest5
2024/10/29 04:39:21 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSumDownload/subtest6
2024/10/29 04:39:24 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2024/10/29 04:39:25 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2024/10/29 04:39:27 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== NAME  TestCheckSumDownload
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:286: Sleeping for 6s just to make sure
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (47.73s)
    --- PASS: TestCheckSumDownload/subtest1 (1.54s)
    --- PASS: TestCheckSumDownload/subtest2 (1.38s)
    --- PASS: TestCheckSumDownload/subtest3 (1.46s)
    --- PASS: TestCheckSumDownload/subtest4 (1.42s)
    --- PASS: TestCheckSumDownload/subtest5 (1.42s)
    --- PASS: TestCheckSumDownload/subtest6 (1.42s)
    --- PASS: TestCheckSumDownload/subtest7 (1.57s)
=== RUN   TestCopyFileBackupDir
    run.go:180: Remote "OpenDrive root 'rclone-test-qoloqex0weja'", Local "Local file system at /tmp/rclone2499888853", Modify Window "1s"
2024/10/29 04:39:40 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0
2024/10/29 04:39:42 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qoloqex0weja/backup"
2024/10/29 04:39:42 DEBUG : Starting OpenDrive session with ID: ed4f26c5ff6d9f22f66c4b205554cc5a58bcae3f034a0ec88f861404b0b5d031
2024/10/29 04:39:43 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18)
2024/10/29 04:39:44 INFO  : dst/file1: Moved (server-side)
2024/10/29 04:39:45 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0
2024/10/29 04:39:46 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2024/10/29 04:39:46 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (9.62s)
=== RUN   TestCaseInsensitiveMoveFileDryRun
    run.go:180: Remote "OpenDrive root 'rclone-test-qoloqex0weja'", Local "Local file system at /tmp/rclone2499888853", Modify Window "1s"
2024/10/29 04:39:49 DEBUG : hello: Uploading chunk 0, size=5, remain=0
2024/10/29 04:39:51 NOTICE: hello: Skipped rename to HELLO as --dry-run is set
--- PASS: TestCaseInsensitiveMoveFileDryRun (2.93s)
PASS
2024/10/29 04:39:52 DEBUG : OpenDrive root 'rclone-test-qoloqex0weja': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFileDryRun|TestCheckSum|TestCheckSumDownload|TestCopyFileBackupDir)$'" - Finished OK in 1m29.897588442s (try 2/5)