"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveLocal|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncNoEmptyDirectories|TestSyncNoTraverse|TestSyncReplaceDirModTime|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 2/5)
2026/10/10 06:18:50 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-huqupik6hoqu"
2026/10/10 06:18:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/10 06:18:50 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Using cached web token
2026/10/10 06:18:51 DEBUG : Creating backend with remote "/tmp/rclone4115764833"
=== RUN   TestSyncNoTraverse
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:18:51 ERROR : Ignoring --no-traverse with sync
2026/10/10 06:18:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:18:52 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:18:52 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:18:57 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:18:57 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:18:57 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoTraverse (9.60s)
=== RUN   TestSyncEmptyDirectories
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:19:01 DEBUG : sub dir2: Making directory with metadata
2026/10/10 06:19:01 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/10/10 06:19:01 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/10/10 06:19:01 INFO  : sub dir2: Making directory
2026/10/10 06:19:03 INFO  : sub dir: Making directory
2026/10/10 06:19:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:19:04 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:19:04 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:19:06 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:19:06 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:19:06 DEBUG : Waiting for deletions to finish
2026/10/10 06:19:07 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestSyncEmptyDirectories (11.10s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:19:12 INFO  : sub dir2: Making directory
2026/10/10 06:19:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:19:12 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:19:12 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:19:16 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:19:16 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:19:16 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (7.57s)
=== RUN   TestServerSideCopyOverSelf
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:19:24 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-banemad6rela"
2026/10/10 06:19:24 DEBUG : Linkbox root 'rclone-test-banemad6rela': Using cached web token
    sync_test.go:656: Server side copy (if possible) Linkbox root 'rclone-test-huqupik6hoqu' -> Linkbox root 'rclone-test-banemad6rela'
2026/10/10 06:19:25 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:19:25 DEBUG : Linkbox root 'rclone-test-banemad6rela': Waiting for checks to finish
2026/10/10 06:19:25 DEBUG : Linkbox root 'rclone-test-banemad6rela': Waiting for transfers to finish
2026/10/10 06:19:25 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1132h43m31.834072514s different from this computer
2026/10/10 06:19:31 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:19:31 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:19:32 DEBUG : sub dir/hello world: Update: removing old file
2026/10/10 06:19:36 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:19:36 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-banemad6rela')
2026/10/10 06:19:36 DEBUG : sub dir/hello world: Sizes differ
2026/10/10 06:19:36 DEBUG : Linkbox root 'rclone-test-banemad6rela': Waiting for checks to finish
2026/10/10 06:19:36 DEBUG : Linkbox root 'rclone-test-banemad6rela': Waiting for transfers to finish
2026/10/10 06:19:36 DEBUG : sub dir/hello world: Update: removing old file
2026/10/10 06:19:39 DEBUG : sub dir/hello world: size = 17 OK
2026/10/10 06:19:39 INFO  : sub dir/hello world: Copied (replaced existing)
2026/10/10 06:19:40 DEBUG : Linkbox root 'rclone-test-banemad6rela': Purge remote
--- PASS: TestServerSideCopyOverSelf (24.79s)
=== RUN   TestServerSideMoveOverSelf
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:19:48 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-wahayuk2bojo"
2026/10/10 06:19:48 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Using cached web token
    sync_test.go:701: Server side copy (if possible) Linkbox root 'rclone-test-huqupik6hoqu' -> Linkbox root 'rclone-test-wahayuk2bojo'
2026/10/10 06:19:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:19:50 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for checks to finish
2026/10/10 06:19:50 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for transfers to finish
2026/10/10 06:19:55 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:19:55 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:19:56 DEBUG : sub dir/hello world: Update: removing old file
2026/10/10 06:20:00 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for checks to finish
2026/10/10 06:20:00 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:20:00 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-wahayuk2bojo')
2026/10/10 06:20:00 DEBUG : sub dir/hello world: Sizes differ
2026/10/10 06:20:00 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for transfers to finish
2026/10/10 06:20:00 DEBUG : sub dir/hello world: Update: removing old file
2026/10/10 06:20:03 DEBUG : sub dir/hello world: size = 17 OK
2026/10/10 06:20:03 INFO  : sub dir/hello world: Copied (replaced existing)
2026/10/10 06:20:05 INFO  : sub dir/hello world: Deleted
2026/10/10 06:20:08 DEBUG : testing file moves
2026/10/10 06:20:08 DEBUG : sub dir/hello world: size = 24 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:20:08 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-wahayuk2bojo')
2026/10/10 06:20:08 DEBUG : sub dir/hello world: Sizes differ
2026/10/10 06:20:08 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for checks to finish
2026/10/10 06:20:08 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Waiting for transfers to finish
2026/10/10 06:20:09 DEBUG : sub dir/hello world: Update: removing old file
2026/10/10 06:20:12 DEBUG : sub dir/hello world: size = 24 OK
2026/10/10 06:20:12 INFO  : sub dir/hello world: Copied (replaced existing)
2026/10/10 06:20:13 INFO  : sub dir/hello world: Deleted
2026/10/10 06:20:14 DEBUG : Linkbox root 'rclone-test-wahayuk2bojo': Purge remote
--- PASS: TestServerSideMoveOverSelf (33.10s)
=== RUN   TestSyncIgnoreErrors
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:20:25 INFO  : d: Making directory
2026/10/10 06:20:27 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/10/10 06:20:28 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:20:28 DEBUG : c/non empty space: size = 5 OK
2026/10/10 06:20:28 DEBUG : c/non empty space: Sizes identical
2026/10/10 06:20:28 DEBUG : c/non empty space: Unchanged skipping
2026/10/10 06:20:28 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:20:32 DEBUG : a/potato2: size = 60 OK
2026/10/10 06:20:32 INFO  : a/potato2: Copied (new)
2026/10/10 06:20:32 DEBUG : Waiting for deletions to finish
2026/10/10 06:20:33 INFO  : b/potato: Deleted
2026/10/10 06:20:33 INFO  : d: Removing directory
2026/10/10 06:20:35 INFO  : b: Removing directory
2026/10/10 06:20:36 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': deleted 2 directories
--- PASS: TestSyncIgnoreErrors (26.09s)
=== RUN   TestSyncAfterAddingAFile
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:20:46 DEBUG : potato: Need to transfer - File not found at Destination
2026/10/10 06:20:46 DEBUG : empty space: size = 1 OK
2026/10/10 06:20:46 DEBUG : empty space: Sizes identical
2026/10/10 06:20:46 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:20:46 DEBUG : empty space: Unchanged skipping
2026/10/10 06:20:46 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:20:48 DEBUG : potato: size = 60 OK
2026/10/10 06:20:48 INFO  : potato: Copied (new)
2026/10/10 06:20:48 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterAddingAFile (7.76s)
=== RUN   TestSyncAfterChangingFilesSizeOnly
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:20:54 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:20:54 DEBUG : potato: size = 21 (Local file system at /tmp/rclone4115764833)
2026/10/10 06:20:54 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:20:54 DEBUG : potato: Sizes differ
2026/10/10 06:20:54 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:20:54 DEBUG : potato: Update: removing old file
2026/10/10 06:20:57 DEBUG : potato: size = 21 OK
2026/10/10 06:20:57 INFO  : potato: Copied (replaced existing)
2026/10/10 06:20:57 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingFilesSizeOnly (7.44s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDir
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:21:06 INFO  : d: Making directory
2026/10/10 06:21:07 INFO  : d/e: Making directory
2026/10/10 06:21:10 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/10/10 06:21:11 DEBUG : c/non empty space: size = 5 OK
2026/10/10 06:21:11 DEBUG : c/non empty space: Sizes identical
2026/10/10 06:21:11 DEBUG : c/non empty space: Unchanged skipping
2026/10/10 06:21:13 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:21:13 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:21:15 DEBUG : a/potato2: size = 60 OK
2026/10/10 06:21:15 INFO  : a/potato2: Copied (new)
2026/10/10 06:21:15 DEBUG : Waiting for deletions to finish
2026/10/10 06:21:16 INFO  : b/potato: Deleted
2026/10/10 06:21:16 INFO  : d/e: Removing directory
2026/10/10 06:21:18 INFO  : d: Removing directory
2026/10/10 06:21:19 INFO  : b: Removing directory
2026/10/10 06:21:21 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': deleted 3 directories
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (29.31s)
=== RUN   TestSyncWithTrackRenamesStrategyLeaf
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
    sync_test.go:1647: Can track renames: false
2026/10/10 06:21:28 ERROR : Linkbox root 'rclone-test-huqupik6hoqu': Ignoring --track-renames as the destination does not support server-side move or copy
2026/10/10 06:21:28 DEBUG : potato: Need to transfer - File not found at Destination
2026/10/10 06:21:28 DEBUG : sub/yam: Need to transfer - File not found at Destination
2026/10/10 06:21:28 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:21:28 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:21:32 DEBUG : potato: size = 14 OK
2026/10/10 06:21:32 INFO  : potato: Copied (new)
2026/10/10 06:21:32 DEBUG : sub/yam: size = 11 OK
2026/10/10 06:21:32 INFO  : sub/yam: Copied (new)
2026/10/10 06:21:32 DEBUG : Waiting for deletions to finish
2026/10/10 06:21:33 ERROR : Linkbox root 'rclone-test-huqupik6hoqu': Ignoring --track-renames as the destination does not support server-side move or copy
2026/10/10 06:21:33 DEBUG : yam: Need to transfer - File not found at Destination
2026/10/10 06:21:33 DEBUG : potato: size = 14 OK
2026/10/10 06:21:33 DEBUG : potato: Sizes identical
2026/10/10 06:21:33 DEBUG : potato: Unchanged skipping
2026/10/10 06:21:33 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:21:33 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:21:35 DEBUG : yam: size = 11 OK
2026/10/10 06:21:35 INFO  : yam: Copied (new)
2026/10/10 06:21:35 DEBUG : Waiting for deletions to finish
2026/10/10 06:21:37 INFO  : sub/yam: Deleted
--- PASS: TestSyncWithTrackRenamesStrategyLeaf (13.78s)
=== RUN   TestServerSideMoveLocal
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:21:42 DEBUG : Creating backend with remote "/tmp/rclone4115764833/dir1"
2026/10/10 06:21:42 DEBUG : Creating backend with remote "/tmp/rclone4115764833/dir2"
2026/10/10 06:21:42 DEBUG : Local file system at /tmp/rclone4115764833/dir2: Using server-side directory move
2026/10/10 06:21:42 INFO  : Local file system at /tmp/rclone4115764833/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2026/10/10 06:21:42 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/10/10 06:21:42 DEBUG : Local file system at /tmp/rclone4115764833/dir2: Waiting for checks to finish
2026/10/10 06:21:42 DEBUG : Local file system at /tmp/rclone4115764833/dir2: Waiting for transfers to finish
2026/10/10 06:21:42 INFO  : file1.txt: Moved (server-side)
--- PASS: TestServerSideMoveLocal (0.46s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:21:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/10/10 06:21:42 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2026/10/10 06:21:42 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:21:42 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:21:49 DEBUG : sub dir/hello world: size = 11 OK
2026/10/10 06:21:49 INFO  : sub dir/hello world: Copied (new)
2026/10/10 06:21:49 INFO  : sub dir/hello world: Deleted
2026/10/10 06:21:50 DEBUG : nested/sub dir/file: size = 6 OK
2026/10/10 06:21:50 INFO  : nested/sub dir/file: Copied (new)
2026/10/10 06:21:50 INFO  : nested/sub dir/file: Deleted
2026/10/10 06:21:50 INFO  : sub dir: Removing directory
2026/10/10 06:21:50 INFO  : nested/sub dir: Removing directory
2026/10/10 06:21:50 INFO  : nested: Removing directory
2026/10/10 06:21:50 DEBUG : Local file system at /tmp/rclone4115764833: deleted 3 directories
--- PASS: TestMoveWithDeleteEmptySrcDirs (16.58s)
=== RUN   TestMoveWithIgnoreExisting
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:21:59 DEBUG : existing-b: Need to transfer - File not found at Destination
2026/10/10 06:21:59 DEBUG : existing: Need to transfer - File not found at Destination
2026/10/10 06:21:59 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:21:59 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:22:01 DEBUG : existing-b: size = 6 OK
2026/10/10 06:22:01 INFO  : existing-b: Copied (new)
2026/10/10 06:22:01 INFO  : existing-b: Deleted
2026/10/10 06:22:02 DEBUG : existing: size = 6 OK
2026/10/10 06:22:02 INFO  : existing: Copied (new)
2026/10/10 06:22:02 INFO  : existing: Deleted
2026/10/10 06:22:02 DEBUG : existing: Destination exists, skipping
2026/10/10 06:22:02 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set
2026/10/10 06:22:02 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for checks to finish
2026/10/10 06:22:02 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Waiting for transfers to finish
2026/10/10 06:22:02 INFO  : There was nothing to transfer
--- PASS: TestMoveWithIgnoreExisting (6.51s)
=== RUN   TestServerSideMove
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:22:05 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-buvedep1foja"
2026/10/10 06:22:05 DEBUG : Linkbox root 'rclone-test-buvedep1foja': Using cached web token
    sync_test.go:1703: Server side move (if possible) Linkbox root 'rclone-test-huqupik6hoqu' -> Linkbox root 'rclone-test-buvedep1foja'
2026/10/10 06:22:19 DEBUG : potato2: Need to transfer - File not found at Destination
2026/10/10 06:22:19 DEBUG : empty space: size = 1 OK
2026/10/10 06:22:19 DEBUG : empty space: Sizes identical
2026/10/10 06:22:19 DEBUG : empty space: Unchanged skipping
2026/10/10 06:22:19 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:22:19 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-buvedep1foja')
2026/10/10 06:22:19 DEBUG : potato3: Sizes differ
2026/10/10 06:22:19 DEBUG : Linkbox root 'rclone-test-buvedep1foja': Waiting for checks to finish
2026/10/10 06:22:19 DEBUG : potato3: Update: removing old file
2026/10/10 06:22:21 INFO  : empty space: Deleted
2026/10/10 06:22:21 DEBUG : Linkbox root 'rclone-test-buvedep1foja': Waiting for transfers to finish
2026/10/10 06:22:21 DEBUG : potato2: size = 60 OK
2026/10/10 06:22:21 INFO  : potato2: Copied (new)
2026/10/10 06:22:23 INFO  : potato2: Deleted
2026/10/10 06:22:23 DEBUG : potato3: size = 68 OK
2026/10/10 06:22:23 INFO  : potato3: Copied (replaced existing)
2026/10/10 06:22:24 INFO  : potato3: Deleted
2026/10/10 06:22:24 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-zoyofef4caba"
2026/10/10 06:22:24 DEBUG : Linkbox root 'rclone-test-zoyofef4caba': Using cached web token
2026/10/10 06:22:26 DEBUG : empty space: Need to transfer - File not found at Destination
2026/10/10 06:22:26 DEBUG : potato2: Need to transfer - File not found at Destination
2026/10/10 06:22:26 DEBUG : potato3: Need to transfer - File not found at Destination
2026/10/10 06:22:26 DEBUG : Linkbox root 'rclone-test-zoyofef4caba': Waiting for checks to finish
2026/10/10 06:22:26 DEBUG : Linkbox root 'rclone-test-zoyofef4caba': Waiting for transfers to finish
2026/10/10 06:22:30 DEBUG : empty space: size = 1 OK
2026/10/10 06:22:30 INFO  : empty space: Copied (new)
2026/10/10 06:22:30 DEBUG : potato3: size = 68 OK
2026/10/10 06:22:30 INFO  : potato3: Copied (new)
2026/10/10 06:22:31 DEBUG : potato2: size = 60 OK
2026/10/10 06:22:31 INFO  : potato2: Copied (new)
2026/10/10 06:22:32 INFO  : empty space: Deleted
2026/10/10 06:22:32 INFO  : potato3: Deleted
2026/10/10 06:22:32 INFO  : potato2: Deleted
2026/10/10 06:22:32 DEBUG : Linkbox root 'rclone-test-zoyofef4caba': Purge remote
2026/10/10 06:22:34 DEBUG : Linkbox root 'rclone-test-buvedep1foja': Purge remote
--- PASS: TestServerSideMove (30.20s)
=== RUN   TestServerSideMoveWithFilter
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:22:36 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-zifahog8ruqe"
2026/10/10 06:22:36 DEBUG : Linkbox root 'rclone-test-zifahog8ruqe': Using cached web token
    sync_test.go:1703: Server side move (if possible) Linkbox root 'rclone-test-huqupik6hoqu' -> Linkbox root 'rclone-test-zifahog8ruqe'
2026/10/10 06:22:46 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/10/10 06:22:46 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/10/10 06:22:47 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/10/10 06:22:47 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/10/10 06:22:47 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/10/10 06:22:47 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/10/10 06:22:48 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/10/10 06:22:48 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/10/10 06:22:49 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/10/10 06:22:52 DEBUG : pacer: Reducing sleep to 1.5s
2026/10/10 06:22:54 DEBUG : pacer: Reducing sleep to 1.125s
2026/10/10 06:22:55 DEBUG : pacer: Reducing sleep to 843.75ms
2026/10/10 06:22:57 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/10/10 06:22:58 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/10/10 06:22:58 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/10/10 06:22:58 DEBUG : empty space: Excluded (Size Filter)
2026/10/10 06:22:58 DEBUG : empty space: Excluded
2026/10/10 06:22:59 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/10/10 06:22:59 DEBUG : empty space: Excluded (Size Filter)
2026/10/10 06:22:59 DEBUG : empty space: Excluded
2026/10/10 06:22:59 DEBUG : potato2: Need to transfer - File not found at Destination
2026/10/10 06:22:59 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-huqupik6hoqu')
2026/10/10 06:22:59 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-zifahog8ruqe')
2026/10/10 06:22:59 DEBUG : potato3: Sizes differ
2026/10/10 06:22:59 DEBUG : Linkbox root 'rclone-test-zifahog8ruqe': Waiting for checks to finish
2026/10/10 06:22:59 DEBUG : Linkbox root 'rclone-test-zifahog8ruqe': Waiting for transfers to finish
2026/10/10 06:22:59 DEBUG : potato3: Update: removing old file
2026/10/10 06:22:59 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/10/10 06:23:00 DEBUG : pacer: Reducing sleep to 200ms
2026/10/10 06:23:01 DEBUG : potato2: size = 60 OK
2026/10/10 06:23:01 INFO  : potato2: Copied (new)
2026/10/10 06:23:02 DEBUG : potato3: size = 68 OK
2026/10/10 06:23:02 INFO  : potato3: Copied (replaced existing)
2026/10/10 06:23:02 INFO  : potato2: Deleted
2026/10/10 06:23:04 INFO  : potato3: Deleted
2026/10/10 06:23:04 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-citipax8rugo"
2026/10/10 06:23:04 DEBUG : Linkbox root 'rclone-test-citipax8rugo': Using cached web token
2026/10/10 06:23:05 DEBUG : empty space: Excluded (Size Filter)
2026/10/10 06:23:05 DEBUG : empty space: Excluded
2026/10/10 06:23:05 DEBUG : potato2: Need to transfer - File not found at Destination
2026/10/10 06:23:05 DEBUG : potato3: Need to transfer - File not found at Destination
2026/10/10 06:23:05 DEBUG : Linkbox root 'rclone-test-citipax8rugo': Waiting for checks to finish
2026/10/10 06:23:05 DEBUG : Linkbox root 'rclone-test-citipax8rugo': Waiting for transfers to finish
2026/10/10 06:23:10 DEBUG : potato2: size = 60 OK
2026/10/10 06:23:10 INFO  : potato2: Copied (new)
2026/10/10 06:23:10 DEBUG : potato3: size = 68 OK
2026/10/10 06:23:10 INFO  : potato3: Copied (new)
2026/10/10 06:23:11 INFO  : potato2: Deleted
2026/10/10 06:23:11 INFO  : potato3: Deleted
2026/10/10 06:23:12 DEBUG : Linkbox root 'rclone-test-citipax8rugo': Purge remote
2026/10/10 06:23:13 DEBUG : Linkbox root 'rclone-test-zifahog8ruqe': Purge remote
--- PASS: TestServerSideMoveWithFilter (40.48s)
=== RUN   TestSyncReplaceDirModTime
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:23:16 DEBUG : empty_dir: Making directory with metadata
2026/10/10 06:23:16 INFO  : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/10/10 06:23:16 DEBUG : empty_on_remote: Making directory with metadata
2026/10/10 06:23:16 INFO  : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/10/10 06:23:16 INFO  : empty_on_remote: Making directory
2026/10/10 06:23:26 INFO  : test_dir1: Set directory modification time (using DirSetModTime)
2026/10/10 06:23:26 INFO  : test_dir2: Set directory modification time (using DirSetModTime)
2026/10/10 06:23:26 INFO  : test_dir2/sub_dir: Set directory modification time (using DirSetModTime)
2026/10/10 06:23:26 INFO  : empty_on_remote: Set directory modification time (using DirSetModTime)
--- PASS: TestSyncReplaceDirModTime (22.97s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:23:39 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/10/10 06:23:39 INFO  : sub dir: Making directory
--- PASS: TestNothingToTransferWithEmptyDirs (41.63s)
=== RUN   TestNothingToTransferWithoutEmptyDirs
    run.go:198: Remote "Linkbox root 'rclone-test-huqupik6hoqu'", Local "Local file system at /tmp/rclone4115764833", Modify Window "876000h0m0s"
2026/10/10 06:24:21 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/10/10 06:24:21 INFO  : sub dir: Making directory
2026/10/10 06:25:00 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/10/10 06:25:00 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/10/10 06:25:01 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/10/10 06:25:01 DEBUG : pacer: Reducing sleep to 200ms
--- PASS: TestNothingToTransferWithoutEmptyDirs (58.34s)
PASS
2026/10/10 06:25:19 DEBUG : Linkbox root 'rclone-test-huqupik6hoqu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveLocal|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncEmptyDirectories|TestSyncIgnoreErrors|TestSyncNoEmptyDirectories|TestSyncNoTraverse|TestSyncReplaceDirModTime|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished OK in 6m30.048181962s (try 2/5)