"./vfs.test -test.v -test.timeout 30m0s -remote TestFichier: -verbose -test.run '^(TestDirHandleMethods|TestDirHandleReaddir)$'" - Starting (try 2/5)
=== RUN   TestDirHandleMethods
2020/04/15 06:03:08 INFO  : 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': poll-interval is not supported by this remote
2020/04/15 06:03:08 DEBUG : Adding path "vfs/forget" to remote control registry
2020/04/15 06:03:08 DEBUG : Adding path "vfs/refresh" to remote control registry
2020/04/15 06:03:08 DEBUG : Adding path "vfs/poll-interval" to remote control registry
2020/04/15 06:04:10 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=TZATHRKGIG: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:04:10 DEBUG : pacer: Rate limited, increasing sleep to 668ms
2020/04/15 06:04:12 DEBUG : pacer: Reducing sleep to 501ms
2020/04/15 06:04:13 DEBUG : pacer: Reducing sleep to 375.75ms
2020/04/15 06:05:13 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=LIR83d2P21: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:05:13 DEBUG : pacer: Rate limited, increasing sleep to 751.5ms
2020/04/15 06:05:15 DEBUG : pacer: Reducing sleep to 563.625ms
2020/04/15 06:05:16 DEBUG : pacer: Reducing sleep to 422.71875ms
2020/04/15 06:06:16 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=uVSewiWmq9: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:06:16 DEBUG : pacer: Rate limited, increasing sleep to 845.4375ms
2020/04/15 06:06:18 DEBUG : pacer: Reducing sleep to 634.078125ms
2020/04/15 06:06:19 DEBUG : pacer: Reducing sleep to 475.558593ms
2020/04/15 06:07:20 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=2zXoC9A7Cq: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:07:20 DEBUG : pacer: Rate limited, increasing sleep to 951.117186ms
2020/04/15 06:07:22 DEBUG : pacer: Reducing sleep to 713.337889ms
2020/04/15 06:07:23 DEBUG : pacer: Reducing sleep to 535.003416ms
2020/04/15 06:08:24 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=1rU3ZfKqZc: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:08:24 DEBUG : pacer: Rate limited, increasing sleep to 1.070006832s
2020/04/15 06:08:26 DEBUG : pacer: Reducing sleep to 802.505124ms
2020/04/15 06:08:27 DEBUG : pacer: Reducing sleep to 601.878843ms
2020/04/15 06:09:27 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=JuaDIQQmCf: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:09:27 DEBUG : pacer: Rate limited, increasing sleep to 1.203757686s
2020/04/15 06:09:29 DEBUG : pacer: Reducing sleep to 902.818264ms
2020/04/15 06:09:31 DEBUG : pacer: Reducing sleep to 677.113698ms
2020/04/15 06:10:32 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=g2WaNjHhXL: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:10:32 DEBUG : pacer: Rate limited, increasing sleep to 1.354227396s
2020/04/15 06:10:34 DEBUG : pacer: Reducing sleep to 1.015670547s
2020/04/15 06:10:35 DEBUG : pacer: Reducing sleep to 761.75291ms
2020/04/15 06:11:36 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=j7R7NhhOen: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:11:36 DEBUG : pacer: Rate limited, increasing sleep to 1.52350582s
2020/04/15 06:11:38 DEBUG : pacer: Reducing sleep to 1.142629365s
2020/04/15 06:11:39 DEBUG : pacer: Reducing sleep to 856.972023ms
2020/04/15 06:12:41 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=Z8uEXPIme0: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:12:41 DEBUG : pacer: Rate limited, increasing sleep to 1.713944046s
2020/04/15 06:12:43 DEBUG : pacer: Reducing sleep to 1.285458034s
2020/04/15 06:12:44 DEBUG : pacer: Reducing sleep to 964.093525ms
2020/04/15 06:13:46 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=mC68RWlr7Z: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:13:46 DEBUG : pacer: Rate limited, increasing sleep to 1.92818705s
2020/04/15 06:13:46 DEBUG : pacer: Reducing sleep to 1.446140287s
2020/04/15 06:13:48 DEBUG : pacer: Reducing sleep to 1.084605215s
2020/04/15 06:13:49 DEBUG : pacer: Reducing sleep to 813.453911ms
2020/04/15 06:13:50 DEBUG : pacer: Reducing sleep to 610.090433ms
2020/04/15 06:13:51 DEBUG : pacer: Reducing sleep to 457.567824ms
2020/04/15 06:13:51 DEBUG : pacer: Reducing sleep to 343.175868ms
2020/04/15 06:13:52 DEBUG : pacer: Reducing sleep to 334ms
--- FAIL: TestDirHandleMethods (644.28s)
    run.go:176: Remote "1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3'", Local "Local file system at /tmp/rclone960679152", Modify Window "876000h0m0s"
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 1/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=TZATHRKGIG: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 2/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=LIR83d2P21: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 3/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=uVSewiWmq9: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 4/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=2zXoC9A7Cq: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 5/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=1rU3ZfKqZc: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 6/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=JuaDIQQmCf: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 7/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=g2WaNjHhXL: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 8/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=j7R7NhhOen: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 9/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=Z8uEXPIme0: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:282: Failed to put "dir/file1" to "1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3'": couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=mC68RWlr7Z: dial tcp 5.39.224.125:443: i/o timeout
=== RUN   TestDirHandleReaddir
2020/04/15 06:13:52 INFO  : 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': poll-interval is not supported by this remote
2020/04/15 06:13:52 DEBUG : Adding path "vfs/forget" to remote control registry
2020/04/15 06:13:52 DEBUG : Adding path "vfs/refresh" to remote control registry
2020/04/15 06:13:52 DEBUG : Adding path "vfs/poll-interval" to remote control registry
2020/04/15 06:14:54 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=4FlYGkYthf: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:14:54 DEBUG : pacer: Rate limited, increasing sleep to 668ms
2020/04/15 06:14:56 DEBUG : pacer: Reducing sleep to 501ms
2020/04/15 06:14:56 DEBUG : pacer: Reducing sleep to 375.75ms
2020/04/15 06:15:57 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=eNAOQUwQ9S: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:15:57 DEBUG : pacer: Rate limited, increasing sleep to 751.5ms
2020/04/15 06:15:59 DEBUG : pacer: Reducing sleep to 563.625ms
2020/04/15 06:16:00 DEBUG : pacer: Reducing sleep to 422.71875ms
2020/04/15 06:17:00 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=hQzdGhsUf9: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:17:00 DEBUG : pacer: Rate limited, increasing sleep to 845.4375ms
2020/04/15 06:17:02 DEBUG : pacer: Reducing sleep to 634.078125ms
2020/04/15 06:17:03 DEBUG : pacer: Reducing sleep to 475.558593ms
2020/04/15 06:18:04 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=lm6f9sCxyr: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:18:04 DEBUG : pacer: Rate limited, increasing sleep to 951.117186ms
2020/04/15 06:18:06 DEBUG : pacer: Reducing sleep to 713.337889ms
2020/04/15 06:18:07 DEBUG : pacer: Reducing sleep to 535.003416ms
2020/04/15 06:19:07 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=AXa0SE93XK: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:19:07 DEBUG : pacer: Rate limited, increasing sleep to 1.070006832s
2020/04/15 06:19:09 DEBUG : pacer: Reducing sleep to 802.505124ms
2020/04/15 06:19:10 DEBUG : pacer: Reducing sleep to 601.878843ms
2020/04/15 06:20:11 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=YBFBErSgYi: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:20:11 DEBUG : pacer: Rate limited, increasing sleep to 1.203757686s
2020/04/15 06:20:13 DEBUG : pacer: Reducing sleep to 902.818264ms
2020/04/15 06:20:14 DEBUG : pacer: Reducing sleep to 677.113698ms
2020/04/15 06:21:15 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=CuBBYKOXC7: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:21:15 DEBUG : pacer: Rate limited, increasing sleep to 1.354227396s
2020/04/15 06:21:17 DEBUG : pacer: Reducing sleep to 1.015670547s
2020/04/15 06:21:19 DEBUG : pacer: Reducing sleep to 761.75291ms
2020/04/15 06:22:20 DEBUG : pacer: low level retry 1/1 (error Post https://ru-3.1fichier.com/upload.cgi?id=cawYHeIMg0: dial tcp 5.39.224.39:443: i/o timeout)
2020/04/15 06:22:20 DEBUG : pacer: Rate limited, increasing sleep to 1.52350582s
2020/04/15 06:22:22 DEBUG : pacer: Reducing sleep to 1.142629365s
2020/04/15 06:22:23 DEBUG : pacer: Reducing sleep to 856.972023ms
2020/04/15 06:23:24 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=m409J3rlYK: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:23:24 DEBUG : pacer: Rate limited, increasing sleep to 1.713944046s
2020/04/15 06:23:26 DEBUG : pacer: Reducing sleep to 1.285458034s
2020/04/15 06:23:28 DEBUG : pacer: Reducing sleep to 964.093525ms
2020/04/15 06:24:29 DEBUG : pacer: low level retry 1/1 (error Post https://up2.1fichier.com/upload.cgi?id=87nLQr63SY: dial tcp 5.39.224.125:443: i/o timeout)
2020/04/15 06:24:29 DEBUG : pacer: Rate limited, increasing sleep to 1.92818705s
2020/04/15 06:24:29 DEBUG : pacer: Reducing sleep to 1.446140287s
2020/04/15 06:24:31 DEBUG : pacer: Reducing sleep to 1.084605215s
2020/04/15 06:24:33 DEBUG : pacer: Reducing sleep to 813.453911ms
2020/04/15 06:24:34 DEBUG : pacer: Reducing sleep to 610.090433ms
2020/04/15 06:24:35 DEBUG : pacer: Reducing sleep to 457.567824ms
2020/04/15 06:24:35 DEBUG : pacer: Reducing sleep to 343.175868ms
2020/04/15 06:24:36 DEBUG : pacer: Reducing sleep to 334ms
--- FAIL: TestDirHandleReaddir (643.69s)
    run.go:176: Remote "1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3'", Local "Local file system at /tmp/rclone960679152", Modify Window "876000h0m0s"
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 1/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=4FlYGkYthf: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 2/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=eNAOQUwQ9S: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 3/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=hQzdGhsUf9: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 4/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=lm6f9sCxyr: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 5/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=AXa0SE93XK: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 6/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=YBFBErSgYi: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 7/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=CuBBYKOXC7: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 8/10 (couldn't upload file: Post https://ru-3.1fichier.com/upload.cgi?id=cawYHeIMg0: dial tcp 5.39.224.39:443: i/o timeout)
    run.go:278: Retry Put of "dir/file1" to 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': 9/10 (couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=m409J3rlYK: dial tcp 5.39.224.125:443: i/o timeout)
    run.go:282: Failed to put "dir/file1" to "1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3'": couldn't upload file: Post https://up2.1fichier.com/upload.cgi?id=87nLQr63SY: dial tcp 5.39.224.125:443: i/o timeout
FAIL
2020/04/15 06:24:36 DEBUG : 1Fichier root 'rclone-test-xefibut9xexeweq8xawijip3': Purge dir ""
"./vfs.test -test.v -test.timeout 30m0s -remote TestFichier: -verbose -test.run '^(TestDirHandleMethods|TestDirHandleReaddir)$'" - Finished ERROR in 21m29.426773094s (try 2/5): exit status 1: Failed [TestDirHandleMethods TestDirHandleReaddir]