"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCheck|TestCheckSum|TestCheckSumDownload|TestCopyFileBackupDir)$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Starting (try 2/5)
2025/01/11 06:12:27 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-guxewur5hevi"
2025/01/11 06:12:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/11 06:12:27 DEBUG : Creating backend with remote "TestYandex:rclone-test-guxewur5hevi"
2025/01/11 06:12:27 DEBUG : Reset feature "ListR"
2025/01/11 06:12:27 DEBUG : Creating backend with remote "/tmp/rclone2494418535"
=== RUN   TestCheck
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi'", Local "Local file system at /tmp/rclone2494418535", Modify Window "1ns"
2025/01/11 06:12:34 INFO  : rutabaga.rclone_chunk.001_x05nmt: Moved (server-side) to: rutabaga
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2025/01/11 06:12:42 INFO  : empty space.rclone_chunk.001_x05w1x: Moved (server-side) to: empty space
=== RUN   TestCheck/3
2025/01/11 06:12:52 INFO  : potato2.rclone_chunk.001_x063ln: Moved (server-side) to: potato2.rclone_chunk.001
2025/01/11 06:12:54 INFO  : potato2.rclone_chunk.002_x063ln: Moved (server-side) to: potato2.rclone_chunk.002
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2025/01/11 06:13:07 INFO  : remotepotato.rclone_chunk.001_x06ici: Moved (server-side) to: remotepotato.rclone_chunk.001
2025/01/11 06:13:09 INFO  : remotepotato.rclone_chunk.002_x06ici: Moved (server-side) to: remotepotato.rclone_chunk.002
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (65.74s)
    --- PASS: TestCheck/1 (0.65s)
    --- PASS: TestCheck/2 (0.69s)
    --- PASS: TestCheck/3 (0.40s)
    --- PASS: TestCheck/4 (0.83s)
    --- PASS: TestCheck/5 (0.82s)
    --- PASS: TestCheck/6 (1.12s)
    --- PASS: TestCheck/7 (1.07s)
=== RUN   TestCheckSum
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi'", Local "Local file system at /tmp/rclone2494418535", Modify Window "1ns"
2025/01/11 06:13:33 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-guxewur5hevi/data"
2025/01/11 06:13:33 DEBUG : Creating backend with remote "TestYandex:rclone-test-guxewur5hevi/data"
2025/01/11 06:13:33 DEBUG : Reset feature "ListR"
2025/01/11 06:13:41 INFO  : data/banana.rclone_chunk.001_x07h2e: Moved (server-side) to: data/banana
2025/01/11 06:13:49 INFO  : test.sum.rclone_chunk.001_x07od0: Moved (server-side) to: test.sum
=== RUN   TestCheckSum/subtest1
2025/01/11 06:13:57 INFO  : data/potato.rclone_chunk.001_x07zu3: Moved (server-side) to: data/potato
2025/01/11 06:15:22 INFO  : test.sum: Deleted
2025/01/11 06:15:24 INFO  : test.sum.rclone_chunk.001_x086v9: Moved (server-side) to: test.sum
=== RUN   TestCheckSum/subtest2
2025/01/11 06:15:38 INFO  : test.sum.rclone_chunk.001_x0ao1j: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:15:40 INFO  : test.sum.rclone_chunk.002_x0ao1j: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest3
2025/01/11 06:16:11 INFO  : test.sum.rclone_chunk.001_x0bfwt: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:16:13 INFO  : test.sum.rclone_chunk.002_x0bfwt: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest4
2025/01/11 06:16:47 INFO  : test.sum.rclone_chunk.001_x0c6f0: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:16:49 INFO  : test.sum.rclone_chunk.002_x0c6f0: Moved (server-side) to: test.sum.rclone_chunk.002
2025/01/11 06:16:51 INFO  : test.sum.rclone_chunk.003_x0c6f0: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSum/subtest5
2025/01/11 06:17:17 INFO  : test.sum.rclone_chunk.001_x0d8hz: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:17:19 INFO  : test.sum.rclone_chunk.002_x0d8hz: Moved (server-side) to: test.sum.rclone_chunk.002
2025/01/11 06:17:21 INFO  : test.sum.rclone_chunk.003_x0d8hz: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSum/subtest6
2025/01/11 06:17:38 INFO  : data/banana: Deleted
2025/01/11 06:17:40 INFO  : data/banana.rclone_chunk.001_x0e4xd: Moved (server-side) to: data/banana
2025/01/11 06:17:48 INFO  : data/potato: Deleted
2025/01/11 06:17:51 INFO  : data/potato.rclone_chunk.001_x0ec31: Moved (server-side) to: data/potato
2025/01/11 06:18:07 INFO  : test.sum.rclone_chunk.001_x0eock: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:18:09 INFO  : test.sum.rclone_chunk.002_x0eock: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest7
--- PASS: TestCheckSum (299.17s)
    --- PASS: TestCheckSum/subtest1 (1.80s)
    --- PASS: TestCheckSum/subtest2 (1.99s)
    --- PASS: TestCheckSum/subtest3 (8.59s)
    --- PASS: TestCheckSum/subtest4 (3.46s)
    --- PASS: TestCheckSum/subtest5 (4.41s)
    --- PASS: TestCheckSum/subtest6 (3.90s)
    --- PASS: TestCheckSum/subtest7 (3.15s)
