\n \n\t\n\t
Platnost odkazu na stránku vypršela
\n
\nLink to the page has expired
\n\t\n \n\n\n \n\n\n\n\n\n"
2025/09/17 06:05:13 ERROR : Local file system at /tmp/051327go/basic/path2: not deleting files as there were IO errors
2025/09/17 06:05:13 INFO : subdir: Set directory modification time (using SetModTime)
2025/09/17 06:05:13 ERROR : Local file system at /tmp/051327go/basic/path2: not deleting directories as there were IO errors
2025/09/17 06:05:13 ERROR : [31mBisync critical error: failed to open source object: HTTP error 400 (400 Bad Request) returned body: "\n\n\n \n \n\t\n\t
Platnost odkazu na stránku vypršela
\n
\nLink to the page has expired
\n\t\n \n\n\n \n\n\n\n\n\n"[0m
2025/09/17 06:05:13 ERROR : [31mBisync aborted. Must run --resync to recover.[0m
2025/09/17 06:05:13 NOTICE: Bisync error: bisync aborted
2025/09/17 06:05:13 NOTICE: ----------------------------------------------------------
2025/09/17 06:05:13 NOTICE: [31mMISCOMPARE - Number of Golden and Results files do not match:[0m
2025/09/17 06:05:13 NOTICE: Golden count: 9
2025/09/17 06:05:13 NOTICE: Result count: 7
2025/09/17 06:05:13 NOTICE: Golden files: _testdir_path1.._testdir_path2.copy1to2.que, _testdir_path1.._testdir_path2.copy2to1.que, _testdir_path1.._testdir_path2.path1.lst, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path1.lst-old, _testdir_path1.._testdir_path2.path2.lst, _testdir_path1.._testdir_path2.path2.lst-new, _testdir_path1.._testdir_path2.path2.lst-old, test.log
2025/09/17 06:05:13 NOTICE: Result files: _testdir_path1.._testdir_path2.copy1to2.que, _testdir_path1.._testdir_path2.copy2to1.que, _testdir_path1.._testdir_path2.path1.lst-err, _testdir_path1.._testdir_path2.path1.lst-new, _testdir_path1.._testdir_path2.path2.lst-err, _testdir_path1.._testdir_path2.path2.lst-new, test.log
2025/09/17 06:05:13 NOTICE: File found in Golden but not in Results: _testdir_path1.._testdir_path2.path1.lst
2025/09/17 06:05:13 NOTICE: File found in Golden but not in Results: _testdir_path1.._testdir_path2.path1.lst-old
2025/09/17 06:05:13 NOTICE: File found in Golden but not in Results: _testdir_path1.._testdir_path2.path2.lst
2025/09/17 06:05:13 NOTICE: File found in Golden but not in Results: _testdir_path1.._testdir_path2.path2.lst-old
2025/09/17 06:05:13 NOTICE: File found in Results but not in Golden: _testdir_path1.._testdir_path2.path1.lst-err
2025/09/17 06:05:13 NOTICE: File found in Results but not in Golden: _testdir_path1.._testdir_path2.path2.lst-err
2025/09/17 06:05:13 NOTICE: ----------------------------------------------------------
2025/09/17 06:05:13 NOTICE: [31m| MISCOMPARE -Golden vs +Results for test.log[0m
2025/09/17 06:05:13 NOTICE: | @@ -53,3 +53,6 @@
2025/09/17 06:05:13 NOTICE: | -INFO : Updating listings
2025/09/17 06:05:13 NOTICE: | -INFO : Validating listings for Path1 "{path1/}" vs Path2 "{path2/}"
2025/09/17 06:05:13 NOTICE: | -INFO : [32mBisync successful[0m
2025/09/17 06:05:13 NOTICE: | +ERROR : subdir/file20.txt: Failed to copy: failed to open source object: HTTP error 400 (400 Bad Request) returned body: "\n\n\n \n \n\t\n\t
Platnost odkazu na stránku vypršela
\n
\nLink to the page has expired
\n\t\n \n\n\n \n\n\n\n\n\n"
2025/09/17 06:05:13 NOTICE: | +ERROR : {path2String}: not deleting files as there were IO errors
2025/09/17 06:05:13 NOTICE: | +ERROR : {path2String}: not deleting directories as there were IO errors
2025/09/17 06:05:13 NOTICE: | +ERROR : [31mBisync critical error: failed to open source object: HTTP error 400 (400 Bad Request) returned body: "\n\n\n \n \n\t\n\t
Platnost odkazu na stránku vypršela
\n
\nLink to the page has expired
\n\t\n \n\n\n \n\n\n\n\n\n"[0m
2025/09/17 06:05:13 NOTICE: | +ERROR : [31mBisync aborted. Must run --resync to recover.[0m
2025/09/17 06:05:13 NOTICE: | +Bisync error: bisync aborted
2025/09/17 06:05:13 NOTICE: ----------------------------------------------------------
2025/09/17 06:05:13 DEBUG : Waiting for deletions to finish
2025/09/17 06:05:15 DEBUG : pacer: Reducing sleep to 1.125s
2025/09/17 06:05:16 DEBUG : pacer: Reducing sleep to 843.75ms
2025/09/17 06:05:17 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/09/17 06:05:18 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/09/17 06:05:19 DEBUG : pacer: Reducing sleep to 355.957031ms
2025/09/17 06:05:19 DEBUG : pacer: Reducing sleep to 266.967773ms
2025/09/17 06:05:19 DEBUG : pacer: Reducing sleep to 200.225829ms
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 150.169371ms
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 112.627028ms
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 84.470271ms
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 63.352703ms
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 47.514527ms
2025/09/17 06:05:20 INFO : RCLONE_TEST: Deleted
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 35.635895ms
2025/09/17 06:05:20 INFO : file1.copy4.txt: Deleted
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 26.726921ms
2025/09/17 06:05:20 INFO : file1.copy5.txt: Deleted
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 20.04519ms
2025/09/17 06:05:20 INFO : file1.txt: Deleted
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 15.033892ms
2025/09/17 06:05:20 INFO : file1.copy1.txt: Deleted
2025/09/17 06:05:20 DEBUG : pacer: Reducing sleep to 11.275419ms
2025/09/17 06:05:20 INFO : file1.copy2.txt: Deleted
2025/09/17 06:05:21 DEBUG : pacer: Reducing sleep to 10ms
2025/09/17 06:05:21 INFO : file1.copy3.txt: Deleted
2025/09/17 06:05:21 INFO : subdir/file20.txt: Deleted
2025/09/17 06:05:21 DEBUG : removing 1 level 1 directories
2025/09/17 06:05:21 INFO : subdir: Removing directory
2025/09/17 06:05:21 DEBUG : removing 1 level 0 directories
2025/09/17 06:05:21 INFO : uloz.to root 'rclone-test-qicimug0wuya/051327go/basic/path1': Removing directory
2025/09/17 06:05:23 DEBUG : Waiting for deletions to finish
2025/09/17 06:05:23 INFO : file1.copy1.txt: Deleted
2025/09/17 06:05:23 INFO : file1.copy3.txt: Deleted
2025/09/17 06:05:23 INFO : file1.copy4.txt: Deleted
2025/09/17 06:05:23 INFO : RCLONE_TEST: Deleted
2025/09/17 06:05:23 INFO : file1.copy2.txt: Deleted
2025/09/17 06:05:23 INFO : file1.copy5.txt: Deleted
2025/09/17 06:05:23 INFO : file1.txt: Deleted
2025/09/17 06:05:23 INFO : subdir/file20.txt: Deleted
2025/09/17 06:05:23 DEBUG : removing 1 level 1 directories
2025/09/17 06:05:23 INFO : subdir: Removing directory
2025/09/17 06:05:23 DEBUG : removing 1 level 0 directories
2025/09/17 06:05:23 INFO : Local file system at /tmp/051327go/basic/path2: Removing directory
bisync_test.go:608: [31mTEST basic FAILED - 7 MISCOMPARED FILES[0m
=== RUN TestBisyncRemoteLocal/changes
2025/09/17 06:05:23 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go"
2025/09/17 06:05:23 DEBUG : Config file has changed externally - reloading
2025/09/17 06:05:26 INFO : path1: Making directory
2025/09/17 06:05:26 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1"
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/tmp/051327go"
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2"
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/initial"
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/tmp/051327go/initdir/test_changes-texuves1"
2025/09/17 06:05:29 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : Local file system at /tmp/051327go/initdir/test_changes-texuves1: Waiting for checks to finish
2025/09/17 06:05:29 DEBUG : Local file system at /tmp/051327go/initdir/test_changes-texuves1: Waiting for transfers to finish
2025/09/17 06:05:29 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/17 06:05:29 INFO : file1.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/09/17 06:05:29 INFO : file3.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/17 06:05:29 INFO : file2.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/17 06:05:29 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/17 06:05:29 INFO : RCLONE_TEST: Copied (new)
2025/09/17 06:05:29 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/09/17 06:05:29 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 INFO : file4.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/09/17 06:05:29 INFO : file6.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/09/17 06:05:29 INFO : file5.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/09/17 06:05:29 INFO : file7.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:29 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/09/17 06:05:29 INFO : file8.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/modfiles"
2025/09/17 06:05:29 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:29 DEBUG : Local file system at /tmp/051327go/datadir/test_changes-hapibob5: Waiting for checks to finish
2025/09/17 06:05:29 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:29 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:29 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/09/17 06:05:29 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt
2025/09/17 06:05:29 INFO : file2.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/17 06:05:29 INFO : file1.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : Local file system at /tmp/051327go/datadir/test_changes-hapibob5: Waiting for transfers to finish
2025/09/17 06:05:29 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/09/17 06:05:29 INFO : file10.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:29 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt
2025/09/17 06:05:29 INFO : file11.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/09/17 06:05:29 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/09/17 06:05:29 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt
2025/09/17 06:05:29 INFO : file5L.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt
2025/09/17 06:05:29 INFO : file5R.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:29 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt
2025/09/17 06:05:29 INFO : file7.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:29 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/09/17 06:05:29 INFO : file6.txt: Copied (new)
2025/09/17 06:05:29 DEBUG : Waiting for deletions to finish
2025/09/17 06:05:29 ERROR : error listing: directory not found
2025/09/17 06:05:29 ERROR : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Failed to list "": directory not found
2025/09/17 06:05:29 DEBUG : removing 1 level 0 directories
2025/09/17 06:05:29 INFO : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Removing directory
2025/09/17 06:05:30 ERROR : Failed to rmdir: directory not found
2025/09/17 06:05:30 DEBUG : Waiting for deletions to finish
2025/09/17 06:05:30 ERROR : error listing: directory not found
2025/09/17 06:05:30 ERROR : Local file system at /tmp/051327go/changes/path2: Failed to list "": directory not found
2025/09/17 06:05:30 DEBUG : removing 1 level 0 directories
2025/09/17 06:05:30 INFO : Local file system at /tmp/051327go/changes/path2: Removing directory
2025/09/17 06:05:30 ERROR : Failed to rmdir: stat /tmp/051327go/changes/path2: no such file or directory
2025/09/17 06:05:30 ERROR : error listing: directory not found
2025/09/17 06:05:30 ERROR : error listing: directory not found
2025/09/17 06:05:30 NOTICE: checking initFs Local file system at /tmp/051327go/initdir/test_changes-texuves1
2025/09/17 06:05:30 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:30 DEBUG : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Waiting for checks to finish
2025/09/17 06:05:30 DEBUG : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Waiting for transfers to finish
2025/09/17 06:05:32 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/17 06:05:32 INFO : RCLONE_TEST: Copied (new)
2025/09/17 06:05:32 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:32 INFO : file2.txt: Copied (new)
2025/09/17 06:05:32 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:32 INFO : file3.txt: Copied (new)
2025/09/17 06:05:32 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:32 INFO : file1.txt: Copied (new)
2025/09/17 06:05:33 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:33 INFO : file5.txt: Copied (new)
2025/09/17 06:05:33 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:33 INFO : file7.txt: Copied (new)
2025/09/17 06:05:33 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:33 INFO : file4.txt: Copied (new)
2025/09/17 06:05:33 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:33 INFO : file6.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 INFO : file8.txt: Copied (new)
2025/09/17 06:05:35 NOTICE: checking Path1 uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1'
2025/09/17 06:05:35 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:35 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : Local file system at /tmp/051327go/changes/path2: Waiting for checks to finish
2025/09/17 06:05:35 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2025/09/17 06:05:35 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt
2025/09/17 06:05:35 INFO : file1.txt: Copied (new)
2025/09/17 06:05:35 INFO : file2.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt
2025/09/17 06:05:35 INFO : file3.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : Local file system at /tmp/051327go/changes/path2: Waiting for transfers to finish
2025/09/17 06:05:35 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/09/17 06:05:35 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt
2025/09/17 06:05:35 INFO : file4.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt
2025/09/17 06:05:35 INFO : file6.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2025/09/17 06:05:35 INFO : RCLONE_TEST: Copied (new)
2025/09/17 06:05:35 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt
2025/09/17 06:05:35 INFO : file5.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt
2025/09/17 06:05:35 INFO : file7.txt: Copied (new)
2025/09/17 06:05:35 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/09/17 06:05:35 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt
2025/09/17 06:05:35 INFO : file8.txt: Copied (new)
2025/09/17 06:05:35 NOTICE: checking path2 Local file system at /tmp/051327go/changes/path2
2025/09/17 06:05:35 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/09/17 06:05:35 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/09/17 06:05:35 NOTICE: [36m(03) :[0m [34mbisync resync[0m
2025/09/17 06:05:38 DEBUG : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
2025/09/17 06:05:38 INFO : [2mSetting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.[0m
2025/09/17 06:05:38 INFO : Bisyncing with Comparison Settings:
{
"Modtime": true,
"Size": true,
"Checksum": false,
"HashType1": 0,
"HashType2": 0,
"NoSlowHash": false,
"SlowHashSyncOnly": false,
"SlowHashDetected": true,
"DownloadHash": false
}
2025/09/17 06:05:38 INFO : Synching Path1 "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" with Path2 "/tmp/051327go/changes/path2/"
2025/09/17 06:05:38 INFO : Copying Path2 files to Path1
2025/09/17 06:05:38 INFO : - [34mPath2[0m [35mResync is copying files to[0m - [36mPath1[0m
2025/09/17 06:05:38 INFO : There was nothing to transfer
2025/09/17 06:05:38 INFO : - [36mPath1[0m [35mResync is copying files to[0m - [36mPath2[0m
2025/09/17 06:05:39 INFO : There was nothing to transfer
2025/09/17 06:05:39 INFO : Resync updating listings
2025/09/17 06:05:39 INFO : Validating listings for Path1 "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" vs Path2 "/tmp/051327go/changes/path2/"
2025/09/17 06:05:39 INFO : [32mBisync successful[0m
2025/09/17 06:05:39 NOTICE: [36m(04) :[0m [34mtest make modifications on both paths[0m
2025/09/17 06:05:39 NOTICE: [36m(05) :[0m [34mtest new on path2 - file10[0m
2025/09/17 06:05:39 NOTICE: [36m(06) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file10.txt /tmp/051327go/changes/path2/[0m
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/"
2025/09/17 06:05:39 DEBUG : fs cache: renaming cache item "/tmp/051327go/datadir/test_changes-hapibob5/" to be canonical "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:39 DEBUG : file10.txt: Set modification time 2001-01-02
2025/09/17 06:05:39 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file10.txt" to "/tmp/051327go/changes/path2/" as ""
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file10.txt"
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2/"
2025/09/17 06:05:39 DEBUG : operations.CopyFile "file10.txt" to "Local file system at /tmp/051327go/changes/path2" as "file10.txt"
2025/09/17 06:05:39 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:39 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:39 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt
2025/09/17 06:05:39 INFO : file10.txt: Copied (new)
2025/09/17 06:05:39 NOTICE: [36m(07) :[0m [34mtest newer on path2 - file1[0m
2025/09/17 06:05:39 NOTICE: [36m(08) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file1.txt /tmp/051327go/changes/path2/[0m
2025/09/17 06:05:39 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:39 DEBUG : file1.txt: Set modification time 2001-01-02
2025/09/17 06:05:39 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file1.txt" to "/tmp/051327go/changes/path2/" as ""
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file1.txt"
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2/"
2025/09/17 06:05:39 DEBUG : operations.CopyFile "file1.txt" to "Local file system at /tmp/051327go/changes/path2" as "file1.txt"
2025/09/17 06:05:39 DEBUG : file1.txt: Sizes differ (src 19 vs dst 0)
2025/09/17 06:05:39 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:39 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt
2025/09/17 06:05:39 INFO : file1.txt: Copied (replaced existing)
2025/09/17 06:05:39 NOTICE: [36m(09) :[0m [34mtest new on path1 - file11[0m
2025/09/17 06:05:39 NOTICE: [36m(10) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file11.txt TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/[0m
2025/09/17 06:05:39 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:39 DEBUG : file11.txt: Set modification time 2001-01-02
2025/09/17 06:05:39 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file11.txt" to "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" as ""
2025/09/17 06:05:39 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file11.txt"
2025/09/17 06:05:39 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/"
2025/09/17 06:05:41 DEBUG : operations.CopyFile "file11.txt" to "uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1'" as "file11.txt"
2025/09/17 06:05:42 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/09/17 06:05:43 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:43 INFO : file11.txt: Copied (new)
2025/09/17 06:05:43 NOTICE: [36m(11) :[0m [34mtest newer on path1 - file2[0m
2025/09/17 06:05:43 NOTICE: [36m(12) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file2.txt TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/[0m
2025/09/17 06:05:43 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:43 DEBUG : file2.txt: Set modification time 2001-01-02
2025/09/17 06:05:43 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file2.txt" to "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" as ""
2025/09/17 06:05:43 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file2.txt"
2025/09/17 06:05:43 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/"
2025/09/17 06:05:45 DEBUG : operations.CopyFile "file2.txt" to "uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1'" as "file2.txt"
2025/09/17 06:05:45 DEBUG : file2.txt: Sizes differ (src 13 vs dst 0)
2025/09/17 06:05:46 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/09/17 06:05:46 INFO : file2.txt: Copied (replaced existing)
2025/09/17 06:05:46 NOTICE: [36m(13) :[0m [34mtest deleted on path2 - file3[0m
2025/09/17 06:05:46 NOTICE: [36m(14) :[0m [34mdelete-file /tmp/051327go/changes/path2/file3.txt[0m
2025/09/17 06:05:46 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2/"
2025/09/17 06:05:46 DEBUG : fs cache: renaming cache item "/tmp/051327go/changes/path2/" to be canonical "/tmp/051327go/changes/path2"
2025/09/17 06:05:46 INFO : file3.txt: Deleted
2025/09/17 06:05:46 NOTICE: [36m(15) :[0m [34mtest deleted on path1 - file4[0m
2025/09/17 06:05:46 NOTICE: [36m(16) :[0m [34mdelete-file TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/file4.txt[0m
2025/09/17 06:05:46 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/"
2025/09/17 06:05:49 DEBUG : fs cache: renaming cache item "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" to be canonical "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1"
2025/09/17 06:05:49 INFO : file4.txt: Deleted
2025/09/17 06:05:49 NOTICE: [36m(17) :[0m [34mtest deleted on both paths - file8[0m
2025/09/17 06:05:49 NOTICE: [36m(18) :[0m [34mdelete-file TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/file8.txt[0m
2025/09/17 06:05:49 DEBUG : fs cache: switching user supplied name "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" for canonical name "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1"
2025/09/17 06:05:50 INFO : file8.txt: Deleted
2025/09/17 06:05:50 NOTICE: [36m(19) :[0m [34mdelete-file /tmp/051327go/changes/path2/file8.txt[0m
2025/09/17 06:05:50 DEBUG : fs cache: switching user supplied name "/tmp/051327go/changes/path2/" for canonical name "/tmp/051327go/changes/path2"
2025/09/17 06:05:50 INFO : file8.txt: Deleted
2025/09/17 06:05:50 NOTICE: [36m(20) :[0m [34mtest changed on both paths - file5 (file5R, file5L)[0m
2025/09/17 06:05:50 NOTICE: [36m(21) :[0m [34mtouch-glob 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/ file5R.txt[0m
2025/09/17 06:05:50 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:50 DEBUG : file5R.txt: Set modification time 2001-01-02
2025/09/17 06:05:50 NOTICE: [36m(22) :[0m [34mcopy-as /tmp/051327go/datadir/test_changes-hapibob5/file5R.txt /tmp/051327go/changes/path2/ file5.txt[0m
2025/09/17 06:05:50 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file5R.txt" to "/tmp/051327go/changes/path2/" as "file5.txt"
2025/09/17 06:05:50 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file5R.txt"
2025/09/17 06:05:50 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2/"
2025/09/17 06:05:50 DEBUG : operations.CopyFile "file5R.txt" to "Local file system at /tmp/051327go/changes/path2" as "file5.txt"
2025/09/17 06:05:50 DEBUG : file5R.txt: Sizes differ (src 39 vs dst 0)
2025/09/17 06:05:50 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/09/17 06:05:50 DEBUG : file5.txt.232124ee.partial: renamed to: file5.txt
2025/09/17 06:05:50 INFO : file5R.txt: Copied (replaced existing) to: file5.txt
2025/09/17 06:05:50 NOTICE: [36m(23) :[0m [34mtouch-glob 2001-03-04 /tmp/051327go/datadir/test_changes-hapibob5/ file5L.txt[0m
2025/09/17 06:05:50 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:50 DEBUG : file5L.txt: Set modification time 2001-03-04
2025/09/17 06:05:50 NOTICE: [36m(24) :[0m [34mcopy-as /tmp/051327go/datadir/test_changes-hapibob5/file5L.txt TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/ file5.txt[0m
2025/09/17 06:05:50 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file5L.txt" to "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" as "file5.txt"
2025/09/17 06:05:50 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file5L.txt"
2025/09/17 06:05:50 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/"
2025/09/17 06:05:52 DEBUG : operations.CopyFile "file5L.txt" to "uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1'" as "file5.txt"
2025/09/17 06:05:52 DEBUG : file5L.txt: Sizes differ (src 39 vs dst 0)
2025/09/17 06:05:55 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/09/17 06:05:55 INFO : file5L.txt: Copied (replaced existing) to: file5.txt
2025/09/17 06:05:55 NOTICE: [36m(25) :[0m [34mtest newer on path2 and deleted on path1 - file6[0m
2025/09/17 06:05:55 NOTICE: [36m(26) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file6.txt /tmp/051327go/changes/path2/[0m
2025/09/17 06:05:55 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:55 DEBUG : file6.txt: Set modification time 2001-01-02
2025/09/17 06:05:55 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file6.txt" to "/tmp/051327go/changes/path2/" as ""
2025/09/17 06:05:55 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file6.txt"
2025/09/17 06:05:55 DEBUG : Creating backend with remote "/tmp/051327go/changes/path2/"
2025/09/17 06:05:55 DEBUG : operations.CopyFile "file6.txt" to "Local file system at /tmp/051327go/changes/path2" as "file6.txt"
2025/09/17 06:05:55 DEBUG : file6.txt: Sizes differ (src 19 vs dst 0)
2025/09/17 06:05:55 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:55 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt
2025/09/17 06:05:55 INFO : file6.txt: Copied (replaced existing)
2025/09/17 06:05:55 NOTICE: [36m(27) :[0m [34mdelete-file TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/file6.txt[0m
2025/09/17 06:05:55 DEBUG : fs cache: switching user supplied name "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" for canonical name "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1"
2025/09/17 06:05:55 INFO : file6.txt: Deleted
2025/09/17 06:05:55 NOTICE: [36m(28) :[0m [34mtest newer on path1 and deleted on path2 - file7[0m
2025/09/17 06:05:55 NOTICE: [36m(29) :[0m [34mtouch-copy 2001-01-02 /tmp/051327go/datadir/test_changes-hapibob5/file7.txt TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/[0m
2025/09/17 06:05:55 DEBUG : fs cache: switching user supplied name "/tmp/051327go/datadir/test_changes-hapibob5/" for canonical name "/tmp/051327go/datadir/test_changes-hapibob5"
2025/09/17 06:05:55 DEBUG : file7.txt: Set modification time 2001-01-02
2025/09/17 06:05:55 DEBUG : copyFile "/tmp/051327go/datadir/test_changes-hapibob5/file7.txt" to "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/" as ""
2025/09/17 06:05:55 DEBUG : Creating backend with remote "/tmp/051327go/datadir/test_changes-hapibob5/file7.txt"
2025/09/17 06:05:55 DEBUG : Creating backend with remote "TestUlozto:rclone-test-qicimug0wuya/051327go/changes/path1/"
2025/09/17 06:05:58 DEBUG : operations.CopyFile "file7.txt" to "uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1'" as "file7.txt"
2025/09/17 06:05:58 DEBUG : file7.txt: Sizes differ (src 19 vs dst 0)
2025/09/17 06:05:59 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/09/17 06:05:59 INFO : file7.txt: Copied (replaced existing)
2025/09/17 06:05:59 NOTICE: [36m(30) :[0m [34mdelete-file /tmp/051327go/changes/path2/file7.txt[0m
2025/09/17 06:05:59 DEBUG : fs cache: switching user supplied name "/tmp/051327go/changes/path2/" for canonical name "/tmp/051327go/changes/path2"
2025/09/17 06:05:59 INFO : file7.txt: Deleted
2025/09/17 06:05:59 NOTICE: [36m(31) :[0m [34mtest bisync run[0m
2025/09/17 06:05:59 NOTICE: [36m(32) :[0m [34mbisync[0m
2025/09/17 06:06:02 DEBUG : uloz.to root 'rclone-test-qicimug0wuya/051327go/changes/path1': Skipping jamDirTimes as remote does not support DirSetModTime or MkdirMetadata
panic: test timed out after 1h0m0s
running tests:
TestBisyncRemoteLocal (1h0m0s)
TestBisyncRemoteLocal/changes (8m2s)
goroutine 5970 [running]:
testing.(*M).startAlarm.func1()
/usr/local/go/src/testing/testing.go:2484 +0x394
created by time.goFunc
/usr/local/go/src/time/sleep.go:215 +0x2d
goroutine 1 [chan receive, 60 minutes]:
testing.(*T).Run(0xc00050f6c0, {0x27eb191?, 0xc00071d6e0?}, 0x2916c78)
/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc00050f6c0)
/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc00050f6c0, 0xc00071d820)
/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc000a19530, {0x407c7c0, 0x4, 0x4}, {0xee05c3a75?, 0x40baac0?, 0x40baac0?})
/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc000467360)
/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc000467360)
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5
github.com/rclone/rclone/cmd/bisync_test.TestMain(0xc000467360)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:243 +0xf2
main.main()
_testmain.go:55 +0xa8
goroutine 15 [chan receive, 8 minutes]:
testing.(*T).Run(0xc00050f880, {0xc000a14a55?, 0x2c33678?}, 0xc000c801e0)
/usr/local/go/src/testing/testing.go:1859 +0x431
github.com/rclone/rclone/cmd/bisync_test.testBisync({0x2c6e188, 0xc00098a270}, 0xc00050f880, {0xc000a25380, 0x23}, {0x0, 0x0})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:398 +0x94f
github.com/rclone/rclone/cmd/bisync_test.TestBisyncRemoteLocal(0xc00050f880)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:256 +0x175
testing.tRunner(0xc00050f880, 0x2916c78)
/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 1
/usr/local/go/src/testing/testing.go:1851 +0x413
goroutine 51 [syscall, 60 minutes]:
os/signal.signal_recv()
/usr/local/go/src/runtime/sigqueue.go:152 +0x29
os/signal.loop()
/usr/local/go/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
/usr/local/go/src/os/signal/signal.go:152 +0x1f
goroutine 52 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 53 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 1148 [chan receive (nil chan), 59 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 81
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 5945 [IO wait]:
internal/poll.runtime_pollWait(0x7bb1cc49c5f8, 0x77)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000538280?, 0x0?, 0x0)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitWrite(...)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:93
internal/poll.(*FD).WaitWrite(...)
/usr/local/go/src/internal/poll/fd_unix.go:692
net.(*netFD).connect(0xc000538280, {0x2c6e230, 0xc00035ebd0}, {0x41b074?, 0x72?}, {0x2c44f40?, 0xc0007c2340?})
/usr/local/go/src/net/fd_unix.go:141 +0x6cb
net.(*netFD).dial(0xc000538280, {0x2c6e230, 0xc00035ebd0}, {0x2c75f88?, 0x0?}, {0x2c75f88, 0xc00092c9c0}, 0xc000a33210?)
/usr/local/go/src/net/sock_posix.go:124 +0x3bc
net.socket({0x2c6e230, 0xc00035ebd0}, {0x27b6061, 0x3}, 0x2, 0x1, 0x2?, 0x0, {0x2c75f88, 0x0}, ...)
/usr/local/go/src/net/sock_posix.go:70 +0x29b
net.internetSocket({0x2c6e230, 0xc00035ebd0}, {0x27b6061, 0x3}, {0x2c75f88, 0x0}, {0x2c75f88, 0xc00092c9c0}, 0x1, 0x0, ...)
/usr/local/go/src/net/ipsock_posix.go:167 +0xf8
net.(*sysDialer).doDialTCPProto(0xc000e2a780, {0x2c6e230, 0xc00035ebd0}, 0x0, 0xc00092c9c0, 0x0)
/usr/local/go/src/net/tcpsock_posix.go:85 +0xe7
net.(*sysDialer).doDialTCP(...)
/usr/local/go/src/net/tcpsock_posix.go:75
net.(*sysDialer).dialTCP(0x0?, {0x2c6e230?, 0xc00035ebd0?}, 0xc000a33528?, 0xc000a33420?)
/usr/local/go/src/net/tcpsock_posix.go:71 +0x69
net.(*sysDialer).dialSingle(0xc000e2a780, {0x2c6e230, 0xc00035ebd0}, {0x2c59278, 0xc00092c9c0})
/usr/local/go/src/net/dial.go:721 +0x3ce
net.(*sysDialer).dialSerial(0xc000e2a780, {0x2c6e230, 0xc00035ebd0}, {0xc000990650?, 0x1, 0xc000e43b90?})
/usr/local/go/src/net/dial.go:686 +0x24e
net.(*sysDialer).dialParallel(0x0?, {0x2c6e230?, 0xc00035ebd0?}, {0xc000990650?, 0x238d720?, 0x27b71d2?}, {0x0?, 0x27b6061?, 0xc0009fe7f0?})
/usr/local/go/src/net/dial.go:587 +0x3a7
net.(*Dialer).DialContext(0xc0006b4640, {0x2c6e1c0, 0xc000d9acd0}, {0x27b6061, 0x3}, {0xc000bf4a50, 0x24})
/usr/local/go/src/net/dial.go:578 +0x6ac
github.com/rclone/rclone/fs/fshttp.(*Dialer).DialContext(0xc0006b4640, {0x2c6e1c0, 0xc000d9acd0}, {0x27b6061?, 0x7bb1cc69ec68?}, {0xc000bf4a50, 0x24})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:62 +0x125
github.com/rclone/rclone/fs/fshttp.NewTransportCustom.func2({0x2c6e1c0, 0xc000d9acd0}, {0x27b6061, 0x3}, {0xc000bf4a50, 0x24})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:269 +0x5c
net/http.(*Transport).dial(0xc0009fea08?, {0x2c6e1c0?, 0xc000d9acd0?}, {0x27b6061?, 0xc000223560?}, {0xc000bf4a50?, 0xea?})
/usr/local/go/src/net/http/transport.go:1278 +0xd2
net/http.(*Transport).dialConn(0xc0007e2000, {0x2c6e1c0, 0xc000d9acd0}, {{}, 0x0, {0xc000c7f1e0, 0x5}, {0xc000bf4a50, 0x24}, 0x0})
/usr/local/go/src/net/http/transport.go:1780 +0x7e5
net/http.(*Transport).dialConnFor(0xc0007e2000, 0xc000c5a210)
/usr/local/go/src/net/http/transport.go:1615 +0xb8
net/http.(*Transport).startDialConnForLocked.func1()
/usr/local/go/src/net/http/transport.go:1597 +0x35
created by net/http.(*Transport).startDialConnForLocked in goroutine 5642
/usr/local/go/src/net/http/transport.go:1596 +0x112
goroutine 4307 [sync.WaitGroup.Wait, 7 minutes]:
sync.runtime_SemacquireWaitGroup(0x0?)
/usr/local/go/src/runtime/sema.go:110 +0x25
sync.(*WaitGroup).Wait(0xc000aff207?)
/usr/local/go/src/sync/waitgroup.go:118 +0x48
github.com/rclone/rclone/fs/sync.(*syncCopyMove).stopTransfers(0xc000db2f08)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:543 +0x6f
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0xc000db2f08)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:978 +0x325
github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x2c6e1c0, 0xc000aff180}, {0x2c85650, 0xc0008abb00}, {0x2c86d10, 0xc000b21680}, 0x3, 0x0, 0x0, 0x0, ...)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1369 +0x225
github.com/rclone/rclone/fs/sync.Sync({0x2c6e1c0, 0xc000aff180}, {0x2c85650, 0xc0008abb00}, {0x2c86d10, 0xc000b21680}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1375 +0x77
github.com/rclone/rclone/cmd/bisync.(*bisyncRun).fastCopy(0xc00102cc08, {0x2c6e188?, 0xc00049c3c0?}, {0x2c86d10, 0xc000b21680}, {0x2c85650, 0xc0008abb00}, 0xc0004a2900, {0x27c4773, 0x8})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/queue.go:254 +0x4e5
github.com/rclone/rclone/cmd/bisync.(*bisyncRun).applyDeltas(0xc00102cc08, {0x2c6e188, 0xc00049c3c0}, 0xc00035f9d0, 0xc000432380)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/deltas.go:505 +0x2287
github.com/rclone/rclone/cmd/bisync.(*bisyncRun).runLocked(0xc00102cc08, {0x2c6e188, 0xc00049c3c0})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/operations.go:382 +0x1331
github.com/rclone/rclone/cmd/bisync.Bisync({0x2c6e188, 0xc00049c3c0}, {0x2c86d10, 0xc000b21680}, {0x2c85650, 0xc0008abb00}, 0xc00006d0c8)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/operations.go:180 +0xa58
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runBisync.func3()
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1218 +0x38
github.com/rclone/rclone/cmd/bisync/bilib.CaptureOutput(0xc00006d1e0)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/output.go:22 +0xd4
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runBisync(0xc000b2a1c0, {0x2c6e188?, 0xc0001b77a0?}, {0xc000db0740, 0x0, 0xc000db06d0?})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1217 +0x12c5
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestStep(0xc000b2a1c0, {0x2c6e188, 0xc0002fd620}, {0xc0003d6690, 0x6})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:788 +0x3af
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase-range1({0xc000c25baf, 0x6})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:542 +0x1ed
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase.SplitSeq.splitSeq.func3(0xc0008d65c0)
/usr/local/go/src/strings/iter.go:61 +0x8a
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase(0xc000b2a1c0, {0x2c6e188, 0xc00098a270}, 0xc00035ddc0, {0xc000a14a55, 0x7})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:525 +0x165b
github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0xc00035ddc0)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 +0x234
testing.tRunner(0xc00035ddc0, 0xc000c801e0)
/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 15
/usr/local/go/src/testing/testing.go:1851 +0x413
goroutine 80 [chan receive, 59 minutes]:
github.com/rclone/rclone/lib/atexit.Register.func1.1()
/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29
created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 15
/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68
goroutine 5318 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0007c7c20, {0x2c6e1c0, 0xc0008fc910})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 4197 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e81e0, {0x2c6e1c0, 0xc000d9aaf0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4174
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 1138 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0007c6780, {0x2c6e1c0, 0xc000800a50})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 1121
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5966 [IO wait]:
internal/poll.runtime_pollWait(0x7bb1cd08b060, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000356700?, 0xc0007a6d80?, 0x0)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc000356700, {0xc0007a6d80, 0x240, 0x240})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000356700, {0xc0007a6d80?, 0x47c27f?, 0x205?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148a58, {0xc0007a6d80?, 0x53bfae?, 0x0?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc001022720, {0xc0007a6d80?, 0x7bb1cc7173d8?, 0x7bb21559d108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc001022750, {0xc0007a6d80?, 0xc0007757a8?, 0x53b93d?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000e809b8, {0x2c480a0, 0xc001022750})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000e80708, {0x7bb1cc52a5e8, 0xc001022720}, 0xe9?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000e80708, 0x0)
/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).readHandshakeBytes(0xc000e80708, 0x4)
/usr/local/go/src/crypto/tls/conn.go:1078 +0x51
crypto/tls.(*Conn).readHandshake(0xc000e80708, {0x0, 0x0})
/usr/local/go/src/crypto/tls/conn.go:1089 +0x39
crypto/tls.(*Conn).clientHandshake(0xc000e80708, {0x2c6e1c0, 0xc0006854f0})
/usr/local/go/src/crypto/tls/handshake_client.go:340 +0x4fb
crypto/tls.(*Conn).handshakeContext(0xc000e80708, {0x2c6e1c0, 0xc0006853b0})
/usr/local/go/src/crypto/tls/conn.go:1568 +0x39a
crypto/tls.(*Conn).HandshakeContext(...)
/usr/local/go/src/crypto/tls/conn.go:1508
net/http.(*persistConn).addTLS.func2()
/usr/local/go/src/net/http/transport.go:1703 +0x6e
created by net/http.(*persistConn).addTLS in goroutine 5960
/usr/local/go/src/net/http/transport.go:1699 +0x309
goroutine 5274 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc000c652c0, {0x2c6e1c0, 0xc000afeaa0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 854 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0007c63c0, {0x2c6e1c0, 0xc000b1e050})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 853
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5644 [select]:
net/http.(*Transport).getConn(0xc0007e2000, 0xc000685270, {{}, 0x0, {0xc000b9eb00, 0x5}, {0xc000e71500, 0x24}, 0x0})
/usr/local/go/src/net/http/transport.go:1520 +0x4ae
net/http.(*Transport).roundTrip(0xc0007e2000, 0xc000c68dc0)
/usr/local/go/src/net/http/transport.go:685 +0xb57
net/http.(*Transport).RoundTrip(...)
/usr/local/go/src/net/http/roundtrip.go:30
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0008108a0, 0xc000c68dc0)
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:496 +0x345
net/http.send(0xc000c68dc0, {0x2c469a0, 0xc0008108a0}, {0x479601?, 0xc00006d0f0?, 0x0?})
/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0000c52f0, 0xc000c68dc0, {0x7bb1cc4febd8?, 0x40de1c0?, 0x0?})
/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0000c52f0, 0xc000c68dc0)
/usr/local/go/src/net/http/client.go:728 +0x989
net/http.(*Client).Do(...)
/usr/local/go/src/net/http/client.go:587
github.com/rclone/rclone/lib/rest.(*Client).Call(0xc0008fc190, {0x2c6e1c0, 0xc000aff2c0}, 0xc000ac9900)
/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:353 +0xd67
github.com/rclone/rclone/backend/ulozto.(*Object).Open.func2()
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:804 +0x52
github.com/rclone/rclone/fs.pacerInvoker(0x8, 0xa, 0x2c45460?)
/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc000810900, 0xc000b33040, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc000810900, 0xc000b33040)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93
github.com/rclone/rclone/backend/ulozto.(*Object).Open(0xc000811e60, {0x2c6e1c0, 0xc000aff2c0}, {0xc000617d10, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:803 +0x428
github.com/rclone/rclone/fs/operations.(*ReOpen).open(0xc0007eb880)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:147 +0x109
github.com/rclone/rclone/fs/operations.NewReOpen({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc000811e60}, 0xa, {0xc000617d00, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:102 +0x4f5
github.com/rclone/rclone/fs/operations.Open({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc000811e60}, {0xc000617d00, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:124 +0x6b
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000d8e000, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:265 +0x4dc
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000d8e000, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:314 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2c6e1c0, 0xc000aff2c0}, {0x2c85650, 0xc0008abb00}, {0x0, 0x0}, {0xc000b3a210, 0x13}, {0x2c86d80, 0xc000811e60})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:416 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000db2f08, {0x2c6e1c0, 0xc000aff2c0}, 0xc000aff220, {0x2c85650, 0xc0008abb00}, 0x32, 0xc0006c9f60?)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 5419 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e9860, {0x2c6e1c0, 0xc00044a2d0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5603 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc000b725a0, {0x2c6e1c0, 0xc000d9a6e0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 5642
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5299 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0007c70e0, {0x2c6e1c0, 0xc0008fc370})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5288 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e9680, {0x2c6e1c0, 0xc00044a4b0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 2966 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e9c20, {0x2c6e1c0, 0xc0003e80f0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 2965
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5478 [chan receive (nil chan), 7 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 5960 [chan receive]:
net/http.(*persistConn).addTLS(0xc00084ec60, {0x2c6e1c0, 0xc0006853b0}, {0xc000e71500, 0x20}, 0x0)
/usr/local/go/src/net/http/transport.go:1709 +0x327
net/http.(*Transport).dialConn(0xc0007e2000, {0x2c6e1c0, 0xc0006853b0}, {{}, 0x0, {0xc000b9eb00, 0x5}, {0xc000e71500, 0x24}, 0x0})
/usr/local/go/src/net/http/transport.go:1790 +0x99c
net/http.(*Transport).dialConnFor(0xc0007e2000, 0xc00090e2c0)
/usr/local/go/src/net/http/transport.go:1615 +0xb8
net/http.(*Transport).startDialConnForLocked.func1()
/usr/local/go/src/net/http/transport.go:1597 +0x35
created by net/http.(*Transport).startDialConnForLocked in goroutine 5644
/usr/local/go/src/net/http/transport.go:1596 +0x112
goroutine 5342 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0008ce1e0, {0x2c6e1c0, 0xc0008fd680})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5938 [select]:
net/http.(*persistConn).writeLoop(0xc00075e5a0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 5916
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 3125 [chan receive (nil chan), 59 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 2200
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 1105 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e8f00, {0x2c6e1c0, 0xc0008fd3b0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 1104
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5921 [select]:
net.(*netFD).connect.func2()
/usr/local/go/src/net/fd_unix.go:118 +0x7a
created by net.(*netFD).connect in goroutine 5945
/usr/local/go/src/net/fd_unix.go:117 +0x349
goroutine 981 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e8d20, {0x2c6e1c0, 0xc0008fc050})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 980
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 991 [chan receive (nil chan), 59 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 81
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 1298 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e90e0, {0x2c6e1c0, 0xc0008fc690})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 1295
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 1195 [chan receive (nil chan), 59 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 81
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 5121 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0006e8960, {0x2c6e1c0, 0xc000d9b8b0})
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 5120
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x11a
goroutine 5967 [select]:
crypto/tls.(*Conn).handshakeContext.func2()
/usr/local/go/src/crypto/tls/conn.go:1544 +0x86
created by crypto/tls.(*Conn).handshakeContext in goroutine 5966
/usr/local/go/src/crypto/tls/conn.go:1543 +0x27b
goroutine 5642 [select]:
net/http.(*Transport).getConn(0xc0007e2000, 0xc000d9ac80, {{}, 0x0, {0xc000c7f1e0, 0x5}, {0xc000bf4a50, 0x24}, 0x0})
/usr/local/go/src/net/http/transport.go:1520 +0x4ae
net/http.(*Transport).roundTrip(0xc0007e2000, 0xc000cac500)
/usr/local/go/src/net/http/transport.go:685 +0xb57
net/http.(*Transport).RoundTrip(...)
/usr/local/go/src/net/http/roundtrip.go:30
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0008108a0, 0xc000cac500)
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:496 +0x345
net/http.send(0xc000cac500, {0x2c469a0, 0xc0008108a0}, {0x479601?, 0xc0007350f0?, 0x0?})
/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0000c52f0, 0xc000cac500, {0x7bb1cc4febd8?, 0x40de1c0?, 0x0?})
/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0000c52f0, 0xc000cac500)
/usr/local/go/src/net/http/client.go:728 +0x989
net/http.(*Client).Do(...)
/usr/local/go/src/net/http/client.go:587
github.com/rclone/rclone/lib/rest.(*Client).Call(0xc0008fc190, {0x2c6e1c0, 0xc000aff2c0}, 0xc000a432c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:353 +0xd67
github.com/rclone/rclone/backend/ulozto.(*Object).Open.func2()
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:804 +0x52
github.com/rclone/rclone/fs.pacerInvoker(0x8, 0xa, 0x2c45460?)
/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc000810900, 0xc000b32ac0, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc000810900, 0xc000b32ac0)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93
github.com/rclone/rclone/backend/ulozto.(*Object).Open(0xc000811da0, {0x2c6e1c0, 0xc000aff2c0}, {0xc000b0f740, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:803 +0x428
github.com/rclone/rclone/fs/operations.(*ReOpen).open(0xc000d16d20)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:147 +0x109
github.com/rclone/rclone/fs/operations.NewReOpen({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc000811da0}, 0xa, {0xc000b0f730, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:102 +0x4f5
github.com/rclone/rclone/fs/operations.Open({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc000811da0}, {0xc000b0f730, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:124 +0x6b
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000c226c0, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:265 +0x4dc
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000c226c0, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:314 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2c6e1c0, 0xc000aff2c0}, {0x2c85650, 0xc0008abb00}, {0x0, 0x0}, {0xc000b13ba0, 0xa}, {0x2c86d80, 0xc000811da0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:416 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000db2f08, {0x2c6e1c0, 0xc000aff2c0}, 0xc000aff220, {0x2c85650, 0xc0008abb00}, 0x0, 0xc0007a8f40?)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 5643 [select]:
net/http.(*persistConn).roundTrip(0xc00075e5a0, 0xc000afe550)
/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc0007e2000, 0xc000d908c0)
/usr/local/go/src/net/http/transport.go:696 +0xb9a
net/http.(*Transport).RoundTrip(...)
/usr/local/go/src/net/http/roundtrip.go:30
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0008108a0, 0xc000d908c0)
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:496 +0x345
net/http.send(0xc000d908c0, {0x2c469a0, 0xc0008108a0}, {0x479601?, 0xc000a710f0?, 0x0?})
/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0000c52f0, 0xc000d908c0, {0x7bb1cc4febd8?, 0x40de1c0?, 0x0?})
/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0000c52f0, 0xc000d908c0)
/usr/local/go/src/net/http/client.go:728 +0x989
net/http.(*Client).Do(...)
/usr/local/go/src/net/http/client.go:587
github.com/rclone/rclone/lib/rest.(*Client).Call(0xc0008fc190, {0x2c6e1c0, 0xc000aff2c0}, 0xc000ac9a40)
/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:353 +0xd67
github.com/rclone/rclone/backend/ulozto.(*Object).Open.func2()
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:804 +0x52
github.com/rclone/rclone/fs.pacerInvoker(0x7, 0xa, 0x2c45460?)
/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc000810900, 0xc000b32cc0, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc000810900, 0xc000b32cc0)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93
github.com/rclone/rclone/backend/ulozto.(*Object).Open(0xc0009aa120, {0x2c6e1c0, 0xc000aff2c0}, {0xc000617da0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/ulozto/ulozto.go:803 +0x428
github.com/rclone/rclone/fs/operations.(*ReOpen).open(0xc0007eb960)
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:147 +0x109
github.com/rclone/rclone/fs/operations.NewReOpen({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc0009aa120}, 0xa, {0xc000617d90, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:102 +0x4f5
github.com/rclone/rclone/fs/operations.Open({0x2c6e1c0, 0xc000aff2c0}, {0x2c86d80, 0xc0009aa120}, {0xc000617d90, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/reopen.go:124 +0x6b
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000d8e090, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:265 +0x4dc
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000d8e090, {0x2c6e1c0, 0xc000aff2c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:314 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2c6e1c0, 0xc000aff2c0}, {0x2c85650, 0xc0008abb00}, {0x0, 0x0}, {0xc000b13d30, 0x9}, {0x2c86d80, 0xc0009aa120})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:416 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000db2f08, {0x2c6e1c0, 0xc000aff2c0}, 0xc000aff220, {0x2c85650, 0xc0008abb00}, 0x19, 0xc0008ebf98?)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 5905 [IO wait]:
internal/poll.runtime_pollWait(0x7bb1cc49c4e0, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000538200?, 0xc0004f2000?, 0x0)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc000538200, {0xc0004f2000, 0xd80, 0xd80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000538200, {0xc0004f2000?, 0xc00011cea0?, 0x27d8428?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148920, {0xc0004f2000?, 0xc0004f1968?, 0xa68705?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc001022390, {0xc0004f2000?, 0x7bb1cc4ed140?, 0x7bb21559da78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000ec22e8, {0xc0004f2000?, 0xc0004f19b0?, 0xa6a4bc?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000e802b8, {0x2c480a0, 0xc000ec22e8})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000e80008, {0x7bb1cc52a5e8, 0xc001022390}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000e80008, 0x0)
/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc000e80008, {0xc000838000, 0x1000, 0x7bb21559da78?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00075e5a0, {0xc000838000?, 0x412565?, 0x68?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00071a240)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00071a240, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00075e5a0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 5916
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 5435 [chan receive (nil chan), 7 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
goroutine 5654 [chan receive, 7 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 4307
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:255 +0x378
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestUlozto: -verbose" - Finished ERROR in 1h0m2.543056915s (try 3/5): exit status 2: Failed []