"./operations.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -test.run '^TestRcat$'" - Starting (try 2/5)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=false,ignoreChecksum=false
2020/03/09 05:17:02 DEBUG : B2 bucket rclone-test-qudopek3qotopac4meqiyab6: File to upload is small (34 bytes), uploading instead of streaming
2020/03/09 05:17:04 DEBUG : no_checksum_small_file_from_pipe: SHA-1 = 4c3452689ee5e2b950454c46181b8b5e7bcfeca9 OK
2020/03/09 05:17:04 INFO  : no_checksum_small_file_from_pipe: Copied (new)
2020/03/09 05:17:04 DEBUG : no_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload.
2020/03/09 05:17:05 DEBUG : no_checksum_big_file_from_pipe: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
=== RUN   TestRcat/withChecksum=true,ignoreChecksum=false
2020/03/09 05:17:18 DEBUG : B2 bucket rclone-test-qudopek3qotopac4meqiyab6: File to upload is small (34 bytes), uploading instead of streaming
2020/03/09 05:17:20 DEBUG : with_checksum_small_file_from_pipe: SHA-1 = 4c3452689ee5e2b950454c46181b8b5e7bcfeca9 OK
2020/03/09 05:17:20 INFO  : with_checksum_small_file_from_pipe: Copied (new)
2020/03/09 05:17:20 DEBUG : with_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload.
2020/03/09 05:17:21 DEBUG : with_checksum_big_file_from_pipe: SHA-1 = d0080f73aa8b494570ad63df1beb25c01ea9eea2 OK
2020/03/09 05:17:21 DEBUG : with_checksum_big_file_from_pipe: Size and SHA-1 of src and dst objects identical
=== RUN   TestRcat/withChecksum=false,ignoreChecksum=true
2020/03/09 05:17:22 DEBUG : B2 bucket rclone-test-qudopek3qotopac4meqiyab6: File to upload is small (34 bytes), uploading instead of streaming
2020/03/09 05:17:23 INFO  : ignore_checksum_small_file_from_pipe: Copied (new)
2020/03/09 05:17:23 DEBUG : ignore_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload.
2020/03/09 05:17:23 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
=== RUN   TestRcat/withChecksum=true,ignoreChecksum=true
2020/03/09 05:17:26 DEBUG : B2 bucket rclone-test-qudopek3qotopac4meqiyab6: File to upload is small (34 bytes), uploading instead of streaming
2020/03/09 05:17:26 INFO  : ignore_checksum_small_file_from_pipe: Copied (new)
2020/03/09 05:17:26 DEBUG : ignore_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload.
2020/03/09 05:17:27 NOTICE: B2 bucket rclone-test-qudopek3qotopac4meqiyab6: --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2020/03/09 05:17:27 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical
--- PASS: TestRcat (27.40s)
    run.go:176: Remote "B2 bucket rclone-test-qudopek3qotopac4meqiyab6", Local "Local file system at /tmp/rclone512790952", Modify Window "1ms"
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (16.47s)
    run.go:176: Remote "B2 bucket rclone-test-qudopek3qotopac4meqiyab6", Local "Local file system at /tmp/rclone512790952", Modify Window "1ms"
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (4.51s)
    run.go:176: Remote "B2 bucket rclone-test-qudopek3qotopac4meqiyab6", Local "Local file system at /tmp/rclone512790952", Modify Window "1ms"
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (3.42s)
    run.go:176: Remote "B2 bucket rclone-test-qudopek3qotopac4meqiyab6", Local "Local file system at /tmp/rclone512790952", Modify Window "1ms"
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (3.00s)
PASS
2020/03/09 05:17:29 DEBUG : B2 bucket rclone-test-qudopek3qotopac4meqiyab6: Purge remote
2020/03/09 05:17:29 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f1002227ca4bd9484_d20200309_m051727_c001_v0001033_t0057")
2020/03/09 05:17:29 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c412f_d20200309_m051726_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f11158f45ab756ed8_d20200309_m051724_c001_v0001128_t0019")
2020/03/09 05:17:29 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4129_d20200309_m051723_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f115261b1f1fae94c_d20200309_m051728_c001_v0001040_t0020")
2020/03/09 05:17:29 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c412d_d20200309_m051726_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f11613c4bd5439e85_d20200309_m051725_c001_v0001128_t0010")
2020/03/09 05:17:29 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4128_d20200309_m051722_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : no_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f1073ec7fd8b03ffe_d20200309_m051705_c001_v0001040_t0017")
2020/03/09 05:17:29 DEBUG : no_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4114_d20200309_m051704_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : no_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f102a1cede7e5fb44_d20200309_m051709_c001_v0001013_t0039")
2020/03/09 05:17:29 DEBUG : no_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4111_d20200309_m051703_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : with_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f114036935cdf30c1_d20200309_m051721_c001_v0001025_t0010")
2020/03/09 05:17:29 DEBUG : with_checksum_big_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4127_d20200309_m051720_c001_v0001032_t0036")
2020/03/09 05:17:29 DEBUG : with_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f113424cd3826076d_d20200309_m051721_c001_v0001120_t0032")
2020/03/09 05:17:29 DEBUG : with_checksum_small_file_from_pipe: Deleting (id "4_z0f829db3b09dbbdb7f080e1b_f101a9b79d35c4125_d20200309_m051718_c001_v0001032_t0036")
"./operations.test -test.v -test.timeout 30m0s -remote TestB2: -verbose -test.run '^TestRcat$'" - Finished OK in 29.826480965s (try 2/5)