"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^(FsMkdirMetadata|FsPutError)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestDirectoryMetadata|TestMetadataMapper|TestReadMetadata|TestReadPermissions|TestServerSideCopyMove|TestUploadSinglePart|TestWritePermissions)$'" - Starting (try 4/5) 2026/01/29 02:00:09 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vecekob5hose" 2026/01/29 02:00:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:00:09 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:00:10 DEBUG : Creating backend with remote "/tmp/rclone471952866" === RUN TestIntegration fstests.go:438: Using remote "TestOneDrive:" 2026/01/29 02:00:10 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vicuted6wuzi" 2026/01/29 02:00:10 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:00:10 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsPutError 2026/01/29 02:00:17 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload 2026/01/29 02:00:17 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/10240 size 10240 2026/01/29 02:00:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Cancelling multipart upload: Put "https://my.microsoftpersonalcontent.com/personal/71a96798e7b1d253/_api/v2.0/drives/b!vKC3DXjgjk-Lp7XrVMpysWhcKnHtT8dLkaHuPSl-l2DGmC7WzjOlT7z5hN2HZRn_/items/01C6Y6557JRKLXYLBVHJDIQXWWUQD2RJRD/uploadSession?guid='14ff7a00-1259-4f06-9eef-3816e415fb55'&overwrite=True&rename=False&dc=0&tempauth=v1e.eyJzaXRlaWQiOiIwZGI3YTBiYy1lMDc4LTRmOGUtOGJhNy1iNWViNTRjYTcyYjEiLCJhcHBfZGlzcGxheW5hbWUiOiJyY2xvbmUiLCJhcHBpZCI6ImIxNTY2NWQ5LWVkYTYtNDA5Mi04NTM5LTBlZWMzNzZhZmQ1OSIsImF1ZCI6IjAwMDAwMDAzLTAwMDAtMGZmMS1jZTAwLTAwMDAwMDAwMDAwMC9teS5taWNyb3NvZnRwZXJzb25hbGNvbnRlbnQuY29tQDkxODgwNDBkLTZjNjctNGM1Yi1iMTEyLTM2YTMwNGI2NmRhZCIsImV4cCI6IjE3Njk3Mzg0MTcifQ.tF4xWwIQ25pCZJjoFa5TVHpKEtwM-bVmjSuJpLEjGJTcwd9opkPxK_jzu7wDDp3mccEz0O1ivstBH7I1-d4-hFBOdH1Urbfhuz81zL2Ed3x_OOmWHv7Xdop924GUwOc114lHMaQ50IklvtV8n0l8DBlI5WqlnsdV81SwV2X45kXHHAqh-aJSXugu1u7Q7ykalTvbtEIu_1IyB-B_aLJiXyMFKGbHqtpfwuKeeJpdkEnw9R4OZTm-4p83cuC7kkYBnBqNS7TpIgRExHn59iqmbVmDdbC2RVnlz72vG-_rkvZBBEFJ6_UMC2Wg6QNKl5uJiAfA8c8hz7DLFnrO0wjOdTyA-YiogqbTSRVgZnluNlE-wC0ZT8MXLpVnihMEQanUVKYy8oGmXtkgWHi7On1aXi7nCNFc7pv1_GiPFqt1d9OqIBv5HpoDGRFWu52xTQG_7PaIRgknju3qqeS79d2SZA.6cfwxCsjty-G1pNYnVfsmzKTvjwsK1GQYn-68RsNpko": potato 2026/01/29 02:00:18 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Failed to cancel multipart upload: unauthenticated: Unauthenticated (upload failed due to: Put "https://my.microsoftpersonalcontent.com/personal/71a96798e7b1d253/_api/v2.0/drives/b!vKC3DXjgjk-Lp7XrVMpysWhcKnHtT8dLkaHuPSl-l2DGmC7WzjOlT7z5hN2HZRn_/items/01C6Y6557JRKLXYLBVHJDIQXWWUQD2RJRD/uploadSession?guid='14ff7a00-1259-4f06-9eef-3816e415fb55'&overwrite=True&rename=False&dc=0&tempauth=v1e.eyJzaXRlaWQiOiIwZGI3YTBiYy1lMDc4LTRmOGUtOGJhNy1iNWViNTRjYTcyYjEiLCJhcHBfZGlzcGxheW5hbWUiOiJyY2xvbmUiLCJhcHBpZCI6ImIxNTY2NWQ5LWVkYTYtNDA5Mi04NTM5LTBlZWMzNzZhZmQ1OSIsImF1ZCI6IjAwMDAwMDAzLTAwMDAtMGZmMS1jZTAwLTAwMDAwMDAwMDAwMC9teS5taWNyb3NvZnRwZXJzb25hbGNvbnRlbnQuY29tQDkxODgwNDBkLTZjNjctNGM1Yi1iMTEyLTM2YTMwNGI2NmRhZCIsImV4cCI6IjE3Njk3Mzg0MTcifQ.tF4xWwIQ25pCZJjoFa5TVHpKEtwM-bVmjSuJpLEjGJTcwd9opkPxK_jzu7wDDp3mccEz0O1ivstBH7I1-d4-hFBOdH1Urbfhuz81zL2Ed3x_OOmWHv7Xdop924GUwOc114lHMaQ50IklvtV8n0l8DBlI5WqlnsdV81SwV2X45kXHHAqh-aJSXugu1u7Q7ykalTvbtEIu_1IyB-B_aLJiXyMFKGbHqtpfwuKeeJpdkEnw9R4OZTm-4p83cuC7kkYBnBqNS7TpIgRExHn59iqmbVmDdbC2RVnlz72vG-_rkvZBBEFJ6_UMC2Wg6QNKl5uJiAfA8c8hz7DLFnrO0wjOdTyA-YiogqbTSRVgZnluNlE-wC0ZT8MXLpVnihMEQanUVKYy8oGmXtkgWHi7On1aXi7nCNFc7pv1_GiPFqt1d9OqIBv5HpoDGRFWu52xTQG_7PaIRgknju3qqeS79d2SZA.6cfwxCsjty-G1pNYnVfsmzKTvjwsK1GQYn-68RsNpko": potato) 2026/01/29 02:00:18 DEBUG : info from Update error: null fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 1/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 2/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 3/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 4/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 5/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 6/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 7/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 8/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 9/10 fstests.go:143: FsPutError: test object does not exist error: object is present - low level retry 10/10 fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:761 Error: Received unexpected error: object is present Test: TestIntegration/FsMkdir/FsPutError Messages: FsPutError: test object does not exist === RUN TestIntegration/FsMkdir/FsPutFiles 2026/01/29 02:00:42 DEBUG : file name.txt: Starting multipart upload 2026/01/29 02:00:42 DEBUG : file name.txt: Uploading segment 0/100 size 100 2026/01/29 02:00:43 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload 2026/01/29 02:00:44 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100 2026/01/29 02:00:45 DEBUG : file name.txt: Starting multipart upload 2026/01/29 02:00:45 DEBUG : file name.txt: skipping unsupported metadata item: rclonetest: potato 2026/01/29 02:00:45 INFO : file name.txt: no writeable metadata found: map[rclonetest:potato] 2026/01/29 02:00:46 DEBUG : file name.txt: Uploading segment 0/100 size 100 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal 2026/01/29 02:00:47 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-sucezat3noga" 2026/01/29 02:00:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:00:47 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:00:49 DEBUG : Creating backend with remote "/tmp/rclone1768475803" run.go:185: Remote "OneDrive root 'rclone-test-sucezat3noga'", Local "Local file system at /tmp/rclone1768475803", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestWritePermissions 2026/01/29 02:00:50 DEBUG : some file-vaxanef3.txt: Starting multipart upload 2026/01/29 02:00:51 DEBUG : info from Update error: null fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:382 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:55 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: invalidRequest: Invalid request Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestWritePermissions Messages: Put 2026/01/29 02:00:51 DEBUG : OneDrive root 'rclone-test-sucezat3noga': Purge remote 2026/01/29 02:00:51 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-ziguwuz4sogu" 2026/01/29 02:00:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:00:51 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:00:53 DEBUG : Creating backend with remote "/tmp/rclone1872288339" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:185: Remote "OneDrive root 'rclone-test-ziguwuz4sogu'", Local "Local file system at /tmp/rclone1872288339", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestUploadSinglePart 2026/01/29 02:00:54 DEBUG : some file-nekaqux9.txt: Starting singlepart upload 2026/01/29 02:00:55 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/ARVr8iPErlBHikXCwSM9n7g" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:00:55 DEBUG : some file-nekaqux9.txt: sortPermissions: will add permission: &{ 0xc000706300 [0xc000706480] [] [read] } [read] 2026/01/29 02:00:55 DEBUG : some file-nekaqux9.txt: skipping remove permission -- can't remove 'owner' role 2026/01/29 02:00:55 DEBUG : some file-nekaqux9.txt: metadata permissions: to add: 1 to update: 0 to remove: 0 2026/01/29 02:00:56 ERROR : some file-nekaqux9.txt: Failed to add permission: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:00:56 ERROR : some file-nekaqux9.txt: error writing permissions: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:00:56 DEBUG : info from Update error: null fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:382 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:55 Error: Received unexpected error: failed to fetch and update metadata: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestUploadSinglePart Messages: Put 2026/01/29 02:00:56 DEBUG : OneDrive root 'rclone-test-ziguwuz4sogu': Purge remote 2026/01/29 02:00:56 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-rupoqoy5boju" 2026/01/29 02:00:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:00:56 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:00:58 DEBUG : Creating backend with remote "/tmp/rclone2663370677" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:185: Remote "OneDrive root 'rclone-test-rupoqoy5boju'", Local "Local file system at /tmp/rclone2663370677", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadPermissions 2026/01/29 02:01:00 DEBUG : some file-sibizux2.txt: Starting singlepart upload 2026/01/29 02:01:02 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/ASojnfE4eVFNhTmMNVtRtzs" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:03 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/ASojnfE4eVFNhTmMNVtRtzs" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:03 DEBUG : some file-sibizux2.txt: Starting singlepart upload 2026/01/29 02:01:05 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/ASojnfE4eVFNhTmMNVtRtzs" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:07 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/ASojnfE4eVFNhTmMNVtRtzs" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] onedrive_internal_test.go:141: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:141 Error: Should be false Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadPermissions Messages: permissions metadata key was unexpectedly found: [{"id":"aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ","grantedTo":{"user":{"displayName":"Nick Craig-Wood","id":"4","email":"nick@craig-wood.com"},"application":{},"device":{},"group":{},"siteGroup":{},"siteUser":{}},"grantedToV2":{"user":{},"application":{},"device":{},"group":{},"siteGroup":{},"siteUser":{"displayName":"Nick Craig-Wood","id":"4","email":"nick@craig-wood.com","loginName":"i:0#.f|membership|nick@craig-wood.com"}},"link":{"webUrl":"https://1drv.ms/t/c/71A96798E7B1D253/ASojnfE4eVFNhTmMNVtRtzs"},"roles":["owner"],"shareId":"aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ"}] 2026/01/29 02:01:07 DEBUG : OneDrive root 'rclone-test-rupoqoy5boju': Purge remote 2026/01/29 02:01:08 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-demofak2pexa" 2026/01/29 02:01:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:01:08 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:01:09 DEBUG : Creating backend with remote "/tmp/rclone2814452160" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:185: Remote "OneDrive root 'rclone-test-demofak2pexa'", Local "Local file system at /tmp/rclone2814452160", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata 2026/01/29 02:01:09 DEBUG : some file-cevawif3.txt: Starting singlepart upload 2026/01/29 02:01:10 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/AfOfJRn-Y4dMoaOn8UkkZlg" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:11 DEBUG : some file-cevawif3.txt: sortPermissions: will add permission: &{ 0xc000297380 [0xc000297500] [] [write] } [write] 2026/01/29 02:01:11 DEBUG : some file-cevawif3.txt: skipping remove permission -- can't remove 'owner' role 2026/01/29 02:01:11 DEBUG : some file-cevawif3.txt: metadata permissions: to add: 1 to update: 0 to remove: 0 2026/01/29 02:01:11 ERROR : some file-cevawif3.txt: Failed to add permission: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:11 ERROR : some file-cevawif3.txt: error writing permissions: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:11 DEBUG : info from Update error: null fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:382 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:156 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: failed to fetch and update metadata: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata Messages: Put 2026/01/29 02:01:11 DEBUG : OneDrive root 'rclone-test-demofak2pexa': Purge remote 2026/01/29 02:01:11 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fonotoh9buju" 2026/01/29 02:01:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:01:11 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:01:12 DEBUG : Creating backend with remote "/tmp/rclone1844778698" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:185: Remote "OneDrive root 'rclone-test-fonotoh9buju'", Local "Local file system at /tmp/rclone1844778698", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata 2026/01/29 02:01:12 DEBUG : subdir: Making directory with metadata 2026/01/29 02:01:13 DEBUG : subdir: skipping unsupported metadata item: content-type: inode/directory onedrive_internal_test.go:208: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:208 Error: Received unexpected error: resourceModified: The resource has changed since the caller last read it; usually an eTag mismatch Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata onedrive_internal_test.go:209: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:209 Error: Expected value not to be nil. Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata 2026/01/29 02:01:13 DEBUG : OneDrive root 'rclone-test-fonotoh9buju': Purge remote 2026/01/29 02:01:13 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-roqufur2maco" 2026/01/29 02:01:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/29 02:01:13 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup 2026/01/29 02:01:14 DEBUG : Creating backend with remote "/tmp/rclone2652507077" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:185: Remote "OneDrive root 'rclone-test-roqufur2maco'", Local "Local file system at /tmp/rclone2652507077", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove 2026/01/29 02:01:15 DEBUG : some file-yawesew4.txt: Starting singlepart upload 2026/01/29 02:01:16 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/AaMpGzP_QytIrGzsxPlLTdk" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:16 DEBUG : some file-yawesew4.txt: sortPermissions: will add permission: &{ 0xc000158d80 [0xc000158f00] [] [read] } [read] 2026/01/29 02:01:16 DEBUG : some file-yawesew4.txt: skipping remove permission -- can't remove 'owner' role 2026/01/29 02:01:16 DEBUG : some file-yawesew4.txt: metadata permissions: to add: 1 to update: 0 to remove: 0 2026/01/29 02:01:17 ERROR : some file-yawesew4.txt: Failed to add permission: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:17 ERROR : some file-yawesew4.txt: error writing permissions: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:17 DEBUG : info from Update error: null fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:382 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:293 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: failed to fetch and update metadata: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove Messages: Put 2026/01/29 02:01:17 DEBUG : OneDrive root 'rclone-test-roqufur2maco': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper 2026/01/29 02:01:17 DEBUG : some file-zojisay0.txt: Starting singlepart upload 2026/01/29 02:01:18 DEBUG : Metadata mapper sent: { "SrcFs": "/tmp/rclone2652507077", "SrcFsType": "local", "DstFs": "TestOneDrive:rclone-test-roqufur2maco", "DstFsType": "onedrive", "Remote": "some file-zojisay0.txt", "Size": 0, "MimeType": "text/plain; charset=utf-8", "ModTime": "2020-02-29T12:34:56.789Z", "IsDir": false, "Metadata": { "atime": "2020-02-29T12:34:56.789Z", "btime": "2026-01-29T02:01:17.423855619Z", "gid": "1000", "mode": "100600", "mtime": "2020-02-29T12:34:56.789Z", "uid": "1000" } } 2026/01/29 02:01:18 DEBUG : some file-zojisay0.txt: Calling metadata mapper echo "{""Metadata"":{""permissions"":""[{\""grantedToIdentities\"":[{\""user\"":{\""id\"":\""ryan@contoso.com\""}}],\""roles\"":[\""read\""]}]""}}" 2026/01/29 02:01:18 DEBUG : Metadata mapper received: {"Metadata":{"permissions":"[{\"grantedToIdentities\":[{\"user\":{\"id\":\"ryan@contoso.com\"}}],\"roles\":[\"read\"]}]"}} 2026/01/29 02:01:18 DEBUG : some file-zojisay0.txt: Metadata mapper returned in 2.739154ms 2026/01/29 02:01:18 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/AT0wLo_hVgVKrFIh8utuTyk" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] 2026/01/29 02:01:19 DEBUG : some file-zojisay0.txt: sortPermissions: will add permission: &{ [0xc000296d80] [] [read] } [read] 2026/01/29 02:01:19 DEBUG : some file-zojisay0.txt: skipping remove permission -- can't remove 'owner' role 2026/01/29 02:01:19 DEBUG : some file-zojisay0.txt: metadata permissions: to add: 1 to update: 0 to remove: 0 2026/01/29 02:01:19 ERROR : some file-zojisay0.txt: Failed to add permission: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:19 ERROR : some file-zojisay0.txt: error writing permissions: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false 2026/01/29 02:01:19 DEBUG : info from Update error: null 2026/01/29 02:01:19 ERROR : some file-daruwej8.txt: Failed to copy: failed to fetch and update metadata: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false onedrive_internal_test.go:345: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:345 Error: Received unexpected error: failed to fetch and update metadata: failed to process permissions: failed to set permissions: invalidRequest: RequireSignIn and SendInvitation cannot both be false Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper 2026/01/29 02:01:19 DEBUG : perms: [ { "id": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ", "grantedTo": { "user": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "grantedToV2": { "user": {}, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": { "displayName": "Nick Craig-Wood", "id": "4", "email": "nick@craig-wood.com", "loginName": "i:0#.f|membership|nick@craig-wood.com" } }, "link": { "webUrl": "https://1drv.ms/t/c/71A96798E7B1D253/AT0wLo_hVgVKrFIh8utuTyk" }, "roles": [ "owner" ], "shareId": "aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ" } ] onedrive_internal_test.go:368: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:368 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper Messages: no permission found with expected role (want: {"Metadata":{"permissions":"[{\"grantedToIdentities\":[{\"user\":{\"id\":\"ryan@contoso.com\"}}],\"roles\":[\"read\"]}]"}} got: map[btime:2026-01-29T02:01:18Z content-type:text/plain created-by-display-name:Nick Craig-Wood created-by-id:71A96798E7B1D253 id:71A96798E7B1D253#71A96798E7B1D253!s8f2e303d56e14a05ac5221f2eb6e4f29 last-modified-by-display-name:Nick Craig-Wood last-modified-by-id:71A96798E7B1D253 malware-detected:false mtime:2026-01-29T02:01:18Z permissions:[{"id":"aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ","grantedTo":{"user":{"displayName":"Nick Craig-Wood","id":"4","email":"nick@craig-wood.com"},"application":{},"device":{},"group":{},"siteGroup":{},"siteUser":{}},"grantedToV2":{"user":{},"application":{},"device":{},"group":{},"siteGroup":{},"siteUser":{"displayName":"Nick Craig-Wood","id":"4","email":"nick@craig-wood.com","loginName":"i:0#.f|membership|nick@craig-wood.com"}},"link":{"webUrl":"https://1drv.ms/t/c/71A96798E7B1D253/AT0wLo_hVgVKrFIh8utuTyk"},"roles":["owner"],"shareId":"aTowIy5mfG1lbWJlcnNoaXB8bmlja0BjcmFpZy13b29kLmNvbQ"}] utime:2026-01-29T02:01:18Z] ) onedrive_internal_test.go:369: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:369 Error: Not equal: expected: 1 actual : 0 Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper Messages: expected to find exactly 1 match 2026/01/29 02:01:19 DEBUG : OneDrive root 'rclone-test-roqufur2maco': Purge remote 2026/01/29 02:01:20 DEBUG : OneDrive root 'rclone-test-roqufur2maco': Purge remote 2026/01/29 02:01:20 NOTICE: purge failed: directory not found 2026/01/29 02:01:20 DEBUG : OneDrive root 'rclone-test-fonotoh9buju': Purge remote 2026/01/29 02:01:20 NOTICE: purge failed: directory not found 2026/01/29 02:01:20 DEBUG : OneDrive root 'rclone-test-demofak2pexa': Purge remote 2026/01/29 02:01:20 NOTICE: purge failed: directory not found 2026/01/29 02:01:20 DEBUG : OneDrive root 'rclone-test-rupoqoy5boju': Purge remote 2026/01/29 02:01:21 NOTICE: purge failed: directory not found 2026/01/29 02:01:21 DEBUG : OneDrive root 'rclone-test-ziguwuz4sogu': Purge remote 2026/01/29 02:01:21 NOTICE: purge failed: directory not found 2026/01/29 02:01:21 DEBUG : OneDrive root 'rclone-test-sucezat3noga': Purge remote 2026/01/29 02:01:21 NOTICE: purge failed: directory not found === RUN TestIntegration/FsMkdir/FsMkdirMetadata 2026/01/29 02:01:22 DEBUG : dir-metadata: skipping unsupported metadata item: potato: jersey fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:613 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2682 Error: Should be true Test: TestIntegration/FsMkdir/FsMkdirMetadata Messages: dir-metadata: Modification time difference too big |-219021h56m16.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2026-01-29 02:01:23 +0000 UTC) (precision 1s) fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:613 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2683 Error: Should be true Test: TestIntegration/FsMkdir/FsMkdirMetadata Messages: dir-metadata: Modification time difference too big |-219021h56m16.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2026-01-29 02:01:23 +0000 UTC) (precision 1s) === RUN TestIntegration/FsMkdir/FsMkdirMetadata/Update 2026/01/29 02:01:23 DEBUG : dir-metadata: skipping unsupported metadata item: potato: king edwards === RUN TestIntegration/FsMkdir/FsMkdirMetadata/CheckDirectory 2026/01/29 02:01:25 ERROR : error listing: directory not found --- FAIL: TestIntegration (75.90s) --- FAIL: TestIntegration/FsMkdir (73.35s) --- FAIL: TestIntegration/FsMkdir/FsPutError (28.90s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (39.58s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal (34.70s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestWritePermissions (2.12s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestUploadSinglePart (3.27s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadPermissions (8.61s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata (2.25s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata (1.27s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove (2.27s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper (2.28s) --- FAIL: TestIntegration/FsMkdir/FsMkdirMetadata (3.29s) --- PASS: TestIntegration/FsMkdir/FsMkdirMetadata/Update (0.88s) --- PASS: TestIntegration/FsMkdir/FsMkdirMetadata/CheckDirectory (0.00s) FAIL 2026/01/29 02:01:26 DEBUG : OneDrive root 'rclone-test-vecekob5hose': Purge remote 2026/01/29 02:01:26 NOTICE: purge failed: directory not found exit status 1 FAIL github.com/rclone/rclone/backend/onedrive 77.296s "go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^(FsMkdirMetadata|FsPutError)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestDirectoryMetadata|TestMetadataMapper|TestReadMetadata|TestReadPermissions|TestServerSideCopyMove|TestUploadSinglePart|TestWritePermissions)$'" - Finished ERROR in 1m18.044257731s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutError TestIntegration/FsMkdir/FsPutFiles/Internal/TestWritePermissions TestIntegration/FsMkdir/FsPutFiles/Internal/TestUploadSinglePart TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadPermissions TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper TestIntegration/FsMkdir/FsMkdirMetadata]