"go test -v -timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^(FsEncoding|FsPutFiles)$/^(FromRoot|FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|ObjectRemove|control_chars|dot|dot_dot|invalid_UTF-8|leading_CR|leading_HT|leading_LF|leading_VT|leading_dot|leading_space|leading_tilde|punctuation|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$/^(List|ListEntries|Put)$/^Remove$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:396: Using remote "TestOpenDrive:"
2020/12/27 06:41:02 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cuhasos8vomuzas1qesayic9"
2020/12/27 06:41:03 DEBUG : Starting OpenDrive session with ID: 4b5cdfbe762d334cca33f0f217d2c4f9d2a7be62f2dbbbd83999f20d167e3ac4
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsEncoding
=== RUN   TestIntegration/FsMkdir/FsEncoding/control_chars
    fstests.go:644: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
2020/12/27 06:41:10 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:644: testing "．"
2020/12/27 06:41:21 DEBUG : ．/．: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:644: testing "．．"
2020/12/27 06:41:38 DEBUG : ．．/．．: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:644: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2020/12/27 06:42:27 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:644: testing " leading space"
2020/12/27 06:42:37 DEBUG :  leading space/ leading space: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:644: testing "~leading tilde"
2020/12/27 06:42:49 DEBUG : ~leading tilde/~leading tilde: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:644: testing "␍leading CR"
2020/12/27 06:42:59 DEBUG : ␍leading CR/␍leading CR: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:644: testing "␊leading LF"
2020/12/27 06:44:10 DEBUG : ␊leading LF/␊leading LF: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:644: testing "␉leading HT"
2020/12/27 06:44:48 DEBUG : ␉leading HT/␉leading HT: Uploading chunk 0, size=100, remain=0
2020/12/27 06:49:49 DEBUG : pacer: low level retry 1/10 (error Post "https://dev.opendrive.com/api/v1/upload/close_file_upload.json": net/http: timeout awaiting response headers)
2020/12/27 06:49:49 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2020/12/27 06:49:50 DEBUG : pacer: low level retry 2/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:50 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2020/12/27 06:49:51 DEBUG : pacer: low level retry 3/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:51 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2020/12/27 06:49:51 DEBUG : pacer: low level retry 4/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:51 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2020/12/27 06:49:52 DEBUG : pacer: low level retry 5/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:52 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2020/12/27 06:49:52 DEBUG : pacer: low level retry 6/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:52 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2020/12/27 06:49:53 DEBUG : pacer: low level retry 7/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:53 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2020/12/27 06:49:54 DEBUG : pacer: low level retry 8/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:54 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2020/12/27 06:49:55 DEBUG : pacer: low level retry 9/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:55 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2020/12/27 06:49:58 DEBUG : pacer: low level retry 10/10 (error This file is already being processed. Please wait until previous upload operation will be finished. (Error 423))
2020/12/27 06:49:58 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
    fstests.go:150: Put error: failed to create file: This file is already being processed. Please wait until previous upload operation will be finished. (Error 423) - low level retry 1/10
