"go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestDirectoryMetadata$'" - Starting (try 4/5) 2024/10/30 06:02:36 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-yuhipiq1debe" 2024/10/30 06:02:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:37 DEBUG : Creating backend with remote "/tmp/rclone1142869325" === RUN TestIntegration fstests.go:442: Using remote "TestOneDrive:" 2024/10/30 06:02:37 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-dubawez7sefe" 2024/10/30 06:02:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsPutFiles 2024/10/30 06:02:38 DEBUG : file name.txt: Starting multipart upload 2024/10/30 06:02:38 DEBUG : file name.txt: Uploading segment 0/100 size 100 2024/10/30 06:02:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Starting multipart upload 2024/10/30 06:02:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading segment 0/100 size 100 2024/10/30 06:02:41 DEBUG : file name.txt: Starting multipart upload 2024/10/30 06:02:41 DEBUG : file name.txt: skipping unsupported metadata item: rclone-test: potato 2024/10/30 06:02:41 INFO : file name.txt: no writeable metadata found: map[rclone-test:potato] 2024/10/30 06:02:41 DEBUG : file name.txt: Uploading segment 0/100 size 100 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal 2024/10/30 06:02:41 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-xewoyom1qipe" 2024/10/30 06:02:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:42 DEBUG : Creating backend with remote "/tmp/rclone339411320" run.go:180: Remote "OneDrive root 'rclone-test-xewoyom1qipe'", Local "Local file system at /tmp/rclone339411320", Modify Window "1s" 2024/10/30 06:02:42 DEBUG : OneDrive root 'rclone-test-xewoyom1qipe': Purge remote 2024/10/30 06:02:42 NOTICE: purge failed: directory not found 2024/10/30 06:02:42 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-wupaxum6wixe" 2024/10/30 06:02:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:42 DEBUG : Creating backend with remote "/tmp/rclone2247211433" run.go:180: Remote "OneDrive root 'rclone-test-wupaxum6wixe'", Local "Local file system at /tmp/rclone2247211433", Modify Window "1s" 2024/10/30 06:02:42 DEBUG : OneDrive root 'rclone-test-wupaxum6wixe': Purge remote 2024/10/30 06:02:42 NOTICE: purge failed: directory not found 2024/10/30 06:02:42 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-pexoyuk0bocu" 2024/10/30 06:02:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:43 DEBUG : Creating backend with remote "/tmp/rclone4120902276" run.go:180: Remote "OneDrive root 'rclone-test-pexoyuk0bocu'", Local "Local file system at /tmp/rclone4120902276", Modify Window "1s" 2024/10/30 06:02:43 DEBUG : OneDrive root 'rclone-test-pexoyuk0bocu': Purge remote 2024/10/30 06:02:43 NOTICE: purge failed: directory not found 2024/10/30 06:02:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-hagehuc8cumi" 2024/10/30 06:02:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:43 DEBUG : Creating backend with remote "/tmp/rclone2206253338" run.go:180: Remote "OneDrive root 'rclone-test-hagehuc8cumi'", Local "Local file system at /tmp/rclone2206253338", Modify Window "1s" 2024/10/30 06:02:43 DEBUG : OneDrive root 'rclone-test-hagehuc8cumi': Purge remote 2024/10/30 06:02:43 NOTICE: purge failed: directory not found 2024/10/30 06:02:43 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qavotad0wovu" 2024/10/30 06:02:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:44 DEBUG : Creating backend with remote "/tmp/rclone2341937665" run.go:180: Remote "OneDrive root 'rclone-test-qavotad0wovu'", Local "Local file system at /tmp/rclone2341937665", Modify Window "1s" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata 2024/10/30 06:02:44 DEBUG : subdir: Making directory with metadata 2024/10/30 06:02:44 DEBUG : subdir: skipping unsupported metadata item: content-type: inode/directory 2024/10/30 06:02:45 DEBUG : subdir: metadata permissions: to add: 1 to update: 0 to remove: 0 2024/10/30 06:02:46 DEBUG : subdir: updated permissions (now has 1 permissions) 2024/10/30 06:02:46 INFO : subdir: Made directory with metadata (mtime=2023-08-26T23:13:06.499Z) 2024/10/30 06:02:46 DEBUG : perms: [ { "id": "h0OT9YN2aMfA_zWU2tLJLcgq3Y8", "grantedTo": { "user": { "id": "ryan@contoso.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "invitation": { "email": "ryan@contoso.com" }, "link": { "webUrl": "https://1drv.ms/f/s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" }, "roles": [ "read" ], "shareId": "s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" } ] onedrive_internal_test.go:218: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:218 Error: Not equal: expected: time.Date(2023, time.August, 26, 23, 13, 6, 0, time.UTC) actual : time.Date(2023, time.August, 26, 23, 13, 6, 499000000, time.UTC) Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -(time.Time) 2023-08-26 23:13:06 +0000 UTC +(time.Time) 2023-08-26 23:13:06.499 +0000 UTC Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata 2024/10/30 06:02:46 INFO : subdir: Set directory modification time (using SetModTime) onedrive_internal_test.go:222: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive_internal_test.go:222 Error: Not equal: expected: time.Date(2020, time.February, 29, 12, 34, 56, 0, time.UTC) actual : time.Date(2020, time.February, 29, 12, 34, 56, 789000000, time.UTC) Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -(time.Time) 2020-02-29 12:34:56 +0000 UTC +(time.Time) 2020-02-29 12:34:56.789 +0000 UTC Test: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata 2024/10/30 06:02:46 DEBUG : perms: [ { "id": "h0OT9YN2aMfA_zWU2tLJLcgq3Y8", "grantedTo": { "user": { "id": "ryan@contoso.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "invitation": { "email": "ryan@contoso.com" }, "link": { "webUrl": "https://1drv.ms/f/s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" }, "roles": [ "read" ], "shareId": "s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" } ] 2024/10/30 06:02:46 DEBUG : subdir: Making directory with metadata 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: content-type: inode/directory 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: utime: 2024-10-30T06:02:44.963Z 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: malware-detected: false 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!1810980 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: shared-scope: users 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: shared-by-id: 2024/10/30 06:02:46 DEBUG : subdir: skipping unsupported metadata item: shared-time: 2024-10-30T06:02:45.942Z 2024/10/30 06:02:47 DEBUG : subdir: metadata permissions: to add: 1 to update: 0 to remove: 0 2024/10/30 06:02:48 DEBUG : subdir: updated permissions (now has 1 permissions) 2024/10/30 06:02:48 INFO : subdir: Made directory with metadata (mtime=2023-08-26T23:13:06.499Z) 2024/10/30 06:02:48 DEBUG : perms: [ { "id": "h0OT9YN2aMfA_zWU2tLJLcgq3Y8", "grantedTo": { "user": { "id": "ryan@contoso.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "invitation": { "email": "ryan@contoso.com" }, "link": { "webUrl": "https://1drv.ms/f/s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" }, "roles": [ "write" ], "shareId": "s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" } ] 2024/10/30 06:02:48 DEBUG : perms: [ { "id": "h0OT9YN2aMfA_zWU2tLJLcgq3Y8", "grantedTo": { "user": { "id": "ryan@contoso.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "invitation": { "email": "ryan@contoso.com" }, "link": { "webUrl": "https://1drv.ms/f/s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" }, "roles": [ "write" ], "shareId": "s!BFPSseeYZ6lx7sQk2nIX_PF3KpOgOQ" } ] 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: last-modified-by-display-name: Nick Craig-Wood 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: last-modified-by-id: 71a96798e7b1d253 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: shared-owner-id: 71a96798e7b1d253 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: shared-by-id: 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: created-by-id: 71a96798e7b1d253 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: shared-time: 2024-10-30T06:02:45.942Z 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: utime: 2024-10-30T06:02:44.963Z 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: malware-detected: false 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: id: 71a96798e7b1d253#71A96798E7B1D253!1810980 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: content-type: inode/directory 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: created-by-display-name: Nick Craig-Wood 2024/10/30 06:02:48 DEBUG : subdir2: skipping unsupported metadata item: shared-scope: users 2024/10/30 06:02:48 DEBUG : subdir2: metadata permissions: to add: 1 to update: 0 to remove: 0 2024/10/30 06:02:49 DEBUG : subdir2: updated permissions (now has 1 permissions) 2024/10/30 06:02:49 INFO : subdir2: Updated directory metadata 2024/10/30 06:02:49 DEBUG : perms: [ { "id": "cYogO4yVub0bJfpr7S7pI71ff_A", "grantedTo": { "user": { "id": "ryan@contoso.com" }, "application": {}, "device": {}, "group": {}, "siteGroup": {}, "siteUser": {} }, "invitation": { "email": "ryan@contoso.com" }, "link": { "webUrl": "https://1drv.ms/f/s!BFPSseeYZ6lx7sQlAwlw7WoBcas3Xg" }, "roles": [ "write" ], "shareId": "s!BFPSseeYZ6lx7sQlAwlw7WoBcas3Xg" } ] 2024/10/30 06:02:49 DEBUG : subdir2/some file-qoxucav7.txt: Starting multipart upload 2024/10/30 06:02:49 DEBUG : subdir2/some file-qoxucav7.txt: Uploading segment 0/8 size 8 2024/10/30 06:02:50 DEBUG : OneDrive root 'rclone-test-qavotad0wovu': Purge remote 2024/10/30 06:02:50 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-mitedos2hucu" 2024/10/30 06:02:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:02:50 DEBUG : Creating backend with remote "/tmp/rclone2737766214" === NAME TestIntegration/FsMkdir/FsPutFiles/Internal run.go:180: Remote "OneDrive root 'rclone-test-mitedos2hucu'", Local "Local file system at /tmp/rclone2737766214", Modify Window "1s" 2024/10/30 06:02:50 DEBUG : OneDrive root 'rclone-test-mitedos2hucu': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-mitedos2hucu': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-mitedos2hucu': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-qavotad0wovu': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-hagehuc8cumi': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-pexoyuk0bocu': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-wupaxum6wixe': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:51 DEBUG : OneDrive root 'rclone-test-xewoyom1qipe': Purge remote 2024/10/30 06:02:51 NOTICE: purge failed: directory not found 2024/10/30 06:02:52 ERROR : : error listing: directory not found --- FAIL: TestIntegration (14.83s) --- FAIL: TestIntegration/FsMkdir (13.76s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (13.18s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal (10.18s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata (5.86s) FAIL 2024/10/30 06:02:52 DEBUG : OneDrive root 'rclone-test-yuhipiq1debe': Purge remote 2024/10/30 06:02:52 NOTICE: purge failed: directory not found exit status 1 FAIL github.com/rclone/rclone/backend/onedrive 15.469s "go test -v -timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^Internal$/^TestDirectoryMetadata$'" - Finished ERROR in 16.594823408s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles/Internal/TestDirectoryMetadata]