"go test -v -timeout 1h0m0s -remote TestCryptDrive: -verbose" - Starting (try 1/5)
=== RUN   TestNewNameEncryptionMode
--- PASS: TestNewNameEncryptionMode (0.00s)
=== RUN   TestNewNameEncryptionModeString
--- PASS: TestNewNameEncryptionModeString (0.00s)
=== RUN   TestEncodeFileNameBase32
--- PASS: TestEncodeFileNameBase32 (0.00s)
=== RUN   TestEncodeFileNameBase64
--- PASS: TestEncodeFileNameBase64 (0.00s)
=== RUN   TestEncodeFileNameBase32768
--- PASS: TestEncodeFileNameBase32768 (0.00s)
=== RUN   TestDecodeFileNameBase32
--- PASS: TestDecodeFileNameBase32 (0.00s)
=== RUN   TestDecodeFileNameBase64
--- PASS: TestDecodeFileNameBase64 (0.00s)
=== RUN   TestDecodeFileNameBase32768
--- PASS: TestDecodeFileNameBase32768 (0.00s)
=== RUN   TestEncryptSegmentBase32
--- PASS: TestEncryptSegmentBase32 (0.00s)
=== RUN   TestEncryptSegmentBase64
--- PASS: TestEncryptSegmentBase64 (0.00s)
=== RUN   TestEncryptSegmentBase32768
--- PASS: TestEncryptSegmentBase32768 (0.00s)
=== RUN   TestDecryptSegmentBase32
--- PASS: TestDecryptSegmentBase32 (0.00s)
=== RUN   TestDecryptSegmentBase64
--- PASS: TestDecryptSegmentBase64 (0.00s)
=== RUN   TestDecryptSegmentBase32768
--- PASS: TestDecryptSegmentBase32768 (0.00s)
=== RUN   TestStandardEncryptFileNameBase32
--- PASS: TestStandardEncryptFileNameBase32 (0.00s)
=== RUN   TestStandardEncryptFileNameBase64
--- PASS: TestStandardEncryptFileNameBase64 (0.00s)
=== RUN   TestStandardEncryptFileNameBase32768
--- PASS: TestStandardEncryptFileNameBase32768 (0.00s)
=== RUN   TestNonStandardEncryptFileName
--- PASS: TestNonStandardEncryptFileName (0.00s)
=== RUN   TestStandardDecryptFileNameBase32
--- PASS: TestStandardDecryptFileNameBase32 (0.00s)
=== RUN   TestStandardDecryptFileNameBase64
--- PASS: TestStandardDecryptFileNameBase64 (0.00s)
=== RUN   TestStandardDecryptFileNameBase32768
--- PASS: TestStandardDecryptFileNameBase32768 (0.00s)
=== RUN   TestNonStandardDecryptFileName
--- PASS: TestNonStandardDecryptFileName (0.00s)
=== RUN   TestEncDecMatches
--- PASS: TestEncDecMatches (0.00s)
=== RUN   TestStandardEncryptDirNameBase32
--- PASS: TestStandardEncryptDirNameBase32 (0.00s)
=== RUN   TestStandardEncryptDirNameBase64
--- PASS: TestStandardEncryptDirNameBase64 (0.00s)
=== RUN   TestStandardEncryptDirNameBase32768
--- PASS: TestStandardEncryptDirNameBase32768 (0.00s)
=== RUN   TestNonStandardEncryptDirName
--- PASS: TestNonStandardEncryptDirName (0.00s)
=== RUN   TestStandardDecryptDirNameBase32
--- PASS: TestStandardDecryptDirNameBase32 (0.00s)
=== RUN   TestStandardDecryptDirNameBase64
--- PASS: TestStandardDecryptDirNameBase64 (0.00s)
=== RUN   TestStandardDecryptDirNameBase32768
--- PASS: TestStandardDecryptDirNameBase32768 (0.00s)
=== RUN   TestNonStandardDecryptDirName
--- PASS: TestNonStandardDecryptDirName (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.68s)
=== RUN   TestEncryptDecrypt1
--- PASS: TestEncryptDecrypt1 (0.27s)
=== RUN   TestEncryptDecrypt32
--- PASS: TestEncryptDecrypt32 (1.00s)
=== RUN   TestEncryptDecrypt4096
--- PASS: TestEncryptDecrypt4096 (0.97s)
=== RUN   TestEncryptDecrypt65536
--- PASS: TestEncryptDecrypt65536 (0.96s)
=== RUN   TestEncryptDecrypt65537
--- PASS: TestEncryptDecrypt65537 (0.94s)
=== 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.18s)
=== RUN   TestDecrypterCalculateUnderlying
--- PASS: TestDecrypterCalculateUnderlying (0.00s)
=== RUN   TestDecrypterRead
2025/09/30 01:42:42 ERROR : crypt: ignoring: failed to authenticate decrypted block - bad password?
--- PASS: TestDecrypterRead (0.00s)
=== RUN   TestDecrypterClose
--- PASS: TestDecrypterClose (0.00s)
=== RUN   TestPutGetBlock
--- PASS: TestPutGetBlock (0.00s)
=== RUN   TestKey
--- PASS: TestKey (0.25s)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestCryptDrive:"
2025/09/30 01:42:43 NOTICE: TestCryptDrive: Starting server
2025/09/30 01:42:43 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo"
2025/09/30 01:42:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/30 01:42:43 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg"
=== RUN   TestIntegration/FsCheckWrap
=== 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
2025/09/30 01:42:47 INFO  : dir/subdir: Making directory
2025/09/30 01:42:50 INFO  : dir/subdir: Removing directory
2025/09/30 01:42:51 INFO  : dir: Removing directory
2025/09/30 01:42:51 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "i24n0ln37pa2hv8pctddeuh73o"
=== RUN   TestIntegration/FsMkdir/FsListEmpty
=== RUN   TestIntegration/FsMkdir/FsListDirEmpty
=== RUN   TestIntegration/FsMkdir/FsListRDirEmpty
=== RUN   TestIntegration/FsMkdir/FsListDirNotFound
2025/09/30 01:42:53 ERROR : does not exist: error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsListRDirNotFound
2025/09/30 01:42:53 ERROR : does not exist: error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsEncoding
=== RUN   TestIntegration/FsMkdir/FsEncoding/control_chars
    fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
