"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheck|TestCheckSum|TestMoveFileBackupDir|TestPurge)$'" - Starting (try 2/5)
2026/03/01 01:09:40 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kakaxov4lihu"
2026/03/01 01:09:40 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/03/01 01:09:40 DEBUG : Starting OpenDrive session with ID: 4a910ac41e05f7c5d1c520a1ed7f9dcb5b4e7b364fceda9edfe5be8305a60894
2026/03/01 01:09:41 DEBUG : Creating backend with remote "/tmp/rclone3129125230"
=== RUN   TestCheck
    run.go:185: Remote "OpenDrive root 'rclone-test-kakaxov4lihu'", Local "Local file system at /tmp/rclone3129125230", Modify Window "1s"
2026/03/01 01:09:42 DEBUG : rutabaga: Uploading chunk 0, size=8, remain=0
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2026/03/01 01:09:44 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
=== RUN   TestCheck/3
2026/03/01 01:09:46 DEBUG : potato2: Uploading chunk 0, size=60, remain=0
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2026/03/01 01:09:49 DEBUG : remotepotato: Uploading chunk 0, size=60, remain=0
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (10.83s)
    --- PASS: TestCheck/1 (0.18s)
    --- PASS: TestCheck/2 (0.18s)
    --- PASS: TestCheck/3 (0.18s)
    --- PASS: TestCheck/4 (0.18s)
    --- PASS: TestCheck/5 (0.18s)
    --- PASS: TestCheck/6 (0.19s)
    --- PASS: TestCheck/7 (0.18s)
=== RUN   TestCheckSum
    run.go:185: Remote "OpenDrive root 'rclone-test-kakaxov4lihu'", Local "Local file system at /tmp/rclone3129125230", Modify Window "1s"
2026/03/01 01:09:51 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kakaxov4lihu/data"
2026/03/01 01:09:52 DEBUG : Starting OpenDrive session with ID: d634ed5de2d1a1c36df96107ccce05210a8f1a909a0c5e38650b2ebbf98c3428
2026/03/01 01:09:54 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2026/03/01 01:09:56 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest1
2026/03/01 01:09:59 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2026/03/01 01:10:00 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest2
2026/03/01 01:10:02 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest3
2026/03/01 01:10:05 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest4
2026/03/01 01:10:07 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest5
2026/03/01 01:10:09 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest6
2026/03/01 01:10:11 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2026/03/01 01:10:12 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2026/03/01 01:10:14 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest7
--- PASS: TestCheckSum (25.50s)
    --- PASS: TestCheckSum/subtest1 (0.71s)
    --- PASS: TestCheckSum/subtest2 (0.54s)
    --- PASS: TestCheckSum/subtest3 (0.56s)
    --- PASS: TestCheckSum/subtest4 (0.55s)
    --- PASS: TestCheckSum/subtest5 (0.55s)
    --- PASS: TestCheckSum/subtest6 (0.54s)
    --- PASS: TestCheckSum/subtest7 (0.53s)
=== RUN   TestPurge
2026/03/01 01:10:17 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kohetuz0ranu"
2026/03/01 01:10:17 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/03/01 01:10:17 DEBUG : Starting OpenDrive session with ID: fb93bd25137b0fa5148cbacbe9a587bfda16a277ad88fda995ede1a20f5747f6
2026/03/01 01:10:18 DEBUG : Creating backend with remote "/tmp/rclone3445369186"
    run.go:185: Remote "OpenDrive root 'rclone-test-kohetuz0ranu'", Local "Local file system at /tmp/rclone3445369186", Modify Window "1s"
2026/03/01 01:10:20 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0
2026/03/01 01:10:21 INFO  : A2: Making directory
2026/03/01 01:10:21 INFO  : A1/B2: Making directory
2026/03/01 01:10:22 INFO  : A1/B2/C2: Making directory
2026/03/01 01:10:22 INFO  : A1/B1/C3: Making directory
2026/03/01 01:10:23 INFO  : A3: Making directory
2026/03/01 01:10:23 INFO  : A3/B3: Making directory
2026/03/01 01:10:23 INFO  : A3/B3/C4: Making directory
2026/03/01 01:10:24 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0
2026/03/01 01:10:28 ERROR : error listing: directory not found
2026/03/01 01:10:28 DEBUG : OpenDrive root 'rclone-test-kohetuz0ranu': Purge remote
2026/03/01 01:10:29 NOTICE: purge failed: directory not found
--- PASS: TestPurge (11.63s)
=== RUN   TestMoveFileBackupDir
    run.go:185: Remote "OpenDrive root 'rclone-test-kakaxov4lihu'", Local "Local file system at /tmp/rclone3129125230", Modify Window "1s"
2026/03/01 01:10:30 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0
2026/03/01 01:10:31 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kakaxov4lihu/backup"
2026/03/01 01:10:32 DEBUG : Starting OpenDrive session with ID: a53290344c5d7c7ab04bcb87fe6de7b5d79558fbb6c4b4917e1f391ad43d9d51
2026/03/01 01:10:32 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone3129125230)
2026/03/01 01:10:32 DEBUG : dst/file1: size = 18 (OpenDrive root 'rclone-test-kakaxov4lihu')
2026/03/01 01:10:32 DEBUG : dst/file1: Sizes differ
2026/03/01 01:10:34 INFO  : dst/file1: Moved (server-side)
2026/03/01 01:10:34 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0
2026/03/01 01:10:36 DEBUG : dst/file1: size = 14 OK
2026/03/01 01:10:36 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2026/03/01 01:10:36 INFO  : dst/file1: Copied (new)
2026/03/01 01:10:36 INFO  : dst/file1: Deleted
--- PASS: TestMoveFileBackupDir (9.99s)
PASS
2026/03/01 01:10:39 DEBUG : OpenDrive root 'rclone-test-kakaxov4lihu': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheck|TestCheckSum|TestMoveFileBackupDir|TestPurge)$'" - Finished OK in 59.284401303s (try 2/5)