"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveOverlap|TestServerSideMoveWithFilter|TestSyncCompareDest|TestSyncIgnoreTimes|TestSyncReplaceDirModTime)$'" - Starting (try 4/5)
2026/08/11 06:11:48 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yociboq1diqo"
2026/08/11 06:11:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/11 06:11:48 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Using cached web token
2026/08/11 06:11:49 DEBUG : Creating backend with remote "/tmp/rclone3782977377"
=== RUN   TestServerSideMoveOverSelf
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:11:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:11:54 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10)
2026/08/11 06:11:55 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10)
2026/08/11 06:11:56 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-cuyawav3tudo"
2026/08/11 06:11:56 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Using cached web token
    sync_test.go:701: Server side copy (if possible) Linkbox root 'rclone-test-yociboq1diqo' -> Linkbox root 'rclone-test-cuyawav3tudo'
2026/08/11 06:11:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/08/11 06:11:57 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for checks to finish
2026/08/11 06:11:57 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for transfers to finish
2026/08/11 06:11:57 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1443h9m20.889218596s different from this computer
2026/08/11 06:12:03 DEBUG : sub dir/hello world: size = 11 OK
2026/08/11 06:12:03 INFO  : sub dir/hello world: Copied (new)
2026/08/11 06:12:03 DEBUG : sub dir/hello world: Update: removing old file
2026/08/11 06:12:07 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-yociboq1diqo')
2026/08/11 06:12:07 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-cuyawav3tudo')
2026/08/11 06:12:07 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for checks to finish
2026/08/11 06:12:07 DEBUG : sub dir/hello world: Sizes differ
2026/08/11 06:12:07 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for transfers to finish
2026/08/11 06:12:07 DEBUG : sub dir/hello world: Update: removing old file
2026/08/11 06:12:10 DEBUG : sub dir/hello world: size = 17 OK
2026/08/11 06:12:10 INFO  : sub dir/hello world: Copied (replaced existing)
2026/08/11 06:12:12 INFO  : sub dir/hello world: Deleted
2026/08/11 06:12:15 DEBUG : testing file moves
2026/08/11 06:12:16 DEBUG : sub dir/hello world: size = 24 (Linkbox root 'rclone-test-yociboq1diqo')
2026/08/11 06:12:16 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-cuyawav3tudo')
2026/08/11 06:12:16 DEBUG : sub dir/hello world: Sizes differ
2026/08/11 06:12:16 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for checks to finish
2026/08/11 06:12:16 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Waiting for transfers to finish
2026/08/11 06:12:16 DEBUG : sub dir/hello world: Update: removing old file
2026/08/11 06:12:19 DEBUG : sub dir/hello world: size = 24 OK
2026/08/11 06:12:19 INFO  : sub dir/hello world: Copied (replaced existing)
2026/08/11 06:12:20 INFO  : sub dir/hello world: Deleted
2026/08/11 06:12:21 DEBUG : Linkbox root 'rclone-test-cuyawav3tudo': Purge remote
--- PASS: TestServerSideMoveOverSelf (35.64s)
=== RUN   TestSyncIgnoreTimes
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:12:27 DEBUG : existing: size = 6 OK
2026/08/11 06:12:27 DEBUG : existing: Sizes identical
2026/08/11 06:12:27 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Waiting for checks to finish
2026/08/11 06:12:27 DEBUG : existing: Unchanged skipping
2026/08/11 06:12:27 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Waiting for transfers to finish
2026/08/11 06:12:27 DEBUG : Waiting for deletions to finish
2026/08/11 06:12:27 INFO  : There was nothing to transfer
2026/08/11 06:12:27 DEBUG : existing: Transferring unconditionally as --ignore-times is in use
2026/08/11 06:12:27 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Waiting for checks to finish
2026/08/11 06:12:27 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Waiting for transfers to finish
2026/08/11 06:12:27 DEBUG : existing: Update: removing old file
2026/08/11 06:12:30 DEBUG : existing: size = 6 OK
2026/08/11 06:12:30 INFO  : existing: Copied (replaced existing)
2026/08/11 06:12:30 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncIgnoreTimes (7.81s)
=== RUN   TestServerSideMove
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:12:32 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-pokexem9wale"
2026/08/11 06:12:32 DEBUG : Linkbox root 'rclone-test-pokexem9wale': Using cached web token
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-yociboq1diqo' -> Linkbox root 'rclone-test-pokexem9wale'
2026/08/11 06:12:46 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:12:46 DEBUG : empty space: size = 1 OK
2026/08/11 06:12:46 DEBUG : empty space: Sizes identical
2026/08/11 06:12:46 DEBUG : empty space: Unchanged skipping
2026/08/11 06:12:46 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-yociboq1diqo')
2026/08/11 06:12:46 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-pokexem9wale')
2026/08/11 06:12:46 DEBUG : potato3: Sizes differ
2026/08/11 06:12:46 DEBUG : Linkbox root 'rclone-test-pokexem9wale': Waiting for checks to finish
2026/08/11 06:12:46 DEBUG : potato3: Update: removing old file
2026/08/11 06:12:47 INFO  : empty space: Deleted
2026/08/11 06:12:47 DEBUG : Linkbox root 'rclone-test-pokexem9wale': Waiting for transfers to finish
2026/08/11 06:12:48 DEBUG : potato2: size = 60 OK
2026/08/11 06:12:48 INFO  : potato2: Copied (new)
2026/08/11 06:12:49 INFO  : potato2: Deleted
2026/08/11 06:12:49 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:12:50 DEBUG : potato3: size = 68 OK
2026/08/11 06:12:50 INFO  : potato3: Copied (replaced existing)
2026/08/11 06:12:51 INFO  : potato3: Deleted
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
2026/08/11 06:12:59 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-wayunoh3laho"
2026/08/11 06:12:59 DEBUG : Linkbox root 'rclone-test-wayunoh3laho': Using cached web token
2026/08/11 06:13:00 DEBUG : empty space: Need to transfer - File not found at Destination
2026/08/11 06:13:00 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:13:00 DEBUG : potato3: Need to transfer - File not found at Destination
2026/08/11 06:13:00 DEBUG : Linkbox root 'rclone-test-wayunoh3laho': Waiting for checks to finish
2026/08/11 06:13:00 DEBUG : Linkbox root 'rclone-test-wayunoh3laho': Waiting for transfers to finish
2026/08/11 06:13:05 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:13:05 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:13:06 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/11 06:13:06 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:13:06 DEBUG : potato3: size = 68 OK
2026/08/11 06:13:06 INFO  : potato3: Copied (new)
2026/08/11 06:13:06 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10)
2026/08/11 06:13:06 DEBUG : potato2: size = 60 OK
2026/08/11 06:13:06 INFO  : potato2: Copied (new)
2026/08/11 06:13:07 DEBUG : empty space: size = 1 OK
2026/08/11 06:13:07 INFO  : empty space: Copied (new)
2026/08/11 06:13:07 INFO  : potato3: Deleted
2026/08/11 06:13:08 INFO  : potato2: Deleted
2026/08/11 06:13:08 INFO  : empty space: Deleted
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
2026/08/11 06:13:16 DEBUG : Linkbox root 'rclone-test-wayunoh3laho': Purge remote
2026/08/11 06:13:17 DEBUG : Linkbox root 'rclone-test-pokexem9wale': Purge remote
--- PASS: TestServerSideMove (46.94s)
=== RUN   TestServerSideMoveWithFilter
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:13:19 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-tatiwow3kepi"
2026/08/11 06:13:19 DEBUG : Linkbox root 'rclone-test-tatiwow3kepi': Using cached web token
2026/08/11 06:13:24 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-yociboq1diqo' -> Linkbox root 'rclone-test-tatiwow3kepi'
2026/08/11 06:13:30 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/11 06:13:31 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/11 06:13:33 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
2026/08/11 06:13:41 DEBUG : empty space: Excluded (Size Filter)
2026/08/11 06:13:41 DEBUG : empty space: Excluded
2026/08/11 06:13:41 DEBUG : empty space: Excluded (Size Filter)
2026/08/11 06:13:41 DEBUG : empty space: Excluded
2026/08/11 06:13:41 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:13:41 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-yociboq1diqo')
2026/08/11 06:13:41 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-tatiwow3kepi')
2026/08/11 06:13:41 DEBUG : potato3: Sizes differ
2026/08/11 06:13:41 DEBUG : Linkbox root 'rclone-test-tatiwow3kepi': Waiting for checks to finish
2026/08/11 06:13:41 DEBUG : Linkbox root 'rclone-test-tatiwow3kepi': Waiting for transfers to finish
2026/08/11 06:13:42 DEBUG : potato3: Update: removing old file
2026/08/11 06:13:44 DEBUG : potato2: size = 60 OK
2026/08/11 06:13:44 INFO  : potato2: Copied (new)
2026/08/11 06:13:45 DEBUG : potato3: size = 68 OK
2026/08/11 06:13:45 INFO  : potato3: Copied (replaced existing)
2026/08/11 06:13:45 INFO  : potato2: Deleted
2026/08/11 06:13:46 INFO  : potato3: Deleted
2026/08/11 06:13:47 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-fixulow8qoju"
2026/08/11 06:13:47 DEBUG : Linkbox root 'rclone-test-fixulow8qoju': Using cached web token
2026/08/11 06:13:48 DEBUG : empty space: Excluded (Size Filter)
2026/08/11 06:13:48 DEBUG : empty space: Excluded
2026/08/11 06:13:48 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:13:48 DEBUG : potato3: Need to transfer - File not found at Destination
2026/08/11 06:13:48 DEBUG : Linkbox root 'rclone-test-fixulow8qoju': Waiting for checks to finish
2026/08/11 06:13:48 DEBUG : Linkbox root 'rclone-test-fixulow8qoju': Waiting for transfers to finish
2026/08/11 06:13:52 DEBUG : potato3: size = 68 OK
2026/08/11 06:13:52 INFO  : potato3: Copied (new)
2026/08/11 06:13:52 DEBUG : potato2: size = 60 OK
2026/08/11 06:13:52 INFO  : potato2: Copied (new)
2026/08/11 06:13:54 INFO  : potato3: Deleted
2026/08/11 06:13:54 INFO  : potato2: Deleted
2026/08/11 06:13:54 DEBUG : Linkbox root 'rclone-test-fixulow8qoju': Purge remote
2026/08/11 06:13:55 DEBUG : Linkbox root 'rclone-test-tatiwow3kepi': Purge remote
--- PASS: TestServerSideMoveWithFilter (39.48s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:13:59 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-kosucun5kuse"
2026/08/11 06:13:59 DEBUG : Linkbox root 'rclone-test-kosucun5kuse': Using cached web token
2026/08/11 06:14:06 INFO  : tomatoDir: Making directory
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-yociboq1diqo' -> Linkbox root 'rclone-test-kosucun5kuse'
2026/08/11 06:14:15 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:14:15 DEBUG : empty space: size = 1 OK
2026/08/11 06:14:15 DEBUG : empty space: Sizes identical
2026/08/11 06:14:15 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-yociboq1diqo')
2026/08/11 06:14:15 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-kosucun5kuse')
2026/08/11 06:14:15 DEBUG : potato3: Sizes differ
2026/08/11 06:14:15 DEBUG : empty space: Unchanged skipping
2026/08/11 06:14:15 DEBUG : Linkbox root 'rclone-test-kosucun5kuse': Waiting for checks to finish
2026/08/11 06:14:15 DEBUG : potato3: Update: removing old file
2026/08/11 06:14:17 INFO  : empty space: Deleted
2026/08/11 06:14:17 DEBUG : Linkbox root 'rclone-test-kosucun5kuse': Waiting for transfers to finish
2026/08/11 06:14:17 DEBUG : potato2: size = 60 OK
2026/08/11 06:14:17 INFO  : potato2: Copied (new)
2026/08/11 06:14:18 DEBUG : potato3: size = 68 OK
2026/08/11 06:14:18 INFO  : potato3: Copied (replaced existing)
2026/08/11 06:14:19 INFO  : potato2: Deleted
2026/08/11 06:14:20 INFO  : potato3: Deleted
2026/08/11 06:14:20 INFO  : tomatoDir: Removing directory
2026/08/11 06:14:21 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': deleted 1 directories
2026/08/11 06:14:22 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-fuwucol3supi"
2026/08/11 06:14:22 DEBUG : Linkbox root 'rclone-test-fuwucol3supi': Using cached web token
2026/08/11 06:14:23 INFO  : tomatoDir: Making directory
2026/08/11 06:14:25 DEBUG : empty space: Need to transfer - File not found at Destination
2026/08/11 06:14:25 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/11 06:14:25 DEBUG : potato3: Need to transfer - File not found at Destination
2026/08/11 06:14:25 DEBUG : Linkbox root 'rclone-test-fuwucol3supi': Waiting for checks to finish
2026/08/11 06:14:25 DEBUG : Linkbox root 'rclone-test-fuwucol3supi': Waiting for transfers to finish
2026/08/11 06:14:30 DEBUG : empty space: size = 1 OK
2026/08/11 06:14:30 INFO  : empty space: Copied (new)
2026/08/11 06:14:30 DEBUG : potato2: size = 60 OK
2026/08/11 06:14:30 INFO  : potato2: Copied (new)
2026/08/11 06:14:30 DEBUG : potato3: size = 68 OK
2026/08/11 06:14:30 INFO  : potato3: Copied (new)
2026/08/11 06:14:31 INFO  : empty space: Deleted
2026/08/11 06:14:31 INFO  : potato2: Deleted
2026/08/11 06:14:31 INFO  : potato3: Deleted
2026/08/11 06:14:31 INFO  : tomatoDir: Removing directory
2026/08/11 06:14:33 DEBUG : Linkbox root 'rclone-test-kosucun5kuse': deleted 1 directories
2026/08/11 06:14:33 DEBUG : Linkbox root 'rclone-test-fuwucol3supi': Purge remote
2026/08/11 06:14:35 DEBUG : Linkbox root 'rclone-test-kosucun5kuse': Purge remote
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (37.94s)
=== RUN   TestServerSideMoveOverlap
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:14:37 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yociboq1diqo/rclone-move-test"
2026/08/11 06:14:37 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/rclone-move-test': Using cached web token
--- PASS: TestServerSideMoveOverlap (5.18s)
=== RUN   TestSyncCompareDest
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:14:42 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yociboq1diqo/dst"
2026/08/11 06:14:42 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Using cached web token
2026/08/11 06:14:43 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yociboq1diqo/CompareDest"
2026/08/11 06:14:43 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/CompareDest': Using cached web token
2026/08/11 06:14:45 DEBUG : one: Need to transfer - File not found at Destination
2026/08/11 06:14:45 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:14:45 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:14:48 DEBUG : one: size = 3 OK
2026/08/11 06:14:48 INFO  : one: Copied (new)
2026/08/11 06:14:48 DEBUG : Waiting for deletions to finish
2026/08/11 06:14:50 DEBUG : one: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:14:50 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/dst')
2026/08/11 06:14:50 DEBUG : one: Sizes differ
2026/08/11 06:14:50 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:14:50 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:14:50 DEBUG : one: Update: removing old file
2026/08/11 06:14:53 DEBUG : one: size = 5 OK
2026/08/11 06:14:53 INFO  : one: Copied (replaced existing)
2026/08/11 06:14:53 DEBUG : Waiting for deletions to finish
2026/08/11 06:14:53 DEBUG : dst/one: Update: removing old file
2026/08/11 06:15:01 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:15:01 DEBUG : one: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:15:01 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/dst')
2026/08/11 06:15:01 DEBUG : one: Sizes differ
2026/08/11 06:15:01 DEBUG : one: size = 5 OK
2026/08/11 06:15:01 DEBUG : one: Sizes identical
2026/08/11 06:15:01 DEBUG : one: Destination found in --compare-dest, skipping
2026/08/11 06:15:01 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:15:01 DEBUG : Waiting for deletions to finish
2026/08/11 06:15:01 INFO  : There was nothing to transfer
2026/08/11 06:15:05 DEBUG : one: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:15:05 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/dst')
2026/08/11 06:15:05 DEBUG : one: Sizes differ
2026/08/11 06:15:05 DEBUG : two: size = 3 OK
2026/08/11 06:15:05 DEBUG : two: Sizes identical
2026/08/11 06:15:05 DEBUG : two: Destination found in --compare-dest, skipping
2026/08/11 06:15:05 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:15:05 DEBUG : one: size = 5 OK
2026/08/11 06:15:05 DEBUG : one: Sizes identical
2026/08/11 06:15:05 DEBUG : one: Destination found in --compare-dest, skipping
2026/08/11 06:15:05 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:15:05 DEBUG : Waiting for deletions to finish
2026/08/11 06:15:05 INFO  : There was nothing to transfer
2026/08/11 06:15:06 DEBUG : one: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:15:06 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/dst')
2026/08/11 06:15:06 DEBUG : one: Sizes differ
2026/08/11 06:15:06 DEBUG : two: size = 3 OK
2026/08/11 06:15:06 DEBUG : two: Sizes identical
2026/08/11 06:15:06 DEBUG : two: Destination found in --compare-dest, skipping
2026/08/11 06:15:06 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:15:07 DEBUG : one: size = 5 OK
2026/08/11 06:15:07 DEBUG : one: Sizes identical
2026/08/11 06:15:07 DEBUG : one: Destination found in --compare-dest, skipping
2026/08/11 06:15:07 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:15:07 DEBUG : Waiting for deletions to finish
2026/08/11 06:15:07 INFO  : There was nothing to transfer
2026/08/11 06:15:07 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:07 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/08/11 06:15:07 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:07 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/08/11 06:15:07 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/08/11 06:15:08 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:08 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/08/11 06:15:10 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:12 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:14 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:16 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value)
2026/08/11 06:15:18 DEBUG : pacer: Reducing sleep to 1.5s
2026/08/11 06:15:20 DEBUG : pacer: Reducing sleep to 1.125s
2026/08/11 06:15:21 DEBUG : pacer: Reducing sleep to 843.75ms
    sync_test.go:2206: No hash on uploaded file so skipping compare timestamp test
