"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSum|TestMaxDeleteSize|TestPurge|TestRemoveExisting|TestRmdirsNoLeaveRoot)$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Starting (try 2/5)
2026/02/07 02:00:15 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-firoduk6hiwo"
2026/02/07 02:00:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/07 02:00:15 DEBUG : Starting OpenDrive session with ID: 6d624a516e04751294d955a24c985477415c94f3a54791e810fb8e21e5e2adae
2026/02/07 02:00:16 DEBUG : Creating backend with remote "/tmp/rclone2197391541"
=== RUN   TestCheckSum
    run.go:185: Remote "OpenDrive root 'rclone-test-firoduk6hiwo'", Local "Local file system at /tmp/rclone2197391541", Modify Window "1s"
2026/02/07 02:00:16 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-firoduk6hiwo/data"
2026/02/07 02:00:16 DEBUG : Starting OpenDrive session with ID: f4e48b6fe56c435663b512a52179358338cac8162c0c7cd21db2c077bb359cbf
2026/02/07 02:00:18 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2026/02/07 02:00:20 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest1
2026/02/07 02:00:24 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2026/02/07 02:00:25 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0
=== RUN   TestCheckSum/subtest2
2026/02/07 02:00:29 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest3
2026/02/07 02:00:33 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest4
2026/02/07 02:00:35 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest5
2026/02/07 02:00:38 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0
=== RUN   TestCheckSum/subtest6
2026/02/07 02:00:41 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0
2026/02/07 02:00:42 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0
2026/02/07 02:00:43 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0
=== RUN   TestCheckSum/subtest7
--- PASS: TestCheckSum (30.45s)
    --- PASS: TestCheckSum/subtest1 (1.07s)
    --- PASS: TestCheckSum/subtest2 (1.11s)
    --- PASS: TestCheckSum/subtest3 (1.37s)
    --- PASS: TestCheckSum/subtest4 (0.55s)
    --- PASS: TestCheckSum/subtest5 (0.74s)
    --- PASS: TestCheckSum/subtest6 (0.81s)
    --- PASS: TestCheckSum/subtest7 (0.55s)
=== RUN   TestMaxDeleteSize
    run.go:185: Remote "OpenDrive root 'rclone-test-firoduk6hiwo'", Local "Local file system at /tmp/rclone2197391541", Modify Window "1s"
2026/02/07 02:00:47 DEBUG : small: Uploading chunk 0, size=10, remain=0
2026/02/07 02:00:49 DEBUG : medium: Uploading chunk 0, size=60, remain=0
2026/02/07 02:00:50 DEBUG : large: Uploading chunk 0, size=100, remain=0
2026/02/07 02:00:51 DEBUG : Waiting for deletions to finish
2026/02/07 02:00:51 ERROR : small: Got fatal error on delete: --max-delete-size threshold reached
2026/02/07 02:00:52 INFO  : large: Deleted
2026/02/07 02:00:52 INFO  : medium: Deleted
--- PASS: TestMaxDeleteSize (7.12s)
=== RUN   TestPurge
2026/02/07 02:00:53 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kitukaw0fido"
2026/02/07 02:00:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/07 02:00:54 DEBUG : Starting OpenDrive session with ID: f8face6d59ec6f88fe926c8317425881b2092fd84cd5e217a5e657efc279b0bd
2026/02/07 02:00:54 DEBUG : Creating backend with remote "/tmp/rclone1900727064"
    run.go:185: Remote "OpenDrive root 'rclone-test-kitukaw0fido'", Local "Local file system at /tmp/rclone1900727064", Modify Window "1s"
2026/02/07 02:00:56 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0
2026/02/07 02:00:57 INFO  : A2: Making directory
2026/02/07 02:00:58 INFO  : A1/B2: Making directory
2026/02/07 02:00:58 INFO  : A1/B2/C2: Making directory
2026/02/07 02:00:58 INFO  : A1/B1/C3: Making directory
2026/02/07 02:00:59 INFO  : A3: Making directory
2026/02/07 02:00:59 INFO  : A3/B3: Making directory
2026/02/07 02:00:59 INFO  : A3/B3/C4: Making directory
2026/02/07 02:01:00 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0
2026/02/07 02:01:04 ERROR : error listing: directory not found
2026/02/07 02:01:04 DEBUG : OpenDrive root 'rclone-test-kitukaw0fido': Purge remote
2026/02/07 02:01:04 NOTICE: purge failed: directory not found
--- PASS: TestPurge (10.81s)
=== RUN   TestRmdirsNoLeaveRoot
    run.go:185: Remote "OpenDrive root 'rclone-test-firoduk6hiwo'", Local "Local file system at /tmp/rclone2197391541", Modify Window "1s"
