2018/04/03 05:05:35 Testing packages: github.com/ncw/rclone/fs/operations, github.com/ncw/rclone/fs/sync
2018/04/03 05:05:35 Testing remotes: TestB2:, TestCryptDrive:, TestCryptSwift:, TestDrive:, TestDropbox:, TestGoogleCloudStorage:, TestHubic:, TestOneDrive:, TestS3:, TestSftp:, TestSwift:, TestYandex:, TestFTP:, TestBox:, TestQingStor:, TestAzureBlob:, TestPcloud:, TestWebdav:, TestCache:
2018/04/03 05:05:35 github.com/ncw/rclone/fs/operations: Making test binary "operations.test"
2018/04/03 05:05:36 github.com/ncw/rclone/fs/sync: Making test binary "sync.test"
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptSwift:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOneDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDropbox:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCache:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSftp:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptSwift:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestFTP:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCache:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestPcloud:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestWebdav:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud:" - Starting (try 1/5)
2018/04/03 05:05:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav:" - Starting (try 1/5)
2018/04/03 05:05:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestFTP:" - Finished OK in 2.99344609s (try 1/5)
2018/04/03 05:05:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP:" - Finished OK in 3.141379422s (try 1/5)
2018/04/03 05:05:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Finished OK in 4.529178082s (try 1/5)
2018/04/03 05:05:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Finished OK in 4.855419572s (try 1/5)
2018/04/03 05:05:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSftp:" - Finished OK in 5.031732113s (try 1/5)
2018/04/03 05:05:42 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob:" - Finished OK in 6.10701187s (try 1/5)
2018/04/03 05:05:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Finished OK in 6.401243546s (try 1/5)
2018/04/03 05:05:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Finished OK in 8.276332718s (try 1/5)
2018/04/03 05:05:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Finished OK in 8.380190885s (try 1/5)
2018/04/03 05:05:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob:" - Finished OK in 8.94572848s (try 1/5)
2018/04/03 05:05:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp:" - Finished OK in 10.171543574s (try 1/5)
2018/04/03 05:05:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Finished OK in 10.440610334s (try 1/5)
2018/04/03 05:05:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3:" - Finished OK in 10.879378015s (try 1/5)
2018/04/03 05:05:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Finished OK in 12.416350511s (try 1/5)
2018/04/03 05:05:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -fast-list" - Finished OK in 12.456206125s (try 1/5)
2018/04/03 05:05:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir" - Finished OK in 12.67695628s (try 1/5)
2018/04/03 05:05:53 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCache:" - Finished OK in 16.660534825s (try 1/5)
2018/04/03 05:05:56 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Finished OK in 19.96765726s (try 1/5)
2018/04/03 05:05:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3:" - Finished OK in 20.798430225s (try 1/5)
2018/04/03 05:05:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -fast-list" - Finished OK in 20.866078058s (try 1/5)
2018/04/03 05:05:59 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir" - Finished OK in 22.271221097s (try 1/5)
2018/04/03 05:06:14 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCache:" - Finished OK in 37.916137837s (try 1/5)
2018/04/03 05:06:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Finished OK in 38.521846069s (try 1/5)
2018/04/03 05:06:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Finished OK in 46.730248895s (try 1/5)
2018/04/03 05:06:25 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift:" - Finished OK in 48.67037778s (try 1/5)
2018/04/03 05:06:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir" - Finished OK in 51.617165592s (try 1/5)
2018/04/03 05:06:34 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptSwift:" - Finished OK in 57.827983884s (try 1/5)
2018/04/03 05:06:55 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Finished OK in 1m18.852707475s (try 1/5)
2018/04/03 05:06:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Finished OK in 1m21.380827524s (try 1/5)
2018/04/03 05:06:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestWebdav:" - Finished OK in 1m21.576155173s (try 1/5)
2018/04/03 05:06:59 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Finished OK in 1m22.816902894s (try 1/5)
2018/04/03 05:07:00 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Finished OK in 1m23.308201743s (try 1/5)
2018/04/03 05:07:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift:" - Finished OK in 1m24.908494477s (try 1/5)
2018/04/03 05:07:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir" - Finished OK in 1m25.618812524s (try 1/5)
2018/04/03 05:07:04 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Finished OK in 1m27.800204582s (try 1/5)
2018/04/03 05:07:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Finished OK in 1m28.698956742s (try 1/5)
2018/04/03 05:07:14 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOneDrive:" - Finished OK in 1m37.504977126s (try 1/5)
2018/04/03 05:07:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2:" - Finished OK in 1m46.116090764s (try 1/5)
2018/04/03 05:07:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptSwift:" - Finished OK in 1m46.921420065s (try 1/5)
2018/04/03 05:07:27 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list" - Finished OK in 1m50.513994568s (try 1/5)
2018/04/03 05:07:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Finished OK in 2m2.106995268s (try 1/5)
2018/04/03 05:07:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav:" - Finished ERROR in 2m4.496268074s (try 1/5): exit status 1: Failed [TestServerSideMoveWithFilter]
2018/04/03 05:07:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestServerSideMoveWithFilter)$'" - Starting (try 2/5)
2018/04/03 05:07:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestServerSideMoveWithFilter)$'" - Finished OK in 8.716763885s (try 2/5)
2018/04/03 05:08:00 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex:" - Finished OK in 2m23.737013978s (try 1/5)
2018/04/03 05:08:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Finished ERROR in 2m29.292364342s (try 1/5): exit status 1: Failed [TestServerSideMoveDeleteEmptySourceDirs]
2018/04/03 05:08:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -test.run '^(TestServerSideMoveDeleteEmptySourceDirs)$'" - Starting (try 2/5)
2018/04/03 05:08:09 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Finished ERROR in 2m32.685059084s (try 1/5): exit status 1: Failed [TestServerSideMoveDeleteEmptySourceDirs]
2018/04/03 05:08:09 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list -test.run '^(TestServerSideMoveDeleteEmptySourceDirs)$'" - Starting (try 2/5)
2018/04/03 05:08:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Finished ERROR in 2m36.385866968s (try 1/5): exit status 1: Failed [TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs]
2018/04/03 05:08:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list -test.run '^(TestServerSideMoveWithFilter|TestServerSideMoveDeleteEmptySourceDirs)$'" - Starting (try 2/5)
2018/04/03 05:08:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive:" - Finished OK in 2m47.145144903s (try 1/5)
2018/04/03 05:08:25 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -test.run '^(TestServerSideMoveDeleteEmptySourceDirs)$'" - Finished OK in 18.98096437s (try 2/5)
2018/04/03 05:08:27 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list -test.run '^(TestServerSideMoveDeleteEmptySourceDirs)$'" - Finished OK in 17.947202483s (try 2/5)
2018/04/03 05:08:29 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Finished ERROR in 2m53.056018657s (try 1/5): exit status 1: Failed [TestServerSideMoveWithFilter]
2018/04/03 05:08:29 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -test.run '^(TestServerSideMoveWithFilter)$'" - Starting (try 2/5)
2018/04/03 05:08:32 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -test.run '^(TestServerSideMoveWithFilter)$'" - Finished ERROR in 2.479178059s (try 2/5): exit status 1: Failed [TestServerSideMoveWithFilter]
2018/04/03 05:08:32 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -test.run '^(TestServerSideMoveWithFilter)$'" - Starting (try 3/5)
2018/04/03 05:08:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDropbox:" - Finished OK in 3m4.454759743s (try 1/5)
2018/04/03 05:08:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestPcloud:" - Finished OK in 3m8.25388848s (try 1/5)
2018/04/03 05:08:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list -test.run '^(TestServerSideMoveWithFilter|TestServerSideMoveDeleteEmptySourceDirs)$'" - Finished OK in 35.902233766s (try 2/5)
2018/04/03 05:08:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -test.run '^(TestServerSideMoveWithFilter)$'" - Finished OK in 19.723263804s (try 3/5)
2018/04/03 05:08:54 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptDrive:" - Finished OK in 3m18.176085022s (try 1/5)
2018/04/03 05:09:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2:" - Finished OK in 3m25.675807428s (try 1/5)
2018/04/03 05:09:18 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDrive:" - Finished OK in 3m41.567194947s (try 1/5)
2018/04/03 05:09:33 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" - Finished OK in 3m56.895920256s (try 1/5)
2018/04/03 05:09:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex:" - Finished ERROR in 4m2.487031286s (try 1/5): exit status 1: Failed [TestSyncDeleteBefore]
2018/04/03 05:09:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex: -test.run '^(TestSyncDeleteBefore)$'" - Starting (try 2/5)
2018/04/03 05:09:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex: -test.run '^(TestSyncDeleteBefore)$'" - Finished OK in 8.146119011s (try 2/5)
2018/04/03 05:09:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Finished OK in 4m13.604260804s (try 1/5)
2018/04/03 05:10:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox:" - Finished ERROR in 4m29.373176246s (try 1/5): exit status 1: Failed [TestListFormat]
2018/04/03 05:10:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Starting (try 2/5)
2018/04/03 05:10:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list" - Finished ERROR in 4m30.720707981s (try 1/5): exit status 1: Failed [TestSyncAfterChangingContentsOnly TestSyncWithExcludeAndDeleteExcluded]
2018/04/03 05:10:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestSyncAfterChangingContentsOnly|TestSyncWithExcludeAndDeleteExcluded)$'" - Starting (try 2/5)
2018/04/03 05:10:20 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestSyncAfterChangingContentsOnly|TestSyncWithExcludeAndDeleteExcluded)$'" - Finished OK in 12.913470851s (try 2/5)
2018/04/03 05:10:20 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Finished ERROR in 14.68206794s (try 2/5): exit status 1: Failed [TestListFormat]
2018/04/03 05:10:20 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Starting (try 3/5)
2018/04/03 05:10:26 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" - Finished ERROR in 4m50.152131847s (try 1/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:10:26 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Starting (try 2/5)
2018/04/03 05:10:33 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Finished ERROR in 6.195540134s (try 2/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:10:33 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Starting (try 3/5)
2018/04/03 05:10:35 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Finished ERROR in 14.794909199s (try 3/5): exit status 1: Failed [TestListFormat]
2018/04/03 05:10:35 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Starting (try 4/5)
2018/04/03 05:10:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Finished ERROR in 7.0439595s (try 3/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:10:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Starting (try 4/5)
2018/04/03 05:10:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Finished ERROR in 6.122486122s (try 4/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:10:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Starting (try 5/5)
2018/04/03 05:10:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Finished ERROR in 14.975910173s (try 4/5): exit status 1: Failed [TestListFormat]
2018/04/03 05:10:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Starting (try 5/5)
2018/04/03 05:10:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir" - Finished ERROR in 5m14.758091792s (try 1/5): exit status 1: Failed [TestSyncAfterChangingFilesSizeOnly]
2018/04/03 05:10:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestSyncAfterChangingFilesSizeOnly)$'" - Starting (try 2/5)
2018/04/03 05:10:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'" - Finished ERROR in 6.06963811s (try 5/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:10:52 ------------------------------------------------------------
2018/04/03 05:10:52 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" ----
2018/04/03 05:10:52 2018/04/03 05:10:48 NOTICE: empty space: Not updating modification time as --dry-run
--- FAIL: TestSyncAfterChangingModtimeOnly (5.04s)
	run.go:169: Remote "Dropbox root 'rclone-test-meqafiq3zodegun4kukimuj4'", Local "Local file system at /tmp/rclone038302688", Modify Window "1s"
	fstest.go:121: 
			Error Trace:	fstest.go:121
			            				fstest.go:140
			            				fstest.go:186
			            				fstest.go:303
			            				fstest.go:335
			            				sync_test.go:384
			Error:      	Should be true
			Test:       	TestSyncAfterChangingModtimeOnly
			Messages:   	empty space: Modification time difference too big |-95456h54m53.123456789s| > 1s (2001-02-03 04:05:06 +0000 UTC vs 2011-12-25 12:59:59.123456789 +0000 UTC) (precision 1s)
FAIL

2018/04/03 05:10:52 ------------------------------------------------------------
2018/04/03 05:10:55 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive:" - Finished OK in 5m18.852408162s (try 1/5)
2018/04/03 05:11:00 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud:" - Finished OK in 5m23.53924072s (try 1/5)
2018/04/03 05:11:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestSyncAfterChangingFilesSizeOnly)$'" - Finished OK in 9.619767815s (try 2/5)
2018/04/03 05:11:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'" - Finished ERROR in 14.572130277s (try 5/5): exit status 1: Failed [TestListFormat]
2018/04/03 05:11:05 ------------------------------------------------------------
2018/04/03 05:11:05 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox:" ----
2018/04/03 05:11:05 --- FAIL: TestListFormat (12.25s)
	run.go:169: Remote "box root 'rclone-test-ficayos4tajekev1yavosiz9'", Local "Local file system at /tmp/rclone585267421", Modify Window "1s"
	operations_test.go:878: 
			Error Trace:	operations_test.go:878
			Error:      	Not equal: 
			            	expected: "2001-02-02 20:05:06"
			            	actual  : "2001-02-03 04:05:06"
			Test:       	TestListFormat
	operations_test.go:888: 
			Error Trace:	operations_test.go:888
			Error:      	Not equal: 
			            	expected: "1__SEP__a__SEP__2001-02-02 20:05:06"
			            	actual  : "1__SEP__a__SEP__2001-02-03 04:05:06"
			Test:       	TestListFormat
	operations_test.go:889: 
			Error Trace:	operations_test.go:889
			Error:      	Not equal: 
			            	expected: "-1__SEP__subdir/__SEP__2018-04-02 22:10:58"
			            	actual  : "-1__SEP__subdir/__SEP__2018-04-03 05:10:58"
			Test:       	TestListFormat
FAIL

2018/04/03 05:11:05 ------------------------------------------------------------
2018/04/03 05:11:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive:" - Finished OK in 5m30.442605301s (try 1/5)
2018/04/03 05:11:10 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir" - Finished ERROR in 5m33.292012059s (try 1/5): exit status 1: Failed [TestCheckSizeOnly]
2018/04/03 05:11:10 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCheckSizeOnly)$'" - Starting (try 2/5)
2018/04/03 05:11:24 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCheckSizeOnly)$'" - Finished OK in 14.600099328s (try 2/5)
2018/04/03 05:11:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Finished ERROR in 6m4.033714188s (try 1/5): exit status 1: Failed [TestLsLong TestCheckSizeOnly]
2018/04/03 05:11:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestLsLong|TestCheckSizeOnly)$'" - Starting (try 2/5)
2018/04/03 05:11:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestLsLong|TestCheckSizeOnly)$'" - Finished OK in 16.778775037s (try 2/5)
2018/04/03 05:13:12 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic:" - Finished OK in 7m35.38414777s (try 1/5)
2018/04/03 05:16:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox:" - Finished ERROR in 11m4.762290216s (try 1/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly]
2018/04/03 05:16:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestSyncAfterChangingModtimeOnly|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly)$'" - Starting (try 2/5)
2018/04/03 05:17:11 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestSyncAfterChangingModtimeOnly|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly)$'" - Finished OK in 29.740856131s (try 2/5)
2018/04/03 05:26:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic:" - Finished OK in 21m4.776956957s (try 1/5)
2018/04/03 05:26:41 SUMMARY
2018/04/03 05:26:41 FAIL: 2 tests failed in 21m5.72283111s
2018/04/03 05:26:41   * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestSyncAfterChangingModtimeOnly)$'
2018/04/03 05:26:41     * Failed tests: [TestSyncAfterChangingModtimeOnly]
2018/04/03 05:26:41   * /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestListFormat)$'
2018/04/03 05:26:41     * Failed tests: [TestListFormat]