"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestMetadataMapper$'" - Starting (try 2/5)
2025/12/17 04:20:44 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-xuyezaq3xiwa"
2025/12/17 04:20:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:44 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:45 DEBUG : Creating backend with remote "/tmp/rclone3087130977"
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestOneDrive:"
2025/12/17 04:20:45 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-diriwun6gaje"
2025/12/17 04:20:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:45 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/12/17 04:20:46 DEBUG : file name.txt: Starting multipart upload
2025/12/17 04:20:46 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/12/17 04:20:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/12/17 04:20:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/12/17 04:20:50 DEBUG : file name.txt: Starting multipart upload
2025/12/17 04:20:50 DEBUG : file name.txt: skipping unsupported metadata item: rclonetest: potato
2025/12/17 04:20:50 INFO  : file name.txt: no writeable metadata found: map[rclonetest:potato]
2025/12/17 04:20:50 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/12/17 04:20:50 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-peruvay8duxo"
2025/12/17 04:20:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:50 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:51 DEBUG : Creating backend with remote "/tmp/rclone274350093"
    run.go:185: Remote "OneDrive root 'rclone-test-peruvay8duxo'", Local "Local file system at /tmp/rclone274350093", Modify Window "1s"
2025/12/17 04:20:51 DEBUG : OneDrive root 'rclone-test-peruvay8duxo': Purge remote
2025/12/17 04:20:52 NOTICE: purge failed: directory not found
2025/12/17 04:20:52 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-nizujub7gike"
2025/12/17 04:20:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:52 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:52 DEBUG : Creating backend with remote "/tmp/rclone526788053"
    run.go:185: Remote "OneDrive root 'rclone-test-nizujub7gike'", Local "Local file system at /tmp/rclone526788053", Modify Window "1s"
2025/12/17 04:20:52 DEBUG : OneDrive root 'rclone-test-nizujub7gike': Purge remote
2025/12/17 04:20:52 NOTICE: purge failed: directory not found
2025/12/17 04:20:52 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-tewexef8cugu"
2025/12/17 04:20:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:52 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:53 DEBUG : Creating backend with remote "/tmp/rclone3172631721"
    run.go:185: Remote "OneDrive root 'rclone-test-tewexef8cugu'", Local "Local file system at /tmp/rclone3172631721", Modify Window "1s"
2025/12/17 04:20:53 DEBUG : OneDrive root 'rclone-test-tewexef8cugu': Purge remote
2025/12/17 04:20:53 NOTICE: purge failed: directory not found
2025/12/17 04:20:53 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-powazuw9suto"
2025/12/17 04:20:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:53 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:54 DEBUG : Creating backend with remote "/tmp/rclone1361818969"
    run.go:185: Remote "OneDrive root 'rclone-test-powazuw9suto'", Local "Local file system at /tmp/rclone1361818969", Modify Window "1s"
2025/12/17 04:20:54 DEBUG : OneDrive root 'rclone-test-powazuw9suto': Purge remote
2025/12/17 04:20:54 NOTICE: purge failed: directory not found
2025/12/17 04:20:54 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-kemigop0qani"
2025/12/17 04:20:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:54 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:55 DEBUG : Creating backend with remote "/tmp/rclone2204953053"
    run.go:185: Remote "OneDrive root 'rclone-test-kemigop0qani'", Local "Local file system at /tmp/rclone2204953053", Modify Window "1s"
2025/12/17 04:20:55 DEBUG : OneDrive root 'rclone-test-kemigop0qani': Purge remote
2025/12/17 04:20:56 NOTICE: purge failed: directory not found
2025/12/17 04:20:56 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-badayah5mayi"
2025/12/17 04:20:56 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/12/17 04:20:56 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/12/17 04:20:56 DEBUG : Creating backend with remote "/tmp/rclone1006490488"
    run.go:185: Remote "OneDrive root 'rclone-test-badayah5mayi'", Local "Local file system at /tmp/rclone1006490488", Modify Window "1s"
