"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestMetadataMapper|TestReadMetadata)$'" - Starting (try 2/5)
2025/01/25 03:22:36 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lufeqeq5puta"
2025/01/25 03:22:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:37 DEBUG : Creating backend with remote "/tmp/rclone450358181"
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestOneDrive:"
2025/01/25 03:22:37 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-xesobuc4yiwu"
2025/01/25 03:22:37 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/01/25 03:22:38 DEBUG : file name.txt: Starting multipart upload
2025/01/25 03:22:38 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/01/25 03:22:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/01/25 03:22:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/01/25 03:22:41 DEBUG : file name.txt: Starting multipart upload
2025/01/25 03:22:41 DEBUG : file name.txt: skipping unsupported metadata item: rclone-test: potato
2025/01/25 03:22:41 INFO  : file name.txt: no writeable metadata found: map[rclone-test:potato]
2025/01/25 03:22:41 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/01/25 03:22:41 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-copuhoj2saxu"
2025/01/25 03:22:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:42 DEBUG : Creating backend with remote "/tmp/rclone3529331815"
    run.go:180: Remote "OneDrive root 'rclone-test-copuhoj2saxu'", Local "Local file system at /tmp/rclone3529331815", Modify Window "1s"
2025/01/25 03:22:42 DEBUG : OneDrive root 'rclone-test-copuhoj2saxu': Purge remote
2025/01/25 03:22:42 NOTICE: purge failed: directory not found
2025/01/25 03:22:42 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-zeyuqop3kuhu"
2025/01/25 03:22:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:43 DEBUG : Creating backend with remote "/tmp/rclone3748744736"
    run.go:180: Remote "OneDrive root 'rclone-test-zeyuqop3kuhu'", Local "Local file system at /tmp/rclone3748744736", Modify Window "1s"
2025/01/25 03:22:43 DEBUG : OneDrive root 'rclone-test-zeyuqop3kuhu': Purge remote
2025/01/25 03:22:43 NOTICE: purge failed: directory not found
2025/01/25 03:22:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qoludub0tovi"
2025/01/25 03:22:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:43 DEBUG : Creating backend with remote "/tmp/rclone1550797325"
    run.go:180: Remote "OneDrive root 'rclone-test-qoludub0tovi'", Local "Local file system at /tmp/rclone1550797325", Modify Window "1s"
2025/01/25 03:22:43 DEBUG : OneDrive root 'rclone-test-qoludub0tovi': Purge remote
2025/01/25 03:22:44 NOTICE: purge failed: directory not found
2025/01/25 03:22:44 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qefoduc6cane"
2025/01/25 03:22:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:44 DEBUG : Creating backend with remote "/tmp/rclone1719178391"
    run.go:180: Remote "OneDrive root 'rclone-test-qefoduc6cane'", Local "Local file system at /tmp/rclone1719178391", Modify Window "1s"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata
2025/01/25 03:22:45 DEBUG : some file-cowogoz2.txt: Starting multipart upload
2025/01/25 03:22:45 DEBUG : some file-cowogoz2.txt: Uploading segment 0/5 size 5
2025/01/25 03:22:46 DEBUG : some file-cowogoz2.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/01/25 03:22:47 DEBUG : some file-cowogoz2.txt: updated permissions (now has 1 permissions)
2025/01/25 03:22:47 DEBUG : perms: 
[
	{
		"id": "NzD37gEHfHrsvcwHYtMGU2ZnB4s",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx_OcBFG9V0OvmwO6Nbg"
		},
		"roles": [
			"write"
		],
		"shareId": "s!BFPSseeYZ6lx_OcBFG9V0OvmwO6Nbg"
	}
]
2025/01/25 03:22:47 DEBUG : OneDrive root 'rclone-test-qefoduc6cane': Purge remote
2025/01/25 03:22:47 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qexuwaj3ciho"
2025/01/25 03:22:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:47 DEBUG : Creating backend with remote "/tmp/rclone266543255"
=== NAME  TestIntegration/FsMkdir/FsPutFiles/Internal
    run.go:180: Remote "OneDrive root 'rclone-test-qexuwaj3ciho'", Local "Local file system at /tmp/rclone266543255", Modify Window "1s"
2025/01/25 03:22:47 DEBUG : OneDrive root 'rclone-test-qexuwaj3ciho': Purge remote
2025/01/25 03:22:47 NOTICE: purge failed: directory not found
2025/01/25 03:22:47 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-sofuwet0fego"
2025/01/25 03:22:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/25 03:22:48 DEBUG : Creating backend with remote "/tmp/rclone126975408"
    run.go:180: Remote "OneDrive root 'rclone-test-sofuwet0fego'", Local "Local file system at /tmp/rclone126975408", Modify Window "1s"