=== RUN   TestCheckSumDownload
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi'", Local "Local file system at /tmp/rclone2494418535", Modify Window "1ns"
2025/01/11 06:18:32 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-guxewur5hevi/data"
2025/01/11 06:18:32 DEBUG : Creating backend with remote "TestYandex:rclone-test-guxewur5hevi/data"
2025/01/11 06:18:32 DEBUG : Reset feature "ListR"
2025/01/11 06:18:39 INFO  : data/banana.rclone_chunk.001_x0fsru: Moved (server-side) to: data/banana
2025/01/11 06:18:45 INFO  : test.sum.rclone_chunk.001_x0fycx: Moved (server-side) to: test.sum
=== RUN   TestCheckSumDownload/subtest1
2025/01/11 06:18:55 INFO  : data/potato.rclone_chunk.001_x0g8rj: Moved (server-side) to: data/potato
2025/01/11 06:19:02 INFO  : test.sum: Deleted
2025/01/11 06:19:05 INFO  : test.sum.rclone_chunk.001_x0gfmm: Moved (server-side) to: test.sum
=== RUN   TestCheckSumDownload/subtest2
2025/01/11 06:19:17 INFO  : test.sum.rclone_chunk.001_x0gru2: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:19:19 INFO  : test.sum.rclone_chunk.002_x0gru2: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest3
2025/01/11 06:19:44 INFO  : test.sum.rclone_chunk.001_x0hdya: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:19:46 INFO  : test.sum.rclone_chunk.002_x0hdya: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest4
2025/01/11 06:20:11 INFO  : test.sum.rclone_chunk.001_x0i2mw: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:20:13 INFO  : test.sum.rclone_chunk.002_x0i2mw: Moved (server-side) to: test.sum.rclone_chunk.002
2025/01/11 06:20:15 INFO  : test.sum.rclone_chunk.003_x0i2mw: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSumDownload/subtest5
2025/01/11 06:20:42 INFO  : test.sum.rclone_chunk.001_x0ix3s: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:20:44 INFO  : test.sum.rclone_chunk.002_x0ix3s: Moved (server-side) to: test.sum.rclone_chunk.002
2025/01/11 06:20:46 INFO  : test.sum.rclone_chunk.003_x0ix3s: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSumDownload/subtest6
2025/01/11 06:21:08 INFO  : data/banana: Deleted
2025/01/11 06:21:11 INFO  : data/banana.rclone_chunk.001_x0jtxy: Moved (server-side) to: data/banana
2025/01/11 06:21:18 INFO  : data/potato: Deleted
2025/01/11 06:21:20 INFO  : data/potato.rclone_chunk.001_x0k61j: Moved (server-side) to: data/potato
2025/01/11 06:21:35 INFO  : test.sum.rclone_chunk.001_x0kghf: Moved (server-side) to: test.sum.rclone_chunk.001
2025/01/11 06:21:37 INFO  : test.sum.rclone_chunk.002_x0kghf: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (207.80s)
    --- PASS: TestCheckSumDownload/subtest1 (2.52s)
    --- PASS: TestCheckSumDownload/subtest2 (2.10s)
    --- PASS: TestCheckSumDownload/subtest3 (3.55s)
    --- PASS: TestCheckSumDownload/subtest4 (3.28s)
    --- PASS: TestCheckSumDownload/subtest5 (4.41s)
    --- PASS: TestCheckSumDownload/subtest6 (5.58s)
    --- PASS: TestCheckSumDownload/subtest7 (3.41s)