2020/12/27 06:50:10 DEBUG : pacer: Reducing sleep to 5.12s
2020/12/27 06:50:24 DEBUG : pacer: Reducing sleep to 2.56s
2020/12/27 06:50:24 DEBUG : ␉leading HT/␉leading HT: Uploading chunk 0, size=100, remain=0
2020/12/27 06:50:25 DEBUG : pacer: Reducing sleep to 1.28s
2020/12/27 06:51:38 DEBUG : pacer: Reducing sleep to 640ms
2020/12/27 06:51:38 DEBUG : pacer: Reducing sleep to 320ms
2020/12/27 06:51:39 DEBUG : pacer: Reducing sleep to 160ms
2020/12/27 06:51:39 DEBUG : pacer: Reducing sleep to 80ms
2020/12/27 06:51:43 DEBUG : pacer: Reducing sleep to 40ms
2020/12/27 06:51:44 DEBUG : pacer: Reducing sleep to 20ms
2020/12/27 06:51:44 DEBUG : pacer: Reducing sleep to 10ms
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:644: testing "␋leading VT"
2020/12/27 06:52:35 DEBUG : ␋leading VT/␋leading VT: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:644: testing ".leading dot"
2020/12/27 06:53:51 DEBUG : .leading dot/.leading dot: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:644: testing "trailing space "
2020/12/27 06:55:07 DEBUG : trailing space /trailing space : Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:644: testing "trailing CR␍"
2020/12/27 06:56:29 DEBUG : trailing CR␍/trailing CR␍: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:644: testing "trailing LF␊"
2020/12/27 06:57:01 DEBUG : trailing LF␊/trailing LF␊: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:644: testing "trailing HT␉"
2020/12/27 06:57:19 DEBUG : trailing HT␉/trailing HT␉: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:644: testing "trailing VT␋"
2020/12/27 07:00:01 DEBUG : trailing VT␋/trailing VT␋: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:644: testing "trailing dot."
2020/12/27 07:00:11 DEBUG : trailing dot./trailing dot.: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
    fstests.go:644: testing "invalid utf-8\xfe"
2020/12/27 07:02:22 DEBUG : invalid utf-8�/invalid utf-8�: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2020/12/27 07:02:32 DEBUG : file name.txt: Uploading chunk 0, size=100, remain=0
2020/12/27 07:02:45 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Uploading chunk 0, size=100, remain=0
2020/12/27 07:06:22 DEBUG : file name.txt: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurge
2020/12/27 07:10:56 DEBUG : dirToPurge/fileToPurge.txt: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2020/12/27 07:18:01 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-zudexoy5heyisop2guvubop4"
2020/12/27 07:18:02 DEBUG : Starting OpenDrive session with ID: eeaa218b9251b5000340f0ae67b7f0e7187800c2b77dbdb2cb849b2a1c5cb7fc
2020/12/27 07:18:20 DEBUG : OpenDrive root 'rclone-test-zudexoy5heyisop2guvubop4': Purge remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1466: Opening root remote "TestOpenDrive:" path "rclone-test-cuhasos8vomuzas1qesayic9" from "TestOpenDrive:rclone-test-cuhasos8vomuzas1qesayic9"
2020/12/27 07:18:21 DEBUG : Creating backend with remote "TestOpenDrive:"
2020/12/27 07:18:22 DEBUG : Starting OpenDrive session with ID: 36c4ba660f88e4111dee3c28664b901ea193ba1bbe229e7628a0632d8633ddc0
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2020/12/27 07:19:35 DEBUG : rclone-test-cuhasos8vomuzas1qesayic9/created from root.txt: Uploading chunk 0, size=100, remain=0
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
2020/12/27 07:25:16 ERROR : : error listing: directory not found
--- PASS: TestIntegration (2653.93s)
    --- PASS: TestIntegration/FsMkdir (2650.40s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (1283.27s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (10.20s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (10.61s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (47.45s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (19.09s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (10.50s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (10.82s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (10.64s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (80.62s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (439.36s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (70.97s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (66.99s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (85.96s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (87.59s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (17.84s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (162.64s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (9.90s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (130.13s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (11.36s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (1364.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (2.87s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (3.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (1.14s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (3.88s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.86s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (299.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (12.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (116.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (19.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (394.11s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (3.52s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.57s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (389.45s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.42s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (18.61s)
PASS
ok  	github.com/rclone/rclone/backend/opendrive	2653.944s
"go test -v -timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^(FsEncoding|FsPutFiles)$/^(FromRoot|FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|ObjectRemove|control_chars|dot|dot_dot|invalid_UTF-8|leading_CR|leading_HT|leading_LF|leading_VT|leading_dot|leading_space|leading_tilde|punctuation|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$/^(List|ListEntries|Put)$/^Remove$'" - Finished OK in 44m15.660059209s (try 2/5)