2025/09/30 01:42:56 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: md5 = f1ef5a89016c0b45511bc3b290e71b61 OK
2025/09/30 01:42:57 DEBUG : f5e9c92esko9m26sej116anh5babi4i0al2vne0nmg9mvm0d1b9nq1ttlhvs75nh03n25mqg1vfrohsj7ua930ba4p3c4g405vd56tmte6ccvf24guul4t5gib4nm25g5l7cglg1lpefefuvubu655p01tsluhjl8jduu4dtjlour146bad0: Rmdir: contains trashed file: "f5e9c92esko9m26sej116anh5babi4i0al2vne0nmg9mvm0d1b9nq1ttlhvs75nh03n25mqg1vfrohsj7ua930ba4p3c4g405vd56tmte6ccvf24guul4t5gib4nm25g5l7cglg1lpefefuvubu655p01tsluhjl8jduu4dtjlour146bad0"
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/09/30 01:43:00 DEBUG : ．/．: md5 = 94d17a70c0e25accce62ec1027279662 OK
2025/09/30 01:43:02 DEBUG : do1eshp7fq66o1l1ei9pomlig8: Rmdir: contains trashed file: "do1eshp7fq66o1l1ei9pomlig8"
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/09/30 01:43:05 DEBUG : ．．/．．: md5 = 5d7bd87469c0fe1f513c3b74080cebf7 OK
2025/09/30 01:43:06 DEBUG : msnn42iarlnl4kchlpfbl49rq0: Rmdir: contains trashed file: "msnn42iarlnl4kchlpfbl49rq0"
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/09/30 01:43:09 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: md5 = 6e6eed5eb0146865b195071a058b4a00 OK
2025/09/30 01:43:11 DEBUG : hassubu97i2ift2pggdbt1cfp876l53bceemu9btjavl43jthqj7tasdbcmte4busfs27dmocs8na: Rmdir: contains trashed file: "hassubu97i2ift2pggdbt1cfp876l53bceemu9btjavl43jthqj7tasdbcmte4busfs27dmocs8na"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/09/30 01:43:14 DEBUG :  leading space/ leading space: md5 = b05764725199950db2490045a28460c9 OK
2025/09/30 01:43:15 DEBUG : igstt54k5qp9e549r6pqm35hl8: Rmdir: contains trashed file: "igstt54k5qp9e549r6pqm35hl8"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:707: testing "~leading tilde"
2025/09/30 01:43:18 DEBUG : ~leading tilde/~leading tilde: md5 = 931f0c44013030d37b6ddf93520c9d05 OK
2025/09/30 01:43:20 DEBUG : nevsnko0v27og2qt2iomj9cbi4: Rmdir: contains trashed file: "nevsnko0v27og2qt2iomj9cbi4"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:707: testing "␍leading CR"
2025/09/30 01:43:23 DEBUG : ␍leading CR/␍leading CR: md5 = 478abb06b87db3e8115b6b906e083167 OK
2025/09/30 01:43:24 DEBUG : a2h0eu6un2623343gk1tqj6ut4: Rmdir: contains trashed file: "a2h0eu6un2623343gk1tqj6ut4"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:707: testing "␊leading LF"
2025/09/30 01:43:27 DEBUG : ␊leading LF/␊leading LF: md5 = 9139e41e178720336181b94a26dbbd42 OK
2025/09/30 01:43:28 DEBUG : u529vt6ubothc7lvqh76rsb288: Rmdir: contains trashed file: "u529vt6ubothc7lvqh76rsb288"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:707: testing "␉leading HT"
2025/09/30 01:43:31 DEBUG : ␉leading HT/␉leading HT: md5 = f6ec94dd400c344f4f5558f2b798cfce OK
2025/09/30 01:43:33 DEBUG : uhsh7ikeumar00etd5nibokc00: Rmdir: contains trashed file: "uhsh7ikeumar00etd5nibokc00"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:707: testing "␋leading VT"
2025/09/30 01:43:36 DEBUG : ␋leading VT/␋leading VT: md5 = 098d1ba469aa8711bdaccc21d7fb6453 OK
2025/09/30 01:43:37 DEBUG : 5k8glf8j137rtplh8pf777kc6k: Rmdir: contains trashed file: "5k8glf8j137rtplh8pf777kc6k"
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:707: testing ".leading dot"
2025/09/30 01:43:40 DEBUG : .leading dot/.leading dot: md5 = 3c97f12691ccc37251e34bbaf41ec0a9 OK
2025/09/30 01:43:42 DEBUG : hc8mhlb9r1e05buvff53j7ps94: Rmdir: contains trashed file: "hc8mhlb9r1e05buvff53j7ps94"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:707: testing "trailing space "
2025/09/30 01:43:45 DEBUG : trailing space /trailing space : md5 = e61f5a4881a20b7995ea5a057312cbb8 OK
2025/09/30 01:43:46 DEBUG : 85pi11ntdsjcdjq56s37obj3k8: Rmdir: contains trashed file: "85pi11ntdsjcdjq56s37obj3k8"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:707: testing "trailing CR␍"
2025/09/30 01:43:49 DEBUG : trailing CR␍/trailing CR␍: md5 = b65aa3621378c5176e6db967bc3129ab OK
2025/09/30 01:43:51 DEBUG : 0e6sh7hqlktdhvg6jk5u8d06u0: Rmdir: contains trashed file: "0e6sh7hqlktdhvg6jk5u8d06u0"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:707: testing "trailing LF␊"
2025/09/30 01:43:54 DEBUG : trailing LF␊/trailing LF␊: md5 = 63d50f579d0574bfe25f74c5a4a0caa7 OK
2025/09/30 01:43:55 DEBUG : 90oud4k3ofajhl43rm1o73dvd8: Rmdir: contains trashed file: "90oud4k3ofajhl43rm1o73dvd8"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:707: testing "trailing HT␉"
2025/09/30 01:43:58 DEBUG : trailing HT␉/trailing HT␉: md5 = 358b212bc0b3aeb6b9a4671dd6d03abf OK
2025/09/30 01:44:00 DEBUG : dfr970d3hh9t7tp17e6s5eukfk: Rmdir: contains trashed file: "dfr970d3hh9t7tp17e6s5eukfk"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:707: testing "trailing VT␋"
2025/09/30 01:44:03 DEBUG : trailing VT␋/trailing VT␋: md5 = 3590e1ee61d58f0d498d8dc18c94ff9c OK
2025/09/30 01:44:05 DEBUG : pd7ls3vh3ccrv2ib1dd61189cc: Rmdir: contains trashed file: "pd7ls3vh3ccrv2ib1dd61189cc"
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:707: testing "trailing dot."
2025/09/30 01:44:07 DEBUG : trailing dot./trailing dot.: md5 = 578fdd1e36c6017eb4501dcf448d2eb5 OK
2025/09/30 01:44:09 DEBUG : fmlmh67m08l9reo4o1doaon9i4: Rmdir: contains trashed file: "fmlmh67m08l9reo4o1doaon9i4"
=== RUN   TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
    fstests.go:707: testing "invalid utf-8\xfe"
