"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFichier: -verbose -test.run '^(TestDirForgetAll|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMethods)$'" - Starting (try 5/5)
=== RUN   TestDirHandleMethods
2020/07/24 14:20:50 INFO  : 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': poll-interval is not supported by this remote
2020/07/24 14:21:52 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=5NcAxoGDqF: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:21:52 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:21:55 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:21:59 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:23:03 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=IbZmZr1P1W: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:23:03 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:23:05 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:23:10 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:24:14 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=abbg7QGafK: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:24:14 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:24:16 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:24:21 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:25:25 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=UJfyIF9aEQ: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:25:25 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:25:27 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:25:32 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:26:35 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=JyK3edlXrW: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:26:35 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:26:38 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:26:43 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:27:46 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=FkJwKnI64g: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:27:46 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:27:48 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:27:53 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:28:57 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=uaJheD05WK: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:28:57 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:28:59 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:29:04 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:30:08 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=qm0NbCCcAr: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:30:08 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:30:10 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:30:15 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:31:18 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=9MOKAneDnu: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:31:18 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:31:21 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:31:26 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:32:29 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=Cz34Uf9bDZ: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:32:29 DEBUG : pacer: Rate limited, increasing sleep to 5s
--- FAIL: TestDirHandleMethods (699.55s)
    run.go:176: Remote "1Fichier root 'rclone-test-nameduy6remehav4heyisuc2'", Local "Local file system at /tmp/rclone254473194", Modify Window "876000h0m0s"
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 1/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=5NcAxoGDqF: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 2/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=IbZmZr1P1W: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 3/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=abbg7QGafK: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 4/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=UJfyIF9aEQ: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 5/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=JyK3edlXrW: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 6/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=FkJwKnI64g: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 7/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=uaJheD05WK: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 8/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=qm0NbCCcAr: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 9/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=9MOKAneDnu: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:282: Failed to put "dir/file1" to "1Fichier root 'rclone-test-nameduy6remehav4heyisuc2'": couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=Cz34Uf9bDZ: dial tcp 5.39.224.39:443: i/o timeout
=== RUN   TestDirHandleReaddir
2020/07/24 14:32:29 DEBUG : 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': Re-using VFS from active cache
2020/07/24 14:32:29 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:32:34 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:33:38 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=Ln7QWylsiS: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:33:38 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:33:40 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:33:45 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:34:49 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=pwolmI5GvS: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:34:49 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:34:51 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:34:56 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:36:00 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=sVWpsLJPn7: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:36:00 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:36:02 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:36:07 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:37:10 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=oFVWCYoqj4: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:37:10 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:37:12 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:37:17 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:38:21 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=7fekiMouqV: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:38:21 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:38:23 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:38:28 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:39:32 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=hRnu2B8G0L: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:39:32 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:39:34 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:39:39 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:40:43 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=RMj9uO5LsR: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:40:43 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:40:45 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:40:50 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:41:53 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=vpSyQg7yiL: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:41:53 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:41:55 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:42:00 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:43:04 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=yHhIEqOeW5: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:43:04 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:43:06 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:43:11 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:44:15 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=9Czl9IHXbk: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:44:15 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:44:15 DEBUG : WaitForWriters: timeout=10s
2020/07/24 14:44:15 DEBUG : : Looking for writers
2020/07/24 14:44:15 DEBUG : >WaitForWriters: 
2020/07/24 14:44:15 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:44:20 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:44:24 DEBUG : pacer: Reducing sleep to 2.109375s
2020/07/24 14:44:26 DEBUG : pacer: Reducing sleep to 1.58203125s
2020/07/24 14:44:28 DEBUG : pacer: Reducing sleep to 1.186523437s
2020/07/24 14:44:30 DEBUG : pacer: Reducing sleep to 889.892577ms
2020/07/24 14:44:31 DEBUG : pacer: Reducing sleep to 667.419432ms
--- FAIL: TestDirHandleReaddir (721.99s)
    run.go:176: Remote "1Fichier root 'rclone-test-nameduy6remehav4heyisuc2'", Local "Local file system at /tmp/rclone254473194", Modify Window "876000h0m0s"
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 1/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=Ln7QWylsiS: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 2/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=pwolmI5GvS: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 3/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=sVWpsLJPn7: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 4/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=oFVWCYoqj4: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 5/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=7fekiMouqV: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 6/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=hRnu2B8G0L: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 7/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=RMj9uO5LsR: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 8/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=vpSyQg7yiL: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': 9/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=yHhIEqOeW5: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:282: Failed to put "dir/file1" to "1Fichier root 'rclone-test-nameduy6remehav4heyisuc2'": couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=9Czl9IHXbk: dial tcp 5.39.224.125:443: i/o timeout
=== RUN   TestDirHandleReaddirnames
2020/07/24 14:44:31 DEBUG : 1Fichier root 'rclone-test-nameduy6remehav4heyisuc2': Re-using VFS from active cache
2020/07/24 14:44:32 DEBUG : pacer: Reducing sleep to 500.564574ms
2020/07/24 14:44:33 DEBUG : pacer: Reducing sleep to 400ms
2020/07/24 14:45:34 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=oieSns2NbE: dial tcp 5.39.224.39:443: i/o timeout)
2020/07/24 14:45:34 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:45:36 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:45:41 DEBUG : pacer: Reducing sleep to 2.8125s
2020/07/24 14:46:45 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=uQEMEicHoV: dial tcp 5.39.224.125:443: i/o timeout)
2020/07/24 14:46:45 DEBUG : pacer: Rate limited, increasing sleep to 5s
2020/07/24 14:46:47 DEBUG : pacer: Reducing sleep to 3.75s
2020/07/24 14:46:52 DEBUG : pacer: Reducing sleep to 2.8125s
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFichier: -verbose -test.run '^(TestDirForgetAll|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMethods)$'" - Finished ERROR in 27m5.576396126s (try 5/5): signal: terminated: Failed [TestDirHandleMethods TestDirHandleReaddir]