"go test -v -timeout 1h0m0s -remote TestDrive: -verbose" - Starting (try 1/5) === RUN TestDriveScopes --- PASS: TestDriveScopes (0.00s) === RUN TestInternalLoadExampleFormats --- PASS: TestInternalLoadExampleFormats (0.00s) === RUN TestInternalParseExtensions --- PASS: TestInternalParseExtensions (0.00s) === RUN TestInternalFindExportFormat --- PASS: TestInternalFindExportFormat (0.00s) === RUN TestMimeTypesToExtension --- PASS: TestMimeTypesToExtension (0.00s) === RUN TestExtensionToMimeType --- PASS: TestExtensionToMimeType (0.00s) === RUN TestExtensionsForExportFormats --- PASS: TestExtensionsForExportFormats (0.00s) === RUN TestExtensionsForImportFormats drive_internal_test.go:180: --- SKIP: TestExtensionsForImportFormats (0.00s) === RUN TestIntegration fstests.go:418: Using remote "TestDrive:" 2022/04/20 05:06:32 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9" 2022/04/20 05:06:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:459: Not a wrapping Fs === RUN TestIntegration/FsCommand === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2022/04/20 05:06:37 DEBUG : dir/subdir: Making directory 2022/04/20 05:06:39 INFO : dir/subdir: Removing directory 2022/04/20 05:06:41 INFO : dir: Removing directory 2022/04/20 05:06:41 DEBUG : dir: Rmdir: contains trashed file: "subdir" === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound 2022/04/20 05:06:43 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound 2022/04/20 05:06:43 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:674: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2022/04/20 05:06:48 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Rmdir: contains trashed file: "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:674: testing "．" 2022/04/20 05:06:54 DEBUG : ．: Rmdir: contains trashed file: "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:674: testing "．．" 2022/04/20 05:07:00 DEBUG : ．．: Rmdir: contains trashed file: "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2022/04/20 05:07:05 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Rmdir: contains trashed file: "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:674: testing " leading space" 2022/04/20 05:07:11 DEBUG : leading space: Rmdir: contains trashed file: " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:674: testing "~leading tilde" 2022/04/20 05:07:17 DEBUG : ~leading tilde: Rmdir: contains trashed file: "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:674: testing "␍leading CR" 2022/04/20 05:07:24 DEBUG : ␍leading CR: Rmdir: contains trashed file: "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:674: testing "␊leading LF" 2022/04/20 05:07:30 DEBUG : ␊leading LF: Rmdir: contains trashed file: "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:674: testing "␉leading HT" 2022/04/20 05:07:37 DEBUG : ␉leading HT: Rmdir: contains trashed file: "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:674: testing "␋leading VT" 2022/04/20 05:07:42 DEBUG : ␋leading VT: Rmdir: contains trashed file: "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:674: testing ".leading dot" 2022/04/20 05:07:47 DEBUG : .leading dot: Rmdir: contains trashed file: ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:674: testing "trailing space " 2022/04/20 05:07:53 DEBUG : trailing space : Rmdir: contains trashed file: "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:674: testing "trailing CR␍" 2022/04/20 05:07:59 DEBUG : trailing CR␍: Rmdir: contains trashed file: "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:674: testing "trailing LF␊" 2022/04/20 05:08:04 DEBUG : trailing LF␊: Rmdir: contains trashed file: "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:674: testing "trailing HT␉" 2022/04/20 05:08:09 DEBUG : trailing HT␉: Rmdir: contains trashed file: "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:674: testing "trailing VT␋" 2022/04/20 05:08:13 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:08:13 DEBUG : pacer: Rate limited, increasing sleep to 1.403210546s 2022/04/20 05:08:13 DEBUG : pacer: low level retry 2/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:08:13 DEBUG : pacer: Rate limited, increasing sleep to 2.554840641s 2022/04/20 05:08:15 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:08:19 DEBUG : trailing VT␋: Rmdir: contains trashed file: "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:674: testing "trailing dot." 2022/04/20 05:08:24 DEBUG : trailing dot.: Rmdir: contains trashed file: "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:674: testing "invalid utf-8\xfe" 2022/04/20 05:08:30 DEBUG : invalid utf-8: Rmdir: contains trashed file: "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:674: testing "test%46.txt" 2022/04/20 05:08:37 DEBUG : test%46.txt: Rmdir: contains trashed file: "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:747: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsChangeNotify 2022/04/20 05:08:48 DEBUG : dir: Making directory 2022/04/20 05:08:49 DEBUG : dir/subdir1: Making directory 2022/04/20 05:08:50 DEBUG : dir/subdir3: Making directory 2022/04/20 05:08:50 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:50 DEBUG : doChangeNotify("dir/subdir1", 0) 2022/04/20 05:08:51 DEBUG : dir/subdir2: Making directory 2022/04/20 05:08:51 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:51 DEBUG : doChangeNotify("dir/subdir3", 0) 2022/04/20 05:08:52 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:53 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:54 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:54 DEBUG : doChangeNotify("dir/subdir2", 0) 2022/04/20 05:08:55 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:55 DEBUG : doChangeNotify("dir/file2", 1) 2022/04/20 05:08:56 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:57 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:57 DEBUG : doChangeNotify("dir/file4", 1) 2022/04/20 05:08:58 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:08:59 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:00 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote fstests.go:846: Try 1/10 waiting for dirChanges and objChanges 2022/04/20 05:09:01 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:01 DEBUG : doChangeNotify("dir/file3", 1) 2022/04/20 05:09:02 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:03 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:04 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:05 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:05 DEBUG : doChangeNotify("dir/file2", 1) 2022/04/20 05:09:06 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:07 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:07 DEBUG : doChangeNotify("dir/file4", 1) 2022/04/20 05:09:07 DEBUG : doChangeNotify("dir/file3", 1) 2022/04/20 05:09:08 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:08 DEBUG : doChangeNotify("dir/subdir1", 0) 2022/04/20 05:09:09 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:10 DEBUG : doChangeNotify("dir/subdir3", 0) 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "file3" 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "file4" 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "file2" 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "subdir2" 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "subdir3" 2022/04/20 05:09:10 DEBUG : dir: Rmdir: contains trashed file: "subdir1" 2022/04/20 05:09:10 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': Checking for changes on remote 2022/04/20 05:09:10 DEBUG : doChangeNotify("dir/subdir2", 0) === RUN TestIntegration/FsMkdir/FsPutFiles === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2022/04/20 05:09:23 DEBUG : Creating backend with remote "TestDrive:" 2022/04/20 05:09:23 DEBUG : Config file has changed externaly - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2022/04/20 05:09:24 DEBUG : Creating backend with remote "TestDrive:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 2022/04/20 05:09:28 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:09:28 DEBUG : pacer: Rate limited, increasing sleep to 1.418598332s 2022/04/20 05:09:28 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1036: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2022/04/20 05:09:32 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:09:32 DEBUG : pacer: Rate limited, increasing sleep to 1.829501529s 2022/04/20 05:09:32 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2022/04/20 05:09:59 DEBUG : Creating backend with remote "TestDrive:rclone-test-cefoyew5buqocav3cupovir4" 2022/04/20 05:10:01 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:01 DEBUG : pacer: Rate limited, increasing sleep to 1.978651635s 2022/04/20 05:10:02 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:11 DEBUG : Google drive root 'rclone-test-cefoyew5buqocav3cupovir4': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2022/04/20 05:10:12 DEBUG : : Rmdir: contains trashed file: "moveTest" 2022/04/20 05:10:12 DEBUG : : Rmdir: contains trashed file: "dirToPurge" 2022/04/20 05:10:12 DEBUG : : Rmdir: contains trashed file: "dir" 2022/04/20 05:10:12 DEBUG : : Rmdir: contains file: "hello? sausage" === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2022/04/20 05:10:13 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:13 DEBUG : pacer: Rate limited, increasing sleep to 1.644818825s 2022/04/20 05:10:14 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2022/04/20 05:10:26 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2022/04/20 05:10:29 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1503: Opening root remote "TestDrive:" path "rclone-test-jazitit7mekigox5qemiweg9" from "TestDrive:rclone-test-jazitit7mekigox5qemiweg9" 2022/04/20 05:10:31 DEBUG : Creating backend with remote "TestDrive:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR 2022/04/20 05:10:33 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:33 DEBUG : pacer: Rate limited, increasing sleep to 1.999435906s 2022/04/20 05:10:33 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:33 DEBUG : pacer: Rate limited, increasing sleep to 2.898696183s 2022/04/20 05:10:33 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:33 DEBUG : pacer: low level retry 2/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:33 DEBUG : pacer: Rate limited, increasing sleep to 1.552258778s 2022/04/20 05:10:33 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:35 DEBUG : Google drive root '': Disabling ListR to work around bug in drive as multi listing (2) returned no entries 2022/04/20 05:10:35 DEBUG : Google drive root '': Recycled 2 entries 2022/04/20 05:10:36 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:36 DEBUG : pacer: Rate limited, increasing sleep to 1.485738167s 2022/04/20 05:10:36 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:36 DEBUG : pacer: Rate limited, increasing sleep to 2.515831321s 2022/04/20 05:10:36 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:36 DEBUG : pacer: Rate limited, increasing sleep to 4.892727731s 2022/04/20 05:10:36 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:36 DEBUG : pacer: Rate limited, increasing sleep to 8.734636843s 2022/04/20 05:10:36 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:37 DEBUG : Google drive root '': Re-enabling ListR as previous detection was in error 2022/04/20 05:10:37 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:37 DEBUG : pacer: Rate limited, increasing sleep to 1.710220844s 2022/04/20 05:10:37 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:38 DEBUG : pacer: low level retry 2/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:38 DEBUG : pacer: Rate limited, increasing sleep to 1.695633351s 2022/04/20 05:10:38 DEBUG : pacer: Reducing sleep to 0s 2022/04/20 05:10:40 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:40 DEBUG : pacer: Rate limited, increasing sleep to 1.931715559s 2022/04/20 05:10:41 DEBUG : pacer: low level retry 2/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2022/04/20 05:10:41 DEBUG : pacer: Rate limited, increasing sleep to 2.628712191s 2022/04/20 05:10:41 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2022/04/20 05:10:49 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share single file 'file name.txt_does_not_exist' 2022/04/20 05:10:49 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share single file 'file name.txt' 2022/04/20 05:10:51 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share single file 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt' 2022/04/20 05:10:52 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share single file 'file name.txt' 2022/04/20 05:10:53 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2022/04/20 05:10:54 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2022/04/20 05:10:55 DEBUG : Creating backend with remote "TestDrive:rclone-test-potibis1xoweqec6qaqanic7" 2022/04/20 05:10:58 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9': attempting to share directory '' 2022/04/20 05:10:59 DEBUG : Google drive root 'rclone-test-potibis1xoweqec6qaqanic7': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:392: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:1699: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2022/04/20 05:11:03 DEBUG : piped data.txt: Sending chunk 0 length 0 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2022/04/20 05:11:05 DEBUG : piped data.txt: Sending chunk 0 length 100 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport 2022/04/20 05:11:07 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/backend/drive/test/files" 2022/04/20 05:11:07 DEBUG : example2.doc: Need to transfer - File not found at Destination 2022/04/20 05:11:11 INFO : example2.doc: Copied (new) to: example2.docx === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate 2022/04/20 05:11:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/backend/drive/test/files" 2022/04/20 05:11:12 DEBUG : example1.ods: Need to transfer - File not found at Destination 2022/04/20 05:11:13 DEBUG : example1.ods: md5 = 00339b48e86b01836673394effde944a OK 2022/04/20 05:11:13 INFO : example1.ods: Copied (new) to: example2.xlsx === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate/DocumentExport 2022/04/20 05:11:14 DEBUG : example2.txt: Updating size of doc after download to 3050 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate/DocumentExport/DocumentLink === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Errors === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/File === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Dir === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Command 2022/04/20 05:11:25 DEBUG : Creating backend with remote "doesnotexistremote:" 2022/04/20 05:11:25 DEBUG : Creating backend with remote "." 2022/04/20 05:11:25 DEBUG : fs cache: renaming cache item "." to be canonical "/home/rclone/go/src/github.com/rclone/rclone/backend/drive" 2022/04/20 05:11:25 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UnTrash 2022/04/20 05:11:38 DEBUG : trashDir: finding trash to restore in directory "1wP8InVK2Ril2iT3BQ6NWT5elTRTZ_fwr" 2022/04/20 05:11:39 INFO : trashDir/subdir: restoring "1xbP1M-Kf_9ZcVjODYfLa-wkLdReMDs-l" 2022/04/20 05:11:39 DEBUG : trashDir/subdir: finding trash to restore in directory "1xbP1M-Kf_9ZcVjODYfLa-wkLdReMDs-l" 2022/04/20 05:11:39 INFO : trashDir/toBeTrashed: restoring "176lhH6q7KmwVbYWxm8eBsXbmz5EQTZ-Q" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/BadID === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/Directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/WithoutDestName 2022/04/20 05:11:43 DEBUG : Creating backend with remote "/tmp/TestIntegrationFsMkdirFsPutFilesInternalCopyID2970684122/001/" 2022/04/20 05:11:44 DEBUG : z.txt: md5 = ac88e0865ae1f592c1bfeecd6d72955b OK 2022/04/20 05:11:44 INFO : z.txt: Copied (new) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/WithDestName 2022/04/20 05:11:45 DEBUG : z.txt: md5 = ac88e0865ae1f592c1bfeecd6d72955b OK 2022/04/20 05:11:45 INFO : z.txt: Copied (new) to: potato.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/AgeQuery 2022/04/20 05:11:45 DEBUG : --min-age 0s to 2022-04-20 05:11:45.469872367 +0000 UTC m=+312.746514995 2022/04/20 05:11:45 DEBUG : --max-age 1h0m0s to 2022-04-20 04:11:45.4698898 +0000 UTC m=-3287.253467573 2022/04/20 05:11:45 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9/agequery-testdir" 2022/04/20 05:11:46 DEBUG : Creating backend with remote "/tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/001" 2022/04/20 05:11:46 DEBUG : Creating backend with remote "/tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/002" 2022/04/20 05:11:46 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9/agequery-testdir': Waiting for checks to finish 2022/04/20 05:11:46 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9/agequery-testdir': Waiting for transfers to finish 2022/04/20 05:11:51 DEBUG : agequery.txt: md5 = 70fb874a43097a25234382390c0baeb3 OK 2022/04/20 05:11:51 INFO : agequery.txt: Copied (new) 2022/04/20 05:11:51 DEBUG : agequery.txt: Excluded 2022/04/20 05:11:51 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9/agequery-testdir': Waiting for checks to finish 2022/04/20 05:11:51 DEBUG : Google drive root 'rclone-test-jazitit7mekigox5qemiweg9/agequery-testdir': Waiting for transfers to finish 2022/04/20 05:11:52 DEBUG : Local file system at /tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/002: Waiting for checks to finish 2022/04/20 05:11:52 DEBUG : Local file system at /tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/002: Waiting for transfers to finish 2022/04/20 05:11:52 DEBUG : Local file system at /tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/002: Waiting for checks to finish 2022/04/20 05:11:52 DEBUG : Local file system at /tmp/TestIntegrationFsMkdirFsPutFilesInternalAgeQuery3188313958/002: Waiting for transfers to finish 2022/04/20 05:11:53 DEBUG : agequery.txt: md5 = 70fb874a43097a25234382390c0baeb3 OK 2022/04/20 05:11:53 INFO : agequery.txt: Copied (new) === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/256Ki === RUN TestIntegration/FsMkdir/FsPutChunked/256Ki/262143 === RUN TestIntegration/FsMkdir/FsPutChunked/256Ki/262144 2022/04/20 05:11:58 DEBUG : chunked-256Ki-256Ki.bin: Sending chunk 0 length 262144 === RUN TestIntegration/FsMkdir/FsPutChunked/256Ki/524289 2022/04/20 05:12:03 DEBUG : chunked-256Ki-512.001Ki.bin: Sending chunk 0 length 262144 2022/04/20 05:12:03 DEBUG : chunked-256Ki-512.001Ki.bin: Sending chunk 262144 length 262144 2022/04/20 05:12:03 DEBUG : chunked-256Ki-512.001Ki.bin: Sending chunk 524288 length 1 === RUN TestIntegration/FsMkdir/FsPutChunked/512Ki === RUN TestIntegration/FsMkdir/FsPutChunked/512Ki/524287 === RUN TestIntegration/FsMkdir/FsPutChunked/512Ki/524288 2022/04/20 05:12:11 DEBUG : chunked-512Ki-512Ki.bin: Sending chunk 0 length 524288 === RUN TestIntegration/FsMkdir/FsPutChunked/512Ki/1048577 2022/04/20 05:12:17 DEBUG : chunked-512Ki-1.000Mi.bin: Sending chunk 0 length 524288 2022/04/20 05:12:18 DEBUG : chunked-512Ki-1.000Mi.bin: Sending chunk 524288 length 524288 2022/04/20 05:12:18 DEBUG : chunked-512Ki-1.000Mi.bin: Sending chunk 1048576 length 1 === RUN TestIntegration/FsMkdir/FsPutChunked/1Mi === RUN TestIntegration/FsMkdir/FsPutChunked/1Mi/1048575 === RUN TestIntegration/FsMkdir/FsPutChunked/1Mi/1048576 2022/04/20 05:12:28 DEBUG : chunked-1Mi-1Mi.bin: Sending chunk 0 length 1048576 === RUN TestIntegration/FsMkdir/FsPutChunked/1Mi/2097153 2022/04/20 05:12:32 DEBUG : chunked-1Mi-2.000Mi.bin: Sending chunk 0 length 1048576 2022/04/20 05:12:32 DEBUG : chunked-1Mi-2.000Mi.bin: Sending chunk 1048576 length 1048576 2022/04/20 05:12:32 DEBUG : chunked-1Mi-2.000Mi.bin: Sending chunk 2097152 length 1 === RUN TestIntegration/FsMkdir/FsPutChunked/2Mi === RUN TestIntegration/FsMkdir/FsPutChunked/2Mi/2097151 === RUN TestIntegration/FsMkdir/FsPutChunked/2Mi/2097152 2022/04/20 05:12:42 DEBUG : chunked-2Mi-2Mi.bin: Sending chunk 0 length 2097152 === RUN TestIntegration/FsMkdir/FsPutChunked/2Mi/4194305 2022/04/20 05:12:46 DEBUG : chunked-2Mi-4.000Mi.bin: Sending chunk 0 length 2097152 2022/04/20 05:12:46 DEBUG : chunked-2Mi-4.000Mi.bin: Sending chunk 2097152 length 2097152 2022/04/20 05:12:46 DEBUG : chunked-2Mi-4.000Mi.bin: Sending chunk 4194304 length 1 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2022/04/20 05:12:50 DEBUG : unknown-size-put.txt: Sending chunk 0 length 100 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2022/04/20 05:12:55 DEBUG : unknown-size-update.txt: Sending chunk 0 length 200 === RUN TestIntegration/FsMkdir/FsRootCollapse 2022/04/20 05:12:58 DEBUG : Creating backend with remote "TestDrive:rclone-test-jazitit7mekigox5qemiweg9/deeper/nonexisting/directory" === RUN TestIntegration/FsShutdown fstests.go:2003: Shutdown method not supported --- PASS: TestIntegration (388.48s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.32s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.01s) --- PASS: TestIntegration/FsMkdir (385.28s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (5.45s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.25s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.27s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.28s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.28s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding (114.88s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (5.75s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (5.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (5.50s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (5.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (5.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (6.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (7.72s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (5.83s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (6.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (5.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (5.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (5.74s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (6.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (5.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (5.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (9.50s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (5.56s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (5.45s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (7.56s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.52s) --- PASS: TestIntegration/FsMkdir/FsPutError (5.31s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (4.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsChangeNotify (22.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (162.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (2.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (3.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (5.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (3.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (14.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (13.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (2.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (3.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (3.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (17.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (9.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (5.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (2.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (11.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (2.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (5.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (2.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (2.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (46.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport (7.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate (3.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate/DocumentExport (1.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/DocumentImport/DocumentUpdate/DocumentExport/DocumentLink (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts (14.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Errors (1.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/File (2.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Dir (5.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Shortcuts/Command (4.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UnTrash (13.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID (2.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/BadID (0.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/Directory (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/WithoutDestName (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CopyID/WithDestName (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/AgeQuery (8.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (56.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/256Ki (13.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/256Ki/262143 (3.92s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/256Ki/262144 (5.38s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/256Ki/524289 (4.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/512Ki (14.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/512Ki/524287 (3.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/512Ki/524288 (6.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/512Ki/1048577 (4.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/1Mi (13.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/1Mi/1048575 (5.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/1Mi/1048576 (4.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/1Mi/2097153 (4.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2Mi (14.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2Mi/2097151 (5.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2Mi/2097152 (4.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2Mi/4194305 (4.47s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (8.35s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.40s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (5.95s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.25s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/drive 388.489s "go test -v -timeout 1h0m0s -remote TestDrive: -verbose" - Finished OK in 6m29.337960716s (try 1/5)