"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestAllTag|TestBase64|TestConflicting|TestDirTag|TestDoubleTransform|TestFileTag|TestManualTransformFile|TestMove|TestNoTag|TestRunTwice|TestServerSideMoveOverSelf|TestServerSideMoveOverlap|TestSyncAfterChangingModtimeOnly|TestSyncBackupDirWithSuffix|TestSyncCompareDest|TestSyncIgnoreErrors|TestSyncMultipleCompareDest|TestSyncSizeOnly|TestTransformFile)$'" - Starting (try 2/5)
2025/08/29 03:39:42 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe"
2025/08/29 03:39:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/29 03:39:42 DEBUG : Creating backend with remote "/tmp/rclone2189921934"
=== RUN TestServerSideMoveOverSelf
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:39:43 DEBUG : sub dir/hello world: Uploading chunk 1/1
2025/08/29 03:39:44 DEBUG : sub dir/hello world: Uploading chunk 2/1
2025/08/29 03:39:44 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "sub dir/hello world" to batch
2025/08/29 03:39:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:39:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: sub dir/hello world
2025/08/29 03:39:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: sub dir/hello world
2025/08/29 03:39:46 DEBUG : Creating backend with remote "TestDropbox:rclone-test-diqunul9kage"
sync_test.go:701: Server side copy (if possible) Dropbox root 'rclone-test-rahived5sefe' -> Dropbox root 'rclone-test-diqunul9kage'
2025/08/29 03:39:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/08/29 03:39:47 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Waiting for checks to finish
2025/08/29 03:39:47 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Waiting for transfers to finish
2025/08/29 03:39:48 DEBUG : sub dir/hello world: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:39:48 INFO : sub dir/hello world: Copied (server-side copy)
2025/08/29 03:39:49 DEBUG : sub dir/hello world: Uploading chunk 1/1
2025/08/29 03:39:50 DEBUG : sub dir/hello world: Uploading chunk 2/1
2025/08/29 03:39:50 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "sub dir/hello world" to batch
2025/08/29 03:39:51 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:39:51 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: sub dir/hello world
2025/08/29 03:39:51 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: sub dir/hello world
2025/08/29 03:39:52 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Using server-side directory move
2025/08/29 03:39:52 INFO : Dropbox root 'rclone-test-diqunul9kage': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/08/29 03:39:53 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Waiting for checks to finish
2025/08/29 03:39:53 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/08/29 03:39:53 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Waiting for transfers to finish
2025/08/29 03:39:53 INFO : sub dir/hello world: Deleted
2025/08/29 03:39:55 INFO : sub dir/hello world: Moved (server-side)
2025/08/29 03:41:25 ERROR : error listing:
Dropbox - 504
Error (504)
Something went wrong. Don't worry, your files are still safe and the Dropbox team has been notified. Check out our Status Page to see if there is a known incident, our Help Center and forums for help, or head back to home.
fstest.go:279: Error listing:
Dropbox - 504
Error (504)
Something went wrong. Don't worry, your files are still safe and the Dropbox team has been notified. Check out our Status Page to see if there is a known incident, our Help Center and forums for help, or head back to home.
2025/08/29 03:41:25 DEBUG : Dropbox root 'rclone-test-diqunul9kage': Purge remote
--- FAIL: TestServerSideMoveOverSelf (106.00s)
=== RUN TestSyncSizeOnly
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:41:28 DEBUG : sizeonly: Need to transfer - File not found at Destination
2025/08/29 03:41:28 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:41:28 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:41:29 DEBUG : sizeonly: Uploading chunk 1/1
2025/08/29 03:41:29 DEBUG : sizeonly: Uploading chunk 2/1
2025/08/29 03:41:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "sizeonly" to batch
2025/08/29 03:41:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: sizeonly
2025/08/29 03:41:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: sizeonly
2025/08/29 03:41:31 DEBUG : sizeonly: dropbox = 14c9449d1a1b47e2940560b4a3b4fb94d1b3ce3771bdb5ec4eb5f1999220623e OK
2025/08/29 03:41:31 INFO : sizeonly: Copied (new)
2025/08/29 03:41:31 DEBUG : Waiting for deletions to finish
2025/08/29 03:41:32 DEBUG : sizeonly: Sizes identical
2025/08/29 03:41:32 DEBUG : sizeonly: Unchanged skipping
2025/08/29 03:41:32 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:41:32 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:41:32 DEBUG : Waiting for deletions to finish
2025/08/29 03:41:32 INFO : There was nothing to transfer
--- PASS: TestSyncSizeOnly (4.97s)
=== RUN TestSyncIgnoreErrors
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:41:33 DEBUG : b/potato: Uploading chunk 1/1
2025/08/29 03:41:34 DEBUG : b/potato: Uploading chunk 2/1
2025/08/29 03:41:35 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "b/potato" to batch
2025/08/29 03:41:35 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:35 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: b/potato
2025/08/29 03:41:36 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: b/potato
2025/08/29 03:41:36 DEBUG : c/non empty space: Uploading chunk 1/1
2025/08/29 03:41:36 DEBUG : c/non empty space: Uploading chunk 2/1
2025/08/29 03:41:37 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "c/non empty space" to batch
2025/08/29 03:41:38 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:38 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: c/non empty space
2025/08/29 03:41:38 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: c/non empty space
2025/08/29 03:41:38 INFO : d: Making directory
2025/08/29 03:41:40 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/08/29 03:41:40 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:41:40 DEBUG : c/non empty space: Unchanged skipping
2025/08/29 03:41:40 DEBUG : a/potato2: Uploading chunk 1/1
2025/08/29 03:41:40 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:41:40 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:41:41 DEBUG : a/potato2: Uploading chunk 2/1
2025/08/29 03:41:41 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "a/potato2" to batch
2025/08/29 03:41:42 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:42 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: a/potato2
2025/08/29 03:41:43 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: a/potato2
2025/08/29 03:41:43 DEBUG : a/potato2: dropbox = a979481df794fed9c3990a6a422e0b1044ac802c15fab13af9c687f8bdbee01a OK
2025/08/29 03:41:43 INFO : a/potato2: Copied (new)
2025/08/29 03:41:43 DEBUG : Waiting for deletions to finish
2025/08/29 03:41:43 INFO : b/potato: Deleted
2025/08/29 03:41:43 INFO : d: Removing directory
2025/08/29 03:41:44 INFO : b: Removing directory
2025/08/29 03:41:46 DEBUG : Dropbox root 'rclone-test-rahived5sefe': deleted 2 directories
--- PASS: TestSyncIgnoreErrors (17.40s)
=== RUN TestSyncAfterChangingModtimeOnly
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:41:51 DEBUG : empty space: Uploading chunk 1/1
2025/08/29 03:41:51 DEBUG : empty space: Uploading chunk 2/1
2025/08/29 03:41:52 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "empty space" to batch
2025/08/29 03:41:52 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:52 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: empty space
2025/08/29 03:41:53 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: empty space
2025/08/29 03:41:54 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:41:54 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC
2025/08/29 03:41:54 DEBUG : empty space: dropbox = fc62b10ec59efa8041f5a6c924d7c91572c1bbda280d9e01312b660804df1d47 OK
2025/08/29 03:41:54 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1)
2025/08/29 03:41:54 DEBUG : empty space: Unchanged skipping
2025/08/29 03:41:54 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:41:54 DEBUG : Waiting for deletions to finish
2025/08/29 03:41:54 INFO : There was nothing to transfer
2025/08/29 03:41:54 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC
2025/08/29 03:41:54 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:41:54 DEBUG : empty space: dropbox = fc62b10ec59efa8041f5a6c924d7c91572c1bbda280d9e01312b660804df1d47 OK
2025/08/29 03:41:54 NOTICE: Dropbox root 'rclone-test-rahived5sefe': Forced to upload files to set modification times on this backend.
2025/08/29 03:41:54 INFO : empty space: src and dst identical but can't set mod time without deleting and re-uploading
2025/08/29 03:41:55 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:41:55 DEBUG : empty space: Uploading chunk 1/1
2025/08/29 03:41:56 DEBUG : empty space: Uploading chunk 2/1
2025/08/29 03:41:56 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "empty space" to batch
2025/08/29 03:41:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:41:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: empty space
2025/08/29 03:41:58 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: empty space
2025/08/29 03:41:58 DEBUG : empty space: dropbox = fc62b10ec59efa8041f5a6c924d7c91572c1bbda280d9e01312b660804df1d47 OK
2025/08/29 03:41:58 INFO : empty space: Copied (replaced existing)
2025/08/29 03:41:58 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingModtimeOnly (8.69s)
=== RUN TestServerSideMoveOverlap
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
sync_test.go:1940: Skipping test as remote supports DirMove
--- SKIP: TestServerSideMoveOverlap (0.51s)
=== RUN TestSyncCompareDest
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:42:00 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/dst"
2025/08/29 03:42:00 DEBUG : Config file has changed externally - reloading
2025/08/29 03:42:00 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/CompareDest"
2025/08/29 03:42:02 DEBUG : one: Need to transfer - File not found at Destination
2025/08/29 03:42:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:02 DEBUG : one: Uploading chunk 1/1
2025/08/29 03:42:03 DEBUG : one: Uploading chunk 2/1
2025/08/29 03:42:03 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Adding "one" to batch
2025/08/29 03:42:04 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Batch idle for 500ms so committing
2025/08/29 03:42:04 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committing sync batch length 1 starting with: one
2025/08/29 03:42:05 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committed sync batch length 1 starting with: one
2025/08/29 03:42:05 DEBUG : one: dropbox = fe8d7a873dc48961a6af334c996b2cb3ce37149d5ce9c9253952a54c6a92c1ad OK
2025/08/29 03:42:05 INFO : one: Copied (new)
2025/08/29 03:42:05 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:06 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:06 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:06 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:07 DEBUG : one: Uploading chunk 1/1
2025/08/29 03:42:07 DEBUG : one: Uploading chunk 2/1
2025/08/29 03:42:08 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Adding "one" to batch
2025/08/29 03:42:08 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Batch idle for 500ms so committing
2025/08/29 03:42:08 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committing sync batch length 1 starting with: one
2025/08/29 03:42:09 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committed sync batch length 1 starting with: one
2025/08/29 03:42:09 DEBUG : one: dropbox = 7da8d117f9fb226817d81adc15c72720c9879c8b7fb821d27f217d198bd79d0d OK
2025/08/29 03:42:09 INFO : one: Copied (replaced existing)
2025/08/29 03:42:09 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:10 DEBUG : dst/one: Uploading chunk 1/1
2025/08/29 03:42:11 DEBUG : dst/one: Uploading chunk 2/1
2025/08/29 03:42:11 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dst/one" to batch
2025/08/29 03:42:12 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:12 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dst/one
2025/08/29 03:42:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dst/one
2025/08/29 03:42:13 DEBUG : CompareDest/one: Uploading chunk 1/1
2025/08/29 03:42:13 DEBUG : CompareDest/one: Uploading chunk 2/1
2025/08/29 03:42:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "CompareDest/one" to batch
2025/08/29 03:42:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: CompareDest/one
2025/08/29 03:42:16 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: CompareDest/one
2025/08/29 03:42:17 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:17 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:17 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:17 DEBUG : one: Destination found in --compare-dest, skipping
2025/08/29 03:42:17 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:17 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:17 INFO : There was nothing to transfer
2025/08/29 03:42:18 DEBUG : CompareDest/two: Uploading chunk 1/1
2025/08/29 03:42:19 DEBUG : CompareDest/two: Uploading chunk 2/1
2025/08/29 03:42:19 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "CompareDest/two" to batch
2025/08/29 03:42:20 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:20 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: CompareDest/two
2025/08/29 03:42:20 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: CompareDest/two
2025/08/29 03:42:21 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:22 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:22 DEBUG : one: Destination found in --compare-dest, skipping
2025/08/29 03:42:22 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:22 DEBUG : two: Destination found in --compare-dest, skipping
2025/08/29 03:42:22 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:22 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:22 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:22 INFO : There was nothing to transfer
2025/08/29 03:42:22 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:23 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:23 DEBUG : one: Destination found in --compare-dest, skipping
2025/08/29 03:42:23 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:23 DEBUG : two: Destination found in --compare-dest, skipping
2025/08/29 03:42:23 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:23 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:23 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:23 INFO : There was nothing to transfer
2025/08/29 03:42:24 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:24 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:24 DEBUG : one: Destination found in --compare-dest, skipping
2025/08/29 03:42:24 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 UTC
2025/08/29 03:42:24 DEBUG : two: dropbox = 313db63e0283ab2a9bc72e9a0ac749da1d3acf708fcd1a7848767244dd2f17e8 OK
2025/08/29 03:42:24 DEBUG : two: Destination found in --compare-dest, skipping
2025/08/29 03:42:24 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:24 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:24 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:24 INFO : There was nothing to transfer
2025/08/29 03:42:26 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:26 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/08/29 03:42:26 DEBUG : two: Need to transfer - File not found at Destination
2025/08/29 03:42:26 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:42:26 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/08/29 03:42:26 DEBUG : one: Destination found in --compare-dest, skipping
2025/08/29 03:42:26 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:42:26 DEBUG : two: Uploading chunk 1/1
2025/08/29 03:42:27 DEBUG : two: Uploading chunk 2/1
2025/08/29 03:42:27 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Adding "two" to batch
2025/08/29 03:42:28 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Batch idle for 500ms so committing
2025/08/29 03:42:28 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committing sync batch length 1 starting with: two
2025/08/29 03:42:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committed sync batch length 1 starting with: two
2025/08/29 03:42:30 DEBUG : two: dropbox = 25e70b9a05696acbcc5bd6fa74ba6fa580c9a58960a02390ae1d2f71d21c0378 OK
2025/08/29 03:42:30 INFO : two: Copied (new)
2025/08/29 03:42:30 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:37 INFO : Dropbox root 'rclone-test-rahived5sefe/CompareDest': Committing uploads - please wait...
--- PASS: TestSyncCompareDest (37.02s)
=== RUN TestSyncMultipleCompareDest
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:42:37 DEBUG : pre-dest1/1: Uploading chunk 1/1
2025/08/29 03:42:37 DEBUG : pre-dest1/1: Uploading chunk 2/1
2025/08/29 03:42:38 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "pre-dest1/1" to batch
2025/08/29 03:42:39 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:39 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: pre-dest1/1
2025/08/29 03:42:39 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: pre-dest1/1
2025/08/29 03:42:40 DEBUG : pre-dest2/2: Uploading chunk 1/1
2025/08/29 03:42:40 DEBUG : pre-dest2/2: Uploading chunk 2/1
2025/08/29 03:42:41 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "pre-dest2/2" to batch
2025/08/29 03:42:41 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:41 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: pre-dest2/2
2025/08/29 03:42:42 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: pre-dest2/2
2025/08/29 03:42:42 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/dest"
2025/08/29 03:42:43 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/pre-dest1"
2025/08/29 03:42:43 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/pre-dest2"
2025/08/29 03:42:44 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/29 03:42:44 DEBUG : 1: Destination found in --compare-dest, skipping
2025/08/29 03:42:44 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/29 03:42:44 DEBUG : 2: Destination found in --compare-dest, skipping
2025/08/29 03:42:45 DEBUG : 3: Need to transfer - File not found at Destination
2025/08/29 03:42:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Waiting for checks to finish
2025/08/29 03:42:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Waiting for transfers to finish
2025/08/29 03:42:45 DEBUG : 3: Uploading chunk 1/1
2025/08/29 03:42:46 DEBUG : 3: Uploading chunk 2/1
2025/08/29 03:42:46 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Adding "3" to batch
2025/08/29 03:42:47 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Batch idle for 500ms so committing
2025/08/29 03:42:47 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Committing sync batch length 1 starting with: 3
2025/08/29 03:42:49 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dest': Committed sync batch length 1 starting with: 3
2025/08/29 03:42:49 DEBUG : 3: dropbox = 80903da4e6bbdf96e8ff6fc3966b0cfd355c7e860bdd1caa8e4722d9230e40ac OK
2025/08/29 03:42:49 INFO : 3: Copied (new)
2025/08/29 03:42:49 DEBUG : Waiting for deletions to finish
2025/08/29 03:42:55 INFO : Dropbox root 'rclone-test-rahived5sefe/pre-dest1': Committing uploads - please wait...
2025/08/29 03:42:55 INFO : Dropbox root 'rclone-test-rahived5sefe/pre-dest2': Committing uploads - please wait...
--- PASS: TestSyncMultipleCompareDest (18.78s)
=== RUN TestSyncBackupDirWithSuffix
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:42:56 DEBUG : dst/one: Uploading chunk 1/1
2025/08/29 03:42:56 DEBUG : dst/one: Uploading chunk 2/1
2025/08/29 03:42:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dst/one" to batch
2025/08/29 03:42:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:42:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dst/one
2025/08/29 03:42:58 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dst/one
2025/08/29 03:42:59 DEBUG : dst/two: Uploading chunk 1/1
2025/08/29 03:42:59 DEBUG : dst/two: Uploading chunk 2/1
2025/08/29 03:43:00 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dst/two" to batch
2025/08/29 03:43:00 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:00 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dst/two
2025/08/29 03:43:01 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dst/two
2025/08/29 03:43:01 DEBUG : dst/three.txt: Uploading chunk 1/1
2025/08/29 03:43:02 DEBUG : dst/three.txt: Uploading chunk 2/1
2025/08/29 03:43:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dst/three.txt" to batch
2025/08/29 03:43:03 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:03 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dst/three.txt
2025/08/29 03:43:04 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dst/three.txt
2025/08/29 03:43:04 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/dst"
2025/08/29 03:43:04 DEBUG : Creating backend with remote "TestDropbox:rclone-test-rahived5sefe/backup"
2025/08/29 03:43:05 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/08/29 03:43:05 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/29 03:43:05 DEBUG : two: Unchanged skipping
2025/08/29 03:43:05 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:43:07 INFO : one: Moved (server-side) to: one.bak
2025/08/29 03:43:07 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:43:07 DEBUG : one: Uploading chunk 1/1
2025/08/29 03:43:08 DEBUG : one: Uploading chunk 2/1
2025/08/29 03:43:08 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Adding "one" to batch
2025/08/29 03:43:09 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Batch idle for 500ms so committing
2025/08/29 03:43:09 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committing sync batch length 1 starting with: one
2025/08/29 03:43:09 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committed sync batch length 1 starting with: one
2025/08/29 03:43:09 DEBUG : one: dropbox = 525034bfc3bcd23ac5a856a953b1204f255bc2a5c313f3ab750d60ab581b8e81 OK
2025/08/29 03:43:09 INFO : one: Copied (new)
2025/08/29 03:43:09 DEBUG : Waiting for deletions to finish
2025/08/29 03:43:11 INFO : three.txt: Moved (server-side) to: three.txt.bak
2025/08/29 03:43:11 INFO : three.txt: Moved into backup dir
2025/08/29 03:43:12 DEBUG : dst/three.txt: Uploading chunk 1/1
2025/08/29 03:43:12 DEBUG : dst/three.txt: Uploading chunk 2/1
2025/08/29 03:43:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dst/three.txt" to batch
2025/08/29 03:43:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dst/three.txt
2025/08/29 03:43:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dst/three.txt
2025/08/29 03:43:15 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/08/29 03:43:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/29 03:43:15 DEBUG : two: Unchanged skipping
2025/08/29 03:43:15 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for checks to finish
2025/08/29 03:43:16 INFO : one.bak: Deleted
2025/08/29 03:43:17 INFO : one: Moved (server-side) to: one.bak
2025/08/29 03:43:17 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Waiting for transfers to finish
2025/08/29 03:43:17 DEBUG : one: Uploading chunk 1/1
2025/08/29 03:43:18 DEBUG : one: Uploading chunk 2/1
2025/08/29 03:43:18 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Adding "one" to batch
2025/08/29 03:43:19 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Batch idle for 500ms so committing
2025/08/29 03:43:19 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committing sync batch length 1 starting with: one
2025/08/29 03:43:20 DEBUG : Dropbox root 'rclone-test-rahived5sefe/dst': Committed sync batch length 1 starting with: one
2025/08/29 03:43:20 DEBUG : one: dropbox = 1147280340b0797198e7d42f57f0340e2579e601846419ad967bdd7fa2dec259 OK
2025/08/29 03:43:20 INFO : one: Copied (new)
2025/08/29 03:43:20 DEBUG : Waiting for deletions to finish
2025/08/29 03:43:20 INFO : three.txt.bak: Deleted
2025/08/29 03:43:22 INFO : three.txt: Moved (server-side) to: three.txt.bak
2025/08/29 03:43:22 INFO : three.txt: Moved into backup dir
2025/08/29 03:43:28 INFO : Dropbox root 'rclone-test-rahived5sefe/backup': Committing uploads - please wait...
--- PASS: TestSyncBackupDirWithSuffix (32.16s)
=== RUN TestDoubleTransform
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:43:28 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:28 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:28 INFO : tictactoe: Making directory
2025/08/29 03:43:29 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:29 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:29 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:43:29 DEBUG : toe/toe: Need to transfer - File not found at Destination
2025/08/29 03:43:29 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:43:29 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:43:29 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:43:29 DEBUG : tictactoe/tictactoe: Uploading chunk 1/1
2025/08/29 03:43:30 DEBUG : tictactoe/tictactoe: Uploading chunk 2/1
2025/08/29 03:43:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe" to batch
2025/08/29 03:43:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe
2025/08/29 03:43:32 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe
2025/08/29 03:43:32 DEBUG : toe/toe: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:43:32 INFO : toe/toe: Copied (new) to: tictactoe/tictactoe
2025/08/29 03:43:32 DEBUG : Waiting for deletions to finish
--- PASS: TestDoubleTransform (7.45s)
=== RUN TestFileTag
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:43:35 INFO : toe: Making directory
2025/08/29 03:43:36 INFO : toe/toe: Making directory
2025/08/29 03:43:37 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:37 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/08/29 03:43:37 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/08/29 03:43:37 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/08/29 03:43:37 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:43:37 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:43:38 DEBUG : toe/toe/tictactoe: Uploading chunk 1/1
2025/08/29 03:43:38 DEBUG : toe/toe/tictactoe: Uploading chunk 2/1
2025/08/29 03:43:38 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "toe/toe/tictactoe" to batch
2025/08/29 03:43:39 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:39 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: toe/toe/tictactoe
2025/08/29 03:43:40 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: toe/toe/tictactoe
2025/08/29 03:43:40 DEBUG : toe/toe/toe: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:43:40 INFO : toe/toe/toe: Copied (new) to: toe/toe/tictactoe
2025/08/29 03:43:40 DEBUG : Waiting for deletions to finish
--- PASS: TestFileTag (12.02s)
=== RUN TestNoTag
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:43:47 INFO : toe: Making directory
2025/08/29 03:43:48 INFO : toe/toe: Making directory
2025/08/29 03:43:49 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:49 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/08/29 03:43:49 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/08/29 03:43:49 DEBUG : toe/toe/toe: transformed to: toe/toe/tictactoe
2025/08/29 03:43:49 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:43:49 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:43:49 DEBUG : toe/toe/tictactoe: Uploading chunk 1/1
2025/08/29 03:43:50 DEBUG : toe/toe/tictactoe: Uploading chunk 2/1
2025/08/29 03:43:50 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "toe/toe/tictactoe" to batch
2025/08/29 03:43:51 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:43:51 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: toe/toe/tictactoe
2025/08/29 03:43:52 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: toe/toe/tictactoe
2025/08/29 03:43:52 DEBUG : toe/toe/toe: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:43:52 INFO : toe/toe/toe: Copied (new) to: toe/toe/tictactoe
2025/08/29 03:43:52 DEBUG : Waiting for deletions to finish
--- PASS: TestNoTag (10.04s)
=== RUN TestDirTag
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:43:57 DEBUG : empty_dir: Making directory with metadata
2025/08/29 03:43:57 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/08/29 03:43:57 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:43:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:43:57 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:43:57 INFO : tictacempty_dir: Making directory
2025/08/29 03:43:58 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:43:58 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:58 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:58 INFO : tictactoe: Making directory
2025/08/29 03:43:59 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:59 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:43:59 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:43:59 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:44:00 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:00 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:00 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:44:00 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:00 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:00 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:00 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 1/1
2025/08/29 03:44:01 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 2/1
2025/08/29 03:44:01 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/toe.txt" to batch
2025/08/29 03:44:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:02 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:02 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:02 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:02 DEBUG : Waiting for deletions to finish
--- PASS: TestDirTag (11.24s)
=== RUN TestAllTag
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:44:08 DEBUG : empty_dir: Making directory with metadata
2025/08/29 03:44:08 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/08/29 03:44:08 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:08 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:09 INFO : tictacempty_dir: Making directory
2025/08/29 03:44:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:09 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:09 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:09 INFO : tictactoe: Making directory
2025/08/29 03:44:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:10 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:10 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:44:11 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:11 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/08/29 03:44:11 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:11 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:44:11 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:11 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:11 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:11 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 1/1
2025/08/29 03:44:12 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 2/1
2025/08/29 03:44:12 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/tictactoe.txt" to batch
2025/08/29 03:44:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:13 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:13 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:13 DEBUG : Waiting for deletions to finish
2025/08/29 03:44:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:14 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:14 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:14 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:15 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:15 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:15 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/08/29 03:44:15 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:15 DEBUG : tictactoe/tictactoe/tictactoe.txt: OK
2025/08/29 03:44:15 NOTICE: Dropbox root 'rclone-test-rahived5sefe': 0 differences found
2025/08/29 03:44:15 NOTICE: Dropbox root 'rclone-test-rahived5sefe': 1 matching files
--- PASS: TestAllTag (12.02s)
=== RUN TestRunTwice
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:44:20 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:21 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:21 INFO : tictactoe: Making directory
2025/08/29 03:44:21 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:21 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:21 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:21 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:44:22 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:22 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:22 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:44:22 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:22 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:22 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:23 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 1/1
2025/08/29 03:44:23 DEBUG : tictactoe/tictactoe/toe.txt: Uploading chunk 2/1
2025/08/29 03:44:24 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/toe.txt" to batch
2025/08/29 03:44:24 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:24 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:25 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:25 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:25 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:25 DEBUG : Waiting for deletions to finish
2025/08/29 03:44:26 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:26 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:26 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:26 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:27 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:27 DEBUG : toe/toe/toe.txt: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/29 03:44:27 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/toe.txt
2025/08/29 03:44:27 DEBUG : toe/toe/toe.txt: Unchanged skipping
2025/08/29 03:44:27 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:27 DEBUG : Waiting for deletions to finish
--- PASS: TestRunTwice (11.00s)
=== RUN TestConflicting
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:44:32 INFO : toe: Making directory
2025/08/29 03:44:32 INFO : toe/toe: Making directory
2025/08/29 03:44:33 DEBUG : toe/toe/toe: Need to transfer - File not found at Destination
2025/08/29 03:44:33 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:33 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:33 DEBUG : toe/toe/toe: Uploading chunk 1/1
2025/08/29 03:44:34 DEBUG : toe/toe/toe: Uploading chunk 2/1
2025/08/29 03:44:34 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "toe/toe/toe" to batch
2025/08/29 03:44:35 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:35 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: toe/toe/toe
2025/08/29 03:44:36 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: toe/toe/toe
2025/08/29 03:44:36 DEBUG : toe/toe/toe: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:36 INFO : toe/toe/toe: Copied (new)
2025/08/29 03:44:36 DEBUG : Waiting for deletions to finish
--- PASS: TestConflicting (9.28s)
=== RUN TestMove
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:44:41 DEBUG : empty_dir: Making directory with metadata
2025/08/29 03:44:41 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/08/29 03:44:41 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:41 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:41 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:41 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:41 INFO : tictacempty_dir: Making directory
2025/08/29 03:44:42 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:42 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:42 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:42 INFO : tictactoe: Making directory
2025/08/29 03:44:43 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:43 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:43 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:43 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:44:43 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:43 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/08/29 03:44:43 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:43 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:44:43 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:43 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:43 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:43 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:44 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 1/1
2025/08/29 03:44:44 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 2/1
2025/08/29 03:44:45 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/tictactoe.txt" to batch
2025/08/29 03:44:46 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:46 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:46 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:46 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:46 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:46 INFO : toe/toe/toe.txt: Deleted
2025/08/29 03:44:46 INFO : toe/toe: Removing directory
2025/08/29 03:44:46 INFO : toe: Removing directory
2025/08/29 03:44:46 INFO : empty_dir: Removing directory
2025/08/29 03:44:46 DEBUG : Local file system at /tmp/rclone2189921934: deleted 3 directories
--- PASS: TestMove (11.52s)
=== RUN TestTransformFile
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:44:52 DEBUG : empty_dir: Making directory with metadata
2025/08/29 03:44:52 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/08/29 03:44:52 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:52 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:52 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:52 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:52 INFO : tictacempty_dir: Making directory
2025/08/29 03:44:53 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:44:53 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:53 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:53 INFO : tictactoe: Making directory
2025/08/29 03:44:54 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:54 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:44:54 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:54 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:44:55 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:44:55 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/08/29 03:44:55 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:55 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:44:55 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:55 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:55 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:44:55 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:44:55 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 1/1
2025/08/29 03:44:56 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 2/1
2025/08/29 03:44:56 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/tictactoe.txt" to batch
2025/08/29 03:44:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:44:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:57 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:57 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:44:57 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:44:57 INFO : toe/toe/toe.txt: Deleted
2025/08/29 03:44:57 INFO : toe/toe: Removing directory
2025/08/29 03:44:57 INFO : toe: Removing directory
2025/08/29 03:44:57 INFO : empty_dir: Removing directory
2025/08/29 03:44:57 DEBUG : Local file system at /tmp/rclone2189921934: deleted 3 directories
2025/08/29 03:44:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/08/29 03:44:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:44:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:44:59 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:45:00 INFO : tictactoe/tictactoe/tictactoe.txt: Moved (server-side) to: toe/toe/toe.txt
--- PASS: TestTransformFile (16.45s)
=== RUN TestManualTransformFile
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:45:09 DEBUG : Reset feature "Copy"
2025/08/29 03:45:09 DEBUG : Reset feature "Move"
2025/08/29 03:45:09 DEBUG : Reset feature "Copy"
2025/08/29 03:45:09 DEBUG : Reset feature "Move"
2025/08/29 03:45:09 DEBUG : empty_dir: Making directory with metadata
2025/08/29 03:45:09 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/08/29 03:45:09 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:45:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:45:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:45:09 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:45:09 INFO : tictacempty_dir: Making directory
2025/08/29 03:45:10 DEBUG : empty_dir: transformed to: tictacempty_dir
2025/08/29 03:45:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:45:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:45:10 INFO : tictactoe: Making directory
2025/08/29 03:45:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:45:10 DEBUG : toe: transformed to: tictactoe
2025/08/29 03:45:10 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:45:10 INFO : tictactoe/tictactoe: Making directory
2025/08/29 03:45:11 DEBUG : toe/toe: transformed to: tictactoe/tictactoe
2025/08/29 03:45:11 DEBUG : toe.txt: transformed to: tictactoe.txt
2025/08/29 03:45:11 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:11 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:45:11 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:11 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:11 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:45:11 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:45:12 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 1/1
2025/08/29 03:45:12 DEBUG : tictactoe/tictactoe/tictactoe.txt: Uploading chunk 2/1
2025/08/29 03:45:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "tictactoe/tictactoe/tictactoe.txt" to batch
2025/08/29 03:45:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:45:13 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:14 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:14 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:45:14 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt
2025/08/29 03:45:14 INFO : toe/toe/toe.txt: Deleted
2025/08/29 03:45:14 INFO : toe/toe: Removing directory
2025/08/29 03:45:14 INFO : toe: Removing directory
2025/08/29 03:45:14 INFO : empty_dir: Removing directory
2025/08/29 03:45:14 DEBUG : Local file system at /tmp/rclone2189921934: deleted 3 directories
2025/08/29 03:45:15 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/08/29 03:45:15 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:45:15 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:45:15 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt
2025/08/29 03:45:16 DEBUG : toe/toe/toe.txt: Uploading chunk 1/1
2025/08/29 03:45:17 DEBUG : toe/toe/toe.txt: Uploading chunk 2/1
2025/08/29 03:45:17 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "toe/toe/toe.txt" to batch
2025/08/29 03:45:18 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:45:18 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: toe/toe/toe.txt
2025/08/29 03:45:19 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: toe/toe/toe.txt
2025/08/29 03:45:19 DEBUG : tictactoe/tictactoe/tictactoe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:45:19 INFO : tictactoe/tictactoe/tictactoe.txt: Copied (new) to: toe/toe/toe.txt
2025/08/29 03:45:19 INFO : tictactoe/tictactoe/tictactoe.txt: Deleted
--- PASS: TestManualTransformFile (19.04s)
=== RUN TestBase64
run.go:180: Remote "Dropbox root 'rclone-test-rahived5sefe'", Local "Local file system at /tmp/rclone2189921934", Modify Window "1s"
2025/08/29 03:45:28 DEBUG : toe: transformed to: dG9l
2025/08/29 03:45:28 DEBUG : toe: transformed to: dG9l
2025/08/29 03:45:28 INFO : dG9l: Making directory
2025/08/29 03:45:29 DEBUG : toe: transformed to: dG9l
2025/08/29 03:45:29 DEBUG : toe: transformed to: dG9l
2025/08/29 03:45:29 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/08/29 03:45:29 INFO : dG9l/dG9l: Making directory
2025/08/29 03:45:30 DEBUG : toe/toe: transformed to: dG9l/dG9l
2025/08/29 03:45:30 DEBUG : toe.txt: transformed to: dG9lLnR4dA==
2025/08/29 03:45:30 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/08/29 03:45:30 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination
2025/08/29 03:45:30 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA==
2025/08/29 03:45:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for checks to finish
2025/08/29 03:45:30 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Waiting for transfers to finish
2025/08/29 03:45:30 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 1/1
2025/08/29 03:45:30 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Uploading chunk 2/1
2025/08/29 03:45:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Adding "dG9l/dG9l/dG9lLnR4dA==" to batch
2025/08/29 03:45:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Batch idle for 500ms so committing
2025/08/29 03:45:31 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committing sync batch length 1 starting with: dG9l/dG9l/dG9lLnR4dA==
2025/08/29 03:45:32 DEBUG : Dropbox root 'rclone-test-rahived5sefe': Committed sync batch length 1 starting with: dG9l/dG9l/dG9lLnR4dA==
2025/08/29 03:45:32 DEBUG : toe/toe/toe.txt: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK
2025/08/29 03:45:32 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA==
2025/08/29 03:45:32 DEBUG : Waiting for deletions to finish
2025/08/29 03:45:33 DEBUG : dG9l: transformed to: toe
2025/08/29 03:45:33 DEBUG : dG9l: transformed to: toe
2025/08/29 03:45:33 INFO : toe: Set directory modification time (using SetModTime)
2025/08/29 03:45:33 DEBUG : Added delayed dir = "toe", newDst=toe
2025/08/29 03:45:33 DEBUG : dG9l: transformed to: toe
2025/08/29 03:45:33 DEBUG : dG9l/dG9l: transformed to: toe/toe
2025/08/29 03:45:33 INFO : toe/toe: Set directory modification time (using SetModTime)
2025/08/29 03:45:33 DEBUG : Added delayed dir = "toe/toe", newDst=toe/toe
2025/08/29 03:45:34 DEBUG : dG9lLnR4dA==: transformed to: toe.txt
2025/08/29 03:45:34 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Size and modification time the same (differ by 499.999999ms, within tolerance 1s)
2025/08/29 03:45:34 DEBUG : dG9l/dG9l/dG9lLnR4dA==: transformed to: toe/toe/toe.txt
2025/08/29 03:45:34 DEBUG : dG9l/dG9l/dG9lLnR4dA==: Unchanged skipping
2025/08/29 03:45:34 DEBUG : Local file system at /tmp/rclone2189921934: Waiting for checks to finish
2025/08/29 03:45:34 DEBUG : Local file system at /tmp/rclone2189921934: Waiting for transfers to finish
2025/08/29 03:45:34 DEBUG : Waiting for deletions to finish
2025/08/29 03:47:09 ERROR : error listing:
Dropbox - 504
Error (504)
Something went wrong. Don't worry, your files are still safe and the Dropbox team has been notified. Check out our Status Page to see if there is a known incident, our Help Center and forums for help, or head back to home.
fstest.go:279: Error listing:
Dropbox - 504
Error (504)
Something went wrong. Don't worry, your files are still safe and the Dropbox team has been notified. Check out our Status Page to see if there is a known incident, our Help Center and forums for help, or head back to home.
