"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestSyncCompareDest$'" - Starting (try 2/5)
2025/11/28 01:58:15 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-kepenix9jovi"
2025/11/28 01:58:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/28 01:58:15 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/28 01:58:16 DEBUG : Creating backend with remote "/tmp/rclone1755072174"
=== RUN   TestSyncCompareDest
    run.go:185: Remote "OneDrive root 'rclone-test-kepenix9jovi'", Local "Local file system at /tmp/rclone1755072174", Modify Window "1s"
2025/11/28 01:58:16 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-kepenix9jovi/dst"
2025/11/28 01:58:16 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/28 01:58:17 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-kepenix9jovi/CompareDest"
2025/11/28 01:58:17 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/28 01:58:19 DEBUG : one: Need to transfer - File not found at Destination
2025/11/28 01:58:19 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:19 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:20 DEBUG : one: Starting multipart upload
2025/11/28 01:58:21 DEBUG : one: Uploading segment 0/3 size 3
2025/11/28 01:58:21 DEBUG : one: size = 3 OK
2025/11/28 01:58:21 DEBUG : one: quickxor = 6f70431900000000000000000300000000000000 OK
2025/11/28 01:58:21 INFO  : one: Copied (new)
2025/11/28 01:58:21 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:23 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:23 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:23 DEBUG : one: Sizes differ
2025/11/28 01:58:23 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:24 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:24 DEBUG : one: Starting multipart upload
2025/11/28 01:58:25 DEBUG : one: Uploading segment 0/5 size 5
2025/11/28 01:58:25 DEBUG : one: size = 5 OK
2025/11/28 01:58:25 DEBUG : one: quickxor = 6f704319e8200300000000000500000000000000 OK
2025/11/28 01:58:25 INFO  : one: Copied (replaced existing)
2025/11/28 01:58:25 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:25 DEBUG : dst/one: Starting multipart upload
2025/11/28 01:58:26 DEBUG : dst/one: Uploading segment 0/3 size 3
2025/11/28 01:58:27 DEBUG : CompareDest/one: Starting multipart upload
2025/11/28 01:58:27 DEBUG : CompareDest/one: Uploading segment 0/5 size 5
2025/11/28 01:58:28 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:28 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:28 DEBUG : one: Sizes differ
2025/11/28 01:58:28 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:29 DEBUG : one: size = 5 OK
2025/11/28 01:58:29 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:29 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/28 01:58:29 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:29 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:29 INFO  : There was nothing to transfer
2025/11/28 01:58:30 DEBUG : CompareDest/two: Starting multipart upload
2025/11/28 01:58:30 DEBUG : CompareDest/two: Uploading segment 0/3 size 3
2025/11/28 01:58:31 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:31 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:31 DEBUG : one: Sizes differ
2025/11/28 01:58:31 DEBUG : two: size = 3 OK
2025/11/28 01:58:31 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:31 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/28 01:58:31 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:32 DEBUG : one: size = 5 OK
2025/11/28 01:58:32 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:32 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/28 01:58:32 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:32 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:32 INFO  : There was nothing to transfer
2025/11/28 01:58:33 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:33 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:33 DEBUG : one: Sizes differ
2025/11/28 01:58:33 DEBUG : two: size = 3 OK
2025/11/28 01:58:33 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:33 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/28 01:58:33 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:34 DEBUG : one: size = 5 OK
2025/11/28 01:58:34 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:34 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/28 01:58:34 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:34 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:34 INFO  : There was nothing to transfer
2025/11/28 01:58:35 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:35 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:35 DEBUG : one: Sizes differ
2025/11/28 01:58:35 DEBUG : two: size = 3 OK
2025/11/28 01:58:35 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC
2025/11/28 01:58:35 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 OK
2025/11/28 01:58:35 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/28 01:58:35 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:35 DEBUG : one: size = 5 OK
2025/11/28 01:58:35 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:35 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/28 01:58:35 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:35 DEBUG : Waiting for deletions to finish
2025/11/28 01:58:35 INFO  : There was nothing to transfer
2025/11/28 01:58:37 DEBUG : one: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:37 DEBUG : one: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/dst')
2025/11/28 01:58:37 DEBUG : one: Sizes differ
2025/11/28 01:58:37 DEBUG : one: size = 5 OK
2025/11/28 01:58:37 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1s)
2025/11/28 01:58:37 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/28 01:58:37 DEBUG : two: size = 5 (Local file system at /tmp/rclone1755072174)
2025/11/28 01:58:37 DEBUG : two: size = 3 (OneDrive root 'rclone-test-kepenix9jovi/CompareDest')
2025/11/28 01:58:37 DEBUG : two: Sizes differ
2025/11/28 01:58:37 DEBUG : two: Need to transfer - File not found at Destination
2025/11/28 01:58:37 DEBUG : two: Starting multipart upload
2025/11/28 01:58:37 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for checks to finish
2025/11/28 01:58:37 DEBUG : OneDrive root 'rclone-test-kepenix9jovi/dst': Waiting for transfers to finish
2025/11/28 01:58:37 DEBUG : two: Uploading segment 0/5 size 5
2025/11/28 01:58:38 DEBUG : two: size = 5 OK
2025/11/28 01:58:38 DEBUG : two: quickxor = 74b8c31be8300300000000000500000000000000 OK
2025/11/28 01:58:38 INFO  : two: Copied (new)
2025/11/28 01:58:38 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (26.30s)
PASS
2025/11/28 01:58:42 DEBUG : OneDrive root 'rclone-test-kepenix9jovi': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestSyncCompareDest$'" - Finished OK in 27.682402495s (try 2/5)