"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestConflicting|TestFixCase|TestManualTransformFile|TestMove|TestSyncDeleteDuring|TestSyncIgnoreExisting|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestTransformFile)$'" - Starting (try 2/5)
2025/11/22 01:58:30 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-tajawih6pegi"
2025/11/22 01:58:30 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/22 01:58:31 DEBUG : Starting OpenDrive session with ID: 3a8fffad6219c59941df25e5ac00742f8562a8c080057ee7ffc6937eff34ab10
2025/11/22 01:58:31 DEBUG : Creating backend with remote "/tmp/rclone3531290720"
=== RUN   TestSyncIgnoreExisting
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:58:31 DEBUG : existing: Need to transfer - File not found at Destination
2025/11/22 01:58:31 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:58:31 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:58:32 DEBUG : existing: Uploading chunk 0, size=6, remain=0
2025/11/22 01:58:33 DEBUG : existing: size = 6 OK
2025/11/22 01:58:33 DEBUG : existing: md5 = 8ee2027983915ec78acc45027d874316 OK
2025/11/22 01:58:33 INFO  : existing: Copied (new)
2025/11/22 01:58:33 DEBUG : Waiting for deletions to finish
2025/11/22 01:58:34 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:58:34 DEBUG : existing: Destination exists, skipping
2025/11/22 01:58:34 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:58:34 DEBUG : Waiting for deletions to finish
2025/11/22 01:58:34 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreExisting (3.35s)
=== RUN   TestSyncDeleteDuring
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:58:35 DEBUG : potato: Uploading chunk 0, size=21, remain=0
2025/11/22 01:58:37 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
2025/11/22 01:58:38 DEBUG : Waiting for deletions to finish
2025/11/22 01:58:39 DEBUG : empty space: size = 1 OK
2025/11/22 01:58:39 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/11/22 01:58:39 DEBUG : potato2: Need to transfer - File not found at Destination
2025/11/22 01:58:39 DEBUG : empty space: Unchanged skipping
2025/11/22 01:58:39 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:58:39 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:58:39 INFO  : potato: Deleted
2025/11/22 01:58:39 DEBUG : potato2: Uploading chunk 0, size=60, remain=0
2025/11/22 01:58:40 DEBUG : potato2: size = 60 OK
2025/11/22 01:58:40 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2025/11/22 01:58:40 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteDuring (6.89s)
=== RUN   TestSyncSuffix
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:58:42 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/11/22 01:58:44 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/11/22 01:58:46 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/11/22 01:58:47 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-tajawih6pegi/dst"
2025/11/22 01:58:47 DEBUG : Config file has changed externally - reloading
2025/11/22 01:58:48 DEBUG : Starting OpenDrive session with ID: 52970ee240239927ee800c0e15b5ba4d754f792fb24d6667bd472f35b30607e5
2025/11/22 01:58:48 DEBUG : one: size = 4 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:58:48 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-tajawih6pegi/dst')
2025/11/22 01:58:48 DEBUG : one: Sizes differ
2025/11/22 01:58:49 DEBUG : one: same parent dir (ODFfOTYwNzY5N19oMDVOWA) - using file/rename instead of move_copy for one.bak
2025/11/22 01:58:49 INFO  : one: Moved (server-side) to: one.bak
2025/11/22 01:58:50 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/11/22 01:58:51 DEBUG : one: size = 4 OK
2025/11/22 01:58:51 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/11/22 01:58:51 INFO  : one: Copied (new)
2025/11/22 01:58:51 DEBUG : two: size = 3 OK
2025/11/22 01:58:51 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/11/22 01:58:51 DEBUG : two: Unchanged skipping
2025/11/22 01:58:51 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:58:51 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-tajawih6pegi/dst')
2025/11/22 01:58:51 DEBUG : three.txt: Sizes differ
2025/11/22 01:58:52 DEBUG : three.txt: same parent dir (ODFfOTYwNzY5N19oMDVOWA) - using file/rename instead of move_copy for three.txt.bak
2025/11/22 01:58:52 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/11/22 01:58:53 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0
2025/11/22 01:58:54 DEBUG : three.txt: size = 6 OK
2025/11/22 01:58:54 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2025/11/22 01:58:54 INFO  : three.txt: Copied (new)
2025/11/22 01:58:55 DEBUG : one: size = 5 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:58:55 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-tajawih6pegi/dst')
2025/11/22 01:58:55 DEBUG : one: Sizes differ
2025/11/22 01:58:55 INFO  : one.bak: Deleted
2025/11/22 01:58:56 DEBUG : one: same parent dir (ODFfOTYwNzY5N19oMDVOWA) - using file/rename instead of move_copy for one.bak
2025/11/22 01:58:56 INFO  : one: Moved (server-side) to: one.bak
2025/11/22 01:58:57 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/11/22 01:58:58 DEBUG : one: size = 5 OK
2025/11/22 01:58:58 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/11/22 01:58:58 INFO  : one: Copied (new)
2025/11/22 01:58:58 DEBUG : two: size = 3 OK
2025/11/22 01:58:58 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/11/22 01:58:58 DEBUG : two: Unchanged skipping
2025/11/22 01:58:58 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:58:58 DEBUG : three.txt: size = 6 (OpenDrive root 'rclone-test-tajawih6pegi/dst')
2025/11/22 01:58:58 DEBUG : three.txt: Sizes differ
2025/11/22 01:58:58 INFO  : three.txt.bak: Deleted
2025/11/22 01:58:59 DEBUG : three.txt: same parent dir (ODFfOTYwNzY5N19oMDVOWA) - using file/rename instead of move_copy for three.txt.bak
2025/11/22 01:58:59 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/11/22 01:59:00 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0
2025/11/22 01:59:01 DEBUG : three.txt: size = 19 OK
2025/11/22 01:59:01 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2025/11/22 01:59:01 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (21.35s)
=== RUN   TestFixCase
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:03 DEBUG : EXISTING: Uploading chunk 0, size=6, remain=0
2025/11/22 01:59:05 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 0, size=8, remain=0
2025/11/22 01:59:08 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 0, size=8, remain=0
2025/11/22 01:59:10 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 0, size=8, remain=0
2025/11/22 01:59:12 DEBUG : EXISTING: size = 6 OK
2025/11/22 01:59:12 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/11/22 01:59:12 DEBUG : existing: Unchanged skipping
2025/11/22 01:59:12 DEBUG : existingbutdifferent: size = 5 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:59:12 DEBUG : EXISTINGBUTDIFFERENT: size = 8 (OpenDrive root 'rclone-test-tajawih6pegi')
2025/11/22 01:59:12 DEBUG : existingbutdifferent: Sizes differ
2025/11/22 01:59:12 DEBUG : subdira-rclone-move-hafopiv0: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using folder/rename instead of move_copy
2025/11/22 01:59:12 DEBUG : EXISTING: moving to existing-rclone-move-pibipal3
2025/11/22 01:59:12 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-joxuxob5
2025/11/22 01:59:13 DEBUG : subdira: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using folder/rename instead of move_copy
2025/11/22 01:59:13 DEBUG : EXISTINGBUTDIFFERENT: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using file/rename instead of move_copy for existingbutdifferent-rclone-move-joxuxob5
2025/11/22 01:59:13 DEBUG : EXISTING: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using file/rename instead of move_copy for existing-rclone-move-pibipal3
2025/11/22 01:59:13 INFO  : SUBDIRA: Fixed case by renaming to: subdira
2025/11/22 01:59:13 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-joxuxob5
2025/11/22 01:59:13 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent
2025/11/22 01:59:13 INFO  : EXISTING: Moved (server-side) to: existing-rclone-move-pibipal3
2025/11/22 01:59:13 DEBUG : EXISTING: moving to existing
2025/11/22 01:59:13 DEBUG : existingbutdifferent-rclone-move-joxuxob5: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using file/rename instead of move_copy for existingbutdifferent
2025/11/22 01:59:13 INFO  : existingbutdifferent-rclone-move-joxuxob5: Moved (server-side) to: existingbutdifferent
2025/11/22 01:59:13 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent
2025/11/22 01:59:13 INFO  : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent
2025/11/22 01:59:14 DEBUG : existingbutdifferent: Uploading chunk 0, size=5, remain=0
2025/11/22 01:59:14 DEBUG : existing-rclone-move-pibipal3: same parent dir (ODFfOTYwNzY5Nl85WFB3VA) - using file/rename instead of move_copy for existing
2025/11/22 01:59:14 DEBUG : subdira/subdirb-rclone-move-loperub6: same parent dir (ODFfOTYwNzY5OF82azVmYg) - using folder/rename instead of move_copy
2025/11/22 01:59:14 INFO  : existing-rclone-move-pibipal3: Moved (server-side) to: existing
2025/11/22 01:59:14 INFO  : EXISTING: Moved (server-side) to: existing
2025/11/22 01:59:14 INFO  : EXISTING: Fixed case by renaming to: existing
2025/11/22 01:59:14 DEBUG : subdira/subdirb: same parent dir (ODFfOTYwNzY5OF82azVmYg) - using folder/rename instead of move_copy
2025/11/22 01:59:14 INFO  : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb
2025/11/22 01:59:15 DEBUG : existingbutdifferent: size = 5 OK
2025/11/22 01:59:15 DEBUG : existingbutdifferent: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2025/11/22 01:59:15 INFO  : existingbutdifferent: Copied (replaced existing)
2025/11/22 01:59:15 DEBUG : subdira/subdirb/subdirc-rclone-move-lizudin8: same parent dir (ODFfOTYwNzY5OV9ZRkNURg) - using folder/rename instead of move_copy
2025/11/22 01:59:16 DEBUG : subdira/subdirb/subdirc: same parent dir (ODFfOTYwNzY5OV9ZRkNURg) - using folder/rename instead of move_copy
2025/11/22 01:59:16 INFO  : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc
2025/11/22 01:59:16 DEBUG : subdira/subdirb/subdirc/hello: size = 5 (Local file system at /tmp/rclone3531290720)
2025/11/22 01:59:16 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: size = 8 (OpenDrive root 'rclone-test-tajawih6pegi')
2025/11/22 01:59:16 DEBUG : subdira/subdirb/subdirc/hello: Sizes differ
2025/11/22 01:59:17 DEBUG : subdira/subdirb/subdirc/subdird-rclone-move-zusotis2: same parent dir (ODFfOTYwNzcwMF9INlFuNg) - using folder/rename instead of move_copy
2025/11/22 01:59:17 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello-rclone-move-deticop3
2025/11/22 01:59:17 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: same parent dir (ODFfOTYwNzcwMF9INlFuNg) - using file/rename instead of move_copy for subdira/subdirb/subdirc/hello-rclone-move-deticop3
2025/11/22 01:59:17 ERROR : SUBDIRA/subdirb/SUBDIRC/subdird: Error while attempting to rename to subdira/subdirb/subdirc/subdird: directory not found
2025/11/22 01:59:17 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello-rclone-move-deticop3
2025/11/22 01:59:17 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello
2025/11/22 01:59:17 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Need to transfer - File not found at Destination
2025/11/22 01:59:17 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:59:18 DEBUG : subdira/subdirb/subdirc/hello-rclone-move-deticop3: same parent dir (ODFfOTYwNzcwMF9INlFuNg) - using file/rename instead of move_copy for subdira/subdirb/subdirc/hello
2025/11/22 01:59:18 INFO  : subdira/subdirb/subdirc/hello-rclone-move-deticop3: Moved (server-side) to: subdira/subdirb/subdirc/hello
2025/11/22 01:59:18 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello
2025/11/22 01:59:18 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Fixed case by renaming to: subdira/subdirb/subdirc/hello
2025/11/22 01:59:18 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:59:18 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 0, size=5, remain=0
2025/11/22 01:59:18 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 0, size=5, remain=0
2025/11/22 01:59:19 DEBUG : subdira/subdirb/subdirc/hello: size = 5 OK
2025/11/22 01:59:19 DEBUG : subdira/subdirb/subdirc/hello: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2025/11/22 01:59:19 INFO  : subdira/subdirb/subdirc/hello: Copied (replaced existing)
2025/11/22 01:59:19 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: size = 5 OK
2025/11/22 01:59:19 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: md5 = 81bdd90fd4bc5a1c9b7b603014ff1388 OK
2025/11/22 01:59:19 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (new)
2025/11/22 01:59:19 ERROR : OpenDrive root 'rclone-test-tajawih6pegi': not deleting files as there were IO errors
2025/11/22 01:59:19 ERROR : OpenDrive root 'rclone-test-tajawih6pegi': not deleting directories as there were IO errors
    sync_test.go:2685: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2685
        	Error:      	Received unexpected error:
        	            	directory not found
        	Test:       	TestFixCase
