"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestMetadataMapper$'" - Starting (try 2/5)
2025/12/10 01:15:31 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qoweqej2teku"
2025/12/10 01:15:31 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:31 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:32 DEBUG : Creating backend with remote "/tmp/rclone1196118275"
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestOneDrive:"
2025/12/10 01:15:32 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qewuhun3cahu"
2025/12/10 01:15:32 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:32 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/12/10 01:15:34 DEBUG : file name.txt: Starting multipart upload
2025/12/10 01:15:34 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/12/10 01:15:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/12/10 01:15:38 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/12/10 01:15:38 DEBUG : file name.txt: Starting multipart upload
2025/12/10 01:15:38 DEBUG : file name.txt: skipping unsupported metadata item: rclonetest: potato
2025/12/10 01:15:38 INFO  : file name.txt: no writeable metadata found: map[rclonetest:potato]
2025/12/10 01:15:38 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/12/10 01:15:39 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-hapicam0vixa"
2025/12/10 01:15:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:39 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:40 DEBUG : Creating backend with remote "/tmp/rclone1690383580"
    run.go:185: Remote "OneDrive root 'rclone-test-hapicam0vixa'", Local "Local file system at /tmp/rclone1690383580", Modify Window "1s"
2025/12/10 01:15:40 DEBUG : OneDrive root 'rclone-test-hapicam0vixa': Purge remote
2025/12/10 01:15:40 NOTICE: purge failed: directory not found
2025/12/10 01:15:40 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-cidedim7tono"
2025/12/10 01:15:40 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:40 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:41 DEBUG : Creating backend with remote "/tmp/rclone2341893822"
    run.go:185: Remote "OneDrive root 'rclone-test-cidedim7tono'", Local "Local file system at /tmp/rclone2341893822", Modify Window "1s"
2025/12/10 01:15:41 DEBUG : OneDrive root 'rclone-test-cidedim7tono': Purge remote
2025/12/10 01:15:41 NOTICE: purge failed: directory not found
2025/12/10 01:15:41 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-dotazob2sotu"
2025/12/10 01:15:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:41 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:42 DEBUG : Creating backend with remote "/tmp/rclone3097496638"
    run.go:185: Remote "OneDrive root 'rclone-test-dotazob2sotu'", Local "Local file system at /tmp/rclone3097496638", Modify Window "1s"
2025/12/10 01:15:42 DEBUG : OneDrive root 'rclone-test-dotazob2sotu': Purge remote
2025/12/10 01:15:42 NOTICE: purge failed: directory not found
2025/12/10 01:15:42 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fizeciv3yute"
2025/12/10 01:15:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:42 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:43 DEBUG : Creating backend with remote "/tmp/rclone3046700775"
    run.go:185: Remote "OneDrive root 'rclone-test-fizeciv3yute'", Local "Local file system at /tmp/rclone3046700775", Modify Window "1s"
2025/12/10 01:15:43 DEBUG : OneDrive root 'rclone-test-fizeciv3yute': Purge remote
2025/12/10 01:15:43 NOTICE: purge failed: directory not found
2025/12/10 01:15:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fudisac3cujo"
2025/12/10 01:15:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:43 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:44 DEBUG : Creating backend with remote "/tmp/rclone407293228"
    run.go:185: Remote "OneDrive root 'rclone-test-fudisac3cujo'", Local "Local file system at /tmp/rclone407293228", Modify Window "1s"
2025/12/10 01:15:44 DEBUG : OneDrive root 'rclone-test-fudisac3cujo': Purge remote
2025/12/10 01:15:44 NOTICE: purge failed: directory not found
2025/12/10 01:15:44 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vomiyav4yiye"
2025/12/10 01:15:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/10 01:15:44 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/10 01:15:45 DEBUG : Creating backend with remote "/tmp/rclone3657506962"
    run.go:185: Remote "OneDrive root 'rclone-test-vomiyav4yiye'", Local "Local file system at /tmp/rclone3657506962", Modify Window "1s"
