"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDriveBusiness: -verbose -test.run '^(TestMoveEmptyDirectories|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoUpdateDirModtime)$'" - Starting (try 3/5) 2026/04/21 07:28:08 DEBUG : Creating backend with remote "TestOneDriveBusiness:rclone-test-yewotur6guco" 2026/04/21 07:28:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/04/21 07:28:11 DEBUG : Creating backend with remote "/tmp/rclone3182672432" === RUN TestMoveEmptyDirectories run.go:185: Remote "OneDrive root 'rclone-test-yewotur6guco'", Local "Local file system at /tmp/rclone3182672432", Modify Window "1s" 2026/04/21 07:28:11 DEBUG : sub dir2: Making directory with metadata 2026/04/21 07:28:11 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/04/21 07:28:14 DEBUG : sub dir2: Making directory with metadata 2026/04/21 07:28:15 DEBUG : sub dir2: setting time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/04/21 07:28:16 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/04/21 07:28:16 DEBUG : sub dir: Making directory with metadata 2026/04/21 07:28:17 DEBUG : sub dir: setting time 2026-04-21 07:28:11.577268157 +0000 UTC 2026/04/21 07:28:19 INFO : sub dir: Made directory with metadata (mtime=2026-04-21T07:28:11.577268157Z) 2026/04/21 07:28:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/04/21 07:28:19 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for checks to finish 2026/04/21 07:28:19 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for transfers to finish 2026/04/21 07:28:19 DEBUG : sub dir/hello world: Starting multipart upload 2026/04/21 07:28:19 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11 2026/04/21 07:28:20 DEBUG : sub dir/hello world: size = 11 OK 2026/04/21 07:28:20 DEBUG : sub dir/hello world: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2026/04/21 07:28:20 INFO : sub dir/hello world: Copied (new) 2026/04/21 07:28:20 INFO : sub dir/hello world: Deleted --- PASS: TestMoveEmptyDirectories (13.09s) === RUN TestSyncNoUpdateDirModtime run.go:185: Remote "OneDrive root 'rclone-test-yewotur6guco'", Local "Local file system at /tmp/rclone3182672432", Modify Window "1s" 2026/04/21 07:28:24 DEBUG : sub dir no update dir modtime: Making directory with metadata 2026/04/21 07:28:24 INFO : sub dir no update dir modtime: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/04/21 07:28:26 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for checks to finish 2026/04/21 07:28:26 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for transfers to finish 2026/04/21 07:28:26 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoUpdateDirModtime (4.15s) === RUN TestSyncEmptyDirectories run.go:185: Remote "OneDrive root 'rclone-test-yewotur6guco'", Local "Local file system at /tmp/rclone3182672432", Modify Window "1s" 2026/04/21 07:28:28 DEBUG : sub dir2: Making directory with metadata 2026/04/21 07:28:28 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/04/21 07:28:28 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/04/21 07:28:29 DEBUG : sub dir2: Making directory with metadata 2026/04/21 07:28:29 DEBUG : sub dir2: setting time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/04/21 07:28:30 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/04/21 07:28:30 DEBUG : sub dir: Making directory with metadata 2026/04/21 07:29:01 DEBUG : sub dir: setting time 2001-02-03 04:05:06.499999999 +0000 UTC 2026/04/21 07:29:01 INFO : sub dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2026/04/21 07:29:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/04/21 07:29:01 DEBUG : sub dir/hello world: Starting multipart upload 2026/04/21 07:29:01 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for checks to finish 2026/04/21 07:29:01 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for transfers to finish 2026/04/21 07:29:02 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11 2026/04/21 07:29:02 DEBUG : sub dir/hello world: size = 11 OK 2026/04/21 07:29:02 DEBUG : sub dir/hello world: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2026/04/21 07:29:02 INFO : sub dir/hello world: Copied (new) 2026/04/21 07:29:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncEmptyDirectories (44.66s) === RUN TestSyncNoEmptyDirectories run.go:185: Remote "OneDrive root 'rclone-test-yewotur6guco'", Local "Local file system at /tmp/rclone3182672432", Modify Window "1s" 2026/04/21 07:29:13 INFO : sub dir2: Making directory 2026/04/21 07:29:13 DEBUG : Added delayed dir = "sub dir2", newDst= 2026/04/21 07:29:13 DEBUG : Added delayed dir = "sub dir", newDst= 2026/04/21 07:29:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/04/21 07:29:13 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for checks to finish 2026/04/21 07:29:13 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Waiting for transfers to finish 2026/04/21 07:29:14 DEBUG : sub dir/hello world: Starting multipart upload 2026/04/21 07:29:15 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11 2026/04/21 07:29:15 DEBUG : sub dir/hello world: size = 11 OK 2026/04/21 07:29:15 DEBUG : sub dir/hello world: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2026/04/21 07:29:15 INFO : sub dir/hello world: Copied (new) 2026/04/21 07:29:15 DEBUG : Waiting for deletions to finish 2026/04/21 07:29:16 INFO : sub dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncNoEmptyDirectories (4.76s) PASS 2026/04/21 07:29:18 DEBUG : OneDrive root 'rclone-test-yewotur6guco': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDriveBusiness: -verbose -test.run '^(TestMoveEmptyDirectories|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoUpdateDirModtime)$'" - Finished OK in 1m10.036451679s (try 3/5)