"./sync.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -fast-list -test.run '^TestSyncSuffixKeepExtension$'" - Starting (try 5/5) === RUN TestSyncSuffixKeepExtension 2019/10/02 05:22:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2019/10/02 05:22:56 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2019/10/02 05:22:56 INFO : one: Copied (server side copy) 2019/10/02 05:23:07 INFO : one: Deleted 2019/10/02 05:23:08 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2019/10/02 05:23:08 INFO : one: Copied (new) 2019/10/02 05:23:09 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2019/10/02 05:23:09 DEBUG : two: Unchanged skipping 2019/10/02 05:23:09 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2019/10/02 05:23:10 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2019/10/02 05:23:10 INFO : three.txt: Copied (server side copy) 2019/10/02 05:23:12 INFO : three.txt: Deleted 2019/10/02 05:23:12 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2019/10/02 05:23:12 INFO : three.txt: Copied (new) 2019/10/02 05:23:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2019/10/02 05:23:13 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2019/10/02 05:23:13 INFO : one: Copied (server side copy) 2019/10/02 05:23:14 INFO : one: Deleted 2019/10/02 05:23:15 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2019/10/02 05:23:15 INFO : one: Copied (new) 2019/10/02 05:23:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2019/10/02 05:23:16 DEBUG : two: Unchanged skipping 2019/10/02 05:23:16 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2019/10/02 05:23:16 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2019/10/02 05:23:16 INFO : three.txt: Copied (server side copy) 2019/10/02 05:23:19 INFO : three.txt: Deleted 2019/10/02 05:23:20 DEBUG : three.txt: SHA-1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2019/10/02 05:23:20 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (39.37s) run.go:176: Remote "B2 bucket rclone-test-luwacuf6coxoqen0laluvec7", Local "Local file system at /tmp/rclone346251193", Modify Window "1ms" PASS 2019/10/02 05:23:30 DEBUG : B2 bucket rclone-test-luwacuf6coxoqen0laluvec7: Purge remote 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f10816437e10ebe76_d20191002_m052320_c001_v0001042_t0008") 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f105d280c3ffb93a3_d20191002_m052315_c001_v0001120_t0055") 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f111dcfd142973406_d20191002_m052313_c001_v0001113_t0036") 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f105d280c3ffb939e_d20191002_m052308_c001_v0001120_t0055") 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f102d0059f4a93000_d20191002_m052256_c001_v0001009_t0034") 2019/10/02 05:23:30 DEBUG : dst/one: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f1167a2e1bf52853f_d20191002_m052252_c001_v0001102_t0003") 2019/10/02 05:23:30 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f1196ceb617eec58b_d20191002_m052325_c001_v0001091_t0035") 2019/10/02 05:23:30 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f10531a35c2dd51a7_d20191002_m052313_c001_v0001102_t0051") 2019/10/02 05:23:30 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f10524391ed1f8d73_d20191002_m052255_c001_v0001128_t0022") 2019/10/02 05:23:30 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f10264a6d2ec284a1_d20191002_m052326_c001_v0001128_t0011") 2019/10/02 05:23:30 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f117782402b6e46be_d20191002_m052316_c001_v0001006_t0033") 2019/10/02 05:23:30 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f10553064124047db_d20191002_m052309_c001_v0001023_t0001") 2019/10/02 05:23:30 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f11839327917c32ae_d20191002_m052327_c001_v0001128_t0017") 2019/10/02 05:23:30 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f105d280c3ffb93a5_d20191002_m052320_c001_v0001120_t0055") 2019/10/02 05:23:30 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f111fedbfa0f0fc5f_d20191002_m052316_c001_v0001029_t0019") 2019/10/02 05:23:30 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f105d280c3ffb939f_d20191002_m052312_c001_v0001120_t0055") 2019/10/02 05:23:31 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f111f2a6fd0fd25e6_d20191002_m052310_c001_v0001004_t0010") 2019/10/02 05:23:31 DEBUG : dst/three.txt: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f1167a2e1bf528541_d20191002_m052253_c001_v0001102_t0003") 2019/10/02 05:23:31 DEBUG : dst/two: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f106aa9ef09baf4e3_d20191002_m052329_c001_v0001128_t0028") 2019/10/02 05:23:31 DEBUG : dst/two: Deleting (id "4_zcfc2cd83e0bd8bab6fd80e1b_f1167a2e1bf528540_d20191002_m052253_c001_v0001102_t0003") "./sync.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -fast-list -test.run '^TestSyncSuffixKeepExtension$'" - Finished OK in 42.171648734s (try 5/5)