2025/12/10 01:15:45 DEBUG : OneDrive root 'rclone-test-vomiyav4yiye': Purge remote
2025/12/10 01:15:45 NOTICE: purge failed: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper
2025/12/10 01:15:46 DEBUG : some file-tabafot6.txt: Starting multipart upload
2025/12/10 01:15:46 DEBUG : Metadata mapper sent: 
{
	"SrcFs": "/tmp/rclone3657506962",
	"SrcFsType": "local",
	"DstFs": "TestOneDrive:rclone-test-vomiyav4yiye",
	"DstFsType": "onedrive",
	"Remote": "some file-tabafot6.txt",
	"Size": 5,
	"MimeType": "text/plain; charset=utf-8",
	"ModTime": "2020-02-29T12:34:56.789Z",
	"IsDir": false,
	"Metadata": {
		"atime": "2020-02-29T12:34:56.789Z",
		"btime": "2025-12-10T01:15:45.665814318Z",
		"gid": "1000",
		"mode": "100600",
		"mtime": "2020-02-29T12:34:56.789Z",
		"uid": "1000"
	}
}
2025/12/10 01:15:46 DEBUG : some file-tabafot6.txt: Calling metadata mapper echo "{""Metadata"":{""permissions"":""[{\""grantedToIdentities\"":[{\""user\"":{\""id\"":\""ryan@contoso.com\""}}],\""roles\"":[\""read\""]}]""}}"
2025/12/10 01:15:46 DEBUG : Metadata mapper received: 
{"Metadata":{"permissions":"[{\"grantedToIdentities\":[{\"user\":{\"id\":\"ryan@contoso.com\"}}],\"roles\":[\"read\"]}]"}}

2025/12/10 01:15:46 DEBUG : some file-tabafot6.txt: Metadata mapper returned in 2.23875ms
2025/12/10 01:15:46 DEBUG : some file-tabafot6.txt: Uploading segment 0/5 size 5
2025/12/10 01:15:47 DEBUG : some file-tabafot6.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/12/10 01:15:48 DEBUG : some file-tabafot6.txt: updated permissions (now has 1 permissions)
2025/12/10 01:15:48 DEBUG : some file-tabafot6.txt: size = 5 OK
2025/12/10 01:15:48 DEBUG : some file-fenotac5.txt: quickxor = 6828031bd8f00600000000000500000000000000 OK
2025/12/10 01:15:48 INFO  : some file-fenotac5.txt: Copied (new) to: some file-tabafot6.txt
2025/12/10 01:15:48 DEBUG : perms: 
[
	{
		"id": "gXufo-hwWNf4zlu5j0_In_uR3Uk",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbbaJ3PAGlNH7lcq3uk"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbbaJ3PAGlNH7lcq3uk"
	}
]
2025/12/10 01:15:48 DEBUG : OneDrive root 'rclone-test-vomiyav4yiye': Purge remote
2025/12/10 01:15:48 DEBUG : OneDrive root 'rclone-test-vomiyav4yiye': Purge remote
2025/12/10 01:15:48 NOTICE: purge failed: directory not found
2025/12/10 01:15:48 DEBUG : OneDrive root 'rclone-test-fudisac3cujo': Purge remote
2025/12/10 01:15:49 NOTICE: purge failed: directory not found
2025/12/10 01:15:49 DEBUG : OneDrive root 'rclone-test-fizeciv3yute': Purge remote
2025/12/10 01:15:49 NOTICE: purge failed: directory not found
2025/12/10 01:15:49 DEBUG : OneDrive root 'rclone-test-dotazob2sotu': Purge remote
2025/12/10 01:15:49 NOTICE: purge failed: directory not found
2025/12/10 01:15:49 DEBUG : OneDrive root 'rclone-test-cidedim7tono': Purge remote
2025/12/10 01:15:49 NOTICE: purge failed: directory not found
2025/12/10 01:15:49 DEBUG : OneDrive root 'rclone-test-hapicam0vixa': Purge remote
2025/12/10 01:15:50 NOTICE: purge failed: directory not found
2025/12/10 01:15:50 ERROR : error listing: directory not found
--- PASS: TestIntegration (18.65s)
    --- PASS: TestIntegration/FsMkdir (16.80s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (15.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (10.47s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper (2.77s)
PASS
2025/12/10 01:15:50 DEBUG : OneDrive root 'rclone-test-qoweqej2teku': Purge remote
2025/12/10 01:15:51 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	19.871s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestMetadataMapper$'" - Finished OK in 20.866605154s (try 2/5)