2025/12/17 04:20:56 DEBUG : OneDrive root 'rclone-test-badayah5mayi': Purge remote
2025/12/17 04:20:57 NOTICE: purge failed: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper
2025/12/17 04:20:57 DEBUG : some file-dalehep5.txt: Starting multipart upload
2025/12/17 04:20:57 DEBUG : Metadata mapper sent: 
{
	"SrcFs": "/tmp/rclone1006490488",
	"SrcFsType": "local",
	"DstFs": "TestOneDrive:rclone-test-badayah5mayi",
	"DstFsType": "onedrive",
	"Remote": "some file-dalehep5.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-17T04:20:57.004247124Z",
		"gid": "1000",
		"mode": "100600",
		"mtime": "2020-02-29T12:34:56.789Z",
		"uid": "1000"
	}
}
2025/12/17 04:20:57 DEBUG : some file-dalehep5.txt: Calling metadata mapper echo "{""Metadata"":{""permissions"":""[{\""grantedToIdentities\"":[{\""user\"":{\""id\"":\""ryan@contoso.com\""}}],\""roles\"":[\""read\""]}]""}}"
2025/12/17 04:20:57 DEBUG : Metadata mapper received: 
{"Metadata":{"permissions":"[{\"grantedToIdentities\":[{\"user\":{\"id\":\"ryan@contoso.com\"}}],\"roles\":[\"read\"]}]"}}

2025/12/17 04:20:57 DEBUG : some file-dalehep5.txt: Metadata mapper returned in 1.372448ms
2025/12/17 04:20:57 DEBUG : some file-dalehep5.txt: Uploading segment 0/5 size 5
2025/12/17 04:20:58 DEBUG : some file-dalehep5.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/12/17 04:20:59 DEBUG : some file-dalehep5.txt: updated permissions (now has 1 permissions)
2025/12/17 04:20:59 DEBUG : some file-dalehep5.txt: size = 5 OK
2025/12/17 04:20:59 DEBUG : some file-gicibok4.txt: quickxor = 6828031bd8f00600000000000500000000000000 OK
2025/12/17 04:20:59 INFO  : some file-gicibok4.txt: Copied (new) to: some file-dalehep5.txt
2025/12/17 04:20:59 DEBUG : perms: 
[
	{
		"id": "mNJTTzkbiosFU39QQ3Uw09cpd20",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbiQUO5e2AMphrxnVJM"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbiQUO5e2AMphrxnVJM"
	}
]
2025/12/17 04:20:59 DEBUG : OneDrive root 'rclone-test-badayah5mayi': Purge remote
2025/12/17 04:20:59 DEBUG : OneDrive root 'rclone-test-badayah5mayi': Purge remote
2025/12/17 04:20:59 NOTICE: purge failed: directory not found
2025/12/17 04:20:59 DEBUG : OneDrive root 'rclone-test-kemigop0qani': Purge remote
2025/12/17 04:20:59 NOTICE: purge failed: directory not found
2025/12/17 04:20:59 DEBUG : OneDrive root 'rclone-test-powazuw9suto': Purge remote
2025/12/17 04:21:00 NOTICE: purge failed: directory not found
2025/12/17 04:21:00 DEBUG : OneDrive root 'rclone-test-tewexef8cugu': Purge remote
2025/12/17 04:21:00 NOTICE: purge failed: directory not found
2025/12/17 04:21:00 DEBUG : OneDrive root 'rclone-test-nizujub7gike': Purge remote
2025/12/17 04:21:00 NOTICE: purge failed: directory not found
2025/12/17 04:21:00 DEBUG : OneDrive root 'rclone-test-peruvay8duxo': Purge remote
2025/12/17 04:21:00 NOTICE: purge failed: directory not found
2025/12/17 04:21:01 ERROR : error listing: directory not found
--- PASS: TestIntegration (16.34s)
    --- PASS: TestIntegration/FsMkdir (15.07s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (14.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (10.10s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestMetadataMapper (2.24s)
PASS
2025/12/17 04:21:01 DEBUG : OneDrive root 'rclone-test-xuyezaq3xiwa': Purge remote
2025/12/17 04:21:01 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	17.433s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestMetadataMapper$'" - Finished OK in 18.214718674s (try 2/5)