2026/02/07 02:01:06 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0
2026/02/07 02:01:07 INFO  : A2: Making directory
2026/02/07 02:01:07 INFO  : A1/B2: Making directory
2026/02/07 02:01:07 INFO  : A1/B2/C2: Making directory
2026/02/07 02:01:08 INFO  : A1/B1/C3: Making directory
2026/02/07 02:01:08 INFO  : A3: Making directory
2026/02/07 02:01:08 INFO  : A3/B3: Making directory
2026/02/07 02:01:09 INFO  : A3/B3/C4: Making directory
2026/02/07 02:01:10 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0
2026/02/07 02:01:12 DEBUG : removing 1 level 3 directories
2026/02/07 02:01:12 INFO  : A3/B3/C4: Removing directory
2026/02/07 02:01:14 DEBUG : removing 2 level 3 directories
2026/02/07 02:01:14 INFO  : A1/B2/C2: Removing directory
2026/02/07 02:01:14 INFO  : A1/B1/C3: Removing directory
2026/02/07 02:01:14 DEBUG : removing 2 level 2 directories
2026/02/07 02:01:14 INFO  : A3/B3: Removing directory
2026/02/07 02:01:14 INFO  : A1/B2: Removing directory
2026/02/07 02:01:14 DEBUG : removing 2 level 1 directories
2026/02/07 02:01:14 INFO  : A3: Removing directory
2026/02/07 02:01:14 INFO  : A2: Removing directory
2026/02/07 02:01:17 DEBUG : removing 1 level 3 directories
2026/02/07 02:01:17 INFO  : A1/B1/C1: Removing directory
2026/02/07 02:01:17 DEBUG : removing 1 level 2 directories
2026/02/07 02:01:17 INFO  : A1/B1: Removing directory
2026/02/07 02:01:18 DEBUG : removing 1 level 1 directories
2026/02/07 02:01:18 INFO  : A1: Removing directory
2026/02/07 02:01:18 DEBUG : removing 1 level 0 directories
2026/02/07 02:01:18 INFO  : OpenDrive root 'rclone-test-firoduk6hiwo': Removing directory
2026/02/07 02:01:19 ERROR : error listing: directory not found
2026/02/07 02:01:19 ERROR : error listing: directory not found
--- PASS: TestRmdirsNoLeaveRoot (14.68s)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=true,ignoreChecksum=false
    run.go:185: Remote "OpenDrive root 'rclone-test-firoduk6hiwo'", Local "Local file system at /tmp/rclone2197391541", Modify Window "1s"
2026/02/07 02:01:19 ERROR : error listing: directory not found
2026/02/07 02:01:19 DEBUG : OpenDrive root 'rclone-test-firoduk6hiwo': File to upload is small (34 bytes), uploading instead of streaming
2026/02/07 02:01:20 DEBUG : with_checksum_small_file_from_pipe: Uploading chunk 0, size=34, remain=0
2026/02/07 02:01:21 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK
2026/02/07 02:01:21 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK
2026/02/07 02:01:21 DEBUG : with_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical
2026/02/07 02:01:21 DEBUG : OpenDrive root 'rclone-test-firoduk6hiwo': Target remote doesn't support streaming uploads, creating temporary local FS to spool file
2026/02/07 02:01:22 DEBUG : with_checksum_big_file_from_pipe: Uploading chunk 0, size=102401, remain=0
2026/02/07 02:01:23 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK
2026/02/07 02:01:23 DEBUG : with_checksum_big_file_from_pipe: md5 = fffc7956ba9a7b58a63c01b6ce1ddc45 OK
2026/02/07 02:01:23 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical
--- PASS: TestRcat (5.54s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.54s)
=== RUN   TestRemoveExisting
    run.go:185: Remote "OpenDrive root 'rclone-test-firoduk6hiwo'", Local "Local file system at /tmp/rclone2197391541", Modify Window "1s"
2026/02/07 02:01:25 DEBUG : sub dir/test remove existing: Uploading chunk 0, size=11, remain=0
2026/02/07 02:01:27 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Uploading chunk 0, size=21, remain=0
2026/02/07 02:01:30 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.donabif3" before starting
2026/02/07 02:01:30 DEBUG : sub dir/test remove existing: same parent dir (ODFfOTkwODYwMV8wWFRFSw) - using file/rename instead of move_copy for sub dir/test remove existing.donabif3
2026/02/07 02:01:30 DEBUG : sub dir/test remove existing.donabif3: TEST: removing renamed existing file after operation
2026/02/07 02:01:31 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuboyur1" before starting
2026/02/07 02:01:31 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTkwODYwMV8wWFRFSw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuboyur1
2026/02/07 02:01:32 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuboyur1: TEST: renaming existing back after failed operation
2026/02/07 02:01:32 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuboyur1: same parent dir (ODFfOTkwODYwMV8wWFRFSw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789
2026/02/07 02:01:33 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.mupizud4" before starting
2026/02/07 02:01:33 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTkwODYwMV8wWFRFSw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.mupizud4
2026/02/07 02:01:33 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.mupizud4: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (10.51s)
PASS
2026/02/07 02:01:35 DEBUG : OpenDrive root 'rclone-test-firoduk6hiwo': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSum|TestMaxDeleteSize|TestPurge|TestRemoveExisting|TestRmdirsNoLeaveRoot)$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Finished OK in 1m21.049806817s (try 2/5)