2025/09/30 01:44:12 DEBUG : invalid utf-8�/invalid utf-8�: md5 = 4a6c6f02d8d18884983d014209500b57 OK
2025/09/30 01:44:13 DEBUG : toetsandc7pe3o6afhhq1cvja4: Rmdir: contains trashed file: "toetsandc7pe3o6afhhq1cvja4"
=== RUN   TestIntegration/FsMkdir/FsEncoding/URL_encoding
    fstests.go:707: testing "test%46.txt"
2025/09/30 01:44:16 DEBUG : test%46.txt/test%46.txt: md5 = 6badb71e68295833c18302d1f7901e40 OK
2025/09/30 01:44:18 DEBUG : eleoftpogh4o5ffkg9917cnfq4: Rmdir: contains trashed file: "eleoftpogh4o5ffkg9917cnfq4"
=== RUN   TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN   TestIntegration/FsMkdir/FsPutError
=== RUN   TestIntegration/FsMkdir/FsPutZeroLength
2025/09/30 01:44:24 DEBUG : zero-length-file: md5 = d27fd435c69c450eeb3059c30aa72042 OK
=== RUN   TestIntegration/FsMkdir/FsOpenWriterAt
    fstests.go:786: FS has no OpenWriterAt interface
=== RUN   TestIntegration/FsMkdir/FsOpenChunkWriter
    fstests.go:819: FS has no OpenChunkWriter interface
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/09/30 01:44:25 INFO  : dir: Making directory
2025/09/30 01:44:26 INFO  : dir/subdir1: Making directory
2025/09/30 01:44:27 INFO  : dir/subdir3: Making directory
2025/09/30 01:44:27 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:28 INFO  : dir/subdir2: Making directory
2025/09/30 01:44:28 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:29 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:30 DEBUG : dir/file2: md5 = d28d87b718ad75f59667e6a0ae81e426 OK
2025/09/30 01:44:30 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:31 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:32 DEBUG : dir/file4: md5 = 20b334d9c0f4444f5d1eedcb22852fb1 OK
2025/09/30 01:44:32 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:33 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:34 DEBUG : dir/file3: md5 = a060e405c62a3dfcc3b0dc9948aec2b3 OK
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/09/30 01:44:34 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:35 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:36 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/09/30 01:44:37 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:38 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:39 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/09/30 01:44:40 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:41 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:42 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/09/30 01:44:43 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:44 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:45 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/09/30 01:44:46 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:47 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:48 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/09/30 01:44:49 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:50 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:51 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:51 DEBUG : doChangeNotify("zero-length-file", 1)
2025/09/30 01:44:51 DEBUG : doChangeNotify("dir/file2", 1)
2025/09/30 01:44:51 DEBUG : doChangeNotify(" leading space", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify(".leading dot", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("dir/file3", 1)
2025/09/30 01:44:51 DEBUG : doChangeNotify("trailing CR␍", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("␋leading VT", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("trailing VT␋", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("hello? sausage", 0)
2025/09/30 01:44:51 DEBUG : Ignoring notify for file1 or file2: "hello? sausage", 0
2025/09/30 01:44:51 DEBUG : doChangeNotify("␊leading LF", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("dir", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("test%46.txt", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("．．", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("␍leading CR", 0)
2025/09/30 01:44:51 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0)
2025/09/30 01:44:51 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/09/30 01:44:52 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:52 DEBUG : doChangeNotify("dir/file4", 1)
2025/09/30 01:44:52 DEBUG : doChangeNotify("␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("．", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("~leading tilde", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("trailing dot.", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/09/30 01:44:52 DEBUG : doChangeNotify("trailing HT␉", 0)
2025/09/30 01:44:53 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:53 DEBUG : doChangeNotify("dir", 0)
2025/09/30 01:44:53 DEBUG : doChangeNotify("hello? sausage/êé", 0)
2025/09/30 01:44:53 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé", 0
2025/09/30 01:44:53 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界", 0)
2025/09/30 01:44:53 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界", 0
2025/09/30 01:44:53 DEBUG : doChangeNotify("trailing space ", 0)
2025/09/30 01:44:53 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/09/30 01:44:53 DEBUG : doChangeNotify("trailing LF␊", 0)
2025/09/30 01:44:53 DEBUG : doChangeNotify("invalid utf-8\xfe", 0)
2025/09/30 01:44:53 DEBUG : doChangeNotify("␉leading HT", 0)
2025/09/30 01:44:54 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:55 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:56 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:57 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:58 DEBUG : doChangeNotify("dir/file2", 1)
2025/09/30 01:44:58 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Checking for changes on remote
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "633fmaa0qic3kv3cladnu11pto"
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "amq3bkuqh8mg4ohnbs2i3185uk"
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "d26uovf0miqhd1mu3c9jbseq00"
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "9ttr6ktchp8s75c384iri950b4"
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "6lcfeqjd564osl9cuhasslpeto"
2025/09/30 01:44:59 DEBUG : gbh5ioi619nhbt6teh71jdbef8: Rmdir: contains trashed file: "hpv9vbsl47o6lm8alr8q8b1m60"
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/09/30 01:45:01 DEBUG : file name.txt: md5 = 03c8aa8ddf1892417ed15ff37099ed2e OK
2025/09/30 01:45:02 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: md5 = 5ba37279b27bf71cd00c8f6101835f21 OK
2025/09/30 01:45:04 DEBUG : file name.txt: md5 = e5fe00c3f408c4cfa220e30166f43ae0 OK
=== 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
2025/09/30 01:45:09 DEBUG : Creating backend with remote "TestCryptDrive:"
2025/09/30 01:45:09 DEBUG : Creating backend with remote "TestDrive:crypt"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
2025/09/30 01:45:10 DEBUG : Creating backend with remote "TestCryptDrive:"
=== 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/FsNewObjectCaseInsensitive
    fstests.go:1121: Not Case Insensitive
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurge
2025/09/30 01:45:18 DEBUG : dirToPurge/fileToPurge.txt: md5 = 07646c309fe876640c5610b2bd375374 OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/09/30 01:45:24 DEBUG : dirToPurgeFromRoot/fileToPurgeFromRoot.txt: md5 = 2019796122550cdf478b2c3031eda80e OK
2025/09/30 01:45:25 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo/dirToPurgeFromRoot"
2025/09/30 01:45:25 DEBUG : Config file has changed externally - reloading
2025/09/30 01:45:25 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/tvhnk8lggj1s3rabb486oe8ovivigpgp7blmvtprk7pv51ap3c60"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/09/30 01:45:28 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo/hello? sausage/êé"
2025/09/30 01:45:28 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k"
2025/09/30 01:45:33 DEBUG : a/b/c/d/e.txt: md5 = 7ac5d40ade2e69a34b81d9f4ef507df8 OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata
2025/09/30 01:45:40 DEBUG : test metadata copy.txt: md5 = aa8215bf55312717278ad5e4cea43a0b OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
2025/09/30 01:45:55 DEBUG : test metadata move.txt: md5 = c6ff76dcf82f8092ce2091f9cf554f0e OK
2025/09/30 01:45:55 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': Skipping btime metadata as can't update it on an existing file: 2025-09-30T01:45:54.918Z
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2025/09/30 01:45:58 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-wufubuc6woko"
2025/09/30 01:45:58 DEBUG : Creating backend with remote "TestDrive:crypt/e5jgef7vb00d20tq5ou9spogn3pnonkl3feg34d3940vo9p6sqf0"
2025/09/30 01:46:06 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-wufubuc6woko': Purge remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull
2025/09/30 01:46:07 DEBUG : Rmdir: contains trashed file: "jvrdogrnrblgdk6svqeu791rdk"
2025/09/30 01:46:07 DEBUG : Rmdir: contains trashed file: "tvhnk8lggj1s3rabb486oe8ovivigpgp7blmvtprk7pv51ap3c60"
2025/09/30 01:46:07 DEBUG : Rmdir: contains trashed file: "ruuqrs7tbf1d4t5glb6bcbp5rk"
2025/09/30 01:46:07 DEBUG : Rmdir: contains trashed file: "gbh5ioi619nhbt6teh71jdbef8"
2025/09/30 01:46:07 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/ObjectMetadata
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime
2025/09/30 01:46:10 DEBUG : metadatatest: md5 = 0c18365a452ed708d958247332ceadc7 OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata
2025/09/30 01:46:13 DEBUG : test set metadata.txt: md5 = 0b9017350bd08fb203406393cc367e0d OK
    fstests.go:1728: SetMetadata returned fs.ErrorNotImplemented
=== 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
2025/09/30 01:46:26 DEBUG : file name.txt-should-be-ignored.bin: md5 = 6247f19b8ad06daa0f959b08b2d0dbbd OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/09/30 01:46:27 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/09/30 01:46:27 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0/u4ipppammbskorbmr2jnsktems"
2025/09/30 01:46:31 DEBUG : fs cache: renaming child cache item "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0/u4ipppammbskorbmr2jnsktems" to be canonical for parent "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/09/30 01:46:31 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo/not found.txt"
2025/09/30 01:46:31 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/jgn01lqi50h78b6hoirrg20eko"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestCryptDrive:" path "rclone-test-bujoziw2jalo" from "TestCryptDrive:rclone-test-bujoziw2jalo"
2025/09/30 01:46:33 DEBUG : Creating backend with remote "TestCryptDrive:"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2025/09/30 01:46:38 DEBUG : rclone-test-bujoziw2jalo/created from root.txt: md5 = 4c069cebf2a2ed5aa4ab63835c50ad02 OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/PublicLink
2025/09/30 01:46:41 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share single file '80abn8ft86uthvulkui23octdeuodrrspkhsk4hav33t59ipblug'
2025/09/30 01:46:42 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share single file 'nolduc6vng08379n9fboa9fqe4'
2025/09/30 01:46:43 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share single file '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0/u4ipppammbskorbmr2jnsktems'
2025/09/30 01:46:45 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share single file 'nolduc6vng08379n9fboa9fqe4'
2025/09/30 01:46:46 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share directory '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0'
2025/09/30 01:46:46 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share directory '96gujs4dkgufj2s2d5t6mkrddg/elopgm497i0kjatjjfeqjhvg4k/ua43qrl1hugkmo9sgaaa6fljgg/m9faeqldhkv5r8aeijp7g9s9kil7gn2l3rsj9l43nb06fnhu09r0'
2025/09/30 01:46:47 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-covugok8yubi"
2025/09/30 01:46:47 DEBUG : Creating backend with remote "TestDrive:crypt/6ii97qfcfrerp12mbl7qh2kasqgejlg5iimqd536a6vonccf63t0"
2025/09/30 01:46:50 DEBUG : somefile: md5 = 61e29078aea2881a93827e2622a74376 OK
2025/09/30 01:46:51 DEBUG : Google drive root 'crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg': attempting to share directory ''
2025/09/30 01:46:51 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-covugok8yubi': Purge remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/SetTier
    fstests.go:412: FS has no SetTier & GetTier interfaces
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Bucket
    fstests.go:2125: Not a bucket based backend
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectAbout
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0
2025/09/30 01:46:55 DEBUG : cqiebell711479onsrbud2b5lc: Sending chunk 0 length 32
2025/09/30 01:46:56 DEBUG : piped data.txt: md5 = 8eb9246a3eb8099bd139fb6d540bc472 OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/09/30 01:46:58 DEBUG : cqiebell711479onsrbud2b5lc: Sending chunk 0 length 148
2025/09/30 01:46:59 DEBUG : piped data.txt: md5 = e7d2eba38b0a26dbe9339d3c2a16314f OK
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectInfo
2025/09/30 01:46:59 DEBUG : Creating backend with remote "/tmp/rclone-spool3770734747"
2025/09/30 01:46:59 DEBUG : hash_test_object: Computing md5 hash of encrypted source
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectInfoWrap
2025/09/30 01:46:59 DEBUG : Creating backend with remote "/tmp/rclone-spool1395787723"
2025/09/30 01:46:59 DEBUG : new_remote: Computing md5 hash of encrypted source
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ComputeHash
2025/09/30 01:46:59 DEBUG : Creating backend with remote "/tmp/rclone-spool1867471438"
2025/09/30 01:47:01 DEBUG : compute_hash_test: md5 = 5ce1602ca83d06371599168a3587baf9 OK
=== RUN   TestIntegration/FsMkdir/FsPutChunked
    fstests.go:2364: *crypt.Fs does not implement SetUploadChunkSizer
=== RUN   TestIntegration/FsMkdir/FsCopyChunked
    fstests.go:2485: *crypt.Fs does not implement SetCopyCutoff
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize
2025/09/30 01:47:03 DEBUG : 5t6fllu4sbjea82tuvhkr8g5779c8gu1qrjbjcj5lupfmsp501n0: Sending chunk 0 length 148
2025/09/30 01:47:04 DEBUG : unknown-size-put.txt: md5 = 56552bd62f2b413b78b046b326a31c06 OK
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/09/30 01:47:06 DEBUG : unknown-size-update.txt: md5 = e5537f24a30605ddd3de6f2c34a0c0a8 OK
2025/09/30 01:47:07 DEBUG : i60g7a9vietemeugj4vko3pcqb41or1fldle4lnp7rp5c64fh8ng: Sending chunk 0 length 248
2025/09/30 01:47:08 DEBUG : unknown-size-update.txt: md5 = caad7f36cd01ca4463c6c1cc8d61acf0 OK
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/09/30 01:47:08 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bujoziw2jalo/deeper/nonexisting/directory"
2025/09/30 01:47:09 DEBUG : Creating backend with remote "TestDrive:crypt/de7iq2fa74bffrmen66skplr7qkpiapf70eq57maehtqiv92bdlg/a8sv4gs52nbgdd9dahlimee280/fbehe2orn9mdrpoteiv7ibtqvo/486oifeu6kfc5kp8j3to8ir2s4"
=== RUN   TestIntegration/FsMkdir/FsDirSetModTime
=== RUN   TestIntegration/FsMkdir/FsMkdirMetadata
=== RUN   TestIntegration/FsMkdir/FsMkdirMetadata/Update
=== RUN   TestIntegration/FsMkdir/FsMkdirMetadata/CheckDirectory
=== RUN   TestIntegration/FsMkdir/FsDirectory
=== RUN   TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata
=== RUN   TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata
=== RUN   TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime
=== RUN   TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap
=== RUN   TestIntegration/FsShutdown
    fstests.go:2831: Shutdown method not supported
--- PASS: TestIntegration (276.81s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- PASS: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.24s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.71s)
    --- PASS: TestIntegration/FsMkdir (273.71s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (4.59s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.26s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.21s)
        --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.44s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.26s)
        --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.24s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (85.10s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (4.79s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (4.46s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (4.39s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (4.54s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (4.51s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (4.27s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (4.40s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (4.34s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (4.50s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (4.37s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (4.56s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (4.47s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (4.66s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (4.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (4.25s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (4.78s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (4.25s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (4.49s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (4.31s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.47s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (3.48s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (3.12s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsChangeNotify (33.71s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (123.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.22s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.20s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.15s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.71s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.36s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.54s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.47s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (1.21s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.22s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.25s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.26s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.24s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (5.46s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (6.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (7.45s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (8.57s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (5.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (13.94s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (4.21s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (9.10s)
            --- 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.23s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.23s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.25s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.28s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.21s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (2.35s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime (2.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (2.47s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.01s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.26s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.01s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.69s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (6.16s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.86s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (2.63s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.26s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (3.93s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.76s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.68s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.20s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.26s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (1.50s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (4.65s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (1.69s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (10.95s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.26s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (2.05s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.21s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (5.17s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (2.69s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (2.47s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (2.92s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectInfo (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectInfoWrap (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ComputeHash (2.91s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (6.16s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.17s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (3.99s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.86s)
        --- PASS: TestIntegration/FsMkdir/FsDirSetModTime (2.44s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirMetadata (2.40s)
            --- PASS: TestIntegration/FsMkdir/FsMkdirMetadata/Update (0.70s)
            --- PASS: TestIntegration/FsMkdir/FsMkdirMetadata/CheckDirectory (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (3.07s)
            --- PASS: TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata (0.69s)
            --- PASS: TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime (0.72s)
            --- PASS: TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsShutdown (0.00s)
=== RUN   TestStandardBase32
    crypt_test.go:35: Skipping as -remote set
--- SKIP: TestStandardBase32 (0.00s)
=== RUN   TestStandardBase64
    crypt_test.go:56: Skipping as -remote set
--- SKIP: TestStandardBase64 (0.00s)
=== RUN   TestStandardBase32768
    crypt_test.go:78: Skipping as -remote set
--- SKIP: TestStandardBase32768 (0.00s)
=== RUN   TestOff
    crypt_test.go:101: Skipping as -remote set
--- SKIP: TestOff (0.00s)
=== RUN   TestObfuscate
    crypt_test.go:123: Skipping as -remote set
--- SKIP: TestObfuscate (0.00s)
=== RUN   TestNoDataObfuscate
    crypt_test.go:149: Skipping as -remote set
--- SKIP: TestNoDataObfuscate (0.00s)
PASS
ok  	github.com/rclone/rclone/backend/crypt	282.090s
"go test -v -timeout 1h0m0s -remote TestCryptDrive: -verbose" - Finished OK in 4m43.803545673s (try 1/5)