"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestServerSideCopyMove$'" - Starting (try 2/5)
2025/01/03 01:50:00 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fofezoc6nahe"
2025/01/03 01:50:00 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:01 DEBUG : Creating backend with remote "/tmp/rclone1201190975"
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestOneDrive:"
2025/01/03 01:50:01 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fariyus2joci"
2025/01/03 01:50:01 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/01/03 01:50:03 DEBUG : file name.txt: Starting multipart upload
2025/01/03 01:50:03 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/01/03 01:50:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/01/03 01:50:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/01/03 01:50:06 DEBUG : file name.txt: Starting multipart upload
2025/01/03 01:50:06 DEBUG : file name.txt: skipping unsupported metadata item: rclone-test: potato
2025/01/03 01:50:06 INFO  : file name.txt: no writeable metadata found: map[rclone-test:potato]
2025/01/03 01:50:06 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/01/03 01:50:07 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-radawex6limu"
2025/01/03 01:50:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:07 DEBUG : Creating backend with remote "/tmp/rclone772595705"
    run.go:180: Remote "OneDrive root 'rclone-test-radawex6limu'", Local "Local file system at /tmp/rclone772595705", Modify Window "1s"
2025/01/03 01:50:07 DEBUG : OneDrive root 'rclone-test-radawex6limu': Purge remote
2025/01/03 01:50:07 NOTICE: purge failed: directory not found
2025/01/03 01:50:07 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-fefecir3leza"
2025/01/03 01:50:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:08 DEBUG : Creating backend with remote "/tmp/rclone1089592859"
    run.go:180: Remote "OneDrive root 'rclone-test-fefecir3leza'", Local "Local file system at /tmp/rclone1089592859", Modify Window "1s"
2025/01/03 01:50:08 DEBUG : OneDrive root 'rclone-test-fefecir3leza': Purge remote
2025/01/03 01:50:08 NOTICE: purge failed: directory not found
2025/01/03 01:50:08 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-xununib4ledu"
2025/01/03 01:50:08 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:09 DEBUG : Creating backend with remote "/tmp/rclone1385548318"
    run.go:180: Remote "OneDrive root 'rclone-test-xununib4ledu'", Local "Local file system at /tmp/rclone1385548318", Modify Window "1s"
2025/01/03 01:50:09 DEBUG : OneDrive root 'rclone-test-xununib4ledu': Purge remote
2025/01/03 01:50:09 NOTICE: purge failed: directory not found
2025/01/03 01:50:09 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-yozogip0kuno"
2025/01/03 01:50:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:09 DEBUG : Creating backend with remote "/tmp/rclone1597948138"
    run.go:180: Remote "OneDrive root 'rclone-test-yozogip0kuno'", Local "Local file system at /tmp/rclone1597948138", Modify Window "1s"
2025/01/03 01:50:09 DEBUG : OneDrive root 'rclone-test-yozogip0kuno': Purge remote
2025/01/03 01:50:10 NOTICE: purge failed: directory not found
2025/01/03 01:50:10 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-kequhey3yozi"
2025/01/03 01:50:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:10 DEBUG : Creating backend with remote "/tmp/rclone3707340599"
    run.go:180: Remote "OneDrive root 'rclone-test-kequhey3yozi'", Local "Local file system at /tmp/rclone3707340599", Modify Window "1s"
2025/01/03 01:50:10 DEBUG : OneDrive root 'rclone-test-kequhey3yozi': Purge remote
2025/01/03 01:50:10 NOTICE: purge failed: directory not found
2025/01/03 01:50:10 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-hodapeq6jizo"
2025/01/03 01:50:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:50:11 DEBUG : Creating backend with remote "/tmp/rclone4249551700"
    run.go:180: Remote "OneDrive root 'rclone-test-hodapeq6jizo'", Local "Local file system at /tmp/rclone4249551700", Modify Window "1s"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove
2025/01/03 01:50:11 DEBUG : some file-busaman0.txt: Starting multipart upload
2025/01/03 01:50:12 DEBUG : some file-busaman0.txt: Uploading segment 0/5 size 5
2025/01/03 01:50:12 DEBUG : some file-busaman0.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/01/03 01:50:13 DEBUG : some file-busaman0.txt: updated permissions (now has 1 permissions)
2025/01/03 01:50:14 DEBUG : perms: 
[
	{
		"id": "vQ4hj_San-l-7BBeTsiDU15ismQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
	}
]
2025/01/03 01:50:15 DEBUG : perms: 
[
	{
		"id": "vQ4hj_San-l-7BBeTsiDU15ismQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
	}
]
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: malware-detected: false
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: shared-time: 2025-01-03T01:50:13.544Z
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!1983981
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: shared-by-id: 
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: utime: 2025-01-03T01:50:12.37Z
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: shared-scope: users
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: skipping unsupported metadata item: content-type: text/plain
2025/01/03 01:50:15 DEBUG : some file-posiqax5.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/01/03 01:50:16 DEBUG : some file-posiqax5.txt: updated permissions (now has 1 permissions)
2025/01/03 01:50:16 DEBUG : perms: 
[
	{
		"id": "tuGuvBZPnveXdgYp1B_rpYXHYXM",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YtuXvOFhnL6Yft7Lg"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YtuXvOFhnL6Yft7Lg"
	}
]
2025/01/03 01:50:17 DEBUG : perms: 
[
	{
		"id": "vQ4hj_San-l-7BBeTsiDU15ismQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
	}
]
2025/01/03 01:50:17 DEBUG : perms: 
[
	{
		"id": "vQ4hj_San-l-7BBeTsiDU15ismQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
	}
]
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: malware-detected: false
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: shared-scope: users
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: content-type: text/plain
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: shared-time: 2025-01-03T01:50:13.544Z
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!1983981
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: shared-by-id: 
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: utime: 2025-01-03T01:50:12.37Z
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: skipping update for invalid roles: [read] (perm ID: vQ4hj_San-l-7BBeTsiDU15ismQ)
2025/01/03 01:50:17 DEBUG : some file-vezokak3.txt: metadata permissions: to add: 0 to update: 0 to remove: 0
2025/01/03 01:50:18 DEBUG : some file-vezokak3.txt: updated permissions (now has 1 permissions)
2025/01/03 01:50:18 DEBUG : perms: 
[
	{
		"id": "vQ4hj_San-l-7BBeTsiDU15ismQ",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lx-YttfkCbtQzK61IpRw"
	}
]
2025/01/03 01:50:18 DEBUG : OneDrive root 'rclone-test-hodapeq6jizo': Purge remote
2025/01/03 01:50:18 DEBUG : OneDrive root 'rclone-test-hodapeq6jizo': Purge remote
2025/01/03 01:50:18 NOTICE: purge failed: directory not found
2025/01/03 01:50:18 DEBUG : OneDrive root 'rclone-test-hodapeq6jizo': Purge remote
2025/01/03 01:50:18 NOTICE: purge failed: directory not found
2025/01/03 01:50:18 DEBUG : OneDrive root 'rclone-test-kequhey3yozi': Purge remote
2025/01/03 01:50:18 NOTICE: purge failed: directory not found
2025/01/03 01:50:18 DEBUG : OneDrive root 'rclone-test-yozogip0kuno': Purge remote
2025/01/03 01:50:19 NOTICE: purge failed: directory not found
2025/01/03 01:50:19 DEBUG : OneDrive root 'rclone-test-xununib4ledu': Purge remote
2025/01/03 01:50:19 NOTICE: purge failed: directory not found
2025/01/03 01:50:19 DEBUG : OneDrive root 'rclone-test-fefecir3leza': Purge remote
2025/01/03 01:50:19 NOTICE: purge failed: directory not found
2025/01/03 01:50:19 DEBUG : OneDrive root 'rclone-test-radawex6limu': Purge remote
2025/01/03 01:50:19 NOTICE: purge failed: directory not found
2025/01/03 01:50:19 ERROR : : error listing: directory not found
--- PASS: TestIntegration (18.10s)
    --- PASS: TestIntegration/FsMkdir (16.57s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (15.84s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (12.14s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove (6.85s)
PASS
2025/01/03 01:50:20 DEBUG : OneDrive root 'rclone-test-fofezoc6nahe': Purge remote
2025/01/03 01:50:20 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	19.428s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestServerSideCopyMove$'" - Finished OK in 20.0743156s (try 2/5)