"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestReadMetadata|TestServerSideCopyMove)$'" - Starting (try 2/5)
2025/11/18 03:37:42 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-hucefas8muzo"
2025/11/18 03:37:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:42 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:43 DEBUG : Creating backend with remote "/tmp/rclone2581069129"
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestOneDrive:"
2025/11/18 03:37:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-joxazeb8gopu"
2025/11/18 03:37:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:43 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/11/18 03:37:44 DEBUG : file name.txt: Starting multipart upload
2025/11/18 03:37:44 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/11/18 03:37:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/11/18 03:37:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/11/18 03:37:48 DEBUG : file name.txt: Starting multipart upload
2025/11/18 03:37:48 DEBUG : file name.txt: skipping unsupported metadata item: rclone-test: potato
2025/11/18 03:37:48 INFO  : file name.txt: no writeable metadata found: map[rclone-test:potato]
2025/11/18 03:37:49 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/11/18 03:37:49 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qifoxus0yowu"
2025/11/18 03:37:49 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:49 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:50 DEBUG : Creating backend with remote "/tmp/rclone2936514753"
    run.go:185: Remote "OneDrive root 'rclone-test-qifoxus0yowu'", Local "Local file system at /tmp/rclone2936514753", Modify Window "1s"
2025/11/18 03:37:50 DEBUG : OneDrive root 'rclone-test-qifoxus0yowu': Purge remote
2025/11/18 03:37:50 NOTICE: purge failed: directory not found
2025/11/18 03:37:50 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-gimohab8kanu"
2025/11/18 03:37:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:50 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:51 DEBUG : Creating backend with remote "/tmp/rclone990310578"
    run.go:185: Remote "OneDrive root 'rclone-test-gimohab8kanu'", Local "Local file system at /tmp/rclone990310578", Modify Window "1s"
2025/11/18 03:37:51 DEBUG : OneDrive root 'rclone-test-gimohab8kanu': Purge remote
2025/11/18 03:37:51 NOTICE: purge failed: directory not found
2025/11/18 03:37:51 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fatecon9feye"
2025/11/18 03:37:51 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:51 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:52 DEBUG : Creating backend with remote "/tmp/rclone857278715"
    run.go:185: Remote "OneDrive root 'rclone-test-fatecon9feye'", Local "Local file system at /tmp/rclone857278715", Modify Window "1s"
2025/11/18 03:37:52 DEBUG : OneDrive root 'rclone-test-fatecon9feye': Purge remote
2025/11/18 03:37:53 NOTICE: purge failed: directory not found
2025/11/18 03:37:53 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-peheyos4fika"
2025/11/18 03:37:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:53 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:54 DEBUG : Creating backend with remote "/tmp/rclone938594135"
    run.go:185: Remote "OneDrive root 'rclone-test-peheyos4fika'", Local "Local file system at /tmp/rclone938594135", Modify Window "1s"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata
2025/11/18 03:37:55 DEBUG : some file-lebonuh2.txt: Starting multipart upload
2025/11/18 03:37:56 DEBUG : some file-lebonuh2.txt: Uploading segment 0/5 size 5
2025/11/18 03:37:57 DEBUG : some file-lebonuh2.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/11/18 03:37:57 DEBUG : some file-lebonuh2.txt: updated permissions (now has 1 permissions)
2025/11/18 03:37:58 DEBUG : perms: 
[
	{
		"id": "4PvGeGZG5LTLjYoDoirBRzCq1rY",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHD29l9aPqdwnxmgc"
		},
		"roles": [
			"write"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHD29l9aPqdwnxmgc"
	}
]
2025/11/18 03:37:58 DEBUG : OneDrive root 'rclone-test-peheyos4fika': Purge remote
2025/11/18 03:37:58 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-rovuriy8cifu"
2025/11/18 03:37:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:37:58 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:37:59 DEBUG : Creating backend with remote "/tmp/rclone4134168667"
=== NAME  TestIntegration/FsMkdir/FsPutFiles/Internal
    run.go:185: Remote "OneDrive root 'rclone-test-rovuriy8cifu'", Local "Local file system at /tmp/rclone4134168667", Modify Window "1s"
2025/11/18 03:37:59 DEBUG : OneDrive root 'rclone-test-rovuriy8cifu': Purge remote
2025/11/18 03:38:00 NOTICE: purge failed: directory not found
2025/11/18 03:38:00 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qomiyaf7jici"
2025/11/18 03:38:00 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/18 03:38:00 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2025/11/18 03:38:01 DEBUG : Creating backend with remote "/tmp/rclone2290420467"
    run.go:185: Remote "OneDrive root 'rclone-test-qomiyaf7jici'", Local "Local file system at /tmp/rclone2290420467", Modify Window "1s"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove
2025/11/18 03:38:01 DEBUG : some file-yeluwom2.txt: Starting multipart upload
2025/11/18 03:38:02 DEBUG : some file-yeluwom2.txt: Uploading segment 0/5 size 5
2025/11/18 03:38:04 DEBUG : some file-yeluwom2.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/11/18 03:38:04 DEBUG : some file-yeluwom2.txt: updated permissions (now has 1 permissions)
2025/11/18 03:38:05 DEBUG : perms: 
[
	{
		"id": "OoviEwD-DaAYTaXivMIgTCsbCSQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
	}
]
2025/11/18 03:38:07 DEBUG : perms: 
[
	{
		"id": "OoviEwD-DaAYTaXivMIgTCsbCSQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
	}
]
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: content-type: text/plain
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!2925457
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: shared-by-id: 
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: shared-scope: users
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: utime: 2025-11-18T03:38:02.54Z
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: shared-time: 2025-11-18T03:38:04.465Z
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: skipping unsupported metadata item: malware-detected: false
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/11/18 03:38:08 DEBUG : some file-zumurej9.txt: updated permissions (now has 1 permissions)
2025/11/18 03:38:09 DEBUG : perms: 
[
	{
		"id": "4lLPEg-19PRUiSb75e3vncpnOR8",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEralClMtLv9BZVg"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEralClMtLv9BZVg"
	}
]
2025/11/18 03:38:09 DEBUG : perms: 
[
	{
		"id": "OoviEwD-DaAYTaXivMIgTCsbCSQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
	}
]
2025/11/18 03:38:10 DEBUG : perms: 
[
	{
		"id": "OoviEwD-DaAYTaXivMIgTCsbCSQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
	}
]
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: shared-scope: users
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: shared-time: 2025-11-18T03:38:04.465Z
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!2925457
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: malware-detected: false
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: content-type: text/plain
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: utime: 2025-11-18T03:38:02.54Z
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping unsupported metadata item: shared-by-id: 
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: skipping update for invalid roles: [read] (perm ID: OoviEwD-DaAYTaXivMIgTCsbCSQ)
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: metadata permissions: to add: 0 to update: 0 to remove: 0
2025/11/18 03:38:10 DEBUG : some file-gekokic7.txt: updated permissions (now has 1 permissions)
2025/11/18 03:38:11 DEBUG : perms: 
[
	{
		"id": "OoviEwD-DaAYTaXivMIgTCsbCSQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgbLHEX7gRky8bL66aSY"
	}
]
2025/11/18 03:38:11 DEBUG : OneDrive root 'rclone-test-qomiyaf7jici': Purge remote
2025/11/18 03:38:11 DEBUG : OneDrive root 'rclone-test-qomiyaf7jici': Purge remote
2025/11/18 03:38:11 NOTICE: purge failed: directory not found
2025/11/18 03:38:11 DEBUG : OneDrive root 'rclone-test-qomiyaf7jici': Purge remote
2025/11/18 03:38:12 NOTICE: purge failed: directory not found
2025/11/18 03:38:12 DEBUG : OneDrive root 'rclone-test-rovuriy8cifu': Purge remote
2025/11/18 03:38:13 NOTICE: purge failed: directory not found
2025/11/18 03:38:13 DEBUG : OneDrive root 'rclone-test-peheyos4fika': Purge remote
2025/11/18 03:38:13 NOTICE: purge failed: directory not found
2025/11/18 03:38:13 DEBUG : OneDrive root 'rclone-test-fatecon9feye': Purge remote
2025/11/18 03:38:13 NOTICE: purge failed: directory not found
2025/11/18 03:38:13 DEBUG : OneDrive root 'rclone-test-gimohab8kanu': Purge remote
2025/11/18 03:38:13 NOTICE: purge failed: directory not found
2025/11/18 03:38:13 DEBUG : OneDrive root 'rclone-test-qifoxus0yowu': Purge remote
2025/11/18 03:38:14 NOTICE: purge failed: directory not found
2025/11/18 03:38:14 ERROR : error listing: directory not found
--- PASS: TestIntegration (31.33s)
    --- PASS: TestIntegration/FsMkdir (30.07s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (29.38s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (24.48s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestReadMetadata (3.65s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove (9.97s)
PASS
2025/11/18 03:38:14 DEBUG : OneDrive root 'rclone-test-hucefas8muzo': Purge remote
2025/11/18 03:38:15 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	32.595s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^(TestReadMetadata|TestServerSideCopyMove)$'" - Finished OK in 33.62248001s (try 2/5)