"./operations.test -test.v -test.timeout 1h0m0s -remote TestOneDriveBusiness: -verbose" - Starting (try 1/5)
2025/03/18 01:18:49 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela"
2025/03/18 01:18:49 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:18:51 DEBUG : Creating backend with remote "/tmp/rclone2464418373"
=== RUN TestDoMultiThreadCopy
--- PASS: TestDoMultiThreadCopy (0.00s)
=== RUN TestMultithreadCalculateNumChunks
=== RUN TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1}
=== RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576}
=== RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288}
=== RUN TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289}
=== RUN TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288}
--- PASS: TestMultithreadCalculateNumChunks (0.00s)
--- PASS: TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1} (0.00s)
--- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576} (0.00s)
--- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288} (0.00s)
--- PASS: TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289} (0.00s)
--- PASS: TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288} (0.00s)
=== RUN TestMultithreadCopy
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
multithread_test.go:121: multithread writing not supported
2025/03/18 01:18:51 ERROR : : error listing: directory not found
--- SKIP: TestMultithreadCopy (0.28s)
=== RUN TestMultithreadCopyAbort
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
multithread_test.go:121: multithread writing not supported
2025/03/18 01:18:52 ERROR : : error listing: directory not found
--- SKIP: TestMultithreadCopyAbort (0.27s)
=== RUN TestSizeDiffers
--- PASS: TestSizeDiffers (0.00s)
=== RUN TestReOpen
=== RUN TestReOpen/Normal
=== RUN TestReOpen/Normal/Basics
2025/03/18 01:18:52 DEBUG : potato: Seek from 10 to 0
=== RUN TestReOpen/Normal/ErrorAtStart
=== RUN TestReOpen/Normal/WithErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN TestReOpen/Normal/TooManyErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN TestReOpen/Normal/Seek
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Seek from 5 to 2
=== RUN TestReOpen/Normal/AccountRead
=== RUN TestReOpen/Normal/AccountReadDelay
2025/03/18 01:18:52 DEBUG : potato: Seek from 10 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 10 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 10 to 0
=== RUN TestReOpen/Normal/AccountReadError
=== RUN TestReOpen/WithRangeOption
=== RUN TestReOpen/WithRangeOption/Basics
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 0
=== RUN TestReOpen/WithRangeOption/ErrorAtStart
=== RUN TestReOpen/WithRangeOption/WithErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN TestReOpen/WithRangeOption/TooManyErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN TestReOpen/WithRangeOption/Seek
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Seek from 5 to 2
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 4
=== RUN TestReOpen/WithRangeOption/AccountRead
=== RUN TestReOpen/WithRangeOption/AccountReadDelay
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 0
=== RUN TestReOpen/WithRangeOption/AccountReadError
=== RUN TestReOpen/WithSeekOption
=== RUN TestReOpen/WithSeekOption/Basics
2025/03/18 01:18:52 DEBUG : potato: Seek from 8 to 0
=== RUN TestReOpen/WithSeekOption/ErrorAtStart
=== RUN TestReOpen/WithSeekOption/WithErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN TestReOpen/WithSeekOption/TooManyErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN TestReOpen/WithSeekOption/Seek
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Seek from 5 to 2
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 5
=== RUN TestReOpen/WithSeekOption/AccountRead
=== RUN TestReOpen/WithSeekOption/AccountReadDelay
2025/03/18 01:18:52 DEBUG : potato: Seek from 8 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 8 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 8 to 0
=== RUN TestReOpen/WithSeekOption/AccountReadError
=== RUN TestReOpen/UnknownSize
=== RUN TestReOpen/UnknownSize/Basics
2025/03/18 01:18:52 DEBUG : potato: Seek from 9 to 0
=== RUN TestReOpen/UnknownSize/ErrorAtStart
=== RUN TestReOpen/UnknownSize/WithErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN TestReOpen/UnknownSize/TooManyErrors
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2025/03/18 01:18:52 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN TestReOpen/UnknownSize/Seek
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2025/03/18 01:18:52 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2025/03/18 01:18:52 DEBUG : potato: Seek from 5 to 2
2025/03/18 01:18:52 DEBUG : potato: Seek from 7 to 6
=== RUN TestReOpen/UnknownSize/AccountRead
=== RUN TestReOpen/UnknownSize/AccountReadDelay
2025/03/18 01:18:52 DEBUG : potato: Seek from 9 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 9 to 0
2025/03/18 01:18:52 DEBUG : potato: Seek from 9 to 0
=== RUN TestReOpen/UnknownSize/AccountReadError
--- PASS: TestReOpen (0.00s)
--- PASS: TestReOpen/Normal (0.00s)
--- PASS: TestReOpen/Normal/Basics (0.00s)
--- PASS: TestReOpen/Normal/ErrorAtStart (0.00s)
--- PASS: TestReOpen/Normal/WithErrors (0.00s)
--- PASS: TestReOpen/Normal/TooManyErrors (0.00s)
--- PASS: TestReOpen/Normal/Seek (0.00s)
--- PASS: TestReOpen/Normal/AccountRead (0.00s)
--- PASS: TestReOpen/Normal/AccountReadDelay (0.00s)
--- PASS: TestReOpen/Normal/AccountReadError (0.00s)
--- PASS: TestReOpen/WithRangeOption (0.00s)
--- PASS: TestReOpen/WithRangeOption/Basics (0.00s)
--- PASS: TestReOpen/WithRangeOption/ErrorAtStart (0.00s)
--- PASS: TestReOpen/WithRangeOption/WithErrors (0.00s)
--- PASS: TestReOpen/WithRangeOption/TooManyErrors (0.00s)
--- PASS: TestReOpen/WithRangeOption/Seek (0.00s)
--- PASS: TestReOpen/WithRangeOption/AccountRead (0.00s)
--- PASS: TestReOpen/WithRangeOption/AccountReadDelay (0.00s)
--- PASS: TestReOpen/WithRangeOption/AccountReadError (0.00s)
--- PASS: TestReOpen/WithSeekOption (0.00s)
--- PASS: TestReOpen/WithSeekOption/Basics (0.00s)
--- PASS: TestReOpen/WithSeekOption/ErrorAtStart (0.00s)
--- PASS: TestReOpen/WithSeekOption/WithErrors (0.00s)
--- PASS: TestReOpen/WithSeekOption/TooManyErrors (0.00s)
--- PASS: TestReOpen/WithSeekOption/Seek (0.00s)
--- PASS: TestReOpen/WithSeekOption/AccountRead (0.00s)
--- PASS: TestReOpen/WithSeekOption/AccountReadDelay (0.00s)
--- PASS: TestReOpen/WithSeekOption/AccountReadError (0.00s)
--- PASS: TestReOpen/UnknownSize (0.00s)
--- PASS: TestReOpen/UnknownSize/Basics (0.00s)
--- PASS: TestReOpen/UnknownSize/ErrorAtStart (0.00s)
--- PASS: TestReOpen/UnknownSize/WithErrors (0.00s)
--- PASS: TestReOpen/UnknownSize/TooManyErrors (0.00s)
--- PASS: TestReOpen/UnknownSize/Seek (0.00s)
--- PASS: TestReOpen/UnknownSize/AccountRead (0.00s)
--- PASS: TestReOpen/UnknownSize/AccountReadDelay (0.00s)
--- PASS: TestReOpen/UnknownSize/AccountReadError (0.00s)
=== RUN TestCheck
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:18:52 DEBUG : rutabaga: Starting multipart upload
2025/03/18 01:18:53 DEBUG : rutabaga: Uploading segment 0/8 size 8
=== RUN TestCheck/1
=== RUN TestCheck/2
2025/03/18 01:18:55 DEBUG : empty space: Starting multipart upload
2025/03/18 01:18:56 DEBUG : empty space: Uploading segment 0/1 size 1
=== RUN TestCheck/3
2025/03/18 01:18:57 DEBUG : potato2: Starting multipart upload
2025/03/18 01:18:58 DEBUG : potato2: Uploading segment 0/60 size 60
=== RUN TestCheck/4
=== RUN TestCheck/5
2025/03/18 01:19:00 DEBUG : remotepotato: Starting multipart upload
2025/03/18 01:19:01 DEBUG : remotepotato: Uploading segment 0/60 size 60
=== RUN TestCheck/6
=== RUN TestCheck/7
--- PASS: TestCheck (12.74s)
--- PASS: TestCheck/1 (0.30s)
--- PASS: TestCheck/2 (0.30s)
--- PASS: TestCheck/3 (0.30s)
--- PASS: TestCheck/4 (0.31s)
--- PASS: TestCheck/5 (0.31s)
--- PASS: TestCheck/6 (0.31s)
--- PASS: TestCheck/7 (0.31s)
=== RUN TestCheckFsError
2025/03/18 01:19:04 DEBUG : Creating backend with remote "nonexistent"
2025/03/18 01:19:04 DEBUG : Creating backend with remote "nonexistent"
2025/03/18 01:19:04 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: Waiting for checks to finish
2025/03/18 01:19:04 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: error reading source root directory: directory not found
2025/03/18 01:19:04 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 differences found
2025/03/18 01:19:04 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 errors while checking
--- PASS: TestCheckFsError (0.00s)
=== RUN TestCheckDownload
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:19:04 DEBUG : rutabaga: Starting multipart upload
2025/03/18 01:19:06 DEBUG : rutabaga: Uploading segment 0/8 size 8
=== RUN TestCheckDownload/1
=== RUN TestCheckDownload/2
2025/03/18 01:19:09 DEBUG : empty space: Starting multipart upload
2025/03/18 01:19:09 DEBUG : empty space: Uploading segment 0/1 size 1
=== RUN TestCheckDownload/3
2025/03/18 01:19:11 DEBUG : potato2: Starting multipart upload
2025/03/18 01:19:12 DEBUG : potato2: Uploading segment 0/60 size 60
=== RUN TestCheckDownload/4
=== RUN TestCheckDownload/5
2025/03/18 01:19:20 DEBUG : remotepotato: Starting multipart upload
2025/03/18 01:19:21 DEBUG : remotepotato: Uploading segment 0/60 size 60
=== RUN TestCheckDownload/6
=== RUN TestCheckDownload/7
--- PASS: TestCheckDownload (21.85s)
--- PASS: TestCheckDownload/1 (0.85s)
--- PASS: TestCheckDownload/2 (0.83s)
--- PASS: TestCheckDownload/3 (0.84s)
--- PASS: TestCheckDownload/4 (1.34s)
--- PASS: TestCheckDownload/5 (5.90s)
--- PASS: TestCheckDownload/6 (1.01s)
--- PASS: TestCheckDownload/7 (1.03s)
=== RUN TestCheckSizeOnly
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:19:26 DEBUG : rutabaga: Starting multipart upload
2025/03/18 01:19:27 DEBUG : rutabaga: Uploading segment 0/8 size 8
=== RUN TestCheckSizeOnly/1
=== RUN TestCheckSizeOnly/2
2025/03/18 01:19:29 DEBUG : empty space: Starting multipart upload
2025/03/18 01:19:29 DEBUG : empty space: Uploading segment 0/1 size 1
=== RUN TestCheckSizeOnly/3
2025/03/18 01:19:31 DEBUG : potato2: Starting multipart upload
2025/03/18 01:19:31 DEBUG : potato2: Uploading segment 0/60 size 60
=== RUN TestCheckSizeOnly/4
=== RUN TestCheckSizeOnly/5
2025/03/18 01:19:33 DEBUG : remotepotato: Starting multipart upload
2025/03/18 01:19:34 DEBUG : remotepotato: Uploading segment 0/60 size 60
=== RUN TestCheckSizeOnly/6
=== RUN TestCheckSizeOnly/7
--- PASS: TestCheckSizeOnly (11.34s)
--- PASS: TestCheckSizeOnly/1 (0.34s)
--- PASS: TestCheckSizeOnly/2 (0.30s)
--- PASS: TestCheckSizeOnly/3 (0.31s)
--- PASS: TestCheckSizeOnly/4 (0.30s)
--- PASS: TestCheckSizeOnly/5 (0.31s)
--- PASS: TestCheckSizeOnly/6 (0.30s)
--- PASS: TestCheckSizeOnly/7 (0.30s)
=== RUN TestCheckEqualReaders
--- PASS: TestCheckEqualReaders (0.00s)
=== RUN TestParseSumFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:19:38 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:19:38 DEBUG : test.sum: Uploading segment 0/81 size 81
2025/03/18 01:19:40 NOTICE: test.sum: improperly formatted checksum line 4
2025/03/18 01:19:40 NOTICE: test.sum: improperly formatted checksum line 5
2025/03/18 01:19:40 NOTICE: test.sum: improperly formatted checksum line 6
2025/03/18 01:19:40 NOTICE: test.sum: 2 warning(s) suppressed...
2025/03/18 01:19:40 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:19:41 DEBUG : test.sum: Uploading segment 0/90 size 90
2025/03/18 01:19:43 NOTICE: test.sum: improperly formatted checksum line 4
2025/03/18 01:19:43 NOTICE: test.sum: improperly formatted checksum line 5
2025/03/18 01:19:43 NOTICE: test.sum: improperly formatted checksum line 6
2025/03/18 01:19:43 NOTICE: test.sum: 2 warning(s) suppressed...
--- PASS: TestParseSumFile (6.13s)
=== RUN TestCheckSum
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:19:44 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/data"
check_test.go:353: OneDrive root 'rclone-test-waditug9yela/data' lacks md5, skipping
--- SKIP: TestCheckSum (3.48s)
=== RUN TestCheckSumDownload
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:19:47 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/data"
2025/03/18 01:19:50 DEBUG : data/banana: Starting multipart upload
2025/03/18 01:19:51 DEBUG : data/banana: Uploading segment 0/13 size 13
2025/03/18 01:19:51 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:19:52 DEBUG : test.sum: Uploading segment 0/41 size 41
=== RUN TestCheckSumDownload/subtest1
2025/03/18 01:19:56 DEBUG : data/potato: Starting multipart upload
2025/03/18 01:19:57 DEBUG : data/potato: Uploading segment 0/15 size 15
2025/03/18 01:19:58 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:19:58 DEBUG : test.sum: Uploading segment 0/41 size 41
=== RUN TestCheckSumDownload/subtest2
2025/03/18 01:20:01 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:20:02 DEBUG : test.sum: Uploading segment 0/82 size 82
=== RUN TestCheckSumDownload/subtest3
2025/03/18 01:20:06 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:20:06 DEBUG : test.sum: Uploading segment 0/82 size 82
=== RUN TestCheckSumDownload/subtest4
2025/03/18 01:20:10 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:20:10 DEBUG : test.sum: Uploading segment 0/123 size 123
=== RUN TestCheckSumDownload/subtest5
2025/03/18 01:20:14 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:20:14 DEBUG : test.sum: Uploading segment 0/123 size 123
=== RUN TestCheckSumDownload/subtest6
2025/03/18 01:20:18 DEBUG : data/banana: Starting multipart upload
2025/03/18 01:20:18 DEBUG : data/banana: Uploading segment 0/13 size 13
2025/03/18 01:20:19 DEBUG : data/potato: Starting multipart upload
2025/03/18 01:20:20 DEBUG : data/potato: Uploading segment 0/15 size 15
2025/03/18 01:20:20 DEBUG : test.sum: Starting multipart upload
2025/03/18 01:20:21 DEBUG : test.sum: Uploading segment 0/82 size 82
=== RUN TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (39.94s)
--- PASS: TestCheckSumDownload/subtest1 (2.70s)
--- PASS: TestCheckSumDownload/subtest2 (1.94s)
--- PASS: TestCheckSumDownload/subtest3 (2.46s)
--- PASS: TestCheckSumDownload/subtest4 (2.38s)
--- PASS: TestCheckSumDownload/subtest5 (2.04s)
--- PASS: TestCheckSumDownload/subtest6 (2.04s)
--- PASS: TestCheckSumDownload/subtest7 (2.07s)
=== RUN TestApplyTransforms
2025/03/18 01:20:27 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-zevujus3hupa"
2025/03/18 01:20:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:20:28 DEBUG : Creating backend with remote "/tmp/rclone2289790209"
run.go:180: Remote "OneDrive root 'rclone-test-zevujus3hupa'", Local "Local file system at /tmp/rclone2289790209", Modify Window "1s"
2025/03/18 01:20:29 DEBUG : hello, world!: Starting multipart upload
2025/03/18 01:20:30 DEBUG : hello, world!: Uploading segment 0/13 size 13
upper checkfile vs. lower remote (without normalization)
2025/03/18 01:20:32 ERROR : hello, world!: sum not found
2025/03/18 01:20:32 ERROR : HELLO, WORLD!: file not in OneDrive root 'rclone-test-zevujus3hupa'
2025/03/18 01:20:32 NOTICE: OneDrive root 'rclone-test-zevujus3hupa': 1 files missing
2025/03/18 01:20:32 NOTICE: 1 hashes missing
2025/03/18 01:20:32 NOTICE: OneDrive root 'rclone-test-zevujus3hupa': 2 differences found
2025/03/18 01:20:32 NOTICE: OneDrive root 'rclone-test-zevujus3hupa': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2025/03/18 01:20:33 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:20:33 NOTICE: OneDrive root 'rclone-test-zevujus3hupa': 0 differences found
2025/03/18 01:20:33 NOTICE: OneDrive root 'rclone-test-zevujus3hupa': 1 matching files
2025/03/18 01:20:33 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-woqeler7veqe"
2025/03/18 01:20:33 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:20:34 DEBUG : Creating backend with remote "/tmp/rclone795278524"
run.go:180: Remote "OneDrive root 'rclone-test-woqeler7veqe'", Local "Local file system at /tmp/rclone795278524", Modify Window "1s"
2025/03/18 01:20:35 DEBUG : HELLO, WORLD!: Starting multipart upload
2025/03/18 01:20:37 DEBUG : HELLO, WORLD!: Uploading segment 0/13 size 13
2025/03/18 01:20:37 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Service Unavailable) returned body: "<!DOCTYPE html><html xml:lang=\"en\" xmlns=\"http://www.w3.org/1999/xhtml\" xmlns:Web=\"http://schemas.live.com/Web/\"><head><meta http-equiv=\"Content-Type\" content=\"text/html; charset=UTF-8\"/><title>Sharepoint Online</title><meta http-equiv=\"X-UA-Compatible\" content=\"IE=edge,chrome=1\"/><meta name=\"viewport\" content=\"width=device-width, initial-scale=1\"/></head><body><style>\n body,html {\n font: 18px/normal \"Segoe UI\",Arial,Helvetica,Sans-Serif;\n line-height: 23px;\n color: #333333;\n background: #F3F3F3 !important;\n }\n a {\n color: #3366BB;\n text-decoration: none;\n white-space: nowrap;\n }\n #sw_content {\n width: 760px;\n height: auto;\n margin: 0 auto;\n padding: 0;\n margin-bottom: 150px;\n background: #F3F3F3;\n }\n .panda { margin-top: 60px;}\n .panda img {\n width: 350px;\n height: 223px;\n }\n\n .title {\n font-size: 38px;\n line-height: 48px;\n color: #777777;\n text-align: center;\n margin-top: 30px;\n font-family: \"Segoe UI\",Arial,Helvetica,Sans-Serif;\n }\n .sc_errD {\n font-size: 13px;\n line-height: 16px;\n color: #777777;\n text-align: left;\n margin-top: 20px;\n white-space: nowrap\n }\n .sc_error {\n margin-top: 10px;\n padding: 0 20px;\n }\n .sc_error p{ margin: 18px 0px; }\n .bing_logo { margin-top: 25px; }\n .panda, .bing_logo, .sc_error{ text-align: center;}\n #b_header { display: none; }\n a:hover{text-decoration: underline;}\n\n @media(max-width: 736px){\n body{font-family: HelveticaNeue, Roboto, Arial, sans-serif;}\n .panda { margin-top: 60px;}\n .panda img {\n width: 225px;\n height: 143px;\n }\n .title {\n margin-top: 20px;\n font-family: HelveticaNeue, Roboto, Arial, sans-serif;;\n font-size: 23px;\n line-height: 28px;\n color: #333333;\n }\n .sc_errD, .sc_error p {\n font-size: 13px;\n line-height: 16px;\n }\n .sc_error { margin-top: 5px; }\n .sc_error p{ margin: 0px;}\n .bing_logo { margin-top: 20px; }\n #sw_content{ width: auto;}\n }\n</style><div id=\"sw_content\"><div class=\"panda\" data-tag=\"bing_panda\"><img src=\"data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAK4AAACuCAYAAACvDDbuAAAAGXRFWHRTb2Z0d2FyZQBBZG9iZSBJbWFnZVJlYWR5ccllPAAAD8ZJREFUeNrsnd9uFEcWxs+AjWBD2DHsxmRBME4gCpY2GRtEVlokZnKVmwQj5X49b+B5ApsngDyBh3skz+aKXCx2JC4ARdhJtFEgJAyBxNib4IEAdmyCt05Tbdrt6arqv+6Z/n7SyAbP3+5vTp3z1alqIgAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAPIhX2C8fHxgvgxLG4nxa0hbucrlcoUDi1IrXCFaIf4h7jlXX+qCfFWcHhBXGwJIVqOshMtRMsMi7+fxeEFqYq4QpTjMj3QwYG3hsMMNlW4Qq95GWVLPh42IMQ7g0MNNiVVkEXYpE/RMpPisUUcapB4xJXCm/TIZ03giFsWkbeJQw489DVKLxypeiQRVxZh0yFEyxRligGAW19jUl9DfjSyxeBJxyN6jyVZ1AHA2mI93JaR1sZ4RO5SFGFnDZ0DP7BN9qUYDs7h1GVWsCpt1QJHXPnEkzGI1uasTD9A9kTL6cBthbbOByrOZJLMeUYh5s/QlMUabLJsCLYgU86SqoAXehjwHXEdzkHcoqXdu3fnP/zww8nV1dU8Tmtn83Rxaaxn9+5p0tuo5/08rzNVmAjpHJiKlj744APas2ePlZJAvB0r2JK4sWBHy+Vyft/+/bqH1Pw8f84Rym/H/WEOHTpEJ06ccP93PZfLncap7hjB5qVTMOL+2/T0dbp540arh9VFmuBLA3bEjT09KBaL60T7zTff0MzMDC0vLw+JqIuGnM4QLRdf061EywwMDNLx9/4ROk1gbDsstiJp27ZtdPz4cSva2ty6dYuuXbtm/f748WMW9IgQ75ci8tZw+ttSsBz4OPgM6e7b19dHPT15unTpEq0sL1uFuuls2YaIK6dia3GIlvNZp2hVxacQbwkyaDvRjtDLmS8j8vkeEsU55Xt6KKjunBMQVXoxNRtJQwwXYe+//z7t3LlzLbJypGUR802kCNatv79/7TF//PHHxPUvvigPHjsGmyz9gi3KKBso2HR3b7P0cf/+/fNBHu/2cfOySAtV6R84cMDKZzniMizQCxcuWD9ZyB9//PGGxwjR0nc3b9Li06cNToeEeNGQk97ia4TWT9UGZeZPO7YPBHngupkzmTKUyceccSvngL9JtmjtaLv8Ip9Z++lEiJX++/XX1k9ZKE5CIqkUbUmmBaMRPeX5oA9s2dYop2R9N8RwlHXms2IYsCIs39hB4H9zasAR2eZhs0l3Gg0r4rqoiaiLdWvpibLjfvJYQ3pExG1GJlwp3hGZwxgVYSxapyC5avzxxx+tv3300Udrua6T/83P0727d1VPfUaIdwzS2VTRDksdRD1RVBeiDezfe7Y1yg4ubcXHgmTnwClaO9raqQGnCm4uX75MFz/7rFWkdTIqirVhyGdTBFsQt0lqvYp7U9MEZcR1RN5pL6fBnr51FmF2BGYHgScZWNic89rwfTga28LesX07vfnGG7R161avt2Dl3XAaEhXtWIR5bMtzKqJtT5gn6DK4T1kWS0V3EcYTC7ZoOS1gQTK2d+v2bzny8n0ePHjwsjBbWqK79+5R4eBBr9e3ehpE5GWnoQFZxYc4xvnX/7ZvkiKyRBXUwj6BdumOdBoqTqfBnr51OgdOMdrR1An//dNPP113v7UC7dEj+nl2VvU2rNXFfGAhr1gZn/35p+L8/dm4X+d87MKV4p2RkdcSLAvXzd69ey0h882d73LawKJtZYWtFWq//EIPFhZUbwPr1uKNtmtTtg9+/ZV+EiPoc3X9EZSGSBNCp32+9lVYWFgYzufz43auevHiRSuCum0wJ2yD8c0Uznd3vvKKcpiBTRa5aIephf25XdQf+w4cpO7u7ihfriqEG3rplq8tmHp6ejg3OWcP/fawzxG1Fewc+BGt9XW8c8fKexUMw2mIVLT21O0GlsR5+P7mDWo2F6J8yXoUT+J777BcLsc9DTV2C+wcl90FJ6urq1Zq4CVoFWyPsXg1Ntm4OOBDkF34Yow0+2V8/8MP9JkYWW/fjqRdm73bSArsQHuHyVULkyJdKLJT4BTus2fP6OHCQ/r2xrf03a3vAr8xtsneOnxYaakQbLIoROvpILDb46w7uCXRo5/WlIoQbi2K9x9ot0YRdS3RiIjbdIp2ZXmFFh4sWNHy8KHDtH/f/sBvzLbJ4DTExlmVaFmw7mKZo+7kpf/QyspykNdrRiXawMJ1ildGPlpaXLJEu/p8de0+R44coV27dgV+c3zg5ubnVXcp0AuPF+L1F23HSLH9wOMnTzyDxrw4H+zFB8h761F+hi1hHizEy8N05dHDR8Q3N91d3fTe8fdox44dgV/j/tyciU2GpT/mouXaYFQ10nGNoQyd4nyweOfVQcXNJ6kRrhRvXURbT3uKxXt08GgoS4UnJwychjHI0shBGFcVxnfv3tUVxjItXLbShps3bxiZRVF4t5EKl+l9vZdzF8/8Zderu+jowNHAz88Hkqtb1QQGoSHHpBhTbkHA6YEmQGxg+vp1unb1SqLRNjLhSvFy1J3y+jsXce/8/Z1Q4jW0ybAXb2uUm73wqMZT70Hgom1metqyQZPIbyMVroT7Kz2HBHYZwjoNuvxLFmsQ7/poO65zEHjKPSh7du+hN/veoKe/PW41TRyZdxubcEXUbUrxena1c9Tt7e0N/BqqileSl5EXTsML0Y6oHAQD21EJu0aDg4PW78+fP6enj5/Qs5UV513+Hcfnijrisnj521VW3YfFG9YmQ0OOkWhLKseFawauHYLCBTefSy7AbThdWHzylJaXfrcMiCi921iFK8Vr2WRKp2EgnNPAUUKTk5XkEJllB2EiZM2ghM8hF96t+F1EchF9P4nr822J64ml03DG6+/s7bLHG1a8BjbZSEYdBOWSGwOLUUn/kf4NPSouan/5656xuD5jLu6DODc7p7wm2r2f7tFXX38V+Pm50eetQ4dUS3+sonHw2LF6kuKR27by7WTSV9kUwlVeHYlnI3liJyhcYGscIqt/W9Y87RVxHVR1TgN/e4Ni52lpssmEaDkBn5ZRr7AJDkJJVR+EES3XJhrRWgV6nKJNRLjyA3Cx5mmJFA4WQttkBkt/kuxpcH5RGwmKdljnIGiOkxI7vdNQlgU6tbVwHeLV2mQxN+QkKd7PHb/fSUi02ulcg5FJ6SBYU/ddypqkIgtz6gjhOpwG5QYQ/G0OI17DhpwknAZnPj2VgGg5HVFuWxVGtGuB5VXluTknC3LqKOFK8fJJVNpkli8Yr9MwJBcGxoZcXNpMIlWIqwfBCfdW976mnDSqi3NbTVJLiQpXipe/lZ7fzLANOXZ00ZyokQQacupSxA1FERdF2qKczjVYPa11EFi4mnw+8cWriQtXirdCisaLKBpyDNrzxuXMUpx5ri5NGBXinQgqYOeS8lYY7FehdRB4MYDGQajE7SCkRrj2iEoam6xQKIRyGgwaciZitMmmDNKEYSm8Sb/ilSPGiOrzh+lB4HTNmiBSF2OnkyrGUiNcE6eh/+3+UDbZZjbkyBThE0WaMOTISwvkw+9VLSm3R5ww07mGoq3ImoUyJVwpXj65yo2ko1i3pmnZK1JMG0lrrpx5yjHcGl9l02RJOYtW03Sv5MjbR3QOQi1JByF1wpXi5RNWVTkNYXsaDJqki0EbcuQ14oIwFIdoeYThkSYonJ5pRrkpWaNQpoXrcBpiFW8cDTmyH2Hab34q0wQi/9cz9r2k3Nd56O210jMFDdJ48ZkSrhSvciNpHrrCOg0GJvxZU5vMcZX5PPnfYv6UX9GGWVJu6iCkoQeh7YQrxat0GtgED9OQ40O8Jk5DyTFkn/L5Vs74FG3oJeW6Yszqj07JdK4JOUoZc7Nz2q2BuA2S2yGD8mcRXRQbSdvRRbuRtEwVJqQj0CP3Eo4U+SXyzGvtL2OYmbET/zyhK8aqckRMDVvSJlw5FFVI05DDC/SCEtVG0jJq8nW6pij6K9IkMp1r0INQS5toUylch9OgLAJ4gV4Ym8xwI2mt08BRVtzKFE8zTWxLyhmDVdczaXAQ2iJVcKUNwyrxPPrtEV29dpVW1q8q9UVaN5KW9tywykEIU4zxiKXpreURry8txVhbRFxH5GWX4ZzKaTBobFaSxo2kk1xSrhBtOa2iTb1wpXitjaRV4u2AhhynaPl1El1S7lGMpXrf4dQL1z6QpGnI0bTeKeEIZiCGibjXrW32knLJmc2ezu0Y4TrWrXkOXe2+kXRalpSLYz3WDppol4hrJN4230h6ghTeNb+vsA3hvChV5SCQYtodwg0nXu0OOe24kXRWlpRnVrhSvHXSNOS000bSWVpSnmnhSvEm0pAT90bSWVtSnnnhSvEqN5Lmhpw0bySdxSXlEO5LYt9I2sDon5Qi9OsgZG5JOYS73mnQNuSE2UiaewFisMkyuaQcwt3oNLTNRtJZXlIO4bYWb+wbSWvWcmk3knYtKW/KArPmMzVRFmNpXlIO4bYWLwsg1o2kDRtySgoHgaNtg17YeX2y6+yOj2IwrGg3dUk5hOst3jHS2GS89Dpmp6HkUYzx0puqECsL9py4Nd1fik5fUh4lXdR5VGXOWfQqXBYXFwNf2d3uzuI+Xo9d0N91/4cU6ekQaYiSdllSjoirdxqUG0lH0ZCjKKBKfnNnReHXVDkm1udtoyXlEK6ZeDdrI+m8n0kJ8TwND8GekV/AvMpB6LQehEwL18RpYGJsyPETdd3C5Tx0oFKpjJHC623HJeXIcc3FW5+bnWPxtrSp7IacAOvWuNGHr5hYEEP9uyLyFbq2bi2q8lwDuNqvuvZbOBXiS1eVDUkE4baneGtCvCfJowPL3kj6yrUrfp62KAR2uoV7UCCfOy/KiMu72kyZRu52XVIeJTnKCEK8PLPlOWMV4HprXmKLBLm/2EQrV0R3jTEh2oFOP59bKDtEvZH0v2J+vyfd/8FLyg2KsXIWTmZmhGu6kXSLhhyvqDoU81secjsI7b6kHMINLt4GadattbDJ2Jbqo40zcnnHdqFRpwkFmfvW5etXe1/rLYtikoWZo9bXz6h2qoOQ6RzXle8Ok2LlwcqzFZr6fMp2GtZyWSmoUUehV0v6Or3y/buv1XumXVbnIuKGdBpI0ZDj2ki6sZYkVyoNKVQ7Ag+l4OPUsibazEZcR+TSXtn96LGjOc2QrryWWcwRN/arlEO46RUvX+W8qIjOadxDeFXm6QPttjoXqUJ0cLF2jhRWWVrfd1ZFy3RlXbVymK3KSJaXQ/BJ+bOQ0rddyZKDAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAm/F+AAQA1GwLUNH600gAAAABJRU5ErkJggg==\"/></div><div class=\"title\">Something went wrong</div><div class=\"sc_error\"><p>This is a temporary issue, so try again in a few minutes.</p></div>\n<div class=\"sc_errD\" data-tag=\"refcode\"><p>Technical details:</><p>Ref A: EE87CD7C5E8B4088860CC12B6AE18CBB Ref B: FRA231050411009 Ref C: 2025-03-18T01:20:37Z</p></div><div class=\"bing_logo\"></div></div><!--AppServer--></body></html></body></html>")
2025/03/18 01:20:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/03/18 01:20:39 DEBUG : pacer: Reducing sleep to 15ms
2025/03/18 01:20:39 DEBUG : pacer: Reducing sleep to 11.25ms
lower checkfile vs. upper remote (without normalization)
2025/03/18 01:20:39 DEBUG : pacer: Reducing sleep to 10ms
2025/03/18 01:20:39 ERROR : HELLO, WORLD!: sum not found
2025/03/18 01:20:39 ERROR : hello, world!: file not in OneDrive root 'rclone-test-woqeler7veqe'
2025/03/18 01:20:39 NOTICE: OneDrive root 'rclone-test-woqeler7veqe': 1 files missing
2025/03/18 01:20:39 NOTICE: 1 hashes missing
2025/03/18 01:20:39 NOTICE: OneDrive root 'rclone-test-woqeler7veqe': 2 differences found
2025/03/18 01:20:39 NOTICE: OneDrive root 'rclone-test-woqeler7veqe': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2025/03/18 01:20:41 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:20:41 NOTICE: OneDrive root 'rclone-test-woqeler7veqe': 0 differences found
2025/03/18 01:20:41 NOTICE: OneDrive root 'rclone-test-woqeler7veqe': 1 matching files
2025/03/18 01:20:41 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-fulumac4jepi"
2025/03/18 01:20:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:20:43 DEBUG : Creating backend with remote "/tmp/rclone3473853685"
run.go:180: Remote "OneDrive root 'rclone-test-fulumac4jepi'", Local "Local file system at /tmp/rclone3473853685", Modify Window "1s"
2025/03/18 01:20:44 DEBUG : HeLlO, wOrLd!: Starting multipart upload
2025/03/18 01:20:47 DEBUG : HeLlO, wOrLd!: Uploading segment 0/13 size 13
lower checkfile vs. upperlowermixed remote (without normalization)
2025/03/18 01:20:52 ERROR : HeLlO, wOrLd!: sum not found
2025/03/18 01:20:52 ERROR : hello, world!: file not in OneDrive root 'rclone-test-fulumac4jepi'
2025/03/18 01:20:52 NOTICE: OneDrive root 'rclone-test-fulumac4jepi': 1 files missing
2025/03/18 01:20:52 NOTICE: 1 hashes missing
2025/03/18 01:20:52 NOTICE: OneDrive root 'rclone-test-fulumac4jepi': 2 differences found
2025/03/18 01:20:52 NOTICE: OneDrive root 'rclone-test-fulumac4jepi': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2025/03/18 01:20:54 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:20:54 NOTICE: OneDrive root 'rclone-test-fulumac4jepi': 0 differences found
2025/03/18 01:20:54 NOTICE: OneDrive root 'rclone-test-fulumac4jepi': 1 matching files
2025/03/18 01:20:54 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-zurudin5gaju"
2025/03/18 01:20:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:20:56 DEBUG : Creating backend with remote "/tmp/rclone168671906"
run.go:180: Remote "OneDrive root 'rclone-test-zurudin5gaju'", Local "Local file system at /tmp/rclone168671906", Modify Window "1s"
2025/03/18 01:20:57 DEBUG : HELLO, WORLD!: Starting multipart upload
2025/03/18 01:20:58 DEBUG : HELLO, WORLD!: Uploading segment 0/13 size 13
upperlowermixed checkfile vs. upper remote (without normalization)
2025/03/18 01:21:00 ERROR : HELLO, WORLD!: sum not found
2025/03/18 01:21:00 ERROR : HeLlO, wOrLd!: file not in OneDrive root 'rclone-test-zurudin5gaju'
2025/03/18 01:21:00 NOTICE: OneDrive root 'rclone-test-zurudin5gaju': 1 files missing
2025/03/18 01:21:00 NOTICE: 1 hashes missing
2025/03/18 01:21:00 NOTICE: OneDrive root 'rclone-test-zurudin5gaju': 2 differences found
2025/03/18 01:21:00 NOTICE: OneDrive root 'rclone-test-zurudin5gaju': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2025/03/18 01:21:01 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:01 NOTICE: OneDrive root 'rclone-test-zurudin5gaju': 0 differences found
2025/03/18 01:21:01 NOTICE: OneDrive root 'rclone-test-zurudin5gaju': 1 matching files
2025/03/18 01:21:01 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-makebip2payi"
2025/03/18 01:21:01 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:02 DEBUG : Creating backend with remote "/tmp/rclone2666641018"
run.go:180: Remote "OneDrive root 'rclone-test-makebip2payi'", Local "Local file system at /tmp/rclone2666641018", Modify Window "1s"
2025/03/18 01:21:03 DEBUG : 測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:03 DEBUG : 測試_Русский___ě_áñ: Uploading segment 0/13 size 13
NFD checkfile vs. NFC remote (without normalization)
2025/03/18 01:21:05 ERROR : 測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:05 ERROR : 測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-makebip2payi'
2025/03/18 01:21:05 NOTICE: OneDrive root 'rclone-test-makebip2payi': 1 files missing
2025/03/18 01:21:05 NOTICE: 1 hashes missing
2025/03/18 01:21:05 NOTICE: OneDrive root 'rclone-test-makebip2payi': 2 differences found
2025/03/18 01:21:05 NOTICE: OneDrive root 'rclone-test-makebip2payi': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2025/03/18 01:21:06 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:06 NOTICE: OneDrive root 'rclone-test-makebip2payi': 0 differences found
2025/03/18 01:21:06 NOTICE: OneDrive root 'rclone-test-makebip2payi': 1 matching files
2025/03/18 01:21:06 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-quwijag3jaco"
2025/03/18 01:21:06 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:08 DEBUG : Creating backend with remote "/tmp/rclone2285032449"
run.go:180: Remote "OneDrive root 'rclone-test-quwijag3jaco'", Local "Local file system at /tmp/rclone2285032449", Modify Window "1s"
2025/03/18 01:21:09 DEBUG : 測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:09 DEBUG : 測試_Русский___ě_áñ: Uploading segment 0/13 size 13
NFC checkfile vs. NFD remote (without normalization)
2025/03/18 01:21:11 ERROR : 測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:11 ERROR : 測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-quwijag3jaco'
2025/03/18 01:21:11 NOTICE: OneDrive root 'rclone-test-quwijag3jaco': 1 files missing
2025/03/18 01:21:11 NOTICE: 1 hashes missing
2025/03/18 01:21:11 NOTICE: OneDrive root 'rclone-test-quwijag3jaco': 2 differences found
2025/03/18 01:21:11 NOTICE: OneDrive root 'rclone-test-quwijag3jaco': 2 errors while checking
NFC checkfile vs. NFD remote (with normalization)
2025/03/18 01:21:12 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:12 NOTICE: OneDrive root 'rclone-test-quwijag3jaco': 0 differences found
2025/03/18 01:21:12 NOTICE: OneDrive root 'rclone-test-quwijag3jaco': 1 matching files
2025/03/18 01:21:12 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-piletig2vuda"
2025/03/18 01:21:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:13 DEBUG : Creating backend with remote "/tmp/rclone42287563"
run.go:180: Remote "OneDrive root 'rclone-test-piletig2vuda'", Local "Local file system at /tmp/rclone42287563", Modify Window "1s"
2025/03/18 01:21:14 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:15 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Uploading segment 0/13 size 13
NFDx2 checkfile vs. both remote (without normalization)
2025/03/18 01:21:17 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:17 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-piletig2vuda'
2025/03/18 01:21:17 NOTICE: OneDrive root 'rclone-test-piletig2vuda': 1 files missing
2025/03/18 01:21:17 NOTICE: 1 hashes missing
2025/03/18 01:21:17 NOTICE: OneDrive root 'rclone-test-piletig2vuda': 2 differences found
2025/03/18 01:21:17 NOTICE: OneDrive root 'rclone-test-piletig2vuda': 2 errors while checking
NFDx2 checkfile vs. both remote (with normalization)
2025/03/18 01:21:17 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:17 NOTICE: OneDrive root 'rclone-test-piletig2vuda': 0 differences found
2025/03/18 01:21:17 NOTICE: OneDrive root 'rclone-test-piletig2vuda': 1 matching files
2025/03/18 01:21:17 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-joxuvod5pata"
2025/03/18 01:21:17 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:18 DEBUG : Creating backend with remote "/tmp/rclone3566494008"
run.go:180: Remote "OneDrive root 'rclone-test-joxuvod5pata'", Local "Local file system at /tmp/rclone3566494008", Modify Window "1s"
2025/03/18 01:21:19 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:20 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Uploading segment 0/13 size 13
NFCx2 checkfile vs. both remote (without normalization)
2025/03/18 01:21:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-joxuvod5pata'
2025/03/18 01:21:22 NOTICE: OneDrive root 'rclone-test-joxuvod5pata': 1 files missing
2025/03/18 01:21:22 NOTICE: 1 hashes missing
2025/03/18 01:21:22 NOTICE: OneDrive root 'rclone-test-joxuvod5pata': 2 differences found
2025/03/18 01:21:22 NOTICE: OneDrive root 'rclone-test-joxuvod5pata': 2 errors while checking
NFCx2 checkfile vs. both remote (with normalization)
2025/03/18 01:21:23 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:23 NOTICE: OneDrive root 'rclone-test-joxuvod5pata': 0 differences found
2025/03/18 01:21:23 NOTICE: OneDrive root 'rclone-test-joxuvod5pata': 1 matching files
2025/03/18 01:21:23 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-nanopud5juve"
2025/03/18 01:21:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:25 DEBUG : Creating backend with remote "/tmp/rclone3020686109"
run.go:180: Remote "OneDrive root 'rclone-test-nanopud5juve'", Local "Local file system at /tmp/rclone3020686109", Modify Window "1s"
2025/03/18 01:21:26 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:27 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Uploading segment 0/13 size 13
both checkfile vs. NFDx2 remote (without normalization)
2025/03/18 01:21:28 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:28 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-nanopud5juve'
2025/03/18 01:21:28 NOTICE: OneDrive root 'rclone-test-nanopud5juve': 1 files missing
2025/03/18 01:21:28 NOTICE: 1 hashes missing
2025/03/18 01:21:28 NOTICE: OneDrive root 'rclone-test-nanopud5juve': 2 differences found
2025/03/18 01:21:28 NOTICE: OneDrive root 'rclone-test-nanopud5juve': 2 errors while checking
both checkfile vs. NFDx2 remote (with normalization)
2025/03/18 01:21:29 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:29 NOTICE: OneDrive root 'rclone-test-nanopud5juve': 0 differences found
2025/03/18 01:21:29 NOTICE: OneDrive root 'rclone-test-nanopud5juve': 1 matching files
2025/03/18 01:21:29 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-yexiloh6quri"
2025/03/18 01:21:29 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:21:31 DEBUG : Creating backend with remote "/tmp/rclone780133907"
run.go:180: Remote "OneDrive root 'rclone-test-yexiloh6quri'", Local "Local file system at /tmp/rclone780133907", Modify Window "1s"
2025/03/18 01:21:32 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Starting multipart upload
2025/03/18 01:21:33 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Uploading segment 0/13 size 13
both checkfile vs. NFCx2 remote (without normalization)
2025/03/18 01:21:35 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2025/03/18 01:21:35 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in OneDrive root 'rclone-test-yexiloh6quri'
2025/03/18 01:21:35 NOTICE: OneDrive root 'rclone-test-yexiloh6quri': 1 files missing
2025/03/18 01:21:35 NOTICE: 1 hashes missing
2025/03/18 01:21:35 NOTICE: OneDrive root 'rclone-test-yexiloh6quri': 2 differences found
2025/03/18 01:21:35 NOTICE: OneDrive root 'rclone-test-yexiloh6quri': 2 errors while checking
both checkfile vs. NFCx2 remote (with normalization)
2025/03/18 01:21:36 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2025/03/18 01:21:36 NOTICE: OneDrive root 'rclone-test-yexiloh6quri': 0 differences found
2025/03/18 01:21:36 NOTICE: OneDrive root 'rclone-test-yexiloh6quri': 1 matching files
2025/03/18 01:21:36 DEBUG : OneDrive root 'rclone-test-yexiloh6quri': Purge remote
2025/03/18 01:21:36 DEBUG : OneDrive root 'rclone-test-nanopud5juve': Purge remote
2025/03/18 01:21:37 DEBUG : OneDrive root 'rclone-test-joxuvod5pata': Purge remote
2025/03/18 01:21:37 DEBUG : OneDrive root 'rclone-test-piletig2vuda': Purge remote
2025/03/18 01:21:37 DEBUG : OneDrive root 'rclone-test-quwijag3jaco': Purge remote
2025/03/18 01:21:38 DEBUG : OneDrive root 'rclone-test-makebip2payi': Purge remote
2025/03/18 01:21:38 DEBUG : OneDrive root 'rclone-test-zurudin5gaju': Purge remote
2025/03/18 01:21:38 DEBUG : OneDrive root 'rclone-test-fulumac4jepi': Purge remote
2025/03/18 01:21:39 DEBUG : OneDrive root 'rclone-test-woqeler7veqe': Purge remote
2025/03/18 01:21:39 DEBUG : OneDrive root 'rclone-test-zevujus3hupa': Purge remote
--- PASS: TestApplyTransforms (72.86s)
=== RUN TestTruncateString
--- PASS: TestTruncateString (0.00s)
=== RUN TestCopyFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:21:42 DEBUG : file1: Need to transfer - File not found at Destination
2025/03/18 01:21:42 DEBUG : sub/file2: Starting multipart upload
2025/03/18 01:21:43 DEBUG : sub/file2: Uploading segment 0/14 size 14
2025/03/18 01:21:44 DEBUG : file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:21:44 INFO : file1: Copied (new) to: sub/file2
2025/03/18 01:21:45 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:21:45 DEBUG : file1: Unchanged skipping
2025/03/18 01:21:46 DEBUG : OneDrive root 'rclone-test-waditug9yela': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestCopyFile (8.20s)
=== RUN TestCopyLongFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
copy_test.go:153: Test only runs on local
--- SKIP: TestCopyLongFile (0.60s)
=== RUN TestCopyFileBackupDir
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:21:49 DEBUG : dst/file1: Starting multipart upload
2025/03/18 01:21:50 DEBUG : dst/file1: Uploading segment 0/18 size 18
2025/03/18 01:21:52 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/backup"
2025/03/18 01:21:55 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18)
2025/03/18 01:21:58 INFO : dst/file1: Moved (server-side)
2025/03/18 01:21:58 DEBUG : dst/file1: Starting multipart upload
2025/03/18 01:21:58 DEBUG : dst/file1: Uploading segment 0/14 size 14
2025/03/18 01:21:59 DEBUG : dst/file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:21:59 INFO : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (15.23s)
=== RUN TestCopyFileCompareDest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:22:04 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/dst"
2025/03/18 01:22:07 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/CompareDest"
2025/03/18 01:22:10 DEBUG : one: Need to transfer - File not found at Destination
2025/03/18 01:22:11 DEBUG : one: Starting multipart upload
2025/03/18 01:22:12 DEBUG : one: Uploading segment 0/3 size 3
2025/03/18 01:22:13 DEBUG : one: quickxor = 6f70431900000000000000000300000000000000 OK
2025/03/18 01:22:13 INFO : one: Copied (new)
2025/03/18 01:22:15 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:15 DEBUG : one: Starting multipart upload
2025/03/18 01:22:16 DEBUG : one: Uploading segment 0/5 size 5
2025/03/18 01:22:17 DEBUG : one: quickxor = 6f704319e8200300000000000500000000000000 OK
2025/03/18 01:22:17 INFO : one: Copied (replaced existing)
2025/03/18 01:22:17 DEBUG : dst/one: Starting multipart upload
2025/03/18 01:22:18 DEBUG : dst/one: Uploading segment 0/3 size 3
2025/03/18 01:22:19 DEBUG : CompareDest/one: Starting multipart upload
2025/03/18 01:22:20 DEBUG : CompareDest/one: Uploading segment 0/5 size 5
2025/03/18 01:22:22 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:23 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:22:23 DEBUG : one: Destination found in --compare-dest, skipping
2025/03/18 01:22:23 DEBUG : CompareDest/two: Starting multipart upload
2025/03/18 01:22:24 DEBUG : CompareDest/two: Uploading segment 0/3 size 3
2025/03/18 01:22:26 DEBUG : two: Need to transfer - File not found at Destination
2025/03/18 01:22:27 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:22:27 DEBUG : two: Destination found in --compare-dest, skipping
2025/03/18 01:22:28 DEBUG : two: Need to transfer - File not found at Destination
2025/03/18 01:22:28 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:22:28 DEBUG : two: Destination found in --compare-dest, skipping
2025/03/18 01:22:30 DEBUG : two: Need to transfer - File not found at Destination
2025/03/18 01:22:31 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:31 DEBUG : two: Starting multipart upload
2025/03/18 01:22:31 DEBUG : two: Uploading segment 0/5 size 5
2025/03/18 01:22:32 DEBUG : two: quickxor = 74b8c31be8300300000000000500000000000000 OK
2025/03/18 01:22:32 INFO : two: Copied (new)
--- PASS: TestCopyFileCompareDest (32.11s)
=== RUN TestCopyFileCopyDest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:22:36 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/dst"
2025/03/18 01:22:39 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/CopyDest"
2025/03/18 01:22:41 DEBUG : one: Need to transfer - File not found at Destination
2025/03/18 01:22:43 DEBUG : one: Starting multipart upload
2025/03/18 01:22:43 DEBUG : one: Uploading segment 0/3 size 3
2025/03/18 01:22:45 DEBUG : one: quickxor = 6f70431900000000000000000300000000000000 OK
2025/03/18 01:22:45 INFO : one: Copied (new)
2025/03/18 01:22:46 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:47 DEBUG : one: Starting multipart upload
2025/03/18 01:22:48 DEBUG : one: Uploading segment 0/5 size 5
2025/03/18 01:22:48 DEBUG : one: quickxor = 6f704319e8200300000000000500000000000000 OK
2025/03/18 01:22:48 INFO : one: Copied (replaced existing)
2025/03/18 01:22:49 DEBUG : dst/one: Starting multipart upload
2025/03/18 01:22:49 DEBUG : dst/one: Uploading segment 0/3 size 3
2025/03/18 01:22:51 DEBUG : CopyDest/one: Starting multipart upload
2025/03/18 01:22:52 DEBUG : CopyDest/one: Uploading segment 0/5 size 5
2025/03/18 01:22:54 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/BackupDir"
2025/03/18 01:22:57 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:57 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:22:57 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/18 01:22:59 INFO : one: Moved (server-side)
2025/03/18 01:23:03 DEBUG : one: quickxor = 6f704319e8200300000000000500000000000000 OK
2025/03/18 01:23:03 INFO : one: Copied (server-side copy)
2025/03/18 01:23:03 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/03/18 01:23:04 DEBUG : CopyDest/two: Starting multipart upload
2025/03/18 01:23:05 DEBUG : CopyDest/two: Uploading segment 0/3 size 3
2025/03/18 01:23:07 DEBUG : two: Need to transfer - File not found at Destination
2025/03/18 01:23:07 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:23:10 DEBUG : two: quickxor = 74b8c31b00000000000000000300000000000000 OK
2025/03/18 01:23:10 INFO : two: Copied (server-side copy)
2025/03/18 01:23:10 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/03/18 01:23:11 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/03/18 01:23:11 DEBUG : two: Unchanged skipping
2025/03/18 01:23:12 DEBUG : CopyDest/three: Starting multipart upload
2025/03/18 01:23:12 DEBUG : CopyDest/three: Uploading segment 0/5 size 5
2025/03/18 01:23:14 DEBUG : three: Need to transfer - File not found at Destination
2025/03/18 01:23:15 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/03/18 01:23:15 DEBUG : three: Destination not found in --copy-dest
2025/03/18 01:23:15 DEBUG : three: Starting multipart upload
2025/03/18 01:23:16 DEBUG : three: Uploading segment 0/7 size 7
2025/03/18 01:23:16 DEBUG : three: quickxor = 7440831cca50063acc0000000700000000000000 OK
2025/03/18 01:23:16 INFO : three: Copied (new)
--- PASS: TestCopyFileCopyDest (45.77s)
=== RUN TestCopyInplace
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
copy_test.go:370: Partial uploads not supported
--- SKIP: TestCopyInplace (0.58s)
=== RUN TestCopyLongFileName
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
copy_test.go:403: Partial uploads not supported
--- SKIP: TestCopyLongFileName (0.57s)
=== RUN TestCopyFileMaxTransfer
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:23:24 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2025/03/18 01:23:24 DEBUG : TestCopyFileMaxTransfer/file1: Starting multipart upload
2025/03/18 01:23:25 DEBUG : TestCopyFileMaxTransfer/file1: Uploading segment 0/14 size 14
2025/03/18 01:23:26 DEBUG : TestCopyFileMaxTransfer/file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:23:26 INFO : TestCopyFileMaxTransfer/file1: Copied (new)
2025/03/18 01:23:27 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2025/03/18 01:23:27 DEBUG : TestCopyFileMaxTransfer/file2: Starting multipart upload
2025/03/18 01:23:28 DEBUG : TestCopyFileMaxTransfer/file2: Uploading segment 0/2062 size 2062
2025/03/18 01:23:28 DEBUG : TestCopyFileMaxTransfer/file2: Cancelling multipart upload: Put "https://whitecell-my.sharepoint.com/personal/nick_craig-wood_whitecell_online/_api/v2.0/drives/b!tPczmrJTCE2ShO96VLAAn_DGv2_4eZJGl83N0OQe_t9LuHcGPileQ7YByS0_6_xp/items/01W3O4PFZAQP5BJOV4BFDIZZTMK2MRADIQ/uploadSession?guid='53a51208-60a2-440c-a87b-eaf296cc6b3f'&overwrite=True&rename=False&dc=0&tempauth=v1.eyJzaXRlaWQiOiI5YTMzZjdiNC01M2IyLTRkMDgtOTI4NC1lZjdhNTRiMDAwOWYiLCJhcHBfZGlzcGxheW5hbWUiOiJyY2xvbmUiLCJhcHBpZCI6ImIxNTY2NWQ5LWVkYTYtNDA5Mi04NTM5LTBlZWMzNzZhZmQ1OSIsImF1ZCI6IjAwMDAwMDAzLTAwMDAtMGZmMS1jZTAwLTAwMDAwMDAwMDAwMC93aGl0ZWNlbGwtbXkuc2hhcmVwb2ludC5jb21AZmFmZDY5NGEtNTBjMS00ZWVhLWIzYzctNDk1MTdlNWFkZDg5IiwiZXhwIjoiMTc0MjM0NzQwNyJ9.CgoKBHNuaWQSAjY2EgsI7MC3zbDx8j0QBRoNMjAuMTkwLjE4My4yNiosZzJKNmNRUGtjdnM5QnFPZnRQcmp3KytyWEVsZHlWVCtuZElaODhFTDkwaz0wpQI4AUIQoYuQYMWgAACONEjVdr_7iEoQaGFzaGVkcHJvb2Z0b2tlbnIpMGguZnxtZW1iZXJzaGlwfDEwMDNiZmZkYWMzMmY4NzFAbGl2ZS5jb216ATKCARIJSmn9-sFQ6k4Rs8dJUX5a3YmSAQROaWNrmgEKQ3JhaWctV29vZKIBIG5pY2tfY3JhaWctd29vZEB3aGl0ZWNlbGwub25saW5lqgEQMTAwM0JGRkRBQzMyRjg3MbIBRW15ZmlsZXMucmVhZCBhbGxmaWxlcy5yZWFkIG15ZmlsZXMud3JpdGUgYWxsZmlsZXMud3JpdGUgYWxsc2l0ZXMucmVhZMgBAQ.0OMCE8VzIxZ1Pk1rKWgWtKZ0wQ28unjNFl44-3SN-qw": max transfer limit reached as set by --max-transfer
2025/03/18 01:23:28 DEBUG : info from Update error:
null
2025/03/18 01:23:28 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Put "https://whitecell-my.sharepoint.com/personal/nick_craig-wood_whitecell_online/_api/v2.0/drives/b!tPczmrJTCE2ShO96VLAAn_DGv2_4eZJGl83N0OQe_t9LuHcGPileQ7YByS0_6_xp/items/01W3O4PFZAQP5BJOV4BFDIZZTMK2MRADIQ/uploadSession?guid='53a51208-60a2-440c-a87b-eaf296cc6b3f'&overwrite=True&rename=False&dc=0&tempauth=v1.eyJzaXRlaWQiOiI5YTMzZjdiNC01M2IyLTRkMDgtOTI4NC1lZjdhNTRiMDAwOWYiLCJhcHBfZGlzcGxheW5hbWUiOiJyY2xvbmUiLCJhcHBpZCI6ImIxNTY2NWQ5LWVkYTYtNDA5Mi04NTM5LTBlZWMzNzZhZmQ1OSIsImF1ZCI6IjAwMDAwMDAzLTAwMDAtMGZmMS1jZTAwLTAwMDAwMDAwMDAwMC93aGl0ZWNlbGwtbXkuc2hhcmVwb2ludC5jb21AZmFmZDY5NGEtNTBjMS00ZWVhLWIzYzctNDk1MTdlNWFkZDg5IiwiZXhwIjoiMTc0MjM0NzQwNyJ9.CgoKBHNuaWQSAjY2EgsI7MC3zbDx8j0QBRoNMjAuMTkwLjE4My4yNiosZzJKNmNRUGtjdnM5QnFPZnRQcmp3KytyWEVsZHlWVCtuZElaODhFTDkwaz0wpQI4AUIQoYuQYMWgAACONEjVdr_7iEoQaGFzaGVkcHJvb2Z0b2tlbnIpMGguZnxtZW1iZXJzaGlwfDEwMDNiZmZkYWMzMmY4NzFAbGl2ZS5jb216ATKCARIJSmn9-sFQ6k4Rs8dJUX5a3YmSAQROaWNrmgEKQ3JhaWctV29vZKIBIG5pY2tfY3JhaWctd29vZEB3aGl0ZWNlbGwub25saW5lqgEQMTAwM0JGRkRBQzMyRjg3MbIBRW15ZmlsZXMucmVhZCBhbGxmaWxlcy5yZWFkIG15ZmlsZXMud3JpdGUgYWxsZmlsZXMud3JpdGUgYWxsc2l0ZXMucmVhZMgBAQ.0OMCE8VzIxZ1Pk1rKWgWtKZ0wQ28unjNFl44-3SN-qw": max transfer limit reached as set by --max-transfer
2025/03/18 01:23:29 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2025/03/18 01:23:30 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2025/03/18 01:23:30 DEBUG : TestCopyFileMaxTransfer/file4: Starting multipart upload
2025/03/18 01:23:31 DEBUG : TestCopyFileMaxTransfer/file4: Uploading segment 0/2062 size 2062
2025/03/18 01:23:32 DEBUG : TestCopyFileMaxTransfer/file4: quickxor = 99fc62b3a5f73043d5e6dc21c8a10d3188c19dbc OK
2025/03/18 01:23:32 INFO : TestCopyFileMaxTransfer/file4: Copied (new)
--- PASS: TestCopyFileMaxTransfer (11.39s)
=== RUN TestDeduplicateInteractive
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateInteractive (0.57s)
=== RUN TestDeduplicateSkip
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateSkip (0.56s)
=== RUN TestDeduplicateSizeOnly
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateSizeOnly (0.57s)
=== RUN TestDeduplicateFirst
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateFirst (0.55s)
=== RUN TestDeduplicateNewest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateNewest (0.56s)
=== RUN TestDeduplicateNewestByHash
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:23:37 DEBUG : one: Starting multipart upload
2025/03/18 01:23:38 DEBUG : one: Uploading segment 0/100 size 100
2025/03/18 01:23:40 DEBUG : also/one: Starting multipart upload
2025/03/18 01:23:40 DEBUG : also/one: Uploading segment 0/100 size 100
2025/03/18 01:23:41 DEBUG : another: Starting multipart upload
2025/03/18 01:23:42 DEBUG : another: Uploading segment 0/100 size 100
2025/03/18 01:23:43 DEBUG : not-one: Starting multipart upload
2025/03/18 01:23:43 DEBUG : not-one: Uploading segment 0/5 size 5
2025/03/18 01:23:45 INFO : OneDrive root 'rclone-test-waditug9yela': Looking for duplicate quickxor hashes using newest mode.
2025/03/18 01:23:45 NOTICE: 2180f41fa6202c30f43a2e3607f1d08ddc831fe2: Found 3 files with duplicate quickxor hashes
2025/03/18 01:23:46 INFO : one: Deleted
2025/03/18 01:23:46 INFO : also/one: Deleted
2025/03/18 01:23:46 NOTICE: 2180f41fa6202c30f43a2e3607f1d08ddc831fe2: Deleted 2 extra copies
--- PASS: TestDeduplicateNewestByHash (11.37s)
=== RUN TestDeduplicateOldest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateOldest (0.57s)
=== RUN TestDeduplicateLargest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateLargest (0.57s)
=== RUN TestDeduplicateSmallest
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateSmallest (0.57s)
=== RUN TestDeduplicateRename
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:24: Can't test deduplicate - no duplicate files possible
--- SKIP: TestDeduplicateRename (0.56s)
=== RUN TestMergeDirs
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
dedupe_test.go:256: Can't merge directories
--- SKIP: TestMergeDirs (0.56s)
=== RUN TestListDirSorted
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:23:51 DEBUG : a.txt: Starting multipart upload
2025/03/18 01:23:52 DEBUG : a.txt: Uploading segment 0/11 size 11
2025/03/18 01:23:53 DEBUG : zend.txt: Starting multipart upload
2025/03/18 01:23:54 DEBUG : zend.txt: Uploading segment 0/5 size 5
2025/03/18 01:23:56 DEBUG : sub dir/hello world: Starting multipart upload
2025/03/18 01:23:57 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11
2025/03/18 01:23:58 DEBUG : sub dir/hello world2: Starting multipart upload
2025/03/18 01:24:00 DEBUG : sub dir/hello world2: Uploading segment 0/11 size 11
2025/03/18 01:24:03 DEBUG : sub dir/ignore dir/.ignore: Starting multipart upload
2025/03/18 01:24:04 DEBUG : sub dir/ignore dir/.ignore: Uploading segment 0/1 size 1
2025/03/18 01:24:06 DEBUG : sub dir/ignore dir/should be ignored: Starting multipart upload
2025/03/18 01:24:07 DEBUG : sub dir/ignore dir/should be ignored: Uploading segment 0/9 size 9
2025/03/18 01:24:10 DEBUG : sub dir/sub sub dir/hello world3: Starting multipart upload
2025/03/18 01:24:11 DEBUG : sub dir/sub sub dir/hello world3: Uploading segment 0/11 size 11
2025/03/18 01:24:16 DEBUG : a.txt: Excluded (Size Filter)
2025/03/18 01:24:16 DEBUG : a.txt: Excluded
2025/03/18 01:24:17 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/03/18 01:24:17 DEBUG : sub dir/hello world: Excluded
2025/03/18 01:24:17 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/03/18 01:24:17 DEBUG : sub dir/hello world2: Excluded
2025/03/18 01:24:19 DEBUG : sub dir/ignore dir: Excluded
2025/03/18 01:24:20 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/03/18 01:24:20 DEBUG : sub dir/hello world: Excluded
2025/03/18 01:24:20 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/03/18 01:24:20 DEBUG : sub dir/hello world2: Excluded
2025/03/18 01:24:21 DEBUG : sub dir/ignore dir: Excluded
2025/03/18 01:24:24 DEBUG : Too many requests. Trying again in 19 seconds.
2025/03/18 01:24:24 DEBUG : pacer: low level retry 1/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:24:24 DEBUG : pacer: Rate limited, increasing sleep to 19s
2025/03/18 01:24:24 DEBUG : Too many requests. Trying again in 20 seconds.
2025/03/18 01:24:24 DEBUG : pacer: low level retry 2/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:24:24 DEBUG : pacer: Rate limited, increasing sleep to 20s
2025/03/18 01:24:43 DEBUG : Too many requests. Trying again in 28 seconds.
2025/03/18 01:24:43 DEBUG : pacer: low level retry 3/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:24:43 DEBUG : pacer: Rate limited, increasing sleep to 28s
2025/03/18 01:25:03 DEBUG : Too many requests. Trying again in 26 seconds.
2025/03/18 01:25:03 DEBUG : pacer: low level retry 4/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:25:03 DEBUG : pacer: Rate limited, increasing sleep to 26s
2025/03/18 01:25:31 DEBUG : pacer: Reducing sleep to 19.5s
2025/03/18 01:25:57 DEBUG : pacer: Reducing sleep to 14.625s
2025/03/18 01:26:17 DEBUG : pacer: Reducing sleep to 10.96875s
2025/03/18 01:26:31 DEBUG : pacer: Reducing sleep to 8.2265625s
2025/03/18 01:26:42 DEBUG : pacer: Reducing sleep to 6.169921875s
2025/03/18 01:26:51 DEBUG : pacer: Reducing sleep to 4.627441406s
2025/03/18 01:26:57 DEBUG : pacer: Reducing sleep to 3.470581054s
2025/03/18 01:27:01 DEBUG : pacer: Reducing sleep to 2.60293579s
2025/03/18 01:27:05 DEBUG : pacer: Reducing sleep to 1.952201842s
2025/03/18 01:27:07 DEBUG : pacer: Reducing sleep to 1.464151381s
2025/03/18 01:27:09 DEBUG : pacer: Reducing sleep to 1.098113535s
2025/03/18 01:27:11 DEBUG : pacer: Reducing sleep to 823.585151ms
2025/03/18 01:27:12 DEBUG : pacer: Reducing sleep to 617.688863ms
2025/03/18 01:27:13 DEBUG : pacer: Reducing sleep to 463.266647ms
2025/03/18 01:27:13 DEBUG : pacer: Reducing sleep to 347.449985ms
2025/03/18 01:27:14 DEBUG : pacer: Reducing sleep to 260.587488ms
--- PASS: TestListDirSorted (202.48s)
=== RUN TestListJSON
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:14 DEBUG : file1: Starting multipart upload
2025/03/18 01:27:15 DEBUG : pacer: Reducing sleep to 195.440616ms
2025/03/18 01:27:15 DEBUG : file1: Uploading segment 0/5 size 5
2025/03/18 01:27:16 DEBUG : pacer: Reducing sleep to 146.580462ms
2025/03/18 01:27:16 DEBUG : pacer: Reducing sleep to 109.935346ms
2025/03/18 01:27:16 DEBUG : pacer: Reducing sleep to 82.451509ms
2025/03/18 01:27:16 DEBUG : sub/file2: Starting multipart upload
2025/03/18 01:27:17 DEBUG : pacer: Reducing sleep to 61.838631ms
2025/03/18 01:27:17 DEBUG : sub/file2: Uploading segment 0/9 size 9
2025/03/18 01:27:18 DEBUG : pacer: Reducing sleep to 46.378973ms
2025/03/18 01:27:18 DEBUG : pacer: Reducing sleep to 34.784229ms
2025/03/18 01:27:19 DEBUG : pacer: Reducing sleep to 26.088171ms
=== RUN TestListJSON/Default
2025/03/18 01:27:19 DEBUG : pacer: Reducing sleep to 19.566128ms
=== RUN TestListJSON/FilesOnly
2025/03/18 01:27:19 DEBUG : pacer: Reducing sleep to 14.674596ms
=== RUN TestListJSON/DirsOnly
2025/03/18 01:27:20 DEBUG : pacer: Reducing sleep to 11.005947ms
=== RUN TestListJSON/Recurse
2025/03/18 01:27:20 DEBUG : pacer: Reducing sleep to 10ms
=== RUN TestListJSON/SubDir
=== RUN TestListJSON/NoModTime
=== RUN TestListJSON/NoMimeType
=== RUN TestListJSON/ShowHash
=== RUN TestListJSON/HashTypes
2025/03/18 01:27:22 ERROR : file1: Failed to read hash: hash type not supported
=== RUN TestListJSON/Metadata
--- PASS: TestListJSON (10.14s)
--- PASS: TestListJSON/Default (0.30s)
--- PASS: TestListJSON/FilesOnly (0.30s)
--- PASS: TestListJSON/DirsOnly (0.29s)
--- PASS: TestListJSON/Recurse (0.60s)
--- PASS: TestListJSON/SubDir (0.28s)
--- PASS: TestListJSON/NoModTime (0.30s)
--- PASS: TestListJSON/NoMimeType (0.30s)
--- PASS: TestListJSON/ShowHash (0.29s)
--- PASS: TestListJSON/HashTypes (0.29s)
--- PASS: TestListJSON/Metadata (0.31s)
=== RUN TestStatJSON
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:24 DEBUG : file1: Starting multipart upload
2025/03/18 01:27:25 DEBUG : file1: Uploading segment 0/5 size 5
2025/03/18 01:27:26 DEBUG : sub/file2: Starting multipart upload
2025/03/18 01:27:27 DEBUG : sub/file2: Uploading segment 0/9 size 9
=== RUN TestStatJSON/Root
=== RUN TestStatJSON/RootFilesOnly
=== RUN TestStatJSON/RootDirsOnly
=== RUN TestStatJSON/Dir
2025/03/18 01:27:30 DEBUG : sub: setMetaData called on dir instead of obj
Stack trace:
goroutine 4911 [running]:
github.com/rclone/rclone/fs/log.Stack({0x2567260, 0xc00092aa80}, {0x264c22d, 0x28})
/home/rclone/go/src/github.com/rclone/rclone/fs/log/log.go:112 +0x6e
github.com/rclone/rclone/backend/onedrive.(*Object).setMetaData(0xc00012a480?, 0x2a038c0?)
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2173 +0x37d
github.com/rclone/rclone/backend/onedrive.(*Object).readMetaData(0xc00092aa80, {0x2a038c0, 0x3d3f480})
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2263 +0x125
github.com/rclone/rclone/backend/onedrive.(*Fs).newObjectWithInfo(0xc00012a480, {0x2a038c0, 0x3d3f480}, {0x25d0207, 0x3}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1182 +0xfb
github.com/rclone/rclone/backend/onedrive.(*Fs).NewObject(0x2fb91d4?, {0x2a038c0?, 0x3d3f480?}, {0x25d0207?, 0x25d0207?})
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1193 +0x25
github.com/rclone/rclone/fs/operations.StatJSON({0x2a038c0, 0x3d3f480}, {0x2a19420, 0xc00012a480}, {0x25d0207, 0x3}, 0x0?)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/lsjson.go:297 +0x21a
github.com/rclone/rclone/fs/operations_test.TestStatJSON.func1(0xc000d0e1a0)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/lsjson_test.go:388 +0x54
testing.tRunner(0xc000d0e1a0, 0xc000720360)
/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
created by testing.(*T).Run in goroutine 4899
/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390
=== RUN TestStatJSON/DirWithTrailingSlash
=== RUN TestStatJSON/File
=== RUN TestStatJSON/NotFound
=== RUN TestStatJSON/DirFilesOnly
2025/03/18 01:27:32 DEBUG : sub: setMetaData called on dir instead of obj
Stack trace:
goroutine 4950 [running]:
github.com/rclone/rclone/fs/log.Stack({0x2567260, 0xc00092ac00}, {0x264c22d, 0x28})
/home/rclone/go/src/github.com/rclone/rclone/fs/log/log.go:112 +0x6e
github.com/rclone/rclone/backend/onedrive.(*Object).setMetaData(0xc00012a480?, 0x2a038c0?)
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2173 +0x37d
github.com/rclone/rclone/backend/onedrive.(*Object).readMetaData(0xc00092ac00, {0x2a038c0, 0x3d3f480})
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2263 +0x125
github.com/rclone/rclone/backend/onedrive.(*Fs).newObjectWithInfo(0xc00012a480, {0x2a038c0, 0x3d3f480}, {0x25d0207, 0x3}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1182 +0xfb
github.com/rclone/rclone/backend/onedrive.(*Fs).NewObject(0x2fb91d4?, {0x2a038c0?, 0x3d3f480?}, {0x25d0207?, 0x25d0207?})
/home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1193 +0x25
github.com/rclone/rclone/fs/operations.StatJSON({0x2a038c0, 0x3d3f480}, {0x2a19420, 0xc00012a480}, {0x25d0207, 0x3}, 0x0?)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/lsjson.go:297 +0x21a
github.com/rclone/rclone/fs/operations_test.TestStatJSON.func1(0xc000d0e340)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/lsjson_test.go:388 +0x54
testing.tRunner(0xc000d0e340, 0xc000720fc0)
/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
created by testing.(*T).Run in goroutine 4899
/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390
=== RUN TestStatJSON/FileFilesOnly
=== RUN TestStatJSON/NotFoundFilesOnly
=== RUN TestStatJSON/DirDirsOnly
=== RUN TestStatJSON/FileDirsOnly
=== RUN TestStatJSON/NotFoundDirsOnly
=== RUN TestStatJSON/RootNotFound
2025/03/18 01:27:34 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/notfound"
2025/03/18 01:27:34 DEBUG : Config file has changed externally - reloading
--- PASS: TestStatJSON (16.17s)
--- PASS: TestStatJSON/Root (0.30s)
--- PASS: TestStatJSON/RootFilesOnly (0.00s)
--- PASS: TestStatJSON/RootDirsOnly (0.30s)
--- PASS: TestStatJSON/Dir (0.90s)
--- PASS: TestStatJSON/DirWithTrailingSlash (0.29s)
--- PASS: TestStatJSON/File (0.57s)
--- PASS: TestStatJSON/NotFound (0.84s)
--- PASS: TestStatJSON/DirFilesOnly (0.58s)
--- PASS: TestStatJSON/FileFilesOnly (0.57s)
--- PASS: TestStatJSON/NotFoundFilesOnly (0.57s)
--- PASS: TestStatJSON/DirDirsOnly (0.35s)
--- PASS: TestStatJSON/FileDirsOnly (0.30s)
--- PASS: TestStatJSON/NotFoundDirsOnly (0.32s)
--- PASS: TestStatJSON/RootNotFound (3.25s)
=== RUN TestMkdir
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:40 INFO : OneDrive root 'rclone-test-waditug9yela': Making directory
2025/03/18 01:27:41 INFO : OneDrive root 'rclone-test-waditug9yela': Making directory
--- PASS: TestMkdir (0.91s)
=== RUN TestLsd
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:42 DEBUG : sub dir/hello world: Starting multipart upload
2025/03/18 01:27:43 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11
--- PASS: TestLsd (6.04s)
=== RUN TestLs
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:47 DEBUG : potato2: Starting multipart upload
2025/03/18 01:27:48 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:27:49 DEBUG : empty space: Starting multipart upload
2025/03/18 01:27:50 DEBUG : empty space: Uploading segment 0/1 size 1
--- PASS: TestLs (6.14s)
=== RUN TestLsWithFilesFrom
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:27:53 DEBUG : potato2: Starting multipart upload
2025/03/18 01:27:55 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:27:56 DEBUG : empty space: Starting multipart upload
2025/03/18 01:27:56 DEBUG : empty space: Uploading segment 0/1 size 1
2025/03/18 01:27:59 DEBUG : empty space: Excluded (FilesFrom Filter)
2025/03/18 01:27:59 DEBUG : empty space: Excluded
--- PASS: TestLsWithFilesFrom (7.78s)
=== RUN TestLsLong
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:01 DEBUG : potato2: Starting multipart upload
2025/03/18 01:28:02 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:28:04 DEBUG : empty space: Starting multipart upload
2025/03/18 01:28:04 DEBUG : empty space: Uploading segment 0/1 size 1
--- PASS: TestLsLong (6.52s)
=== RUN TestHashSums
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:08 DEBUG : potato2: Starting multipart upload
2025/03/18 01:28:09 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:28:09 DEBUG : empty space: Starting multipart upload
2025/03/18 01:28:11 DEBUG : empty space: Uploading segment 0/1 size 1
=== RUN TestHashSums/Quickxor
=== RUN TestHashSums/QuickxorDownload
=== RUN TestHashSums/QuickxorBase64
=== RUN TestHashSums/QuickxorDownloadBase64
--- PASS: TestHashSums (8.56s)
--- PASS: TestHashSums/Quickxor (0.29s)
--- PASS: TestHashSums/QuickxorDownload (1.26s)
--- PASS: TestHashSums/QuickxorBase64 (0.32s)
--- PASS: TestHashSums/QuickxorDownloadBase64 (0.90s)
=== RUN TestHashSumsWithErrors
2025/03/18 01:28:16 DEBUG : Creating backend with remote ":memory:"
2025/03/18 01:28:16 ERROR : file1: hash unsupported: hash type not supported
--- PASS: TestHashSumsWithErrors (0.00s)
=== RUN TestHashStream
2025/03/18 01:28:16 DEBUG : Creating md5 hash of 0 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating md5 hash of 0 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating md5 hash of 12 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating md5 hash of 12 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating sha1 hash of 12 bytes read from input stream
2025/03/18 01:28:16 DEBUG : Creating sha1 hash of 12 bytes read from input stream
--- PASS: TestHashStream (0.00s)
=== RUN TestSuffixName
--- PASS: TestSuffixName (0.00s)
=== RUN TestCount
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:16 DEBUG : potato2: Starting multipart upload
2025/03/18 01:28:17 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:28:18 DEBUG : empty space: Starting multipart upload
2025/03/18 01:28:19 DEBUG : empty space: Uploading segment 0/1 size 1
2025/03/18 01:28:20 DEBUG : sub dir/potato3: Starting multipart upload
2025/03/18 01:28:21 DEBUG : sub dir/potato3: Uploading segment 0/5 size 5
--- PASS: TestCount (8.59s)
=== RUN TestDelete
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:25 DEBUG : small: Starting multipart upload
2025/03/18 01:28:25 DEBUG : small: Uploading segment 0/10 size 10
2025/03/18 01:28:26 DEBUG : medium: Starting multipart upload
2025/03/18 01:28:27 DEBUG : medium: Uploading segment 0/60 size 60
2025/03/18 01:28:28 DEBUG : large: Starting multipart upload
2025/03/18 01:28:28 DEBUG : large: Uploading segment 0/100 size 100
2025/03/18 01:28:30 DEBUG : Waiting for deletions to finish
2025/03/18 01:28:30 DEBUG : large: Excluded (Size Filter)
2025/03/18 01:28:30 DEBUG : large: Excluded
2025/03/18 01:28:30 INFO : medium: Deleted
2025/03/18 01:28:30 INFO : small: Deleted
--- PASS: TestDelete (6.75s)
=== RUN TestMaxDelete
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:32 DEBUG : small: Starting multipart upload
2025/03/18 01:28:32 DEBUG : small: Uploading segment 0/10 size 10
2025/03/18 01:28:33 DEBUG : medium: Starting multipart upload
2025/03/18 01:28:34 DEBUG : medium: Uploading segment 0/60 size 60
2025/03/18 01:28:35 DEBUG : large: Starting multipart upload
2025/03/18 01:28:35 DEBUG : large: Uploading segment 0/100 size 100
2025/03/18 01:28:36 DEBUG : Waiting for deletions to finish
2025/03/18 01:28:37 ERROR : small: Got fatal error on delete: --max-delete threshold reached
2025/03/18 01:28:37 INFO : large: Deleted
2025/03/18 01:28:37 INFO : medium: Deleted
--- PASS: TestMaxDelete (7.17s)
=== RUN TestMaxDeleteSizeLargeFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:39 DEBUG : small: Starting multipart upload
2025/03/18 01:28:39 DEBUG : small: Uploading segment 0/10 size 10
2025/03/18 01:28:40 DEBUG : medium: Starting multipart upload
2025/03/18 01:28:41 DEBUG : medium: Uploading segment 0/60 size 60
2025/03/18 01:28:42 DEBUG : large: Starting multipart upload
2025/03/18 01:28:42 DEBUG : large: Uploading segment 0/100 size 100
2025/03/18 01:28:43 DEBUG : Waiting for deletions to finish
2025/03/18 01:28:44 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2025/03/18 01:28:44 INFO : medium: Deleted
2025/03/18 01:28:44 INFO : small: Deleted
--- PASS: TestMaxDeleteSizeLargeFile (7.20s)
=== RUN TestMaxDeleteSize
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:46 DEBUG : small: Starting multipart upload
2025/03/18 01:28:47 DEBUG : small: Uploading segment 0/10 size 10
2025/03/18 01:28:47 DEBUG : medium: Starting multipart upload
2025/03/18 01:28:48 DEBUG : medium: Uploading segment 0/60 size 60
2025/03/18 01:28:49 DEBUG : large: Starting multipart upload
2025/03/18 01:28:50 DEBUG : large: Uploading segment 0/100 size 100
2025/03/18 01:28:51 DEBUG : Waiting for deletions to finish
2025/03/18 01:28:51 ERROR : small: Got fatal error on delete: --max-delete-size threshold reached
2025/03/18 01:28:52 INFO : large: Deleted
2025/03/18 01:28:52 INFO : medium: Deleted
--- PASS: TestMaxDeleteSize (7.48s)
=== RUN TestReadFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:53 DEBUG : ReadFile: Starting multipart upload
2025/03/18 01:28:54 DEBUG : ReadFile: Uploading segment 0/28 size 28
--- PASS: TestReadFile (4.37s)
=== RUN TestRetry
2025/03/18 01:28:58 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5
2025/03/18 01:28:58 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5
2025/03/18 01:28:58 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG
2025/03/18 01:28:58 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG
2025/03/18 01:28:58 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG
2025/03/18 01:28:58 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG
2025/03/18 01:28:58 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG
--- PASS: TestRetry (0.05s)
=== RUN TestCat
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:28:58 DEBUG : file1: Starting multipart upload
2025/03/18 01:28:58 DEBUG : file1: Uploading segment 0/10 size 10
2025/03/18 01:28:59 DEBUG : file2: Starting multipart upload
2025/03/18 01:29:00 DEBUG : file2: Uploading segment 0/9 size 9
--- PASS: TestCat (11.39s)
=== RUN TestPurge
2025/03/18 01:29:09 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-gegoceb5siga"
2025/03/18 01:29:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/18 01:29:11 DEBUG : Creating backend with remote "/tmp/rclone1266016689"
run.go:180: Remote "OneDrive root 'rclone-test-gegoceb5siga'", Local "Local file system at /tmp/rclone1266016689", Modify Window "1s"
2025/03/18 01:29:13 DEBUG : A1/B1/C1/one: Starting multipart upload
2025/03/18 01:29:14 DEBUG : A1/B1/C1/one: Uploading segment 0/3 size 3
2025/03/18 01:29:16 INFO : A2: Making directory
2025/03/18 01:29:17 INFO : A1/B2: Making directory
2025/03/18 01:29:18 INFO : A1/B2/C2: Making directory
2025/03/18 01:29:18 INFO : A1/B1/C3: Making directory
2025/03/18 01:29:19 INFO : A3: Making directory
2025/03/18 01:29:20 INFO : A3/B3: Making directory
2025/03/18 01:29:20 INFO : A3/B3/C4: Making directory
2025/03/18 01:29:21 DEBUG : A1/two: Starting multipart upload
2025/03/18 01:29:22 DEBUG : A1/two: Uploading segment 0/3 size 3
2025/03/18 01:29:27 ERROR : : error listing: directory not found
2025/03/18 01:29:27 DEBUG : OneDrive root 'rclone-test-gegoceb5siga': Purge remote
2025/03/18 01:29:27 NOTICE: purge failed: directory not found
--- PASS: TestPurge (17.60s)
=== RUN TestRmdirsNoLeaveRoot
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:29:29 DEBUG : A1/B1/C1/one: Starting multipart upload
2025/03/18 01:29:30 DEBUG : A1/B1/C1/one: Uploading segment 0/3 size 3
2025/03/18 01:29:31 INFO : A2: Making directory
2025/03/18 01:29:31 INFO : A1/B2: Making directory
2025/03/18 01:29:32 INFO : A1/B2/C2: Making directory
2025/03/18 01:29:33 INFO : A1/B1/C3: Making directory
2025/03/18 01:29:33 INFO : A3: Making directory
2025/03/18 01:29:34 INFO : A3/B3: Making directory
2025/03/18 01:29:35 INFO : A3/B3/C4: Making directory
2025/03/18 01:29:35 DEBUG : A1/two: Starting multipart upload
2025/03/18 01:29:36 DEBUG : A1/two: Uploading segment 0/3 size 3
2025/03/18 01:29:39 DEBUG : removing 1 level 3 directories
2025/03/18 01:29:39 INFO : A3/B3/C4: Removing directory
2025/03/18 01:29:42 DEBUG : removing 2 level 3 directories
2025/03/18 01:29:42 INFO : A1/B2/C2: Removing directory
2025/03/18 01:29:42 INFO : A1/B1/C3: Removing directory
2025/03/18 01:29:43 DEBUG : removing 2 level 2 directories
2025/03/18 01:29:43 INFO : A3/B3: Removing directory
2025/03/18 01:29:43 INFO : A1/B2: Removing directory
2025/03/18 01:29:44 DEBUG : removing 2 level 1 directories
2025/03/18 01:29:44 INFO : A3: Removing directory
2025/03/18 01:29:44 INFO : A2: Removing directory
2025/03/18 01:29:48 DEBUG : removing 1 level 3 directories
2025/03/18 01:29:48 INFO : A1/B1/C1: Removing directory
2025/03/18 01:29:49 DEBUG : removing 1 level 2 directories
2025/03/18 01:29:49 INFO : A1/B1: Removing directory
2025/03/18 01:29:49 DEBUG : removing 1 level 1 directories
2025/03/18 01:29:49 INFO : A1: Removing directory
2025/03/18 01:29:50 DEBUG : removing 1 level 0 directories
2025/03/18 01:29:50 INFO : OneDrive root 'rclone-test-waditug9yela': Removing directory
2025/03/18 01:29:51 ERROR : : error listing: directory not found
2025/03/18 01:29:51 ERROR : : error listing: directory not found
--- PASS: TestRmdirsNoLeaveRoot (24.40s)
=== RUN TestRmdirsLeaveRoot
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:29:52 INFO : A1: Making directory
2025/03/18 01:29:52 INFO : A1/B1: Making directory
2025/03/18 01:29:53 INFO : A1/B1/C1: Making directory
2025/03/18 01:29:56 DEBUG : removing 1 level 3 directories
2025/03/18 01:29:56 INFO : A1/B1/C1: Removing directory
2025/03/18 01:29:56 DEBUG : removing 1 level 2 directories
2025/03/18 01:29:56 INFO : A1/B1: Removing directory
--- PASS: TestRmdirsLeaveRoot (7.87s)
=== RUN TestRmdirsWithFilter
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:29:59 INFO : A1: Making directory
2025/03/18 01:30:00 INFO : A1/B1: Making directory
2025/03/18 01:30:00 INFO : A1/B1/C1: Making directory
2025/03/18 01:30:04 DEBUG : removing 1 level 3 directories
2025/03/18 01:30:04 INFO : A1/B1/C1: Removing directory
2025/03/18 01:30:04 DEBUG : removing 1 level 2 directories
2025/03/18 01:30:04 INFO : A1/B1: Removing directory
--- PASS: TestRmdirsWithFilter (7.75s)
=== RUN TestCopyURL
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:07 DEBUG : file1: Starting multipart upload
2025/03/18 01:30:08 DEBUG : file1: Uploading segment 0/14 size 14
2025/03/18 01:30:10 DEBUG : filename.txt: File name found in url
2025/03/18 01:30:10 DEBUG : filename.txt: Starting multipart upload
2025/03/18 01:30:10 DEBUG : filename.txt: Uploading segment 0/14 size 14
2025/03/18 01:30:11 DEBUG : headerfilename.txt: filename found in Content-Disposition header.
2025/03/18 01:30:11 DEBUG : headerfilename.txt: Starting multipart upload
2025/03/18 01:30:12 DEBUG : headerfilename.txt: Uploading segment 0/14 size 14
2025/03/18 01:30:13 DEBUG : file2: Starting multipart upload
2025/03/18 01:30:14 DEBUG : file2: Uploading segment 0/14 size 14
--- PASS: TestCopyURL (10.10s)
=== RUN TestCopyURLToWriter
--- PASS: TestCopyURLToWriter (0.00s)
=== RUN TestMoveFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:17 DEBUG : file1: Need to transfer - File not found at Destination
2025/03/18 01:30:18 DEBUG : sub/file2: Starting multipart upload
2025/03/18 01:30:19 DEBUG : sub/file2: Uploading segment 0/14 size 14
2025/03/18 01:30:20 DEBUG : file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:30:20 INFO : file1: Copied (new) to: sub/file2
2025/03/18 01:30:20 INFO : file1: Deleted
2025/03/18 01:30:21 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:30:21 DEBUG : file1: Unchanged skipping
2025/03/18 01:30:21 INFO : file1: Deleted
2025/03/18 01:30:21 DEBUG : OneDrive root 'rclone-test-waditug9yela': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestMoveFile (6.95s)
=== RUN TestMoveFileWithIgnoreExisting
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:24 DEBUG : file1: Need to transfer - File not found at Destination
2025/03/18 01:30:24 DEBUG : file1: Starting multipart upload
2025/03/18 01:30:25 DEBUG : file1: Uploading segment 0/14 size 14
2025/03/18 01:30:26 DEBUG : file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:30:26 INFO : file1: Copied (new)
2025/03/18 01:30:26 INFO : file1: Deleted
2025/03/18 01:30:27 DEBUG : file1: Destination exists, skipping
2025/03/18 01:30:27 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set
--- PASS: TestMoveFileWithIgnoreExisting (4.19s)
=== RUN TestCaseInsensitiveMoveFile
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:29 DEBUG : file1: Need to transfer - File not found at Destination
2025/03/18 01:30:29 DEBUG : sub/file2: Starting multipart upload
2025/03/18 01:30:30 DEBUG : sub/file2: Uploading segment 0/14 size 14
2025/03/18 01:30:31 DEBUG : file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:30:31 INFO : file1: Copied (new) to: sub/file2
2025/03/18 01:30:31 INFO : file1: Deleted
2025/03/18 01:30:32 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:30:32 DEBUG : file1: Unchanged skipping
2025/03/18 01:30:32 INFO : file1: Deleted
2025/03/18 01:30:34 DEBUG : sub/file2: moving to sub/File2-rclone-move-vivadal7
2025/03/18 01:30:35 INFO : sub/file2: Moved (server-side) to: sub/File2-rclone-move-vivadal7
2025/03/18 01:30:35 DEBUG : sub/file2: moving to sub/File2
2025/03/18 01:30:36 INFO : sub/File2-rclone-move-vivadal7: Moved (server-side) to: sub/File2
--- PASS: TestCaseInsensitiveMoveFile (10.31s)
=== RUN TestCaseInsensitiveMoveFileDryRun
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:38 DEBUG : hello: Starting multipart upload
2025/03/18 01:30:39 DEBUG : hello: Uploading segment 0/5 size 5
2025/03/18 01:30:42 NOTICE: hello: Skipped rename to HELLO as --dry-run is set
--- PASS: TestCaseInsensitiveMoveFileDryRun (4.38s)
=== RUN TestMoveFileBackupDir
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:43 DEBUG : dst/file1: Starting multipart upload
2025/03/18 01:30:44 DEBUG : dst/file1: Uploading segment 0/18 size 18
2025/03/18 01:30:46 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-waditug9yela/backup"
2025/03/18 01:30:49 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18)
2025/03/18 01:30:51 INFO : dst/file1: Moved (server-side)
2025/03/18 01:30:51 DEBUG : dst/file1: Starting multipart upload
2025/03/18 01:30:52 DEBUG : dst/file1: Uploading segment 0/14 size 14
2025/03/18 01:30:53 DEBUG : dst/file1: quickxor = 6648031bca1003108ce10d6eae4319dc40873900 OK
2025/03/18 01:30:53 INFO : dst/file1: Copied (new)
2025/03/18 01:30:53 INFO : dst/file1: Deleted
--- PASS: TestMoveFileBackupDir (15.30s)
=== RUN TestSameConfig
--- PASS: TestSameConfig (0.00s)
=== RUN TestSame
--- PASS: TestSame (0.00s)
=== RUN TestOverlappingFilterCheckWithoutFilter
--- PASS: TestOverlappingFilterCheckWithoutFilter (0.00s)
=== RUN TestOverlappingFilterCheckWithFilter
--- PASS: TestOverlappingFilterCheckWithFilter (0.00s)
=== RUN TestListFormat
--- PASS: TestListFormat (0.00s)
=== RUN TestDirMove
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:30:59 DEBUG : A1/one: Starting multipart upload
2025/03/18 01:31:00 DEBUG : A1/one: Uploading segment 0/3 size 3
2025/03/18 01:31:01 DEBUG : A1/two: Starting multipart upload
2025/03/18 01:31:02 DEBUG : A1/two: Uploading segment 0/3 size 3
2025/03/18 01:31:04 DEBUG : A1/B1/three: Starting multipart upload
2025/03/18 01:31:05 DEBUG : A1/B1/three: Uploading segment 0/5 size 5
2025/03/18 01:31:07 DEBUG : A1/B1/C1/four: Starting multipart upload
2025/03/18 01:31:08 DEBUG : A1/B1/C1/four: Uploading segment 0/4 size 4
2025/03/18 01:31:10 DEBUG : A1/B1/C2/five: Starting multipart upload
2025/03/18 01:31:11 DEBUG : A1/B1/C2/five: Uploading segment 0/4 size 4
2025/03/18 01:31:12 INFO : A1/B2: Making directory
2025/03/18 01:31:13 INFO : A1/B1/C3: Making directory
2025/03/18 01:31:18 DEBUG : Too many requests. Trying again in 17 seconds.
2025/03/18 01:31:18 DEBUG : pacer: low level retry 1/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:31:18 DEBUG : pacer: Rate limited, increasing sleep to 17s
2025/03/18 01:31:19 DEBUG : pacer: Reducing sleep to 12.75s
2025/03/18 01:31:35 DEBUG : Too many requests. Trying again in 22 seconds.
2025/03/18 01:31:35 DEBUG : pacer: low level retry 1/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:31:35 DEBUG : pacer: Rate limited, increasing sleep to 22s
2025/03/18 01:31:48 DEBUG : Too many requests. Trying again in 20 seconds.
2025/03/18 01:31:48 DEBUG : pacer: low level retry 2/10 (error serviceNotAvailable: Service unavailable)
2025/03/18 01:31:48 DEBUG : pacer: Rate limited, increasing sleep to 20s
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela/data': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-nanopud5juve': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-fulumac4jepi': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-piletig2vuda': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela/data': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela/dst': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela/dst': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-makebip2payi': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela/notfound': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-zevujus3hupa': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-woqeler7veqe': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-waditug9yela': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-gegoceb5siga': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-zurudin5gaju': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-yexiloh6quri': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-joxuvod5pata': Token expired but no uploads in progress - doing nothing
2025/03/18 01:31:59 DEBUG : OneDrive root 'rclone-test-quwijag3jaco': Token expired but no uploads in progress - doing nothing
2025/03/18 01:32:10 DEBUG : Config file has changed externally - reloading
2025/03/18 01:32:10 DEBUG : TestOneDriveBusiness: Loaded invalid token from config file - ignoring
2025/03/18 01:32:11 DEBUG : Saving config "token" in section "TestOneDriveBusiness" of the config file
2025/03/18 01:32:11 DEBUG : TestOneDriveBusiness: Saved new token in config file
2025/03/18 01:32:11 DEBUG : pacer: Reducing sleep to 15s
2025/03/18 01:32:30 DEBUG : pacer: Reducing sleep to 11.25s
2025/03/18 01:32:45 DEBUG : pacer: Reducing sleep to 8.4375s
2025/03/18 01:32:57 DEBUG : pacer: Reducing sleep to 6.328125s
2025/03/18 01:33:05 DEBUG : pacer: Reducing sleep to 4.74609375s
2025/03/18 01:33:11 DEBUG : pacer: Reducing sleep to 3.559570312s
2025/03/18 01:33:16 DEBUG : pacer: Reducing sleep to 2.669677734s
2025/03/18 01:33:20 DEBUG : pacer: Reducing sleep to 2.0022583s
2025/03/18 01:33:22 DEBUG : pacer: Reducing sleep to 1.501693725s
2025/03/18 01:33:24 DEBUG : pacer: Reducing sleep to 1.126270293s
2025/03/18 01:33:26 DEBUG : pacer: Reducing sleep to 844.702719ms
2025/03/18 01:33:27 DEBUG : pacer: Reducing sleep to 633.527039ms
2025/03/18 01:33:28 DEBUG : pacer: Reducing sleep to 475.145279ms
2025/03/18 01:33:28 DEBUG : pacer: Reducing sleep to 356.358959ms
2025/03/18 01:33:29 DEBUG : pacer: Reducing sleep to 267.269219ms
2025/03/18 01:33:29 DEBUG : pacer: Reducing sleep to 200.451914ms
2025/03/18 01:33:30 DEBUG : pacer: Reducing sleep to 150.338935ms
2025/03/18 01:33:30 DEBUG : pacer: Reducing sleep to 112.754201ms
2025/03/18 01:33:30 DEBUG : pacer: Reducing sleep to 84.56565ms
2025/03/18 01:33:31 DEBUG : pacer: Reducing sleep to 63.424237ms
2025/03/18 01:33:31 DEBUG : pacer: Reducing sleep to 47.568177ms
2025/03/18 01:33:31 DEBUG : pacer: Reducing sleep to 35.676132ms
2025/03/18 01:33:32 DEBUG : pacer: Reducing sleep to 26.757099ms
2025/03/18 01:33:32 DEBUG : pacer: Reducing sleep to 20.067824ms
2025/03/18 01:33:32 DEBUG : pacer: Reducing sleep to 15.050868ms
2025/03/18 01:33:33 DEBUG : pacer: Reducing sleep to 11.288151ms
2025/03/18 01:33:33 DEBUG : pacer: Reducing sleep to 10ms
2025/03/18 01:33:34 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2025/03/18 01:33:34 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2025/03/18 01:33:34 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three
2025/03/18 01:33:35 INFO : A2/two: Moved (server-side) to: A3/two
2025/03/18 01:33:35 INFO : A2/one: Moved (server-side) to: A3/one
2025/03/18 01:33:40 INFO : OneDrive root 'rclone-test-waditug9yela': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2025/03/18 01:33:46 INFO : A3/one: Moved (server-side) to: A4/one
2025/03/18 01:33:47 INFO : A3/two: Moved (server-side) to: A4/two
2025/03/18 01:33:47 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2025/03/18 01:33:47 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three
2025/03/18 01:33:47 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
--- PASS: TestDirMove (180.15s)
=== RUN TestGetFsInfo
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
--- PASS: TestGetFsInfo (0.56s)
=== RUN TestRcat
=== RUN TestRcat/withChecksum=false,ignoreChecksum=false
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:33:59 DEBUG : OneDrive root 'rclone-test-waditug9yela': File to upload is small (34 bytes), uploading instead of streaming
2025/03/18 01:33:59 DEBUG : no_checksum_small_file_from_pipe: Starting multipart upload
2025/03/18 01:34:00 DEBUG : no_checksum_small_file_from_pipe: Uploading segment 0/34 size 34
2025/03/18 01:34:01 DEBUG : no_checksum_small_file_from_pipe: quickxor = 45dc0e76d116c1d44a3588d25663bb8919e47993 OK
2025/03/18 01:34:01 DEBUG : no_checksum_small_file_from_pipe: Size and quickxor of src and dst objects identical
2025/03/18 01:34:01 DEBUG : OneDrive root 'rclone-test-waditug9yela': Target remote doesn't support streaming uploads, creating temporary local FS to spool file
2025/03/18 01:34:01 DEBUG : no_checksum_big_file_from_pipe: Starting multipart upload
2025/03/18 01:34:02 DEBUG : no_checksum_big_file_from_pipe: Uploading segment 0/102401 size 102401
2025/03/18 01:34:04 DEBUG : no_checksum_big_file_from_pipe: quickxor = 0000000000000000000000000190010000000000 OK
2025/03/18 01:34:04 DEBUG : no_checksum_big_file_from_pipe: Size and quickxor of src and dst objects identical
=== RUN TestRcat/withChecksum=true,ignoreChecksum=false
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:06 DEBUG : OneDrive root 'rclone-test-waditug9yela': File to upload is small (34 bytes), uploading instead of streaming
2025/03/18 01:34:06 DEBUG : with_checksum_small_file_from_pipe: Starting multipart upload
2025/03/18 01:34:06 DEBUG : with_checksum_small_file_from_pipe: Uploading segment 0/34 size 34
2025/03/18 01:34:07 DEBUG : with_checksum_small_file_from_pipe: quickxor = 45dc0e76d116c1d44a3588d25663bb8919e47993 OK
2025/03/18 01:34:07 DEBUG : with_checksum_small_file_from_pipe: Size and quickxor of src and dst objects identical
2025/03/18 01:34:07 DEBUG : OneDrive root 'rclone-test-waditug9yela': Target remote doesn't support streaming uploads, creating temporary local FS to spool file
2025/03/18 01:34:07 DEBUG : with_checksum_big_file_from_pipe: Starting multipart upload
2025/03/18 01:34:08 DEBUG : with_checksum_big_file_from_pipe: Uploading segment 0/102401 size 102401
2025/03/18 01:34:09 DEBUG : with_checksum_big_file_from_pipe: quickxor = 0000000000000000000000000190010000000000 OK
2025/03/18 01:34:09 DEBUG : with_checksum_big_file_from_pipe: Size and quickxor of src and dst objects identical
=== RUN TestRcat/withChecksum=false,ignoreChecksum=true
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:11 DEBUG : OneDrive root 'rclone-test-waditug9yela': File to upload is small (34 bytes), uploading instead of streaming
2025/03/18 01:34:11 DEBUG : ignore_checksum_small_file_from_pipe: Starting multipart upload
2025/03/18 01:34:12 DEBUG : ignore_checksum_small_file_from_pipe: Uploading segment 0/34 size 34
2025/03/18 01:34:12 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:34:12 DEBUG : OneDrive root 'rclone-test-waditug9yela': Target remote doesn't support streaming uploads, creating temporary local FS to spool file
2025/03/18 01:34:12 DEBUG : ignore_checksum_big_file_from_pipe: Starting multipart upload
2025/03/18 01:34:13 DEBUG : ignore_checksum_big_file_from_pipe: Uploading segment 0/102401 size 102401
2025/03/18 01:34:14 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
=== RUN TestRcat/withChecksum=true,ignoreChecksum=true
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:16 DEBUG : OneDrive root 'rclone-test-waditug9yela': File to upload is small (34 bytes), uploading instead of streaming
2025/03/18 01:34:16 DEBUG : ignore_checksum_small_file_from_pipe: Starting multipart upload
2025/03/18 01:34:17 DEBUG : ignore_checksum_small_file_from_pipe: Uploading segment 0/34 size 34
2025/03/18 01:34:18 DEBUG : ignore_checksum_small_file_from_pipe: Src hash empty - aborting Dst hash check
2025/03/18 01:34:18 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical
2025/03/18 01:34:18 DEBUG : OneDrive root 'rclone-test-waditug9yela': Target remote doesn't support streaming uploads, creating temporary local FS to spool file
2025/03/18 01:34:18 DEBUG : ignore_checksum_big_file_from_pipe: Starting multipart upload
2025/03/18 01:34:18 DEBUG : ignore_checksum_big_file_from_pipe: Uploading segment 0/102401 size 102401
2025/03/18 01:34:20 DEBUG : ignore_checksum_big_file_from_pipe: Src hash empty - aborting Dst hash check
2025/03/18 01:34:20 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical
--- PASS: TestRcat (22.59s)
--- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (6.73s)
--- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.10s)
--- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (5.39s)
--- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (5.36s)
=== RUN TestRcatMetadata
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
operations_test.go:1532: Skipping as destination doesn't support user metadata
--- SKIP: TestRcatMetadata (0.54s)
=== RUN TestRcatSize
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:22 DEBUG : potato1: Starting multipart upload
2025/03/18 01:34:23 DEBUG : potato1: Uploading segment 0/60 size 60
2025/03/18 01:34:23 DEBUG : OneDrive root 'rclone-test-waditug9yela': File to upload is small (60 bytes), uploading instead of streaming
2025/03/18 01:34:23 DEBUG : potato2: Starting multipart upload
2025/03/18 01:34:24 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:34:25 DEBUG : potato2: quickxor = 4001dad296b6b4a52d6d694b67dad296b6b4a52d OK
2025/03/18 01:34:25 DEBUG : potato2: Size and quickxor of src and dst objects identical
--- PASS: TestRcatSize (4.27s)
=== RUN TestRcatSizeMetadata
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
operations_test.go:1613: Skipping as destination doesn't support user metadata
--- SKIP: TestRcatSizeMetadata (0.55s)
=== RUN TestTouchDir
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:27 DEBUG : potato2: Starting multipart upload
2025/03/18 01:34:28 DEBUG : potato2: Uploading segment 0/60 size 60
2025/03/18 01:34:28 DEBUG : empty space: Starting multipart upload
2025/03/18 01:34:29 DEBUG : empty space: Uploading segment 0/1 size 1
2025/03/18 01:34:30 DEBUG : sub dir/potato3: Starting multipart upload
2025/03/18 01:34:31 DEBUG : sub dir/potato3: Uploading segment 0/5 size 5
2025/03/18 01:34:33 DEBUG : OneDrive root 'rclone-test-waditug9yela': Touching "empty space"
2025/03/18 01:34:33 DEBUG : OneDrive root 'rclone-test-waditug9yela': Touching "potato2"
2025/03/18 01:34:33 DEBUG : OneDrive root 'rclone-test-waditug9yela': Touching "sub dir/potato3"
--- PASS: TestTouchDir (9.71s)
=== RUN TestMkdirMetadata
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:36 DEBUG : dir with metadata: Making directory with metadata
2025/03/18 01:34:37 DEBUG : dir with metadata: skipping unsupported metadata item: potato: jersey
2025/03/18 01:34:37 DEBUG : dir with metadata: setting time 2001-02-03 04:05:06.499999999 +0000 UTC
2025/03/18 01:34:38 INFO : dir with metadata: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
--- PASS: TestMkdirMetadata (3.24s)
=== RUN TestMkdirModTime
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:40 DEBUG : directory with modtime: Making directory with metadata
2025/03/18 01:34:40 DEBUG : directory with modtime: setting time 2011-12-25 12:59:59.123456789 +0000 UTC
2025/03/18 01:34:41 INFO : directory with modtime: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
--- PASS: TestMkdirModTime (2.90s)
=== RUN TestCopyDirMetadata
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:43 DEBUG : dir with metadata to be copied: Making directory with metadata
2025/03/18 01:34:43 INFO : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/03/18 01:34:43 DEBUG : non existent directory: skipping unsupported metadata item: gid: 1000
2025/03/18 01:34:43 DEBUG : non existent directory: skipping unsupported metadata item: atime: 2001-02-03T04:05:06.499999999Z
2025/03/18 01:34:43 DEBUG : non existent directory: skipping unsupported metadata item: potato: jersey
2025/03/18 01:34:43 DEBUG : non existent directory: skipping unsupported metadata item: mode: 40775
2025/03/18 01:34:43 DEBUG : non existent directory: skipping unsupported metadata item: uid: 1000
2025/03/18 01:34:43 DEBUG : non existent directory: setting time 2001-02-03 04:05:06.499999999 +0000 UTC
2025/03/18 01:34:44 INFO : non existent directory: Updated directory metadata
2025/03/18 01:34:46 DEBUG : existing directory: skipping unsupported metadata item: mode: 40775
2025/03/18 01:34:46 DEBUG : existing directory: skipping unsupported metadata item: uid: 1000
2025/03/18 01:34:46 DEBUG : existing directory: skipping unsupported metadata item: gid: 1000
2025/03/18 01:34:46 DEBUG : existing directory: skipping unsupported metadata item: atime: 2001-02-03T04:05:06.499999999Z
2025/03/18 01:34:46 DEBUG : existing directory: skipping unsupported metadata item: potato: jersey
2025/03/18 01:34:47 INFO : existing directory: Updated directory metadata
--- PASS: TestCopyDirMetadata (5.84s)
=== RUN TestSetDirModTime
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:48 DEBUG : set modtime on non existent directory: Skipping set directory modification time as --no-update-dir-modtime is set
2025/03/18 01:34:50 INFO : set modtime on existing directory: Set directory modification time (using SetModTime)
2025/03/18 01:34:51 INFO : set modtime on existing directory: Set directory modification time (using DirSetModTime)
--- PASS: TestSetDirModTime (4.37s)
=== RUN TestDirsEqual
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:53 DEBUG : dir with metadata to be copied: Making directory with metadata
2025/03/18 01:34:53 INFO : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/03/18 01:34:53 DEBUG : dst: Making directory with metadata
2025/03/18 01:34:54 DEBUG : dst: setting time 2001-02-03 04:05:06.499999999 +0000 UTC
2025/03/18 01:34:54 INFO : dst: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2025/03/18 01:34:54 DEBUG : dst: Directory modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:34:54 INFO : dst: Set directory modification time (using SetModTime)
2025/03/18 01:34:55 INFO : dst: Set directory modification time (using SetModTime)
2025/03/18 01:34:55 DEBUG : dst: Directory modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/03/18 01:34:55 INFO : dst: Set directory modification time (using SetModTime)
2025/03/18 01:34:55 DEBUG : dst: Destination directory is newer than source, skipping
--- PASS: TestDirsEqual (4.06s)
=== RUN TestRemoveExisting
run.go:180: Remote "OneDrive root 'rclone-test-waditug9yela'", Local "Local file system at /tmp/rclone2464418373", Modify Window "1s"
2025/03/18 01:34:58 DEBUG : sub dir/test remove existing: Starting multipart upload
2025/03/18 01:34:59 DEBUG : sub dir/test remove existing: Uploading segment 0/11 size 11
2025/03/18 01:35:00 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Starting multipart upload
2025/03/18 01:35:00 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Uploading segment 0/21 size 21
2025/03/18 01:35:05 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.rohedod7" before starting
2025/03/18 01:35:06 DEBUG : sub dir/test remove existing.rohedod7: TEST: removing renamed existing file after operation
2025/03/18 01:35:08 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.qugebuf5" before starting
2025/03/18 01:35:10 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.qugebuf5: TEST: renaming existing back after failed operation
2025/03/18 01:35:12 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.segarib0" before starting
2025/03/18 01:35:14 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.segarib0: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (20.07s)
=== RUN TestRcAbout
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcAbout (0.00s)
=== RUN TestRcCleanup
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcCleanup (0.00s)
=== RUN TestRcCopyfile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcCopyfile (0.00s)
=== RUN TestRcCopyurl
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcCopyurl (0.00s)
=== RUN TestRcDelete
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcDelete (0.00s)
=== RUN TestRcDeletefile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcDeletefile (0.00s)
=== RUN TestRcList
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcList (0.00s)
=== RUN TestRcStat
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcStat (0.00s)
=== RUN TestRcSetTier
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcSetTier (0.00s)
=== RUN TestRcSetTierFile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcSetTierFile (0.00s)
=== RUN TestRcMkdir
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcMkdir (0.00s)
=== RUN TestRcMovefile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcMovefile (0.00s)
=== RUN TestRcPurge
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcPurge (0.00s)
=== RUN TestRcRmdir
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcRmdir (0.00s)
=== RUN TestRcRmdirs
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcRmdirs (0.00s)
=== RUN TestRcSize
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcSize (0.00s)
=== RUN TestRcPublicLink
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcPublicLink (0.00s)
=== RUN TestRcFsInfo
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcFsInfo (0.00s)
=== RUN TestUploadFile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestUploadFile (0.00s)
=== RUN TestRcCommand
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcCommand (0.00s)
=== RUN TestRcDu
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcDu (0.00s)
=== RUN TestRcCheck
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcCheck (0.00s)
=== RUN TestRcHashsum
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcHashsum (0.00s)
=== RUN TestRcHashsumFile
rc_test.go:30: Skipping test on non local remote
--- SKIP: TestRcHashsumFile (0.00s)
PASS
2025/03/18 01:35:17 DEBUG : OneDrive root 'rclone-test-waditug9yela': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOneDriveBusiness: -verbose" - Finished OK in 16m28.299824824s (try 1/5)