2025/01/25 03:22:48 DEBUG : OneDrive root 'rclone-test-sofuwet0fego': Purge remote
2025/01/25 03:22:48 NOTICE: purge failed: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper
2025/01/25 03:22:49 DEBUG : some file-yacidoq7.txt: Starting multipart upload
2025/01/25 03:22:49 DEBUG : Metadata mapper sent: 
{
	"SrcFs": "/tmp/rclone126975408",
	"SrcFsType": "local",
	"DstFs": "TestOneDrive:rclone-test-sofuwet0fego",
	"DstFsType": "onedrive",
	"Remote": "some file-yacidoq7.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-01-25T03:22:48.679284259Z",
		"gid": "1000",
		"mode": "100600",
		"mtime": "2020-02-29T12:34:56.789Z",
		"uid": "1000"
	}
}
2025/01/25 03:22:49 DEBUG : some file-yacidoq7.txt: Calling metadata mapper echo "{""Metadata"":{""permissions"":""[{\""grantedToIdentities\"":[{\""user\"":{\""id\"":\""ryan@contoso.com\""}}],\""roles\"":[\""read\""]}]""}}"
2025/01/25 03:22:49 DEBUG : Metadata mapper received: 
{"Metadata":{"permissions":"[{\"grantedToIdentities\":[{\"user\":{\"id\":\"ryan@contoso.com\"}}],\"roles\":[\"read\"]}]"}}

2025/01/25 03:22:49 DEBUG : some file-yacidoq7.txt: Metadata mapper returned in 1.121936ms
2025/01/25 03:22:49 DEBUG : some file-yacidoq7.txt: Uploading segment 0/5 size 5
2025/01/25 03:22:50 DEBUG : some file-yacidoq7.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/01/25 03:22:51 DEBUG : some file-yacidoq7.txt: updated permissions (now has 1 permissions)
2025/01/25 03:22:51 DEBUG : some file-joxigek9.txt: quickxor = 6828031bd8f00600000000000500000000000000 OK
2025/01/25 03:22:51 INFO  : some file-joxigek9.txt: Copied (new) to: some file-yacidoq7.txt
2025/01/25 03:22:51 DEBUG : perms: 
[
	{
		"id": "wOB4hmS3BFksi54lDXCeXudydyo",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx_OcDsgHTsx4oBhff3g"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx_OcDsgHTsx4oBhff3g"
	}
]
2025/01/25 03:22:51 DEBUG : OneDrive root 'rclone-test-sofuwet0fego': Purge remote
2025/01/25 03:22:51 DEBUG : OneDrive root 'rclone-test-sofuwet0fego': Purge remote
2025/01/25 03:22:51 NOTICE: purge failed: directory not found
2025/01/25 03:22:51 DEBUG : OneDrive root 'rclone-test-qexuwaj3ciho': Purge remote
2025/01/25 03:22:51 NOTICE: purge failed: directory not found
2025/01/25 03:22:51 DEBUG : OneDrive root 'rclone-test-qefoduc6cane': Purge remote
2025/01/25 03:22:52 NOTICE: purge failed: directory not found
2025/01/25 03:22:52 DEBUG : OneDrive root 'rclone-test-qoludub0tovi': Purge remote
2025/01/25 03:22:52 NOTICE: purge failed: directory not found
2025/01/25 03:22:52 DEBUG : OneDrive root 'rclone-test-zeyuqop3kuhu': Purge remote
2025/01/25 03:22:52 NOTICE: purge failed: directory not found
2025/01/25 03:22:52 DEBUG : OneDrive root 'rclone-test-copuhoj2saxu': Purge remote
2025/01/25 03:22:52 NOTICE: purge failed: directory not found
2025/01/25 03:22:53 ERROR : : error listing: directory not found
--- PASS: TestIntegration (16.14s)
    --- PASS: TestIntegration/FsMkdir (14.97s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (14.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (11.02s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata (2.45s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper (2.75s)
PASS
2025/01/25 03:22:53 DEBUG : OneDrive root 'rclone-test-lufeqeq5puta': Purge remote
2025/01/25 03:22:53 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	16.799s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestMetadataMapper|TestReadMetadata)$'" - Finished OK in 17.33770891s (try 2/5)