--- FAIL: TestFixCase (20.53s)
=== RUN   TestSyncReplaceDirModTimeWithEmptyDirs
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:23 DEBUG : empty_dir: Making directory with metadata
2025/11/22 01:59:23 INFO  : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/11/22 01:59:23 DEBUG : empty_on_remote: Making directory with metadata
2025/11/22 01:59:23 INFO  : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/11/22 01:59:23 INFO  : empty_on_remote: Making directory
2025/11/22 01:59:24 INFO  : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2025/11/22 01:59:27 INFO  : test_dir1: Set directory modification time (using DirSetModTime)
2025/11/22 01:59:27 INFO  : test_dir2: Set directory modification time (using DirSetModTime)
2025/11/22 01:59:27 INFO  : test_dir2/sub_dir: Set directory modification time (using DirSetModTime)
2025/11/22 01:59:27 INFO  : empty_on_remote: Set directory modification time (using DirSetModTime)
2025/11/22 01:59:27 INFO  : empty_dir: Set directory modification time (using DirSetModTime)
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
--- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (15.66s)
=== RUN   TestConflicting
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:39 INFO  : toe: Making directory
2025/11/22 01:59:39 INFO  : toe/toe: Making directory
2025/11/22 01:59:40 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/11/22 01:59:40 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:59:40 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:59:40 DEBUG : toe/toe/toe: Uploading chunk 0, size=11, remain=0
2025/11/22 01:59:41 DEBUG : toe/toe/toe: size = 11 OK
2025/11/22 01:59:41 DEBUG : toe/toe/toe: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/11/22 01:59:41 INFO  : toe/toe/toe: Copied (new)
2025/11/22 01:59:41 DEBUG : Waiting for deletions to finish
--- PASS: TestConflicting (4.63s)
=== RUN   TestMove
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:43 DEBUG : empty_dir: Making directory with metadata
2025/11/22 01:59:43 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/11/22 01:59:43 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:43 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:43 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:44 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:44 INFO  : tictacempty_dir: Making directory
2025/11/22 01:59:44 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:44 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:44 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:44 INFO  : tictactoe: Making directory
2025/11/22 01:59:44 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:44 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:44 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:44 INFO  : tictactoe/tictactoe: Making directory
2025/11/22 01:59:45 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:45 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/11/22 01:59:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:45 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/11/22 01:59:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:45 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:45 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:59:45 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:59:45 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/11/22 01:59:46 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/11/22 01:59:46 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/11/22 01:59:46 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:46 INFO  : toe/toe/toe.txt: Deleted
2025/11/22 01:59:46 INFO  : toe/toe: Removing directory
2025/11/22 01:59:46 INFO  : toe: Removing directory
2025/11/22 01:59:46 INFO  : empty_dir: Removing directory
2025/11/22 01:59:46 DEBUG : Local file system at /tmp/rclone3531290720: deleted 3 directories
--- PASS: TestMove (5.30s)
=== RUN   TestTransformFile
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:49 DEBUG : empty_dir: Making directory with metadata
2025/11/22 01:59:49 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/11/22 01:59:49 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:49 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:49 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:49 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:49 INFO  : tictacempty_dir: Making directory
2025/11/22 01:59:49 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:49 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:49 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:49 INFO  : tictactoe: Making directory
2025/11/22 01:59:50 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:50 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:50 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:50 INFO  : tictactoe/tictactoe: Making directory
2025/11/22 01:59:50 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:50 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/11/22 01:59:50 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:50 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/11/22 01:59:50 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:50 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:50 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:59:50 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:59:51 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/11/22 01:59:52 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/11/22 01:59:52 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/11/22 01:59:52 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:52 INFO  : toe/toe/toe.txt: Deleted
2025/11/22 01:59:52 INFO  : toe/toe: Removing directory
2025/11/22 01:59:52 INFO  : toe: Removing directory
2025/11/22 01:59:52 INFO  : empty_dir: Removing directory
2025/11/22 01:59:52 DEBUG : Local file system at /tmp/rclone3531290720: deleted 3 directories
2025/11/22 01:59:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/11/22 01:59:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/11/22 01:59:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 01:59:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 01:59:53 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 01:59:54 INFO  : tictactoe/tictactoe/tictactoe.txt: Moved (server-side) to: toe/toe/toe.txt
--- PASS: TestTransformFile (8.19s)
=== RUN   TestManualTransformFile
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 01:59:57 DEBUG : Reset feature "Copy"
2025/11/22 01:59:57 DEBUG : Reset feature "Move"
2025/11/22 01:59:57 DEBUG : Reset feature "Copy"
2025/11/22 01:59:57 DEBUG : Reset feature "Move"
2025/11/22 01:59:57 DEBUG : empty_dir: Making directory with metadata
2025/11/22 01:59:57 INFO  : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/11/22 01:59:57 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:57 INFO  : tictacempty_dir: Making directory
2025/11/22 01:59:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/11/22 01:59:57 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:57 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:57 INFO  : tictactoe: Making directory
2025/11/22 01:59:58 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:58 DEBUG : toe: transformed to: tictactoe
2025/11/22 01:59:58 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:58 INFO  : tictactoe/tictactoe: Making directory
2025/11/22 01:59:58 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/11/22 01:59:58 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/11/22 01:59:58 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:58 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/11/22 01:59:58 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:58 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 01:59:58 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 01:59:58 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 01:59:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 0, size=11, remain=0
2025/11/22 02:00:00 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/11/22 02:00:00 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/11/22 02:00:00 INFO  : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/11/22 02:00:00 INFO  : toe/toe/toe.txt: Deleted
2025/11/22 02:00:00 INFO  : toe/toe: Removing directory
2025/11/22 02:00:00 INFO  : toe: Removing directory
2025/11/22 02:00:00 INFO  : empty_dir: Removing directory
2025/11/22 02:00:00 DEBUG : Local file system at /tmp/rclone3531290720: deleted 3 directories
2025/11/22 02:00:01 DEBUG : tictactoe/tictactoe/tictactoe.txt: size = 11 OK
2025/11/22 02:00:01 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/11/22 02:00:01 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 02:00:01 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 02:00:01 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/11/22 02:00:02 DEBUG : toe/toe/toe.txt: Uploading chunk 0, size=11, remain=0
2025/11/22 02:00:03 DEBUG : toe/toe/toe.txt: size = 11 OK
2025/11/22 02:00:03 DEBUG : tictactoe/tictactoe/tictactoe.txt: Src hash empty - aborting Dst hash check
2025/11/22 02:00:03 INFO  : tictactoe/tictactoe/tictactoe.txt: Copied (new) to: toe/toe/toe.txt
2025/11/22 02:00:03 INFO  : tictactoe/tictactoe/tictactoe.txt: Deleted
--- PASS: TestManualTransformFile (10.11s)
=== RUN   TestBase64
    run.go:185: Remote "OpenDrive root 'rclone-test-tajawih6pegi'", Local "Local file system at /tmp/rclone3531290720", Modify Window "1s"
