2018/06/10 05:13:41 Testing packages: github.com/ncw/rclone/fs/operations, github.com/ncw/rclone/fs/sync 2018/06/10 05:13:41 Testing remotes: TestB2:, TestCryptDrive:, TestCryptSwift:, TestDrive:, TestDropbox:, TestGoogleCloudStorage:, TestHubic:, TestOneDrive:, TestS3:, TestSftp:, TestSwift:, TestYandex:, TestFTP:, TestBox:, TestQingStor:, TestAzureBlob:, TestPcloud:, TestWebdav:, TestCache:, TestMega:, TestOpenDrive: 2018/06/10 05:13:41 github.com/ncw/rclone/fs/operations: Making test binary "operations.test" 2018/06/10 05:13:44 github.com/ncw/rclone/fs/sync: Making test binary "sync.test" 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptSwift:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDropbox:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSftp:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOneDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestPcloud:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestWebdav:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCache:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOpenDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestFTP:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCache:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptSwift:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive:" - Starting (try 1/5) 2018/06/10 05:13:46 "/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/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud:" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -fast-list" - Starting (try 1/5) 2018/06/10 05:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir" - Starting (try 1/5) 2018/06/10 05:13:48 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestFTP:" - Finished OK in 2.066008024s (try 1/5) 2018/06/10 05:13:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSftp:" - Finished OK in 3.150718256s (try 1/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP:" - Finished ERROR in 4.870042124s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 127.032459ms (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 112.129437ms (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Finished OK in 5.25067109s (try 1/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 144.137687ms (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob:" - Finished OK in 5.311745722s (try 1/5) 2018/06/10 05:13:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 82.193896ms (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:51 ------------------------------------------------------------ 2018/06/10 05:13:51 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP:" ---- 2018/06/10 05:13:51 --- FAIL: TestCopyRedownload (0.01s) run.go:173: Remote "ftp://localhost:21/rclone-test-virutac3hacafaf3haxares2", Local "Local file system at /tmp/rclone931346840", Modify Window "876000h0m0s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |152065h8m44.500000001s| > 1ns (2018-06-10 05:13:51 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:13:51 ------------------------------------------------------------ 2018/06/10 05:13:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Finished OK in 5.61646459s (try 1/5) 2018/06/10 05:13:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Finished OK in 5.857952547s (try 1/5) 2018/06/10 05:13:55 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Finished OK in 9.018720521s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -fast-list" - Finished OK in 10.564274938s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir -fast-list" - Finished OK in 10.627725837s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -fast-list" - Finished OK in 10.78653327s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3:" - Finished OK in 10.99284132s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob:" - Finished OK in 11.294081885s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestAzureBlob: -subdir" - Finished OK in 11.313735396s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestS3: -subdir" - Finished OK in 11.314603512s (try 1/5) 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp:" - Finished ERROR in 11.391078625s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 404.798605ms (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 291.814369ms (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 287.059292ms (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:13:59 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 314.23413ms (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:13:59 ------------------------------------------------------------ 2018/06/10 05:13:59 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp:" ---- 2018/06/10 05:13:59 --- FAIL: TestCopyRedownload (0.04s) run.go:173: Remote "sftp://teststorage@localhost:22/rclone-test-zegired5marajom2wuhipup9", Local "Local file system at /tmp/rclone727659033", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:13:59 ------------------------------------------------------------ 2018/06/10 05:14:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -fast-list" - Finished OK in 18.667515867s (try 1/5) 2018/06/10 05:14:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir" - Finished OK in 19.357712231s (try 1/5) 2018/06/10 05:14:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3:" - Finished OK in 20.2648384s (try 1/5) 2018/06/10 05:14:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestS3: -subdir -fast-list" - Finished OK in 20.420163386s (try 1/5) 2018/06/10 05:14:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCache:" - Finished OK in 20.740984785s (try 1/5) 2018/06/10 05:14:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Finished OK in 28.656553162s (try 1/5) 2018/06/10 05:14:16 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Finished OK in 30.158410545s (try 1/5) 2018/06/10 05:14:17 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Finished OK in 31.149652268s (try 1/5) 2018/06/10 05:14:17 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Finished OK in 31.378220485s (try 1/5) 2018/06/10 05:14:19 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCache:" - Finished OK in 32.995676248s (try 1/5) 2018/06/10 05:14:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift:" - Finished OK in 55.168973118s (try 1/5) 2018/06/10 05:14:41 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Finished OK in 55.351331428s (try 1/5) 2018/06/10 05:14:53 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptSwift:" - Finished OK in 1m6.674727596s (try 1/5) 2018/06/10 05:14:54 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -subdir" - Finished OK in 1m8.07394825s (try 1/5) 2018/06/10 05:14:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage:" - Finished OK in 1m11.267465006s (try 1/5) 2018/06/10 05:15:00 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -fast-list" - Finished OK in 1m13.833708876s (try 1/5) 2018/06/10 05:15:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Finished OK in 1m20.188665409s (try 1/5) 2018/06/10 05:15:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir -fast-list" - Finished OK in 1m21.323465532s (try 1/5) 2018/06/10 05:15:09 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestWebdav:" - Finished OK in 1m22.858065604s (try 1/5) 2018/06/10 05:15:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOneDrive:" - Finished OK in 1m35.636473117s (try 1/5) 2018/06/10 05:15:27 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -fast-list" - Finished OK in 1m40.977756523s (try 1/5) 2018/06/10 05:15:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestGoogleCloudStorage: -subdir" - Finished OK in 1m41.699259619s (try 1/5) 2018/06/10 05:15:34 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptSwift:" - Finished OK in 1m47.969650638s (try 1/5) 2018/06/10 05:15:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Finished OK in 1m52.505625859s (try 1/5) 2018/06/10 05:15:39 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift:" - Finished OK in 1m52.790950144s (try 1/5) 2018/06/10 05:15:42 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir -fast-list" - Finished OK in 1m55.60533428s (try 1/5) 2018/06/10 05:15:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav:" - Finished ERROR in 2m12.076775046s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:15:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:16:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex:" - Finished ERROR in 2m15.34242307s (try 1/5): exit status 1: Failed [TestLsLong] 2018/06/10 05:16:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex: -test.run '^(TestLsLong)$'" - Starting (try 2/5) 2018/06/10 05:16:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 3.722168078s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:16:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 3.20385766s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:05 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:16:08 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestYandex: -test.run '^(TestLsLong)$'" - Finished OK in 6.176735439s (try 2/5) 2018/06/10 05:16:08 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 3.116475513s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:08 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:16:12 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 3.466904338s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:12 ------------------------------------------------------------ 2018/06/10 05:16:12 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav:" ---- 2018/06/10 05:16:12 --- FAIL: TestCopyRedownload (2.80s) run.go:173: Remote "webdav root 'rclone-test-tilarow7negasew7wovozam7'", Local "Local file system at /tmp/rclone674669026", Modify Window "876000h0m0s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |152065h11m2.500000001s| > 1ns (2018-06-10 05:16:09 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:16:12 ------------------------------------------------------------ 2018/06/10 05:16:12 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega:" - Finished ERROR in 2m26.030273215s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:12 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:16:17 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 4.628774257s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:17 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:16:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 4.34259101s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:16:24 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2:" - Finished ERROR in 2m37.55529091s (try 1/5): exit status 1: Failed [TestCount] 2018/06/10 05:16:24 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCount)$'" - Starting (try 2/5) 2018/06/10 05:16:25 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 3.876132046s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:25 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:16:29 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 4.367672673s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:29 ------------------------------------------------------------ 2018/06/10 05:16:29 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega:" ---- 2018/06/10 05:16:29 --- FAIL: TestCopyRedownload (1.24s) run.go:173: Remote "mega root 'rclone-test-surefuh0noqigaj9comihub7'", Local "Local file system at /tmp/rclone583787806", Modify Window "876000h0m0s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |152065h11m22.500000001s| > 1ns (2018-06-10 05:16:29 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:16:29 ------------------------------------------------------------ 2018/06/10 05:16:32 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCount)$'" - Finished OK in 8.020061551s (try 2/5) 2018/06/10 05:16:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDropbox:" - Finished OK in 2m54.116442958s (try 1/5) 2018/06/10 05:16:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive:" - Finished ERROR in 3m0.170564699s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:16:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 5.574935631s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:16:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 4.81419871s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:16:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:17:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 5.176253581s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:17:02 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:17:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 5.235074803s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:17:07 ------------------------------------------------------------ 2018/06/10 05:17:07 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive:" ---- 2018/06/10 05:17:07 --- FAIL: TestCopyRedownload (3.58s) run.go:173: Remote "One drive root 'rclone-test-mazaxoj1likuxok9bafijac2'", Local "Local file system at /tmp/rclone010703349", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:17:07 ------------------------------------------------------------ 2018/06/10 05:17:14 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestPcloud:" - Finished OK in 3m27.569992215s (try 1/5) 2018/06/10 05:17:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestYandex:" - Finished OK in 3m49.748566026s (try 1/5) 2018/06/10 05:18:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestBox:" - Finished OK in 4m14.846860494s (try 1/5) 2018/06/10 05:18:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" - Finished ERROR in 4m35.39179734s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:18:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:18:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.911556736s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:18:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:18:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.402589908s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:18:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:18:37 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir" - Finished ERROR in 4m50.880487344s (try 1/5): exit status 1: Failed [TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring] 2018/06/10 05:18:37 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir -test.run '^(TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Starting (try 2/5) 2018/06/10 05:18:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestCryptDrive:" - Finished OK in 4m53.741504133s (try 1/5) 2018/06/10 05:18:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.326336482s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:18:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:18:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.267533763s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:18:50 ------------------------------------------------------------ 2018/06/10 05:18:50 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox:" ---- 2018/06/10 05:18:50 --- FAIL: TestCopyRedownload (6.26s) run.go:173: Remote "Dropbox root 'rclone-test-cobafuy4memurud8laqapaw7'", Local "Local file system at /tmp/rclone718797481", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:18:50 ------------------------------------------------------------ 2018/06/10 05:19:00 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSwift: -subdir -test.run '^(TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Finished OK in 23.219122602s (try 2/5) 2018/06/10 05:19:12 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestDrive:" - Finished OK in 5m25.64269866s (try 1/5) 2018/06/10 05:19:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2:" - Finished ERROR in 5m27.318956801s (try 1/5): exit status 1: Failed [TestServerSideCopy TestCopyRedownload TestSyncAfterChangingContentsOnly] 2018/06/10 05:19:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestServerSideCopy|TestCopyRedownload|TestSyncAfterChangingContentsOnly)$'" - Starting (try 2/5) 2018/06/10 05:19:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud:" - Finished ERROR in 5m36.036068158s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:19:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox:" - Finished ERROR in 5m41.868732122s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:28 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:19:29 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestServerSideCopy|TestCopyRedownload|TestSyncAfterChangingContentsOnly)$'" - Finished ERROR in 15.800911723s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:29 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:19:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.95922078s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:19:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.910811241s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:19:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 10.215639013s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:19:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.018979424s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:19:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.977847626s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:19:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.976819071s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:19:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.16316343s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:19:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.314528142s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:49 ------------------------------------------------------------ 2018/06/10 05:19:49 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2:" ---- 2018/06/10 05:19:49 --- FAIL: TestCopyRedownload (4.69s) run.go:173: Remote "B2 bucket rclone-test-vitesuw6tuwimim8qasilel0", Local "Local file system at /tmp/rclone220936998", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:19:49 ------------------------------------------------------------ 2018/06/10 05:19:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir" - Finished ERROR in 6m4.974960721s (try 1/5): exit status 1: Failed [TestCheckDownload] 2018/06/10 05:19:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCheckDownload)$'" - Starting (try 2/5) 2018/06/10 05:19:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.90693301s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:57 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:19:58 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.047341883s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:19:58 ------------------------------------------------------------ 2018/06/10 05:19:58 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud:" ---- 2018/06/10 05:19:58 --- FAIL: TestCopyRedownload (7.60s) run.go:173: Remote "pcloud root 'rclone-test-sawofuh5davaqof3yagejab6'", Local "Local file system at /tmp/rclone550631655", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:19:58 ------------------------------------------------------------ 2018/06/10 05:20:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.272224901s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:06 ------------------------------------------------------------ 2018/06/10 05:20:06 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox:" ---- 2018/06/10 05:20:06 --- FAIL: TestCopyRedownload (7.52s) run.go:173: Remote "box root 'rclone-test-jikopaf1ditawud8guxubut6'", Local "Local file system at /tmp/rclone781406028", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:20:06 ------------------------------------------------------------ 2018/06/10 05:20:07 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCheckDownload)$'" - Finished OK in 15.888700228s (try 2/5) 2018/06/10 05:20:08 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestOpenDrive:" - Finished OK in 6m21.577956738s (try 1/5) 2018/06/10 05:20:20 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir" - Finished ERROR in 6m34.380115479s (try 1/5): exit status 1: Failed [TestCopyRedownload TestSyncAfterChangingModtimeOnly TestSyncAfterChangingContentsOnly TestSyncUTFNorm TestSyncImmutable] 2018/06/10 05:20:20 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingContentsOnly|TestSyncUTFNorm|TestSyncImmutable)$'" - Starting (try 2/5) 2018/06/10 05:20:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive:" - Finished ERROR in 6m36.612124149s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:20:30 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.829265013s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:30 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:20:37 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.005477427s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:37 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:20:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingContentsOnly|TestSyncUTFNorm|TestSyncImmutable)$'" - Finished ERROR in 19.509399163s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:20:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive:" - Finished ERROR in 6m57.276168846s (try 1/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 2/5) 2018/06/10 05:20:44 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.067331335s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:44 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:20:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.798261071s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:49 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:20:51 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.086727009s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:51 ------------------------------------------------------------ 2018/06/10 05:20:51 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive:" ---- 2018/06/10 05:20:51 --- FAIL: TestCopyRedownload (5.89s) run.go:173: Remote "Google drive root 'rclone-test-vusiwev2liqihof1kawixif8'", Local "Local file system at /tmp/rclone930687502", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:20:51 ------------------------------------------------------------ 2018/06/10 05:20:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.402889017s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:52 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:20:56 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 7.534120371s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:20:56 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:21:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.639463785s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:21:01 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:21:06 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 9.291430757s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:21:06 ------------------------------------------------------------ 2018/06/10 05:21:06 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir" ---- 2018/06/10 05:21:06 --- FAIL: TestCopyRedownload (6.27s) run.go:173: Remote "B2 bucket rclone-test-katisaj0yiwuzuf9neriset8 path rclone-test-subdir-nuyutuf7/", Local "Local file system at /tmp/rclone054290858", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:21:06 ------------------------------------------------------------ 2018/06/10 05:21:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 11.379327161s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:21:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:21:16 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list" - Finished ERROR in 7m29.611324819s (try 1/5): exit status 1: Failed [TestLsLong TestCheckDownload] 2018/06/10 05:21:16 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestLsLong|TestCheckDownload)$'" - Starting (try 2/5) 2018/06/10 05:21:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.227278167s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:21:21 ------------------------------------------------------------ 2018/06/10 05:21:21 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive:" ---- 2018/06/10 05:21:21 --- FAIL: TestCopyRedownload (5.89s) run.go:173: Remote "Encrypted drive 'TestCryptDrive:rclone-test-kapixap9cefikub4xisayar8'", Local "Local file system at /tmp/rclone888399304", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:21:21 ------------------------------------------------------------ 2018/06/10 05:21:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestLsLong|TestCheckDownload)$'" - Finished OK in 14.922942079s (try 2/5) 2018/06/10 05:23:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list" - Finished ERROR in 9m26.658393127s (try 1/5): exit status 1: Failed [TestCopyRedownload TestSyncIgnoreTimes TestSyncAfterChangingModtimeOnly TestSyncAfterChangingFilesSizeOnly TestSyncAfterRemovingAFileAndAddingAFile TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring] 2018/06/10 05:23:13 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncIgnoreTimes|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Starting (try 2/5) 2018/06/10 05:23:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" - Finished ERROR in 9m57.170160871s (try 1/5): exit status 1: Failed [TestCopyRedownload TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime TestSyncAfterChangingFilesSizeOnly TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring TestSyncWithExclude] 2018/06/10 05:23:43 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring|TestSyncWithExclude)$'" - Starting (try 2/5) 2018/06/10 05:24:03 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring|TestSyncWithExclude)$'" - Finished ERROR in 19.521763366s (try 2/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:24:03 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Starting (try 3/5) 2018/06/10 05:24:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 11.944149835s (try 3/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:24:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Starting (try 4/5) 2018/06/10 05:24:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 6.943375192s (try 4/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:24:22 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Starting (try 5/5) 2018/06/10 05:24:30 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$'" - Finished ERROR in 8.219928415s (try 5/5): exit status 1: Failed [TestCopyRedownload] 2018/06/10 05:24:30 ------------------------------------------------------------ 2018/06/10 05:24:30 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list" ---- 2018/06/10 05:24:30 --- FAIL: TestCopyRedownload (5.41s) run.go:173: Remote "B2 bucket rclone-test-sapurug3haxiwon6fixopof6 path rclone-test-subdir-nodemon0/", Local "Local file system at /tmp/rclone960538960", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) FAIL 2018/06/10 05:24:30 ------------------------------------------------------------ 2018/06/10 05:25:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic:" - Finished ERROR in 11m36.766046023s (try 1/5): exit status 1: Failed [TestCopyFile] 2018/06/10 05:25:23 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic: -test.run '^(TestCopyFile)$'" - Starting (try 2/5) 2018/06/10 05:25:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestHubic: -test.run '^(TestCopyFile)$'" - Finished OK in 22.368183333s (try 2/5) 2018/06/10 05:30:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncIgnoreTimes|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Finished ERROR in 7m1.895967119s (try 2/5): exit status 1: Failed [TestCopyRedownload TestSyncIgnoreTimes TestSyncAfterChangingModtimeOnly TestSyncAfterChangingFilesSizeOnly TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring] 2018/06/10 05:30:15 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncIgnoreTimes|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Starting (try 3/5) 2018/06/10 05:31:30 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive:" - Finished ERROR in 17m44.042274495s (try 1/5): exit status 1: Failed [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncWithTrackRenames TestSyncUTFNorm] 2018/06/10 05:31:30 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncWithTrackRenames|TestSyncUTFNorm)$'" - Starting (try 2/5) 2018/06/10 05:33:44 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncWithTrackRenames|TestSyncUTFNorm)$'" - Finished ERROR in 2m13.579079547s (try 2/5): exit status 1: Failed [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncUTFNorm] 2018/06/10 05:33:44 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Starting (try 3/5) 2018/06/10 05:33:59 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncIgnoreTimes|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Finished ERROR in 3m44.648341642s (try 3/5): exit status 1: Failed [TestCopyRedownload TestSyncAfterChangingFilesSizeOnly TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring] 2018/06/10 05:33:59 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Starting (try 4/5) 2018/06/10 05:35:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Finished ERROR in 1m37.037396824s (try 3/5): exit status 1: Failed [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncUTFNorm] 2018/06/10 05:35:21 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Starting (try 4/5) 2018/06/10 05:36:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic:" - Finished ERROR in 23m3.748095087s (try 1/5): exit status 1: Failed [TestSyncBackupDirWithSuffix] 2018/06/10 05:36:50 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic: -test.run '^(TestSyncBackupDirWithSuffix)$'" - Starting (try 2/5) 2018/06/10 05:37:09 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Finished ERROR in 1m48.362297048s (try 4/5): exit status 1: Failed [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncUTFNorm] 2018/06/10 05:37:09 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Starting (try 5/5) 2018/06/10 05:37:32 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncDeleteDuring)$'" - Finished ERROR in 3m32.582528508s (try 4/5): exit status 1: Failed [TestCopyRedownload TestSyncAfterChangingFilesSizeOnly TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors] 2018/06/10 05:37:32 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors)$'" - Starting (try 5/5) 2018/06/10 05:38:40 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$'" - Finished ERROR in 1m31.000234055s (try 5/5): exit status 1: Failed [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncUTFNorm] 2018/06/10 05:38:40 ------------------------------------------------------------ 2018/06/10 05:38:40 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive:" ---- 2018/06/10 05:38:40 --- FAIL: TestCopyRedownload (13.20s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-499.999999ms| > 1ns (2001-02-03 04:05:06 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) 2018/06/10 05:37:32 ERROR : foo: corrupted on transfer: MD5 hash differ "acbd18db4cc2f85cedef654fccc4a4d8" vs "37b51d194a7513e45b56f6524f2d51f2" 2018/06/10 05:37:33 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting files as there were IO errors 2018/06/10 05:37:33 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting directories as there were IO errors --- FAIL: TestSyncDoesntUpdateModtime (9.89s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: sync_test.go:456 Error: Received unexpected error: corrupted on transfer: MD5 hash differ "acbd18db4cc2f85cedef654fccc4a4d8" vs "37b51d194a7513e45b56f6524f2d51f2" github.com/ncw/rclone/fs/operations.Copy /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.go:346 github.com/ncw/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.go:306 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:2361 Test: TestSyncDoesntUpdateModtime 2018/06/10 05:37:42 ERROR : potato: corrupted on transfer: MD5 hash differ "100defcf18c42a1e0dc42a789b107cd2" vs "d6548b156ea68a4e003e786df99eee76" 2018/06/10 05:37:42 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting files as there were IO errors 2018/06/10 05:37:42 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting directories as there were IO errors --- FAIL: TestSyncAfterChangingFilesSizeOnly (9.49s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: sync_test.go:491 Error: Received unexpected error: corrupted on transfer: MD5 hash differ "100defcf18c42a1e0dc42a789b107cd2" vs "d6548b156ea68a4e003e786df99eee76" github.com/ncw/rclone/fs/operations.Copy /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.go:346 github.com/ncw/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.go:306 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:2361 Test: TestSyncAfterChangingFilesSizeOnly 2018/06/10 05:37:52 ERROR : potato: corrupted on transfer: MD5 hash differ "e4cb6955d9106df6263c45fcfc10f163" vs "100defcf18c42a1e0dc42a789b107cd2" 2018/06/10 05:37:52 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting files as there were IO errors 2018/06/10 05:37:52 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting directories as there were IO errors --- FAIL: TestSyncAfterChangingContentsOnly (9.74s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: sync_test.go:514 Error: Received unexpected error: corrupted on transfer: MD5 hash differ "e4cb6955d9106df6263c45fcfc10f163" vs "100defcf18c42a1e0dc42a789b107cd2" github.com/ncw/rclone/fs/operations.Copy /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.go:346 github.com/ncw/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.go:306 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:2361 Test: TestSyncAfterChangingContentsOnly 2018/06/10 05:38:24 ERROR : four: corrupted on transfer: MD5 hash differ "8cbad96aced40b3838dd9f07f6ef5772" vs "0a04eb9a514fbe0829cf48049cc69fc7" 2018/06/10 05:38:24 ERROR : two: corrupted on transfer: MD5 hash differ "b8a9f715dbb64fd5c56e7783c6820a61" vs "0f82d86afa0f5dc965c5c15aca58dcfb" 2018/06/10 05:38:25 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting files as there were IO errors 2018/06/10 05:38:25 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting directories as there were IO errors --- FAIL: TestSyncWithUpdateOlder (34.55s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: sync_test.go:837 Error: Received unexpected error: corrupted on transfer: MD5 hash differ "b8a9f715dbb64fd5c56e7783c6820a61" vs "0f82d86afa0f5dc965c5c15aca58dcfb" github.com/ncw/rclone/fs/operations.Copy /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.go:346 github.com/ncw/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.go:306 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:2361 Test: TestSyncWithUpdateOlder 2018/06/10 05:38:37 ERROR : Testêé: corrupted on transfer: MD5 hash differ "ce114e4501d2f4e2dcea3e17b546f339" vs "3b5c716b1f94ae30389ea40ea76fa0d5" 2018/06/10 05:38:38 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting files as there were IO errors 2018/06/10 05:38:38 ERROR : OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6': not deleting directories as there were IO errors --- FAIL: TestSyncUTFNorm (11.02s) run.go:173: Remote "OpenDrive root 'rclone-test-ketazay0tuciqaq8cahegag6'", Local "Local file system at /tmp/rclone806346729", Modify Window "1s" assertions.go:247: Error Trace: sync_test.go:1096 Error: Received unexpected error: corrupted on transfer: MD5 hash differ "ce114e4501d2f4e2dcea3e17b546f339" vs "3b5c716b1f94ae30389ea40ea76fa0d5" github.com/ncw/rclone/fs/operations.Copy /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.go:346 github.com/ncw/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.go:306 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:2361 Test: TestSyncUTFNorm FAIL 2018/06/10 05:38:40 ------------------------------------------------------------ 2018/06/10 05:38:48 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestHubic: -test.run '^(TestSyncBackupDirWithSuffix)$'" - Finished OK in 1m58.560040842s (try 2/5) 2018/06/10 05:38:54 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors)$'" - Finished ERROR in 1m22.494120011s (try 5/5): exit status 1: Failed [TestCopyRedownload TestSyncAfterChangingFilesSizeOnly] 2018/06/10 05:38:54 ------------------------------------------------------------ 2018/06/10 05:38:54 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list" ---- 2018/06/10 05:38:54 --- FAIL: TestCopyRedownload (3.87s) run.go:173: Remote "B2 bucket rclone-test-taqegok6gisutup1vaxiniv7", Local "Local file system at /tmp/rclone804954100", Modify Window "1ms" assertions.go:247: Error Trace: fstest.go:121 fstest.go:140 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:155 Error: Should be true Test: TestCopyRedownload Messages: sub dir/hello world: Modification time difference too big |-999.999µs| > 1ns (2001-02-03 04:05:06.499 +0000 UTC vs 2001-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) --- FAIL: TestSyncAfterChangingFilesSizeOnly (67.30s) run.go:173: Remote "B2 bucket rclone-test-taqegok6gisutup1vaxiniv7", Local "Local file system at /tmp/rclone804954100", Modify Window "1ms" fstest.go:304: Sleeping for 1s for list eventual consistency: 1/6 fstest.go:304: Sleeping for 2s for list eventual consistency: 2/6 fstest.go:304: Sleeping for 4s for list eventual consistency: 3/6 fstest.go:304: Sleeping for 8s for list eventual consistency: 4/6 fstest.go:304: Sleeping for 16s for list eventual consistency: 5/6 fstest.go:304: Sleeping for 32s for list eventual consistency: 6/6 assertions.go:247: Error Trace: fstest.go:311 fstest.go:346 sync_test.go:493 Error: Should be true Test: TestSyncAfterChangingFilesSizeOnly Messages: listing wrong, want potato (21) or potato (21) got potato (60) assertions.go:247: Error Trace: fstest.go:132 fstest.go:138 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:493 Error: Should be true Test: TestSyncAfterChangingFilesSizeOnly Messages: B2 bucket rclone-test-taqegok6gisutup1vaxiniv7/potato: SHA-1 hash incorrect - expecting "0fd321a1023ac4e1e1054fcc0236b9d0755f722f" got "9dc7f7d3279715991a22853f5981df582b7f9f6d" assertions.go:247: Error Trace: fstest.go:139 fstest.go:197 fstest.go:314 fstest.go:346 sync_test.go:493 Error: Not equal: expected: 21 actual : 60 Test: TestSyncAfterChangingFilesSizeOnly Messages: potato: size incorrect file=21 vs obj=60 2018/06/10 05:38:50 ERROR : B2 bucket rclone-test-taqegok6gisutup1vaxiniv7: not deleting files as there were IO errors 2018/06/10 05:38:50 ERROR : B2 bucket rclone-test-taqegok6gisutup1vaxiniv7: not deleting directories as there were IO errors FAIL 2018/06/10 05:38:54 ------------------------------------------------------------ 2018/06/10 05:43:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Expecting errors but got none: [] 2018/06/10 05:43:46 ------------------------------------------------------------ 2018/06/10 05:43:46 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" ---- 2018/06/10 05:43:46 2018/06/10 05:17:58 ERROR : : error listing: directory not found 2018/06/10 05:18:02 ERROR : : error listing: directory not found 2018/06/10 05:18:20 ERROR : : error listing: directory not found 2018/06/10 05:18:35 ERROR : : error listing: directory not found 2018/06/10 05:18:38 ERROR : : error listing: directory not found 2018/06/10 05:19:28 ERROR : : error listing: directory not found 2018/06/10 05:19:29 ERROR : : error listing: directory not found 2018/06/10 05:19:36 ERROR : : error listing: directory not found panic: test timed out after 30m0s goroutine 273 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:1240 +0xfc created by time.goFunc /usr/local/go/src/time/sleep.go:172 +0x44 goroutine 1 [chan receive, 25 minutes]: testing.(*T).Run(0xc4200e4000, 0xf8c911, 0x11, 0xfcb868, 0x48e301) /usr/local/go/src/testing/testing.go:825 +0x301 testing.runTests.func1(0xc4201f8870) /usr/local/go/src/testing/testing.go:1063 +0x64 testing.tRunner(0xc4201f8870, 0xc420271db8) /usr/local/go/src/testing/testing.go:777 +0xd0 testing.runTests(0xc420287920, 0x15c8d60, 0x1f, 0x1f, 0xc4202519a0) /usr/local/go/src/testing/testing.go:1061 +0x2c4 testing.(*M).Run(0xc420188500, 0x0) /usr/local/go/src/testing/testing.go:978 +0x171 github.com/ncw/rclone/fstest.TestMain(0xc420188500) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:65 +0x42 github.com/ncw/rclone/fs/operations_test.TestMain(0xc420188500) /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations_test.go:54 +0x2b main.main() _testmain.go:102 +0x151 goroutine 19 [syscall, 26 minutes]: os/signal.signal_recv(0x0) /usr/local/go/src/runtime/sigqueue.go:139 +0xa6 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:22 +0x22 created by os/signal.init.0 /usr/local/go/src/os/signal/signal_unix.go:28 +0x41 goroutine 102 [semacquire, 17 minutes]: sync.runtime_Semacquire(0xc42050608c) /usr/local/go/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc420506080) /usr/local/go/src/sync/waitgroup.go:129 +0x72 github.com/ncw/rclone/fs/walk.walk(0x1087480, 0xc4200818c0, 0x0, 0x0, 0x1, 0xffffffffffffffff, 0xc42050c040, 0xfcb720, 0x101, 0x7fc858c9b458) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:172 +0x31d github.com/ncw/rclone/fs/walk.walkListDirSorted(0x1087480, 0xc4200818c0, 0x0, 0x0, 0x412601, 0xffffffffffffffff, 0xc42050c040, 0x7fc858bfe801, 0xc42050c040) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:69 +0x7f github.com/ncw/rclone/fs/walk.Walk(0x1087480, 0xc4200818c0, 0x0, 0x0, 0xc420348601, 0xffffffffffffffff, 0xc42050c040, 0x101000000000000, 0x0) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:62 +0x88 github.com/ncw/rclone/fstest.NewRun.func1() /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:141 +0xde github.com/ncw/rclone/fstest.(*Run).Finalise(0xc4203606c0) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:310 +0x2b runtime.Goexit() /usr/local/go/src/runtime/panic.go:377 +0x117 testing.(*common).FailNow(0xc4200e4000) /usr/local/go/src/testing/testing.go:553 +0x39 testing.(*common).Fatalf(0xc4200e4000, 0xf92b29, 0x16, 0xc42050c000, 0x2, 0x2) /usr/local/go/src/testing/testing.go:597 +0x83 testing.(*common).Fatalf-fm(0xf92b29, 0x16, 0xc42050c000, 0x2, 0x2) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:174 +0x5c github.com/ncw/rclone/fstest.(*Run).ForceMkdir(0xc4203606c0, 0x1087480, 0xc4200818c0) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:217 +0x10f github.com/ncw/rclone/fstest.(*Run).Mkdir(0xc4203606c0, 0x1087480, 0xc4200818c0) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:225 +0x9f github.com/ncw/rclone/fstest.(*Run).WriteObjectTo(0xc4203606c0, 0x1087480, 0xc4200818c0, 0xf7f810, 0x5, 0xf863ba, 0xb, 0x1dcd64ff, 0xeb20d7a72, 0x0, ...) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:238 +0xd9 github.com/ncw/rclone/fstest.(*Run).WriteObject(0xc4203606c0, 0xf7f810, 0x5, 0xf863ba, 0xb, 0x1dcd64ff, 0xeb20d7a72, 0x0, 0x0, 0x0, ...) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:260 +0xe1 github.com/ncw/rclone/fs/operations_test.TestListDirSorted(0xc4200e4000) /home/rclone/go/src/github.com/ncw/rclone/fs/operations/listdirsorted_test.go:26 +0x106 testing.tRunner(0xc4200e4000, 0xfcb868) /usr/local/go/src/testing/testing.go:777 +0xd0 created by testing.(*T).Run /usr/local/go/src/testing/testing.go:824 +0x2e0 goroutine 177 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 293 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 295 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 291 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 292 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 294 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 290 [select, 17 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420506070, 0xc4205a4120, 0xfcb720, 0x1087480, 0xc4200818c0, 0x408401, 0xc4205060a0, 0xc42050c040, 0xc420506080, 0xc4202366c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 2018/06/10 05:43:46 ------------------------------------------------------------ 2018/06/10 05:43:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Finished ERROR in 30m0.168739051s (try 1/5): exit status 2: Failed [] 2018/06/10 05:43:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Starting (try 2/5) 2018/06/10 05:43:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" - Finished ERROR in 30m0.823291454s (try 1/5): exit status 2: Failed [TestCopyWithDryRun TestCopy TestCopyWithDepth TestCopyEmptyDirectories TestServerSideCopy TestCopyAfterDelete TestCopyRedownload TestSyncBasedOnCheckSum TestSyncSizeOnly] 2018/06/10 05:43:47 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy|TestCopyWithDepth|TestCopyEmptyDirectories|TestServerSideCopy|TestCopyAfterDelete|TestCopyRedownload|TestSyncBasedOnCheckSum|TestSyncSizeOnly)$'" - Starting (try 2/5) 2018/06/10 05:43:56 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega:" - Finished ERROR in 30m9.565309203s (try 1/5): exit status 2: Failed [TestMergeDirs TestListDirSorted TestMkdir TestLsd TestLs TestLsLong TestHashSums TestCount TestDelete TestCheck] 2018/06/10 05:43:56 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Starting (try 2/5) 2018/06/10 05:45:48 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Finished ERROR in 1m52.701859716s (try 2/5): exit status 1: Failed [TestMergeDirs TestListDirSorted TestMkdir TestLsd TestLs TestLsLong TestHashSums TestCount TestDelete TestCheck] 2018/06/10 05:45:48 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Starting (try 3/5) 2018/06/10 05:47:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Finished ERROR in 1m47.34175206s (try 3/5): exit status 1: Failed [TestMergeDirs TestListDirSorted TestMkdir TestLsd TestLs TestLsLong TestHashSums TestCount TestDelete TestCheck] 2018/06/10 05:47:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Starting (try 4/5) 2018/06/10 05:48:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs|TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Finished ERROR in 1m0.274830827s (try 4/5): exit status 1: Failed [TestMergeDirs] 2018/06/10 05:48:36 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs)$'" - Starting (try 5/5) 2018/06/10 05:48:45 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestMergeDirs)$'" - Finished OK in 8.755532997s (try 5/5) 2018/06/10 05:48:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy|TestCopyWithDepth|TestCopyEmptyDirectories|TestServerSideCopy|TestCopyAfterDelete|TestCopyRedownload|TestSyncBasedOnCheckSum|TestSyncSizeOnly)$'" - Finished ERROR in 4m59.044526271s (try 2/5): exit status 1: Failed [TestCopyWithDryRun TestCopy TestCopyWithDepth TestCopyEmptyDirectories TestServerSideCopy TestCopyAfterDelete TestCopyRedownload TestSyncBasedOnCheckSum TestSyncSizeOnly] 2018/06/10 05:48:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy|TestCopyWithDepth|TestCopyEmptyDirectories|TestServerSideCopy|TestCopyAfterDelete|TestCopyRedownload|TestSyncBasedOnCheckSum|TestSyncSizeOnly)$'" - Starting (try 3/5) 2018/06/10 06:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" - Finished ERROR in 30m0.035242405s (try 2/5): exit status 2: Failed [TestListDirSorted TestMkdir TestLsd TestLs TestLsLong TestHashSums TestCount TestDelete TestCheck] 2018/06/10 06:13:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Starting (try 3/5) 2018/06/10 06:18:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy|TestCopyWithDepth|TestCopyEmptyDirectories|TestServerSideCopy|TestCopyAfterDelete|TestCopyRedownload|TestSyncBasedOnCheckSum|TestSyncSizeOnly)$'" - Finished ERROR in 30m0.032574168s (try 3/5): exit status 2: Failed [TestCopyWithDryRun TestCopy] 2018/06/10 06:18:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy)$'" - Starting (try 4/5) 2018/06/10 06:35:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy)$'" - Finished ERROR in 16m51.876881499s (try 4/5): exit status 1: Failed [TestCopyWithDryRun TestCopy] 2018/06/10 06:35:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy)$'" - Starting (try 5/5) 2018/06/10 06:43:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs|TestLsLong|TestHashSums|TestCount|TestDelete|TestCheck)$'" - Finished ERROR in 30m0.036351733s (try 3/5): exit status 2: Failed [TestListDirSorted TestMkdir TestLsd TestLs] 2018/06/10 06:43:46 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs)$'" - Starting (try 4/5) 2018/06/10 07:05:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" - Expecting errors but got none: [] 2018/06/10 07:05:38 ------------------------------------------------------------ 2018/06/10 07:05:38 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" ---- 2018/06/10 07:05:38 panic: test timed out after 30m0s goroutine 182 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:1240 +0xfc created by time.goFunc /usr/local/go/src/time/sleep.go:172 +0x44 goroutine 1 [chan receive]: testing.(*T).Run(0xc4201f8960, 0xf85ca1, 0x12, 0xfc33f0, 0x48e346) /usr/local/go/src/testing/testing.go:825 +0x301 testing.runTests.func1(0xc4201f8870) /usr/local/go/src/testing/testing.go:1063 +0x64 testing.tRunner(0xc4201f8870, 0xc42027bdb8) /usr/local/go/src/testing/testing.go:777 +0xd0 testing.runTests(0xc420297980, 0x15ba3e0, 0x28, 0x28, 0xc42028f900) /usr/local/go/src/testing/testing.go:1061 +0x2c4 testing.(*M).Run(0xc4201a4480, 0x0) /usr/local/go/src/testing/testing.go:978 +0x171 github.com/ncw/rclone/fstest.TestMain(0xc4201a4480) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:65 +0x42 github.com/ncw/rclone/fs/sync.TestMain(0xc4201a4480) /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync_test.go:31 +0x2b main.main() _testmain.go:118 +0x151 goroutine 20 [syscall]: os/signal.signal_recv(0x0) /usr/local/go/src/runtime/sigqueue.go:139 +0xa6 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:22 +0x22 created by os/signal.init.0 /usr/local/go/src/os/signal/signal_unix.go:28 +0x41 goroutine 35 [semacquire]: sync.runtime_Semacquire(0xc420311b4c) /usr/local/go/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc420311b40) /usr/local/go/src/sync/waitgroup.go:129 +0x72 github.com/ncw/rclone/fs/walk.walk(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0x1, 0xffffffffffffffff, 0xc4204301e0, 0xfc32e8, 0x131, 0x7fdf72b97d90) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:172 +0x31d github.com/ncw/rclone/fs/walk.walkListDirSorted(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0x412601, 0xffffffffffffffff, 0xc4204301e0, 0x101, 0xc4204301e0) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:69 +0x7f github.com/ncw/rclone/fs/walk.Walk(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0xc420304c01, 0xffffffffffffffff, 0xc4204301e0, 0x100000000000000, 0x0) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:62 +0x88 github.com/ncw/rclone/fstest.NewRun.func1() /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:141 +0xde github.com/ncw/rclone/fstest.(*Run).Finalise(0xc4201a7920) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:310 +0x2b runtime.Goexit() /usr/local/go/src/runtime/panic.go:377 +0x117 testing.(*common).FailNow(0xc4201f8960) /usr/local/go/src/testing/testing.go:553 +0x39 testing.(*common).Fatalf(0xc4201f8960, 0xf8a9a2, 0x16, 0xc4204301a0, 0x2, 0x2) /usr/local/go/src/testing/testing.go:597 +0x83 testing.(*common).Fatalf-fm(0xf8a9a2, 0x16, 0xc4204301a0, 0x2, 0x2) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:174 +0x5c github.com/ncw/rclone/fstest.(*Run).ForceMkdir(0xc4201a7920, 0x107e3c0, 0xc4201a7860) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:217 +0x10f github.com/ncw/rclone/fstest.(*Run).Mkdir(0xc4201a7920, 0x107e3c0, 0xc4201a7860) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:225 +0x9f github.com/ncw/rclone/fs/sync.TestCopyWithDryRun(0xc4201f8960) /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync_test.go:39 +0x121 testing.tRunner(0xc4201f8960, 0xfc33f0) /usr/local/go/src/testing/testing.go:777 +0xd0 created by testing.(*T).Run /usr/local/go/src/testing/testing.go:824 +0x2e0 goroutine 131 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 132 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 133 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 134 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 135 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 136 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 137 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 2018/06/10 07:05:38 ------------------------------------------------------------ 2018/06/10 07:05:38 "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestCopyWithDryRun|TestCopy)$'" - Finished ERROR in 30m0.033992382s (try 5/5): exit status 2: Failed [TestCopyWithDryRun TestCopy] 2018/06/10 07:05:38 ------------------------------------------------------------ 2018/06/10 07:05:38 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor:" ---- 2018/06/10 07:05:38 panic: test timed out after 30m0s goroutine 182 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:1240 +0xfc created by time.goFunc /usr/local/go/src/time/sleep.go:172 +0x44 goroutine 1 [chan receive]: testing.(*T).Run(0xc4201f8960, 0xf85ca1, 0x12, 0xfc33f0, 0x48e346) /usr/local/go/src/testing/testing.go:825 +0x301 testing.runTests.func1(0xc4201f8870) /usr/local/go/src/testing/testing.go:1063 +0x64 testing.tRunner(0xc4201f8870, 0xc42027bdb8) /usr/local/go/src/testing/testing.go:777 +0xd0 testing.runTests(0xc420297980, 0x15ba3e0, 0x28, 0x28, 0xc42028f900) /usr/local/go/src/testing/testing.go:1061 +0x2c4 testing.(*M).Run(0xc4201a4480, 0x0) /usr/local/go/src/testing/testing.go:978 +0x171 github.com/ncw/rclone/fstest.TestMain(0xc4201a4480) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:65 +0x42 github.com/ncw/rclone/fs/sync.TestMain(0xc4201a4480) /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync_test.go:31 +0x2b main.main() _testmain.go:118 +0x151 goroutine 20 [syscall]: os/signal.signal_recv(0x0) /usr/local/go/src/runtime/sigqueue.go:139 +0xa6 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:22 +0x22 created by os/signal.init.0 /usr/local/go/src/os/signal/signal_unix.go:28 +0x41 goroutine 35 [semacquire]: sync.runtime_Semacquire(0xc420311b4c) /usr/local/go/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc420311b40) /usr/local/go/src/sync/waitgroup.go:129 +0x72 github.com/ncw/rclone/fs/walk.walk(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0x1, 0xffffffffffffffff, 0xc4204301e0, 0xfc32e8, 0x131, 0x7fdf72b97d90) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:172 +0x31d github.com/ncw/rclone/fs/walk.walkListDirSorted(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0x412601, 0xffffffffffffffff, 0xc4204301e0, 0x101, 0xc4204301e0) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:69 +0x7f github.com/ncw/rclone/fs/walk.Walk(0x107e3c0, 0xc4201a7860, 0x0, 0x0, 0xc420304c01, 0xffffffffffffffff, 0xc4204301e0, 0x100000000000000, 0x0) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:62 +0x88 github.com/ncw/rclone/fstest.NewRun.func1() /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:141 +0xde github.com/ncw/rclone/fstest.(*Run).Finalise(0xc4201a7920) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:310 +0x2b runtime.Goexit() /usr/local/go/src/runtime/panic.go:377 +0x117 testing.(*common).FailNow(0xc4201f8960) /usr/local/go/src/testing/testing.go:553 +0x39 testing.(*common).Fatalf(0xc4201f8960, 0xf8a9a2, 0x16, 0xc4204301a0, 0x2, 0x2) /usr/local/go/src/testing/testing.go:597 +0x83 testing.(*common).Fatalf-fm(0xf8a9a2, 0x16, 0xc4204301a0, 0x2, 0x2) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:174 +0x5c github.com/ncw/rclone/fstest.(*Run).ForceMkdir(0xc4201a7920, 0x107e3c0, 0xc4201a7860) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:217 +0x10f github.com/ncw/rclone/fstest.(*Run).Mkdir(0xc4201a7920, 0x107e3c0, 0xc4201a7860) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:225 +0x9f github.com/ncw/rclone/fs/sync.TestCopyWithDryRun(0xc4201f8960) /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync_test.go:39 +0x121 testing.tRunner(0xc4201f8960, 0xfc33f0) /usr/local/go/src/testing/testing.go:777 +0xd0 created by testing.(*T).Run /usr/local/go/src/testing/testing.go:824 +0x2e0 goroutine 131 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 132 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 133 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 134 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 135 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 136 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 137 [select]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420311b30, 0xc42038eba0, 0xfc32e8, 0x107e3c0, 0xc4201a7860, 0x408401, 0xc420311b60, 0xc4204301e0, 0xc420311b40, 0xc42042ea80, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 2018/06/10 07:05:38 ------------------------------------------------------------ 2018/06/10 07:13:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs)$'" - Finished ERROR in 29m44.406658477s (try 4/5): exit status 1: Failed [TestListDirSorted TestMkdir TestLsd TestLs] 2018/06/10 07:13:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs)$'" - Starting (try 5/5) 2018/06/10 07:43:31 "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted|TestMkdir|TestLsd|TestLs)$'" - Finished ERROR in 30m0.020640054s (try 5/5): exit status 2: Failed [TestListDirSorted] 2018/06/10 07:43:31 ------------------------------------------------------------ 2018/06/10 07:43:31 ---- "/home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor:" ---- 2018/06/10 07:43:31 2018/06/10 07:16:03 ERROR : : error listing: directory not found --- FAIL: TestListDirSorted (151.80s) run.go:173: Remote "QingStor bucket rclone-test-desapav5tiyowob3memofiw6", Local "Local file system at /tmp/rclone413683952", Modify Window "876000h0m0s" run.go:174: Failed to mkdir "QingStor bucket rclone-test-desapav5tiyowob3memofiw6": QingStor Error: StatusCode "403", Code "too_many_buckets", Message "You created too many buckets, please open ticket to apply more quota.", Request ID "3edf3f725c5409bf", Reference URL "http://docs.qingcloud.com/qingstor/api/common/error_code.html" panic: test timed out after 30m0s goroutine 108 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:1240 +0xfc created by time.goFunc /usr/local/go/src/time/sleep.go:172 +0x44 goroutine 1 [chan receive, 28 minutes]: testing.(*T).Run(0xc4201f21e0, 0xf83f24, 0x9, 0xfcb8a8, 0x48e300) /usr/local/go/src/testing/testing.go:825 +0x301 testing.runTests.func1(0xc4201f2870) /usr/local/go/src/testing/testing.go:1063 +0x64 testing.tRunner(0xc4201f2870, 0xc42026bdb8) /usr/local/go/src/testing/testing.go:777 +0xd0 testing.runTests(0xc42027f920, 0x15c8d60, 0x1f, 0x1f, 0xc42024b900) /usr/local/go/src/testing/testing.go:1061 +0x2c4 testing.(*M).Run(0xc42017c500, 0x0) /usr/local/go/src/testing/testing.go:978 +0x171 github.com/ncw/rclone/fstest.TestMain(0xc42017c500) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:65 +0x42 github.com/ncw/rclone/fs/operations_test.TestMain(0xc42017c500) /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations_test.go:54 +0x2b main.main() _testmain.go:102 +0x151 goroutine 5 [syscall, 28 minutes]: os/signal.signal_recv(0x0) /usr/local/go/src/runtime/sigqueue.go:139 +0xa6 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:22 +0x22 created by os/signal.init.0 /usr/local/go/src/os/signal/signal_unix.go:28 +0x41 goroutine 68 [semacquire, 28 minutes]: sync.runtime_Semacquire(0xc42025636c) /usr/local/go/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc420256360) /usr/local/go/src/sync/waitgroup.go:129 +0x72 github.com/ncw/rclone/fs/walk.walk(0x1087480, 0xc42019f800, 0x0, 0x0, 0x1, 0xffffffffffffffff, 0xc4204ec440, 0xfcb720, 0xc420073d68, 0x7f6998f42d90) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:172 +0x31d github.com/ncw/rclone/fs/walk.walkListDirSorted(0x1087480, 0xc42019f800, 0x0, 0x0, 0x412601, 0xffffffffffffffff, 0xc4204ec440, 0xc4201f2101, 0xc4204ec440) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:69 +0x7f github.com/ncw/rclone/fs/walk.Walk(0x1087480, 0xc42019f800, 0x0, 0x0, 0xc4202d4d01, 0xffffffffffffffff, 0xc4204ec440, 0xc420073e98, 0x7ad659) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:62 +0x88 github.com/ncw/rclone/fstest.NewRun.func1() /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:141 +0xde github.com/ncw/rclone/fstest.(*Run).Finalise(0xc420372fc0) /home/rclone/go/src/github.com/ncw/rclone/fstest/run.go:310 +0x2b runtime.Goexit() /usr/local/go/src/runtime/panic.go:377 +0x117 testing.(*common).FailNow(0xc4201f21e0) /usr/local/go/src/testing/testing.go:553 +0x39 github.com/ncw/rclone/vendor/github.com/stretchr/testify/require.NoError(0x107c2a0, 0xc4201f21e0, 0x1076d80, 0xc4200aa2d0, 0x0, 0x0, 0x0) /home/rclone/go/src/github.com/ncw/rclone/vendor/github.com/stretchr/testify/require/require.go:563 +0xb9 github.com/ncw/rclone/fs/operations_test.TestMkdir(0xc4201f21e0) /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations_test.go:62 +0xc0 testing.tRunner(0xc4201f21e0, 0xfcb8a8) /usr/local/go/src/testing/testing.go:777 +0xd0 created by testing.(*T).Run /usr/local/go/src/testing/testing.go:824 +0x2e0 goroutine 82 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 83 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 84 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 85 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 86 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 87 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 goroutine 88 [select, 28 minutes]: github.com/ncw/rclone/fs/walk.walk.func2(0xc420256350, 0xc4200807e0, 0xfcb720, 0x1087480, 0xc42019f800, 0x1, 0xc420256348, 0xc4204ec440, 0xc420256360, 0xc4202523c0, ...) /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:117 +0x132 created by github.com/ncw/rclone/fs/walk.walk /home/rclone/go/src/github.com/ncw/rclone/fs/walk/walk.go:114 +0x263 2018/06/10 07:43:31 ------------------------------------------------------------ 2018/06/10 07:43:31 SUMMARY 2018/06/10 07:43:31 FAIL: 17 tests failed in 2h29m50.225395554s 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestFTP: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestSftp: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestWebdav: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestMega: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOneDrive: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDropbox: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestPcloud: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestBox: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestDrive: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestCryptDrive: -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -subdir -fast-list -test.run '^(TestCopyRedownload)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestOpenDrive: -test.run '^(TestCopyRedownload|TestSyncDoesntUpdateModtime|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingContentsOnly|TestSyncWithUpdateOlder|TestSyncUTFNorm)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload TestSyncDoesntUpdateModtime TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncWithUpdateOlder TestSyncUTFNorm] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestB2: -fast-list -test.run '^(TestCopyRedownload|TestSyncAfterChangingFilesSizeOnly)$' 2018/06/10 07:43:31 * Failed tests: [TestCopyRedownload TestSyncAfterChangingFilesSizeOnly] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/sync/sync.test -test.timeout 30m0s -remote TestQingStor: 2018/06/10 07:43:31 * Failed tests: [TestCopyWithDryRun TestCopy] 2018/06/10 07:43:31 * /home/rclone/go/src/github.com/ncw/rclone/fs/operations/operations.test -test.timeout 30m0s -remote TestQingStor: -test.run '^(TestListDirSorted)$' 2018/06/10 07:43:31 * Failed tests: [TestListDirSorted]