"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestServerSideCopyMove$'" - Starting (try 2/5)
2025/08/18 01:05:11 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vuvizam1xiqa"
2025/08/18 01:05:11 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:12 DEBUG : Creating backend with remote "/tmp/rclone706686448"
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestOneDrive:"
2025/08/18 01:05:12 NOTICE: TestOneDrive: Starting server
2025/08/18 01:05:12 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lekuxep6mewe"
2025/08/18 01:05:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/08/18 01:05:15 DEBUG : file name.txt: Starting multipart upload
2025/08/18 01:05:15 DEBUG : file name.txt: Uploading segment 0/100 size 100
2025/08/18 01:05:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload
2025/08/18 01:05:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100
2025/08/18 01:05:19 DEBUG : file name.txt: Starting multipart upload
2025/08/18 01:05:19 DEBUG : file name.txt: skipping unsupported metadata item: rclone-test: potato
2025/08/18 01:05:19 INFO  : file name.txt: no writeable metadata found: map[rclone-test:potato]
2025/08/18 01:05:19 DEBUG : file name.txt: Uploading segment 0/100 size 100
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
2025/08/18 01:05:20 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lemekad9yijo"
2025/08/18 01:05:20 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:21 DEBUG : Creating backend with remote "/tmp/rclone2945252838"
    run.go:180: Remote "OneDrive root 'rclone-test-lemekad9yijo'", Local "Local file system at /tmp/rclone2945252838", Modify Window "1s"
2025/08/18 01:05:21 DEBUG : OneDrive root 'rclone-test-lemekad9yijo': Purge remote
2025/08/18 01:05:22 NOTICE: purge failed: directory not found
2025/08/18 01:05:22 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-texadop1daxi"
2025/08/18 01:05:22 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:23 DEBUG : Creating backend with remote "/tmp/rclone1896983878"
    run.go:180: Remote "OneDrive root 'rclone-test-texadop1daxi'", Local "Local file system at /tmp/rclone1896983878", Modify Window "1s"
2025/08/18 01:05:23 DEBUG : OneDrive root 'rclone-test-texadop1daxi': Purge remote
2025/08/18 01:05:23 NOTICE: purge failed: directory not found
2025/08/18 01:05:23 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-dequvux2ziva"
2025/08/18 01:05:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:24 DEBUG : Creating backend with remote "/tmp/rclone3897820076"
    run.go:180: Remote "OneDrive root 'rclone-test-dequvux2ziva'", Local "Local file system at /tmp/rclone3897820076", Modify Window "1s"
2025/08/18 01:05:24 DEBUG : OneDrive root 'rclone-test-dequvux2ziva': Purge remote
2025/08/18 01:05:24 NOTICE: purge failed: directory not found
2025/08/18 01:05:24 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-gecemoy8saji"
2025/08/18 01:05:24 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:25 DEBUG : Creating backend with remote "/tmp/rclone114984484"
    run.go:180: Remote "OneDrive root 'rclone-test-gecemoy8saji'", Local "Local file system at /tmp/rclone114984484", Modify Window "1s"
2025/08/18 01:05:25 DEBUG : OneDrive root 'rclone-test-gecemoy8saji': Purge remote
2025/08/18 01:05:25 NOTICE: purge failed: directory not found
2025/08/18 01:05:25 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vajagok9hobi"
2025/08/18 01:05:25 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:26 DEBUG : Creating backend with remote "/tmp/rclone3210032477"
    run.go:180: Remote "OneDrive root 'rclone-test-vajagok9hobi'", Local "Local file system at /tmp/rclone3210032477", Modify Window "1s"
2025/08/18 01:05:26 DEBUG : OneDrive root 'rclone-test-vajagok9hobi': Purge remote
2025/08/18 01:05:26 NOTICE: purge failed: directory not found
2025/08/18 01:05:26 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-nirurut8huca"
2025/08/18 01:05:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/18 01:05:27 DEBUG : Creating backend with remote "/tmp/rclone3526174510"
    run.go:180: Remote "OneDrive root 'rclone-test-nirurut8huca'", Local "Local file system at /tmp/rclone3526174510", Modify Window "1s"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove
2025/08/18 01:05:28 DEBUG : some file-qaweqov5.txt: Starting multipart upload
2025/08/18 01:05:28 DEBUG : some file-qaweqov5.txt: Uploading segment 0/5 size 5
2025/08/18 01:05:29 DEBUG : some file-qaweqov5.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/08/18 01:05:30 DEBUG : some file-qaweqov5.txt: updated permissions (now has 1 permissions)
2025/08/18 01:05:30 DEBUG : perms: 
[
	{
		"id": "xiwyebm4D8Hc69oPboRSJule-1g",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
	}
]
2025/08/18 01:05:32 DEBUG : perms: 
[
	{
		"id": "xiwyebm4D8Hc69oPboRSJule-1g",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
	}
]
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: malware-detected: false
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: shared-time: 2025-08-18T01:05:29.743Z
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: content-type: text/plain
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: shared-by-id: 
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: shared-scope: users
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: utime: 2025-08-18T01:05:28.913Z
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!2640309
2025/08/18 01:05:32 DEBUG : some file-nisolah1.txt: metadata permissions: to add: 1 to update: 0 to remove: 0
2025/08/18 01:05:33 DEBUG : some file-nisolah1.txt: updated permissions (now has 1 permissions)
2025/08/18 01:05:33 DEBUG : perms: 
[
	{
		"id": "cWJyQtRIeu3AhWlqrs5Os7G-03M",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNt9ZyuHRyUvwVUA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNt9ZyuHRyUvwVUA"
	}
]
2025/08/18 01:05:34 DEBUG : perms: 
[
	{
		"id": "xiwyebm4D8Hc69oPboRSJule-1g",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
	}
]
2025/08/18 01:05:34 DEBUG : perms: 
[
	{
		"id": "xiwyebm4D8Hc69oPboRSJule-1g",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
	}
]
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: utime: 2025-08-18T01:05:28.913Z
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: shared-scope: users
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: shared-time: 2025-08-18T01:05:29.743Z
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: shared-by-id: 
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!2640309
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: content-type: text/plain
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping unsupported metadata item: malware-detected: false
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: skipping update for invalid roles: [read] (perm ID: xiwyebm4D8Hc69oPboRSJule-1g)
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: metadata permissions: to add: 0 to update: 0 to remove: 0
2025/08/18 01:05:34 DEBUG : some file-peqajay5.txt: updated permissions (now has 1 permissions)
2025/08/18 01:05:35 DEBUG : perms: 
[
	{
		"id": "xiwyebm4D8Hc69oPboRSJule-1g",
		"grantedTo": {
			"user": {
				"id": "ryan@contoso.com"
			},
			"application": {},
			"device": {},
			"group": {},
			"siteGroup": {},
			"siteUser": {}
		},
		"invitation": {
			"email": "ryan@contoso.com"
		},
		"link": {
			"webUrl": "https://1drv.ms/t/s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
		},
		"roles": [
			"read"
		],
		"shareId": "s!BFPSseeYZ6lxgaGTNSM_zCc7Ju3wzcA"
	}
]
2025/08/18 01:05:35 DEBUG : OneDrive root 'rclone-test-nirurut8huca': Purge remote
2025/08/18 01:05:35 DEBUG : OneDrive root 'rclone-test-nirurut8huca': Purge remote
2025/08/18 01:05:35 NOTICE: purge failed: directory not found
2025/08/18 01:05:35 DEBUG : OneDrive root 'rclone-test-nirurut8huca': Purge remote
2025/08/18 01:05:35 NOTICE: purge failed: directory not found
2025/08/18 01:05:35 DEBUG : OneDrive root 'rclone-test-vajagok9hobi': Purge remote
2025/08/18 01:05:36 NOTICE: purge failed: directory not found
2025/08/18 01:05:36 DEBUG : OneDrive root 'rclone-test-gecemoy8saji': Purge remote
2025/08/18 01:05:36 NOTICE: purge failed: directory not found
2025/08/18 01:05:36 DEBUG : OneDrive root 'rclone-test-dequvux2ziva': Purge remote
2025/08/18 01:05:36 NOTICE: purge failed: directory not found
2025/08/18 01:05:36 DEBUG : OneDrive root 'rclone-test-texadop1daxi': Purge remote
2025/08/18 01:05:36 NOTICE: purge failed: directory not found
2025/08/18 01:05:36 DEBUG : OneDrive root 'rclone-test-lemekad9yijo': Purge remote
2025/08/18 01:05:37 NOTICE: purge failed: directory not found
2025/08/18 01:05:37 ERROR : error listing: directory not found
--- PASS: TestIntegration (25.55s)
    --- PASS: TestIntegration/FsMkdir (23.26s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (22.15s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (16.69s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TestServerSideCopyMove (7.59s)
PASS
2025/08/18 01:05:38 DEBUG : OneDrive root 'rclone-test-vuvizam1xiqa': Purge remote
2025/08/18 01:05:38 NOTICE: purge failed: directory not found
ok  	github.com/rclone/rclone/backend/onedrive	27.032s
"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestServerSideCopyMove$'" - Finished OK in 28.096791002s (try 2/5)