2026/08/11 06:15:23 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/08/11 06:15:23 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/08/11 06:15:24 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/08/11 06:15:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:15:24 DEBUG : one: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/dst')
2026/08/11 06:15:24 DEBUG : one: Sizes differ
2026/08/11 06:15:24 DEBUG : two: size = 5 (Local file system at /tmp/rclone3782977377)
2026/08/11 06:15:24 DEBUG : two: size = 3 (Linkbox root 'rclone-test-yociboq1diqo/CompareDest')
2026/08/11 06:15:24 DEBUG : two: Sizes differ
2026/08/11 06:15:24 DEBUG : two: Need to transfer - File not found at Destination
2026/08/11 06:15:24 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for checks to finish
2026/08/11 06:15:25 DEBUG : one: size = 5 OK
2026/08/11 06:15:25 DEBUG : one: Sizes identical
2026/08/11 06:15:25 DEBUG : one: Destination found in --compare-dest, skipping
2026/08/11 06:15:25 DEBUG : Linkbox root 'rclone-test-yociboq1diqo/dst': Waiting for transfers to finish
2026/08/11 06:15:26 DEBUG : two: size = 5 OK
2026/08/11 06:15:26 INFO  : two: Copied (new)
2026/08/11 06:15:26 DEBUG : Waiting for deletions to finish
2026/08/11 06:15:27 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/08/11 06:15:27 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/08/11 06:15:27 DEBUG : pacer: Reducing sleep to 200ms
--- PASS: TestSyncCompareDest (54.91s)
=== RUN   TestSyncReplaceDirModTime
    run.go:198: Remote "Linkbox root 'rclone-test-yociboq1diqo'", Local "Local file system at /tmp/rclone3782977377", Modify Window "876000h0m0s"
2026/08/11 06:15:37 DEBUG : empty_dir: Making directory with metadata
2026/08/11 06:15:37 INFO  : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/08/11 06:15:37 DEBUG : empty_on_remote: Making directory with metadata
2026/08/11 06:15:37 INFO  : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/08/11 06:15:37 INFO  : empty_on_remote: Making directory
2026/08/11 06:15:38 INFO  : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/08/11 06:15:47 INFO  : test_dir1: Set directory modification time (using DirSetModTime)
2026/08/11 06:15:47 INFO  : test_dir2: Set directory modification time (using DirSetModTime)
2026/08/11 06:15:47 INFO  : test_dir2/sub_dir: Set directory modification time (using DirSetModTime)
2026/08/11 06:15:47 INFO  : empty_on_remote: Set directory modification time (using DirSetModTime)
--- PASS: TestSyncReplaceDirModTime (23.24s)
PASS
2026/08/11 06:16:00 DEBUG : Linkbox root 'rclone-test-yociboq1diqo': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveOverlap|TestServerSideMoveWithFilter|TestSyncCompareDest|TestSyncIgnoreTimes|TestSyncReplaceDirModTime)$'" - Finished OK in 4m13.676099854s (try 4/5)