"go test -v -timeout 30m0s -remote TestCryptDrive: -verbose" - Starting (try 1/5) === RUN TestNewNameEncryptionMode --- PASS: TestNewNameEncryptionMode (0.00s) === RUN TestNewNameEncryptionModeString --- PASS: TestNewNameEncryptionModeString (0.00s) === RUN TestEncodeFileName --- PASS: TestEncodeFileName (0.00s) === RUN TestDecodeFileName --- PASS: TestDecodeFileName (0.00s) === RUN TestEncryptSegment --- PASS: TestEncryptSegment (0.00s) === RUN TestDecryptSegment --- PASS: TestDecryptSegment (0.00s) === RUN TestEncryptFileName --- PASS: TestEncryptFileName (0.00s) === RUN TestDecryptFileName --- PASS: TestDecryptFileName (0.00s) === RUN TestEncDecMatches --- PASS: TestEncDecMatches (0.00s) === RUN TestEncryptDirName --- PASS: TestEncryptDirName (0.00s) === RUN TestDecryptDirName --- PASS: TestDecryptDirName (0.00s) === RUN TestEncryptedSize --- PASS: TestEncryptedSize (0.00s) === RUN TestDecryptedSize --- PASS: TestDecryptedSize (0.00s) === RUN TestNoncePointer --- PASS: TestNoncePointer (0.00s) === RUN TestNonceFromReader --- PASS: TestNonceFromReader (0.00s) === RUN TestNonceFromBuf --- PASS: TestNonceFromBuf (0.00s) === RUN TestNonceIncrement --- PASS: TestNonceIncrement (0.00s) === RUN TestNonceAdd --- PASS: TestNonceAdd (0.00s) === RUN TestRandomSource --- PASS: TestRandomSource (0.58s) === RUN TestEncryptDecrypt1 --- PASS: TestEncryptDecrypt1 (0.76s) === RUN TestEncryptDecrypt32 --- PASS: TestEncryptDecrypt32 (1.14s) === RUN TestEncryptDecrypt4096 --- PASS: TestEncryptDecrypt4096 (0.96s) === RUN TestEncryptDecrypt65536 --- PASS: TestEncryptDecrypt65536 (0.98s) === RUN TestEncryptDecrypt65537 --- PASS: TestEncryptDecrypt65537 (1.00s) === RUN TestEncryptData --- PASS: TestEncryptData (0.00s) === RUN TestNewEncrypter --- PASS: TestNewEncrypter (0.00s) === RUN TestNewEncrypterErrUnexpectedEOF --- PASS: TestNewEncrypterErrUnexpectedEOF (0.00s) === RUN TestNewDecrypter --- PASS: TestNewDecrypter (0.00s) === RUN TestNewDecrypterErrUnexpectedEOF --- PASS: TestNewDecrypterErrUnexpectedEOF (0.00s) === RUN TestNewDecrypterSeekLimit --- PASS: TestNewDecrypterSeekLimit (0.23s) === RUN TestDecrypterCalculateUnderlying --- PASS: TestDecrypterCalculateUnderlying (0.00s) === RUN TestDecrypterRead --- PASS: TestDecrypterRead (0.00s) === RUN TestDecrypterClose --- PASS: TestDecrypterClose (0.00s) === RUN TestPutGetBlock --- PASS: TestPutGetBlock (0.00s) === RUN TestKey --- PASS: TestKey (0.28s) === RUN TestIntegration === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsRmdirNotFound 2019/10/12 05:36:08 DEBUG : : Rmdir: contains file: "rclone-test-yozuwow6pocakuc0fenizez4" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2019/10/12 05:36:11 DEBUG : dir/subdir: Making directory 2019/10/12 05:36:14 DEBUG : dir/subdir: Removing directory 2019/10/12 05:36:15 DEBUG : dir: Removing directory 2019/10/12 05:36:15 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "i24n0ln37pa2hv8pctddeuh73o" === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound 2019/10/12 05:36:17 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound 2019/10/12 05:36:17 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars 2019/10/12 05:36:21 DEBUG : f5e9c92esko9m26sej116anh5babi4i0al2vne0nmg9mvm0d1b9nq1ttlhvs75nh03n25mqg1vfrohsj7ua930ba4p3c4g405vd56tmte6ccvf24guul4t5gib4nm25g5l7cglg1lpefefuvubu655p01tsluhjl8jduu4dtjlour146bad0: Rmdir: contains trashed file: "f5e9c92esko9m26sej116anh5babi4i0al2vne0nmg9mvm0d1b9nq1ttlhvs75nh03n25mqg1vfrohsj7ua930ba4p3c4g405vd56tmte6ccvf24guul4t5gib4nm25g5l7cglg1lpefefuvubu655p01tsluhjl8jduu4dtjlour146bad0" === RUN TestIntegration/FsMkdir/FsEncoding/dot 2019/10/12 05:37:02 DEBUG : do1eshp7fq66o1l1ei9pomlig8: Rmdir: contains trashed file: "do1eshp7fq66o1l1ei9pomlig8" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot 2019/10/12 05:37:06 DEBUG : msnn42iarlnl4kchlpfbl49rq0: Rmdir: contains trashed file: "msnn42iarlnl4kchlpfbl49rq0" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation 2019/10/12 05:37:10 DEBUG : hassubu97i2ift2pggdbt1cfp876l53bceemu9btjavl43jthqj7tasdbcmte4busfs27dmocs8na: Rmdir: contains trashed file: "hassubu97i2ift2pggdbt1cfp876l53bceemu9btjavl43jthqj7tasdbcmte4busfs27dmocs8na" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space 2019/10/12 05:37:15 DEBUG : igstt54k5qp9e549r6pqm35hl8: Rmdir: contains trashed file: "igstt54k5qp9e549r6pqm35hl8" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde 2019/10/12 05:37:20 DEBUG : nevsnko0v27og2qt2iomj9cbi4: Rmdir: contains trashed file: "nevsnko0v27og2qt2iomj9cbi4" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR 2019/10/12 05:37:25 DEBUG : a2h0eu6un2623343gk1tqj6ut4: Rmdir: contains trashed file: "a2h0eu6un2623343gk1tqj6ut4" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF 2019/10/12 05:37:30 DEBUG : u529vt6ubothc7lvqh76rsb288: Rmdir: contains trashed file: "u529vt6ubothc7lvqh76rsb288" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT 2019/10/12 05:37:35 DEBUG : uhsh7ikeumar00etd5nibokc00: Rmdir: contains trashed file: "uhsh7ikeumar00etd5nibokc00" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT 2019/10/12 05:37:39 DEBUG : 5k8glf8j137rtplh8pf777kc6k: Rmdir: contains trashed file: "5k8glf8j137rtplh8pf777kc6k" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot 2019/10/12 05:37:44 DEBUG : hc8mhlb9r1e05buvff53j7ps94: Rmdir: contains trashed file: "hc8mhlb9r1e05buvff53j7ps94" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space 2019/10/12 05:37:48 DEBUG : 85pi11ntdsjcdjq56s37obj3k8: Rmdir: contains trashed file: "85pi11ntdsjcdjq56s37obj3k8" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR 2019/10/12 05:37:53 DEBUG : 0e6sh7hqlktdhvg6jk5u8d06u0: Rmdir: contains trashed file: "0e6sh7hqlktdhvg6jk5u8d06u0" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF 2019/10/12 05:38:24 DEBUG : 90oud4k3ofajhl43rm1o73dvd8: Rmdir: contains trashed file: "90oud4k3ofajhl43rm1o73dvd8" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT 2019/10/12 05:38:29 DEBUG : dfr970d3hh9t7tp17e6s5eukfk: Rmdir: contains trashed file: "dfr970d3hh9t7tp17e6s5eukfk" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT 2019/10/12 05:38:33 DEBUG : pd7ls3vh3ccrv2ib1dd61189cc: Rmdir: contains trashed file: "pd7ls3vh3ccrv2ib1dd61189cc" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot 2019/10/12 05:38:38 DEBUG : fmlmh67m08l9reo4o1doaon9i4: Rmdir: contains trashed file: "fmlmh67m08l9reo4o1doaon9i4" === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 2019/10/12 05:38:43 DEBUG : toetsandc7pe3o6afhhq1cvja4: Rmdir: contains trashed file: "toetsandc7pe3o6afhhq1cvja4" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt === RUN TestIntegration/FsMkdir/FsChangeNotify 2019/10/12 05:38:52 DEBUG : dir: Making directory 2019/10/12 05:38:53 DEBUG : dir/subdir1: Making directory 2019/10/12 05:38:54 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:54 DEBUG : dir/subdir3: Making directory 2019/10/12 05:38:54 DEBUG : doChangeNotify("dir", 2) 2019/10/12 05:38:55 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:55 DEBUG : dir/subdir2: Making directory 2019/10/12 05:38:55 DEBUG : doChangeNotify("dir/subdir1", 2) 2019/10/12 05:38:56 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:56 DEBUG : doChangeNotify("dir/subdir3", 2) 2019/10/12 05:38:57 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:57 DEBUG : doChangeNotify("dir/subdir2", 2) 2019/10/12 05:38:58 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:58 DEBUG : doChangeNotify("dir/file2", 3) 2019/10/12 05:38:59 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:38:59 DEBUG : doChangeNotify("dir/file4", 3) 2019/10/12 05:39:00 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:01 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:01 DEBUG : doChangeNotify("dir/file3", 3) 2019/10/12 05:39:02 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:03 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:04 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:05 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:05 DEBUG : doChangeNotify("dir/file2", 3) 2019/10/12 05:39:06 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:06 DEBUG : doChangeNotify("dir/file4", 3) 2019/10/12 05:39:06 DEBUG : doChangeNotify("dir/file3", 3) 2019/10/12 05:39:07 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:07 DEBUG : doChangeNotify("dir/subdir1", 2) 2019/10/12 05:39:08 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': Checking for changes on remote 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "633fmaa0qic3kv3cladnu11pto" 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "amq3bkuqh8mg4ohnbs2i3185uk" 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "d26uovf0miqhd1mu3c9jbseq00" 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "9ttr6ktchp8s75c384iri950b4" 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "6lcfeqjd564osl9cuhasslpeto" 2019/10/12 05:39:08 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "hpv9vbsl47o6lm8alr8q8b1m60" 2019/10/12 05:39:08 DEBUG : doChangeNotify("dir/subdir3", 2) 2019/10/12 05:39:08 DEBUG : doChangeNotify("dir/subdir2", 2) === RUN TestIntegration/FsMkdir/FsPutFiles === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 2019/10/12 05:39:15 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) 2019/10/12 05:39:15 DEBUG : pacer: Rate limited, increasing sleep to 1.819605515s 2019/10/12 05:39:15 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) 2019/10/12 05:39:15 DEBUG : pacer: Rate limited, increasing sleep to 2.740167265s 2019/10/12 05:39:17 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2019/10/12 05:39:23 DEBUG : Copy of hf05pq3u0r89bgo8rs66mb5f38: Skipping undecryptable file name: illegal base32 data at input byte 3 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2019/10/12 05:39:24 DEBUG : Copy of hf05pq3u0r89bgo8rs66mb5f38: Skipping undecryptable file name: illegal base32 data at input byte 3 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2019/10/12 05:40:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-verecub7kanofat9guqodec8': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2019/10/12 05:40:02 DEBUG : : Rmdir: contains trashed file: "jvrdogrnrblgdk6svqeu791rdk" 2019/10/12 05:40:02 DEBUG : : Rmdir: contains trashed file: "gbh5ioi619nhbt6teh71jdbef8" 2019/10/12 05:40:02 DEBUG : : Rmdir: contains file: "96gujs4dkgufj2s2d5t6mkrddg" === 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 === 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 === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR 2019/10/12 05:40:21 DEBUG : Copy of hf05pq3u0r89bgo8rs66mb5f38: Skipping undecryptable file name: illegal base32 data at input byte 3 === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2019/10/12 05:40:26 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share single file '80abn8ft86uthvulkui23octdeuodrrspkhsk4hav33t59ipblug' 2019/10/12 05:40:27 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share single file 'nolduc6vng08379n9fboa9fqe4' 2019/10/12 05:40:29 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share single file '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0/u4ipppammbskorbmr2jnsktems' 2019/10/12 05:40:30 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share single file 'nolduc6vng08379n9fboa9fqe4' 2019/10/12 05:40:31 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share directory '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0' 2019/10/12 05:40:33 DEBUG : Google drive root 'crypt/9a1d1v4son5lf6ak0ltolf4no0515t9l452lir6sik0as53q89ghnsfgqoftmmdihjh9jlo2pu5fc': attempting to share directory '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0' 2019/10/12 05:40:37 DEBUG : Google drive root 'crypt/qp2sbl2a6gpl58lc46tm2g5b3q8uop3hcv9ub1pe0ktjfqpdcgfproekcedh9po0vlgs8j2tcmkse': attempting to share directory '' 2019/10/12 05:40:38 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-dobacuc4wifaxah0joyozic2': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize === RUN TestIntegration/FsMkdir/FsRootCollapse --- PASS: TestIntegration (291.43s) fstests.go:350: Using remote "TestCryptDrive:" --- PASS: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (4.12s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.68s) --- PASS: TestIntegration/FsMkdir (283.46s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (4.91s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.23s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.21s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.19s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.21s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding (146.45s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (4.54s) fstests.go:574: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (40.75s) fstests.go:574: testing "．" --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (4.18s) fstests.go:574: testing "．．" --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (4.21s) fstests.go:574: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (4.60s) fstests.go:574: testing " leading space" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (5.30s) fstests.go:574: testing "~leading tilde" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (5.12s) fstests.go:574: testing "␍leading CR" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (4.38s) fstests.go:574: testing "␊leading LF" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (5.00s) fstests.go:574: testing "␉leading HT" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (4.86s) fstests.go:574: testing "␋leading VT" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (4.17s) fstests.go:574: testing ".leading dot" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (4.28s) fstests.go:574: testing "trailing space " --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (4.63s) fstests.go:574: testing "trailing CR␍" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (31.57s) fstests.go:574: testing "trailing LF␊" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (4.67s) fstests.go:574: testing "trailing HT␉" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (4.33s) fstests.go:574: testing "trailing VT␋" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (5.28s) fstests.go:574: testing "trailing dot." --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (4.39s) fstests.go:574: testing "invalid utf-8\xfe" --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.48s) --- PASS: TestIntegration/FsMkdir/FsPutError (4.99s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (2.66s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) fstests.go:647: FS has no OpenWriterAt interface --- PASS: TestIntegration/FsMkdir/FsChangeNotify (16.71s) fstests.go:746: Try 1/10 waiting for dirChanges and objChanges --- PASS: TestIntegration/FsMkdir/FsPutFiles (94.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (5.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (1.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (9.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (12.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (9.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.24s) fstests.go:1190: MimeType method not supported --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (2.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (2.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (3.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.38s) fstests.go:1343: Opening root remote "TestCryptDrive:" path "rclone-test-xuzeten8kogijuv0jipidet5" from "TestCryptDrive:rclone-test-xuzeten8kogijuv0jipidet5" --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (4.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (12.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) fstests.go:329: FS has no SetTier & GetTier interfaces --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (2.40s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) fstests.go:1607: *crypt.Fs does not implement InternalTester --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) fstests.go:1624: *crypt.Fs does not implement SetUploadChunkSizer --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (5.85s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.98s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (3.87s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.97s) === RUN TestStandard --- SKIP: TestStandard (0.00s) crypt_test.go:34: Skipping as -remote set === RUN TestOff --- SKIP: TestOff (0.00s) crypt_test.go:55: Skipping as -remote set === RUN TestObfuscate --- SKIP: TestObfuscate (0.00s) crypt_test.go:76: Skipping as -remote set PASS ok github.com/rclone/rclone/backend/crypt 297.375s "go test -v -timeout 30m0s -remote TestCryptDrive: -verbose" - Finished OK in 4m59.981223561s (try 1/5)