"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestSyncDoesntUpdateModtime|TestSyncWithUpdateOlder)$'" - Starting (try 2/5)
2025/05/05 04:37:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-loyadej4nawu"
2025/05/05 04:37:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/05 04:37:44 DEBUG : Creating backend with remote "/tmp/rclone405782211"
=== RUN   TestSyncDoesntUpdateModtime
    run.go:180: Remote "OneDrive root 'rclone-test-loyadej4nawu'", Local "Local file system at /tmp/rclone405782211", Modify Window "1s"
2025/05/05 04:37:44 DEBUG : foo: Starting multipart upload
2025/05/05 04:37:44 DEBUG : foo: Uploading segment 0/3 size 3
2025/05/05 04:37:45 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC
2025/05/05 04:37:45 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for checks to finish
2025/05/05 04:37:45 DEBUG : foo: quickxor = 6678c31b00000000000000000300000000000000 (Local file system at /tmp/rclone405782211)
2025/05/05 04:37:45 DEBUG : foo: quickxor = 6208831c00000000000000000300000000000000 (OneDrive root 'rclone-test-loyadej4nawu')
2025/05/05 04:37:45 DEBUG : foo: quickxor differ
2025/05/05 04:37:45 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for transfers to finish
2025/05/05 04:37:45 DEBUG : foo: Starting multipart upload
2025/05/05 04:37:45 DEBUG : foo: Uploading segment 0/3 size 3
2025/05/05 04:37:45 DEBUG : foo: quickxor = 6678c31b00000000000000000300000000000000 OK
2025/05/05 04:37:45 INFO  : foo: Copied (replaced existing)
2025/05/05 04:37:45 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "OneDrive root 'rclone-test-loyadej4nawu'", Local "Local file system at /tmp/rclone405782211", Modify Window "1s"
--- PASS: TestSyncDoesntUpdateModtime (2.77s)
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "OneDrive root 'rclone-test-loyadej4nawu'", Local "Local file system at /tmp/rclone405782211", Modify Window "1s"
2025/05/05 04:37:47 DEBUG : one: Starting multipart upload
2025/05/05 04:37:47 DEBUG : one: Uploading segment 0/3 size 3
2025/05/05 04:37:47 DEBUG : two: Starting multipart upload
2025/05/05 04:37:47 DEBUG : two: Uploading segment 0/3 size 3
2025/05/05 04:37:47 DEBUG : three: Starting multipart upload
2025/05/05 04:37:48 DEBUG : three: Uploading segment 0/5 size 5
2025/05/05 04:37:48 DEBUG : four: Starting multipart upload
2025/05/05 04:37:48 DEBUG : four: Uploading segment 0/8 size 8
2025/05/05 04:37:49 DEBUG : five: Need to transfer - File not found at Destination
2025/05/05 04:37:49 DEBUG : five: Starting multipart upload
2025/05/05 04:37:49 DEBUG : four: Sizes differ (src 4 vs dst 8)
2025/05/05 04:37:49 DEBUG : one: Destination is newer than source, skipping
2025/05/05 04:37:49 DEBUG : three: Sizes identical
2025/05/05 04:37:49 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for checks to finish
2025/05/05 04:37:49 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2025/05/05 04:37:49 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2025/05/05 04:37:49 DEBUG : four: Starting multipart upload
2025/05/05 04:37:49 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 (Local file system at /tmp/rclone405782211)
2025/05/05 04:37:49 DEBUG : two: quickxor = 54b8c21300000000000000000300000000000000 (OneDrive root 'rclone-test-loyadej4nawu')
2025/05/05 04:37:49 DEBUG : two: quickxor differ
2025/05/05 04:37:49 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for transfers to finish
2025/05/05 04:37:49 DEBUG : two: Starting multipart upload
2025/05/05 04:37:49 DEBUG : five: Uploading segment 0/4 size 4
2025/05/05 04:37:49 DEBUG : two: Uploading segment 0/3 size 3
2025/05/05 04:37:49 DEBUG : four: Uploading segment 0/4 size 4
2025/05/05 04:37:49 DEBUG : five: quickxor = 6648831dca000000000000000400000000000000 OK
2025/05/05 04:37:49 INFO  : five: Copied (new)
2025/05/05 04:37:49 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 OK
2025/05/05 04:37:49 INFO  : two: Copied (replaced existing)
2025/05/05 04:37:49 DEBUG : four: quickxor = 6678431de4000000000000000400000000000000 OK
2025/05/05 04:37:49 INFO  : four: Copied (replaced existing)
2025/05/05 04:37:49 DEBUG : Waiting for deletions to finish
2025/05/05 04:37:50 DEBUG : one: Destination is newer than source, skipping
2025/05/05 04:37:50 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for checks to finish
2025/05/05 04:37:50 DEBUG : five: quickxor = 6648831dca000000000000000400000000000000 OK
2025/05/05 04:37:50 DEBUG : five: Size and quickxor of src and dst objects identical
2025/05/05 04:37:50 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2025/05/05 04:37:50 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 OK
2025/05/05 04:37:50 DEBUG : three: quickxor = 7440831cca500600000000000500000000000000 (Local file system at /tmp/rclone405782211)
2025/05/05 04:37:50 DEBUG : two: Size and quickxor of src and dst objects identical
2025/05/05 04:37:50 DEBUG : three: quickxor = 544082148a500400000000000500000000000000 (OneDrive root 'rclone-test-loyadej4nawu')
2025/05/05 04:37:50 DEBUG : three: quickxor differ
2025/05/05 04:37:50 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2025/05/05 04:37:50 DEBUG : four: quickxor = 6678431de4000000000000000400000000000000 OK
2025/05/05 04:37:50 DEBUG : four: Size and quickxor of src and dst objects identical
2025/05/05 04:37:50 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2025/05/05 04:37:50 DEBUG : three: Starting multipart upload
2025/05/05 04:37:50 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2025/05/05 04:37:50 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Waiting for transfers to finish
2025/05/05 04:37:50 DEBUG : three: Uploading segment 0/5 size 5
2025/05/05 04:37:50 DEBUG : three: quickxor = 7440831cca500600000000000500000000000000 OK
2025/05/05 04:37:50 INFO  : three: Copied (replaced existing)
2025/05/05 04:37:50 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (5.13s)
PASS
2025/05/05 04:37:52 DEBUG : OneDrive root 'rclone-test-loyadej4nawu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestSyncDoesntUpdateModtime|TestSyncWithUpdateOlder)$'" - Finished OK in 8.805655145s (try 2/5)