2025/11/22 02:00:07 DEBUG : toe: transformed to: dG9l
2025/11/22 02:00:07 DEBUG : toe: transformed to: dG9l
2025/11/22 02:00:07 INFO  : dG9l: Making directory
2025/11/22 02:00:08 DEBUG : toe: transformed to: dG9l
2025/11/22 02:00:08 DEBUG : toe: transformed to: dG9l
2025/11/22 02:00:08 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/11/22 02:00:08 INFO  : dG9l/dG9l: Making directory
2025/11/22 02:00:08 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/11/22 02:00:08 DEBUG : toe.txt: transformed to: dG9lLnR4dA==
2025/11/22 02:00:08 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/11/22 02:00:08 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/11/22 02:00:08 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/11/22 02:00:08 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for checks to finish
2025/11/22 02:00:08 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Waiting for transfers to finish
2025/11/22 02:00:09 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 0, size=11, remain=0
2025/11/22 02:00:10 DEBUG : dG9l/dG9l/dG9lLnR4dA==: size = 11 OK
2025/11/22 02:00:10 DEBUG : toe/toe/toe.txt: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/11/22 02:00:10 INFO  : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA==
2025/11/22 02:00:10 DEBUG : Waiting for deletions to finish
2025/11/22 02:00:11 DEBUG : dG9l: transformed to: toe
2025/11/22 02:00:11 DEBUG : dG9l: transformed to: toe
2025/11/22 02:00:11 DEBUG : toe: Directory modification time the same (differ by -467.533695ms, within tolerance 1s)
2025/11/22 02:00:11 DEBUG : Added delayed dir = "toe", newDst=toe
2025/11/22 02:00:11 DEBUG : dG9l: transformed to: toe
2025/11/22 02:00:11 DEBUG : dG9l/dG9l: transformed to: toe/toe
2025/11/22 02:00:11 INFO  : toe/toe: Set directory modification time (using SetModTime)
2025/11/22 02:00:11 DEBUG : Added delayed dir = "toe/toe", newDst=toe/toe
2025/11/22 02:00:11 DEBUG : dG9lLnR4dA==: transformed to: toe.txt
2025/11/22 02:00:11 DEBUG : Local file system at /tmp/rclone3531290720: Waiting for checks to finish
2025/11/22 02:00:11 DEBUG : toe/toe/toe.txt: size = 11 OK
2025/11/22 02:00:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Size and modification time the same (differ by 499.999999ms, within tolerance 1s)
2025/11/22 02:00:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: transformed to: toe/toe/toe.txt
2025/11/22 02:00:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Unchanged skipping
2025/11/22 02:00:11 DEBUG : Local file system at /tmp/rclone3531290720: Waiting for transfers to finish
2025/11/22 02:00:11 DEBUG : Waiting for deletions to finish
--- PASS: TestBase64 (6.41s)
FAIL
2025/11/22 02:00:13 DEBUG : OpenDrive root 'rclone-test-tajawih6pegi': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestBase64|TestConflicting|TestFixCase|TestManualTransformFile|TestMove|TestSyncDeleteDuring|TestSyncIgnoreExisting|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestTransformFile)$'" - Finished ERROR in 1m43.843932781s (try 2/5): exit status 1: Failed [TestFixCase]