"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestError|TestManualTransformFile|TestMove|TestRunTwice|TestSyncCompareDest|TestTransformFile)$'" - Starting (try 2/5) 2025/10/02 01:55:47 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lifuqis6dipa" 2025/10/02 01:55:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/02 01:55:48 DEBUG : Creating backend with remote "/tmp/rclone235143593" === RUN TestSyncCompareDest run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:55:48 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lifuqis6dipa/dst" 2025/10/02 01:55:50 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lifuqis6dipa/CompareDest" 2025/10/02 01:55:52 DEBUG : one: Need to transfer - File not found at Destination 2025/10/02 01:55:52 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:55:52 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:55:53 DEBUG : one: Starting multipart upload 2025/10/02 01:55:54 DEBUG : one: Uploading segment 0/3 size 3 2025/10/02 01:55:54 DEBUG : one: quickxor = 6f70431900000000000000000300000000000000 OK 2025/10/02 01:55:54 INFO : one: Copied (new) 2025/10/02 01:55:54 DEBUG : Waiting for deletions to finish 2025/10/02 01:55:56 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:55:56 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:55:57 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:55:57 DEBUG : one: Starting multipart upload 2025/10/02 01:55:58 DEBUG : one: Uploading segment 0/5 size 5 2025/10/02 01:55:58 DEBUG : one: quickxor = 6f704319e8200300000000000500000000000000 OK 2025/10/02 01:55:58 INFO : one: Copied (replaced existing) 2025/10/02 01:55:58 DEBUG : Waiting for deletions to finish 2025/10/02 01:55:58 DEBUG : dst/one: Starting multipart upload 2025/10/02 01:55:59 DEBUG : dst/one: Uploading segment 0/3 size 3 2025/10/02 01:56:00 DEBUG : CompareDest/one: Starting multipart upload 2025/10/02 01:56:00 DEBUG : CompareDest/one: Uploading segment 0/5 size 5 2025/10/02 01:56:01 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:56:01 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:02 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:02 DEBUG : one: Destination found in --compare-dest, skipping 2025/10/02 01:56:02 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:56:02 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:02 INFO : There was nothing to transfer 2025/10/02 01:56:02 DEBUG : CompareDest/two: Starting multipart upload 2025/10/02 01:56:02 DEBUG : CompareDest/two: Uploading segment 0/3 size 3 2025/10/02 01:56:04 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:04 DEBUG : two: Destination found in --compare-dest, skipping 2025/10/02 01:56:04 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:56:04 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:04 DEBUG : one: Destination found in --compare-dest, skipping 2025/10/02 01:56:04 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:56:04 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:04 INFO : There was nothing to transfer 2025/10/02 01:56:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:05 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:05 DEBUG : two: Destination found in --compare-dest, skipping 2025/10/02 01:56:05 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:56:05 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:05 DEBUG : one: Destination found in --compare-dest, skipping 2025/10/02 01:56:05 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:56:05 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:05 INFO : There was nothing to transfer 2025/10/02 01:56:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:06 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2025/10/02 01:56:06 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 OK 2025/10/02 01:56:06 DEBUG : two: Destination found in --compare-dest, skipping 2025/10/02 01:56:06 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:56:06 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:06 DEBUG : one: Destination found in --compare-dest, skipping 2025/10/02 01:56:06 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:56:06 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:06 INFO : There was nothing to transfer 2025/10/02 01:56:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:08 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/10/02 01:56:08 DEBUG : two: Need to transfer - File not found at Destination 2025/10/02 01:56:08 DEBUG : two: Starting multipart upload 2025/10/02 01:56:08 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for checks to finish 2025/10/02 01:56:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s) 2025/10/02 01:56:08 DEBUG : one: Destination found in --compare-dest, skipping 2025/10/02 01:56:08 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa/dst': Waiting for transfers to finish 2025/10/02 01:56:08 DEBUG : two: Uploading segment 0/5 size 5 2025/10/02 01:56:09 DEBUG : two: quickxor = 74b8c31be8300300000000000500000000000000 OK 2025/10/02 01:56:09 INFO : two: Copied (new) 2025/10/02 01:56:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (23.78s) === RUN TestDirTag run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:12 DEBUG : empty_dir: Making directory with metadata 2025/10/02 01:56:12 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:12 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:12 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:12 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:12 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:12 DEBUG : tictacempty_dir: Making directory with metadata 2025/10/02 01:56:13 INFO : tictacempty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:13 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:13 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:13 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:13 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:14 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:12.736823232Z) 2025/10/02 01:56:14 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:14 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:14 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:14 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:14 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:12.736823232Z) 2025/10/02 01:56:14 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:14 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:14 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:14 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:14 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:14 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:14 DEBUG : tictactoe/tictactoe/toe.txt: Starting multipart upload 2025/10/02 01:56:14 DEBUG : tictactoe/tictactoe/toe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:15 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:15 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:15 DEBUG : Waiting for deletions to finish --- PASS: TestDirTag (6.32s) === RUN TestAllTag run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:19 DEBUG : empty_dir: Making directory with metadata 2025/10/02 01:56:19 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:19 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:19 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:19 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:19 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:19 DEBUG : tictacempty_dir: Making directory with metadata 2025/10/02 01:56:19 INFO : tictacempty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:19 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:19 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:19 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:19 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:20 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:19.051841646Z) 2025/10/02 01:56:20 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:20 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:20 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:20 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:20 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:19.051841646Z) 2025/10/02 01:56:20 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:20 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/10/02 01:56:20 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:20 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:20 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:20 DEBUG : tictactoe/tictactoe/tictactoe.txt: Starting multipart upload 2025/10/02 01:56:20 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:20 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:21 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:21 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:21 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:21 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:22 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:22 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:22 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:22 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:22 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:22 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/10/02 01:56:23 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:23 DEBUG : tictactoe/tictactoe/tictactoe.txt: OK 2025/10/02 01:56:23 NOTICE: OneDrive root 'rclone-test-lifuqis6dipa': 0 differences found 2025/10/02 01:56:23 NOTICE: OneDrive root 'rclone-test-lifuqis6dipa': 1 matching files --- PASS: TestAllTag (7.10s) === RUN TestRunTwice run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:26 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:26 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:26 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:27 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:26.148862275Z) 2025/10/02 01:56:27 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:27 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:27 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:27 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:26.148862275Z) 2025/10/02 01:56:27 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:27 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:27 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:27 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:27 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:27 DEBUG : tictactoe/tictactoe/toe.txt: Starting multipart upload 2025/10/02 01:56:27 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:27 DEBUG : tictactoe/tictactoe/toe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:28 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:28 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:28 DEBUG : Waiting for deletions to finish 2025/10/02 01:56:29 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:29 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:29 DEBUG : tictactoe: Directory modification time the same (differ by -862.275µs, within tolerance 1s) 2025/10/02 01:56:29 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:29 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:29 DEBUG : tictactoe/tictactoe: Directory modification time the same (differ by -862.275µs, within tolerance 1s) 2025/10/02 01:56:29 DEBUG : toe/toe/toe.txt: Size and modification time the same (differ by -999.999µs, within tolerance 1s) 2025/10/02 01:56:29 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:29 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt 2025/10/02 01:56:29 DEBUG : toe/toe/toe.txt: Unchanged skipping 2025/10/02 01:56:29 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:29 DEBUG : Waiting for deletions to finish --- PASS: TestRunTwice (7.09s) === RUN TestConflicting run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:33 DEBUG : toe: Making directory with metadata 2025/10/02 01:56:34 INFO : toe: Made directory with metadata (mtime=2025-10-02T01:56:33.234882806Z) 2025/10/02 01:56:34 DEBUG : toe/toe: Making directory with metadata 2025/10/02 01:56:34 INFO : toe/toe: Made directory with metadata (mtime=2025-10-02T01:56:33.234882806Z) 2025/10/02 01:56:34 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/10/02 01:56:34 DEBUG : toe/toe/toe: Starting multipart upload 2025/10/02 01:56:34 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:34 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:34 DEBUG : toe/toe/toe: Uploading segment 0/11 size 11 2025/10/02 01:56:35 DEBUG : toe/toe/toe: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:35 INFO : toe/toe/toe: Copied (new) 2025/10/02 01:56:35 DEBUG : Waiting for deletions to finish --- PASS: TestConflicting (5.42s) === RUN TestMove run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:38 DEBUG : empty_dir: Making directory with metadata 2025/10/02 01:56:38 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:38 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:38 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:38 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:38 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:38 DEBUG : tictacempty_dir: Making directory with metadata 2025/10/02 01:56:39 INFO : tictacempty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:39 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:39 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:39 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:39 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:40 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:38.655898468Z) 2025/10/02 01:56:40 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:40 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:40 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:40 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:40 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:38.655898468Z) 2025/10/02 01:56:40 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:40 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/10/02 01:56:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:40 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:40 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:40 DEBUG : tictactoe/tictactoe/tictactoe.txt: Starting multipart upload 2025/10/02 01:56:40 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:40 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:40 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:41 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:41 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:41 INFO : toe/toe/toe.txt: Deleted 2025/10/02 01:56:41 INFO : toe/toe: Removing directory 2025/10/02 01:56:41 INFO : toe: Removing directory 2025/10/02 01:56:41 INFO : empty_dir: Removing directory 2025/10/02 01:56:41 DEBUG : Local file system at /tmp/rclone235143593: deleted 3 directories --- PASS: TestMove (6.59s) === RUN TestTransformFile run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:45 DEBUG : empty_dir: Making directory with metadata 2025/10/02 01:56:45 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:45 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:45 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:45 DEBUG : tictacempty_dir: Making directory with metadata 2025/10/02 01:56:46 INFO : tictacempty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:46 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:46 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:46 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:46 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:46 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:45.251917473Z) 2025/10/02 01:56:46 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:46 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:46 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:46 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:47 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:45.251917473Z) 2025/10/02 01:56:47 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:47 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/10/02 01:56:47 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:47 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:47 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:47 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:47 DEBUG : tictactoe/tictactoe/tictactoe.txt: Starting multipart upload 2025/10/02 01:56:47 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:47 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:47 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:47 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:47 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:47 INFO : toe/toe/toe.txt: Deleted 2025/10/02 01:56:47 INFO : toe/toe: Removing directory 2025/10/02 01:56:47 INFO : toe: Removing directory 2025/10/02 01:56:47 INFO : empty_dir: Removing directory 2025/10/02 01:56:47 DEBUG : Local file system at /tmp/rclone235143593: deleted 3 directories 2025/10/02 01:56:49 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/02 01:56:49 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:56:49 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:56:49 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:56:50 INFO : tictactoe/tictactoe/tictactoe.txt: Moved (server-side) to: toe/toe/toe.txt --- PASS: TestTransformFile (10.79s) === RUN TestManualTransformFile run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:56:56 DEBUG : Reset feature "Copy" 2025/10/02 01:56:56 DEBUG : Reset feature "Move" 2025/10/02 01:56:56 DEBUG : Reset feature "Copy" 2025/10/02 01:56:56 DEBUG : Reset feature "Move" 2025/10/02 01:56:56 DEBUG : empty_dir: Making directory with metadata 2025/10/02 01:56:56 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:56 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:56 DEBUG : tictacempty_dir: Making directory with metadata 2025/10/02 01:56:56 INFO : tictacempty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/10/02 01:56:56 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/10/02 01:56:56 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:56 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:56 DEBUG : tictactoe: Making directory with metadata 2025/10/02 01:56:57 INFO : tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:56.037948431Z) 2025/10/02 01:56:57 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:57 DEBUG : toe: transformed to: tictactoe 2025/10/02 01:56:57 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:57 DEBUG : tictactoe/tictactoe: Making directory with metadata 2025/10/02 01:56:57 INFO : tictactoe/tictactoe: Made directory with metadata (mtime=2025-10-02T01:56:56.037948431Z) 2025/10/02 01:56:57 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/10/02 01:56:57 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/10/02 01:56:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:57 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:56:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:57 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:56:57 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:57 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:56:57 DEBUG : tictactoe/tictactoe/tictactoe.txt: Starting multipart upload 2025/10/02 01:56:58 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading segment 0/11 size 11 2025/10/02 01:56:58 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:56:58 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/10/02 01:56:58 INFO : toe/toe/toe.txt: Deleted 2025/10/02 01:56:58 INFO : toe/toe: Removing directory 2025/10/02 01:56:58 INFO : toe: Removing directory 2025/10/02 01:56:58 INFO : empty_dir: Removing directory 2025/10/02 01:56:58 DEBUG : Local file system at /tmp/rclone235143593: deleted 3 directories 2025/10/02 01:56:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/02 01:56:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:56:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:56:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/10/02 01:57:01 DEBUG : toe/toe/toe.txt: Starting multipart upload 2025/10/02 01:57:02 DEBUG : toe/toe/toe.txt: Uploading segment 0/11 size 11 2025/10/02 01:57:02 DEBUG : tictactoe/tictactoe/tictactoe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:57:02 INFO : tictactoe/tictactoe/tictactoe.txt: Copied (new) to: toe/toe/toe.txt 2025/10/02 01:57:02 INFO : tictactoe/tictactoe/tictactoe.txt: Deleted --- PASS: TestManualTransformFile (11.74s) === RUN TestBase64 run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:57:07 DEBUG : toe: transformed to: dG9l 2025/10/02 01:57:08 DEBUG : toe: transformed to: dG9l 2025/10/02 01:57:08 DEBUG : dG9l: Making directory with metadata 2025/10/02 01:57:08 INFO : dG9l: Made directory with metadata (mtime=2025-10-02T01:57:07.773981949Z) 2025/10/02 01:57:08 DEBUG : toe: transformed to: dG9l 2025/10/02 01:57:08 DEBUG : toe: transformed to: dG9l 2025/10/02 01:57:08 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/10/02 01:57:08 DEBUG : dG9l/dG9l: Making directory with metadata 2025/10/02 01:57:09 INFO : dG9l/dG9l: Made directory with metadata (mtime=2025-10-02T01:57:07.773981949Z) 2025/10/02 01:57:09 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/10/02 01:57:09 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/10/02 01:57:09 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/10/02 01:57:09 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/10/02 01:57:09 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/10/02 01:57:09 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Starting multipart upload 2025/10/02 01:57:09 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:57:09 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:57:09 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading segment 0/11 size 11 2025/10/02 01:57:09 DEBUG : toe/toe/toe.txt: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:57:09 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2025/10/02 01:57:09 DEBUG : Waiting for deletions to finish 2025/10/02 01:57:10 DEBUG : dG9l: transformed to: toe 2025/10/02 01:57:10 DEBUG : dG9l: transformed to: toe 2025/10/02 01:57:10 DEBUG : toe: Directory modification time the same (differ by 981.949µs, within tolerance 1s) 2025/10/02 01:57:10 DEBUG : Added delayed dir = "toe", newDst=toe 2025/10/02 01:57:11 DEBUG : dG9l: transformed to: toe 2025/10/02 01:57:11 DEBUG : dG9l/dG9l: transformed to: toe/toe 2025/10/02 01:57:11 DEBUG : toe/toe: Directory modification time the same (differ by 981.949µs, within tolerance 1s) 2025/10/02 01:57:11 DEBUG : Added delayed dir = "toe/toe", newDst=toe/toe 2025/10/02 01:57:11 DEBUG : dG9lLnR4dA==: transformed to: toe.txt 2025/10/02 01:57:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Size and modification time the same (differ by 999.999µs, within tolerance 1s) 2025/10/02 01:57:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: transformed to: toe/toe/toe.txt 2025/10/02 01:57:11 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Unchanged skipping 2025/10/02 01:57:11 DEBUG : Local file system at /tmp/rclone235143593: Waiting for checks to finish 2025/10/02 01:57:11 DEBUG : Local file system at /tmp/rclone235143593: Waiting for transfers to finish 2025/10/02 01:57:11 DEBUG : Waiting for deletions to finish --- PASS: TestBase64 (6.85s) === RUN TestError run.go:180: Remote "OneDrive root 'rclone-test-lifuqis6dipa'", Local "Local file system at /tmp/rclone235143593", Modify Window "1s" 2025/10/02 01:57:14 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:14 DEBUG : toe: transformed to: 2025/10/02 01:57:14 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:14 DEBUG : toe: transformed to: 2025/10/02 01:57:14 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Making directory with metadata 2025/10/02 01:57:15 INFO : OneDrive root 'rclone-test-lifuqis6dipa': Made directory with metadata (mtime=2025-10-02T01:57:14.623001432Z) 2025/10/02 01:57:15 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:15 DEBUG : toe: transformed to: 2025/10/02 01:57:15 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:15 DEBUG : toe: transformed to: 2025/10/02 01:57:15 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:15 DEBUG : toe/toe: transformed to: 2025/10/02 01:57:15 ERROR : toe/toe: number of path segments must match: toe/toe (1), (0) 2025/10/02 01:57:15 DEBUG : toe/toe: Making directory with metadata 2025/10/02 01:57:16 INFO : toe/toe: Made directory with metadata (mtime=2025-10-02T01:57:14.623001432Z) 2025/10/02 01:57:16 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:16 DEBUG : toe/toe: transformed to: 2025/10/02 01:57:16 ERROR : toe/toe: number of path segments must match: toe/toe (1), (0) 2025/10/02 01:57:16 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:16 DEBUG : toe: transformed to: 2025/10/02 01:57:16 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination 2025/10/02 01:57:16 ERROR : Failed to transform: transform cannot add path separators: ta/ctoe 2025/10/02 01:57:16 DEBUG : toe/toe/toe: transformed to: 2025/10/02 01:57:16 ERROR : toe/toe/toe: number of path segments must match: toe/toe/toe (2), (0) 2025/10/02 01:57:16 DEBUG : toe/toe/toe: Starting multipart upload 2025/10/02 01:57:16 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for checks to finish 2025/10/02 01:57:16 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Waiting for transfers to finish 2025/10/02 01:57:16 DEBUG : toe/toe/toe: Uploading segment 0/11 size 11 2025/10/02 01:57:16 DEBUG : toe/toe/toe: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2025/10/02 01:57:16 INFO : toe/toe/toe: Copied (new) 2025/10/02 01:57:16 ERROR : OneDrive root 'rclone-test-lifuqis6dipa': not deleting files as there were IO errors 2025/10/02 01:57:16 ERROR : OneDrive root 'rclone-test-lifuqis6dipa': not deleting directories as there were IO errors --- PASS: TestError (5.55s) PASS 2025/10/02 01:57:20 DEBUG : OneDrive root 'rclone-test-lifuqis6dipa': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestError|TestManualTransformFile|TestMove|TestRunTwice|TestSyncCompareDest|TestTransformFile)$'" - Finished OK in 1m32.613726684s (try 2/5)