=== RUN   TestCopyFileBackupDir
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi'", Local "Local file system at /tmp/rclone2494418535", Modify Window "1ns"
2025/01/11 06:22:07 INFO  : dst/file1.rclone_chunk.001_x0ljtt: Moved (server-side) to: dst/file1
2025/01/11 06:22:09 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-guxewur5hevi/backup"
2025/01/11 06:22:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-guxewur5hevi/backup"
2025/01/11 06:22:09 DEBUG : Reset feature "ListR"
2025/01/11 06:22:09 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18)
2025/01/11 06:22:10 DEBUG : dst/file1: move non-chunked object...
2025/01/11 06:22:13 INFO  : dst/file1: Moved (server-side)
2025/01/11 06:22:13 INFO  : dst/file1: Moved (server-side)
2025/01/11 06:22:14 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit
2025/01/11 06:22:21 INFO  : dst/file1.rclone_chunk.001_x0lx88: Moved (server-side) to: dst/file1
2025/01/11 06:22:21 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2025/01/11 06:22:21 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (35.47s)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=true,ignoreChecksum=false
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi'", Local "Local file system at /tmp/rclone2494418535", Modify Window "1ns"
    operations_test.go:1495: Adjust StreamingUploadCutoff to size limit 1Ki (was 100Ki)
2025/01/11 06:22:36 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi': File to upload is small (34 bytes), uploading instead of streaming
2025/01/11 06:22:42 INFO  : with_checksum_small_file_from_pipe.rclone_chunk.001_x0mjl5: Moved (server-side) to: with_checksum_small_file_from_pipe
2025/01/11 06:22:42 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK
2025/01/11 06:22:42 DEBUG : with_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical
2025/01/11 06:23:43 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.001_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.001
2025/01/11 06:23:45 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.002_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.002
2025/01/11 06:23:47 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.003_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.003
2025/01/11 06:23:49 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.004_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.004
2025/01/11 06:23:52 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.005_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.005
2025/01/11 06:23:54 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.006_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.006
2025/01/11 06:23:56 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.007_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.007
2025/01/11 06:23:58 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.008_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.008
2025/01/11 06:24:00 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.009_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.009
2025/01/11 06:24:02 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.010_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.010
2025/01/11 06:24:04 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.011_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.011
2025/01/11 06:24:06 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.012_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.012
2025/01/11 06:24:08 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.013_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.013
2025/01/11 06:24:10 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.014_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.014
2025/01/11 06:24:12 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.015_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.015
2025/01/11 06:24:14 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.016_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.016
2025/01/11 06:24:16 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.017_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.017
2025/01/11 06:24:18 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.018_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.018
2025/01/11 06:24:20 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.019_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.019
2025/01/11 06:24:23 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.020_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.020
2025/01/11 06:24:25 INFO  : with_checksum_big_file_from_pipe.rclone_chunk.021_x0mpke: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.021
2025/01/11 06:24:30 DEBUG : with_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK
2025/01/11 06:24:30 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical
--- PASS: TestRcat (156.51s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (156.51s)
PASS
2025/01/11 06:25:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-guxewur5hevi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCheck|TestCheckSum|TestCheckSumDownload|TestCopyFileBackupDir)$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Finished OK in 12m47.341448689s (try 2/5)